builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1507775882.37 results: success (0) revision: 98a72bed57b730ae8d79d151666deafa4e3caa53 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-11 19:38:02.365616) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-11 19:38:02.366045) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-11 19:38:02.366331) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-11 19:38:02.385144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 19:38:02.385418) ========= 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=6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-11 19:38:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.3M=0s 2017-10-11 19:38:02 (41.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131574 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 19:38:02.537607) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 19:38:02.537921) ========= 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=6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014208 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 19:38:02.587215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 19:38:02.590560) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 98a72bed57b730ae8d79d151666deafa4e3caa53 --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 98a72bed57b730ae8d79d151666deafa4e3caa53 --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=6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-11 19:38:02,937 truncating revision to first 12 chars 2017-10-11 19:38:02,937 Setting DEBUG logging. 2017-10-11 19:38:02,937 attempt 1/10 2017-10-11 19:38:02,937 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/98a72bed57b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-11 19:38:03,340 unpacking tar archive at: mozilla-beta-98a72bed57b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.705219 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 19:38:03.315583) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-11 19:38:03.315896) ========= script_repo_revision: 98a72bed57b730ae8d79d151666deafa4e3caa53 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-11 19:38:03.316251) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-11 19:38:03.316522) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-11 19:38:03.330572) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-10-11 19:38:03.330839) ========= /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=6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:38:03 INFO - MultiFileLogger online at 20171011 19:38:03 in /builds/slave/test 19:38:03 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 19:38:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:38:03 INFO - {'append_to_log': False, 19:38:03 INFO - 'base_work_dir': '/builds/slave/test', 19:38:03 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 19:38:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:38:03 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 19:38:03 INFO - 'buildbot_json_path': 'buildprops.json', 19:38:03 INFO - 'code_coverage': False, 19:38:03 INFO - 'config_files': ('talos/linux_config.py',), 19:38:03 INFO - 'default_actions': ('clobber', 19:38:03 INFO - 'read-buildbot-config', 19:38:03 INFO - 'download-and-extract', 19:38:03 INFO - 'populate-webroot', 19:38:03 INFO - 'create-virtualenv', 19:38:03 INFO - 'install', 19:38:03 INFO - 'setup-mitmproxy', 19:38:03 INFO - 'run-tests'), 19:38:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:38:03 INFO - 'disable_ccov_upload': False, 19:38:03 INFO - 'disable_stylo': False, 19:38:03 INFO - 'download_minidump_stackwalk': True, 19:38:03 INFO - 'download_symbols': 'ondemand', 19:38:03 INFO - 'enable_stylo': False, 19:38:03 INFO - 'enable_webrender': False, 19:38:03 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 19:38:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:38:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:38:03 INFO - 'gecko_profile': False, 19:38:03 INFO - 'gecko_profile_interval': 0, 19:38:03 INFO - 'installer_path': 'installer.exe', 19:38:03 INFO - 'log_level': 'info', 19:38:03 INFO - 'log_name': 'talos', 19:38:03 INFO - 'log_to_console': True, 19:38:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:38:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:38:03 INFO - 'opt_config_files': (), 19:38:03 INFO - 'pip_index': False, 19:38:03 INFO - 'suite': 'dromaeojs-e10s', 19:38:03 INFO - 'system_bits': '32', 19:38:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:38:03 INFO - 'title': 'talos-linux64-ix-023', 19:38:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:38:03 INFO - 'use_talos_json': True, 19:38:03 INFO - 'verify': 'False', 19:38:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:38:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:38:03 INFO - 'work_dir': 'build'} 19:38:03 INFO - [mozharness: 2017-10-12 02:38:03.820063Z] Running clobber step. 19:38:03 INFO - Running pre-action listener: _resource_record_pre_action 19:38:03 INFO - Running main action method: clobber 19:38:03 INFO - rmtree: /builds/slave/test/build 19:38:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:38:04 INFO - Running post-action listener: _resource_record_post_action 19:38:04 INFO - [mozharness: 2017-10-12 02:38:04.885066Z] Finished clobber step (success) 19:38:04 INFO - [mozharness: 2017-10-12 02:38:04.885528Z] Running read-buildbot-config step. 19:38:04 INFO - Running pre-action listener: _resource_record_pre_action 19:38:04 INFO - Running main action method: read_buildbot_config 19:38:04 INFO - Using buildbot properties: 19:38:04 INFO - { 19:38:04 INFO - "project": "", 19:38:04 INFO - "product": "firefox", 19:38:04 INFO - "who": "ryanvm@gmail.com", 19:38:04 INFO - "installer_path": "public/build/target.tar.bz2", 19:38:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 19:38:04 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 19:38:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 19:38:04 INFO - "stage_platform": "linux64", 19:38:04 INFO - "basedir": "/builds/slave/test", 19:38:04 INFO - "buildnumber": 164, 19:38:04 INFO - "platform": "ubuntu64_hw", 19:38:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:38:04 INFO - "slavebuilddir": "test", 19:38:04 INFO - "taskId": "dRaQRgMkRsCfJ5ZxDhb19g", 19:38:04 INFO - "branch": "mozilla-beta", 19:38:04 INFO - "script_repo_revision": "production", 19:38:04 INFO - "revision": "98a72bed57b730ae8d79d151666deafa4e3caa53", 19:38:04 INFO - "slavename": "talos-linux64-ix-023", 19:38:04 INFO - "repo_path": "releases/mozilla-beta" 19:38:04 INFO - } 19:38:04 INFO - Finding installer, test and symbols from parent task. 19:38:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dRaQRgMkRsCfJ5ZxDhb19g'}, attempt #1 19:38:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dRaQRgMkRsCfJ5ZxDhb19g'}, attempt #1 19:38:05 INFO - Task dependencies: OpVO2stQRAyM3PPX6g7-Ew 19:38:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew'}, attempt #1 19:38:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.tar.bz2 19:38:06 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.test_packages.json 19:38:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.crashreporter-symbols.zip 19:38:06 INFO - Running post-action listener: _resource_record_post_action 19:38:06 INFO - [mozharness: 2017-10-12 02:38:06.284756Z] Finished read-buildbot-config step (success) 19:38:06 INFO - [mozharness: 2017-10-12 02:38:06.284974Z] Running download-and-extract step. 19:38:06 INFO - Running pre-action listener: _resource_record_pre_action 19:38:06 INFO - Running main action method: download_and_extract 19:38:06 INFO - mkdir: /builds/slave/test/build/tests 19:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:38:06 INFO - trying https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.test_packages.json 19:38:06 INFO - Downloading https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:38:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:38:07 INFO - Downloaded 989 bytes. 19:38:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:38:07 INFO - Using the following test package requirements: 19:38:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:38:07 INFO - u'common': [u'target.common.tests.zip'], 19:38:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:38:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:38:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:38:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:38:07 INFO - u'mozbase': [u'target.common.tests.zip'], 19:38:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:38:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:38:07 INFO - u'web-platform': [u'target.common.tests.zip', 19:38:07 INFO - u'target.web-platform.tests.tar.gz'], 19:38:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:38:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 19:38:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.common.tests.zip 19:38:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:38:07 INFO - Fetch https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.common.tests.zip into memory 19:38:10 INFO - Content-Length response header: 55182782 19:38:10 INFO - Bytes received: 55182782 19:38:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.talos.tests.zip 19:38:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:38:20 INFO - Fetch https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.talos.tests.zip into memory 19:38:22 INFO - Content-Length response header: 14509251 19:38:22 INFO - Bytes received: 14509251 19:38:23 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')]} 19:38:23 INFO - trying https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.tar.bz2 19:38:23 INFO - Downloading https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:38:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:38:26 INFO - Downloaded 53692550 bytes. 19:38:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.tar.bz2 19:38:26 INFO - mkdir: /builds/slave/test/properties 19:38:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:38:26 INFO - Writing to file /builds/slave/test/properties/build_url 19:38:26 INFO - Contents: 19:38:26 INFO - build_url:https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.tar.bz2 19:38:26 INFO - Running post-action listener: _resource_record_post_action 19:38:26 INFO - Running post-action listener: find_tests_for_verification 19:38:26 INFO - Running post-action listener: set_extra_try_arguments 19:38:26 INFO - [mozharness: 2017-10-12 02:38:26.309266Z] Finished download-and-extract step (success) 19:38:26 INFO - [mozharness: 2017-10-12 02:38:26.309496Z] Running populate-webroot step. 19:38:26 INFO - Running pre-action listener: _resource_record_pre_action 19:38:26 INFO - Running main action method: populate_webroot 19:38:26 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:38:26 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:38:26 INFO - 'tests': ['tresize', 19:38:26 INFO - 'tcanvasmark']}, 19:38:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:38:26 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:38:26 INFO - 'tests': ['dromaeo_css', 19:38:26 INFO - 'kraken']}, 19:38:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:38:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:38:26 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 19:38:26 INFO - 'talos_options': ['--disable-stylo'], 19:38:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:38:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:38:26 INFO - 'tests': ['damp', 'tps']}, 19:38:26 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 19:38:26 INFO - 'talos_options': ['--disable-stylo'], 19:38:26 INFO - 'tests': ['damp', 'tps']}, 19:38:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:38:26 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:38:26 INFO - 'tests': ['dromaeo_dom']}, 19:38:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:38:26 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:38:26 INFO - 'tests': ['basic_compositor_video', 19:38:26 INFO - 'glvideo']}, 19:38:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:38:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:38:26 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 19:38:26 INFO - 'talos_options': ['--disable-stylo'], 19:38:26 INFO - 'tests': ['ts_paint_webext', 19:38:26 INFO - 'tp5o_webext']}, 19:38:26 INFO - 'other-e10s': {'tests': ['a11yr', 19:38:26 INFO - 'ts_paint', 19:38:26 INFO - 'tpaint', 19:38:26 INFO - 'sessionrestore', 19:38:26 INFO - 'sessionrestore_many_windows', 19:38:26 INFO - 'sessionrestore_no_auto_restore', 19:38:26 INFO - 'tabpaint']}, 19:38:26 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:38:26 INFO - 'tests': ['a11yr', 19:38:26 INFO - 'ts_paint', 19:38:26 INFO - 'tpaint', 19:38:26 INFO - 'sessionrestore', 19:38:26 INFO - 'sessionrestore_many_windows', 19:38:26 INFO - 'sessionrestore_no_auto_restore', 19:38:26 INFO - 'tabpaint']}, 19:38:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:38:26 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 19:38:26 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:38:26 INFO - 'tests': ['perf_reftest_singletons']}, 19:38:26 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:38:26 INFO - 'tests': ['bloom_basic']}, 19:38:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:38:26 INFO - 'tsvgr_opacity', 19:38:26 INFO - 'tart', 19:38:26 INFO - 'tscrollx', 19:38:26 INFO - 'tsvg_static']}, 19:38:26 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:38:26 INFO - 'tests': ['tsvgx', 19:38:26 INFO - 'tsvgr_opacity', 19:38:26 INFO - 'tart', 19:38:26 INFO - 'tscrollx', 19:38:26 INFO - 'tsvg_static']}, 19:38:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:38:26 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 19:38:26 INFO - 'talos_options': ['--disable-stylo'], 19:38:26 INFO - 'tests': ['tp5o']}, 19:38:26 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:38:26 INFO - 'talos_options': ['--mitmproxy', 19:38:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:38:26 INFO - '--firstNonBlankPaint'], 19:38:26 INFO - 'tests': ['tp6_google', 19:38:26 INFO - 'tp6_youtube', 19:38:26 INFO - 'tp6_amazon', 19:38:26 INFO - 'tp6_facebook']}, 19:38:26 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:38:26 INFO - 'talos_options': ['--disable-stylo', 19:38:26 INFO - '--mitmproxy', 19:38:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:38:26 INFO - '--firstNonBlankPaint'], 19:38:26 INFO - 'tests': ['tp6_google', 19:38:26 INFO - 'tp6_youtube', 19:38:26 INFO - 'tp6_amazon', 19:38:26 INFO - 'tp6_facebook']}, 19:38:26 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:38:26 INFO - 'talos_options': ['--stylo-threads=1', 19:38:26 INFO - '--mitmproxy', 19:38:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:38:26 INFO - '--firstNonBlankPaint'], 19:38:26 INFO - 'tests': ['tp6_google', 19:38:26 INFO - 'tp6_youtube', 19:38:26 INFO - 'tp6_amazon', 19:38:26 INFO - 'tp6_facebook']}, 19:38:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:38:26 INFO - 'talos_options': ['--xperf_path', 19:38:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:38:26 INFO - 'tests': ['tp5n']}, 19:38:26 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 19:38:26 INFO - 'talos_options': ['--disable-stylo', 19:38:26 INFO - '--xperf_path', 19:38:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:38:26 INFO - 'tests': ['tp5n']}}} 19:38:26 INFO - Running post-action listener: _resource_record_post_action 19:38:26 INFO - [mozharness: 2017-10-12 02:38:26.326762Z] Finished populate-webroot step (success) 19:38:26 INFO - [mozharness: 2017-10-12 02:38:26.326852Z] Running create-virtualenv step. 19:38:26 INFO - Running pre-action listener: _resource_record_pre_action 19:38:26 INFO - Running main action method: create_virtualenv 19:38:26 INFO - Creating virtualenv /builds/slave/test/build/venv 19:38:26 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:38:26 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 19:38:26 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:38:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:38:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:38:26 INFO - Installing distribute.............................................................................................................................................................................................done. 19:38:27 INFO - Installing pip...............done. 19:38:27 INFO - Return code: 0 19:38:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:38:27 INFO - Reading from file tmpfile_stdout 19:38:27 INFO - Output received: 19:38:27 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 19:38:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:38: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')]} 19:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38: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')]} 19:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c090>, '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 0x219cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2196f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', '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 19:38: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', 'pip>=1.5'] in /builds/slave/test/build 19:38: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 pip>=1.5 19:38:27 INFO - Using env: {'DISPLAY': ':0', 19:38:27 INFO - 'HOME': '/home/cltbld', 19:38:27 INFO - 'LANG': 'en_US.UTF-8', 19:38:27 INFO - 'LANGUAGE': 'en_US:en', 19:38:27 INFO - 'LOGNAME': 'cltbld', 19:38:27 INFO - 'MAIL': '/var/mail/cltbld', 19:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:27 INFO - 'MOZ_NO_REMOTE': '1', 19:38:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:27 INFO - 'NO_EM_RESTART': '1', 19:38:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:27 INFO - 'PWD': '/builds/slave/test', 19:38:27 INFO - 'SHELL': '/bin/bash', 19:38:27 INFO - 'SHLVL': '1', 19:38:27 INFO - 'TERM': 'linux', 19:38:27 INFO - 'TMOUT': '86400', 19:38:27 INFO - 'USER': 'cltbld', 19:38:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', 19:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:27 INFO - '_': '/tools/buildbot/bin/python'} 19:38:28 INFO - Ignoring indexes: http://pypi.python.org/simple/ 19:38:28 INFO - Downloading/unpacking pip>=1.5 19:38:28 INFO - Running setup.py egg_info for package pip 19:38:28 INFO - warning: no files found matching 'pip/cacert.pem' 19:38:28 INFO - warning: no files found matching '*.html' under directory 'docs' 19:38:28 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 19:38:28 INFO - no previously-included directories found matching 'docs/_build/_sources' 19:38:28 INFO - Installing collected packages: pip 19:38:28 INFO - Found existing installation: pip 1.1 19:38:28 INFO - Uninstalling pip: 19:38:28 INFO - Successfully uninstalled pip 19:38:28 INFO - Running setup.py install for pip 19:38:28 INFO - warning: no files found matching 'pip/cacert.pem' 19:38:28 INFO - warning: no files found matching '*.html' under directory 'docs' 19:38:28 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 19:38:28 INFO - no previously-included directories found matching 'docs/_build/_sources' 19:38:28 INFO - Installing pip script to /builds/slave/test/build/venv/bin 19:38:28 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 19:38:28 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 19:38:28 INFO - Successfully installed pip 19:38:28 INFO - Cleaning up... 19:38:28 INFO - Return code: 0 19:38:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:28 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 0x1e2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c090>, '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 0x219cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2196f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', '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 19:38:28 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 19:38:28 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 19:38:28 INFO - Using env: {'DISPLAY': ':0', 19:38:28 INFO - 'HOME': '/home/cltbld', 19:38:28 INFO - 'LANG': 'en_US.UTF-8', 19:38:28 INFO - 'LANGUAGE': 'en_US:en', 19:38:28 INFO - 'LOGNAME': 'cltbld', 19:38:28 INFO - 'MAIL': '/var/mail/cltbld', 19:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:28 INFO - 'MOZ_NO_REMOTE': '1', 19:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:28 INFO - 'NO_EM_RESTART': '1', 19:38:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:28 INFO - 'PWD': '/builds/slave/test', 19:38:28 INFO - 'SHELL': '/bin/bash', 19:38:28 INFO - 'SHLVL': '1', 19:38:28 INFO - 'TERM': 'linux', 19:38:28 INFO - 'TMOUT': '86400', 19:38:28 INFO - 'USER': 'cltbld', 19:38:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', 19:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:28 INFO - '_': '/tools/buildbot/bin/python'} 19:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:29 INFO - Downloading/unpacking psutil>=3.1.1 19:38:29 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 19:38:29 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 19:38:29 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 19:38:29 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 19:38:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:38:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:38:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:38:30 INFO - Installing collected packages: psutil 19:38:30 INFO - Running setup.py install for psutil 19:38:30 INFO - building 'psutil._psutil_linux' extension 19:38:30 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 19:38:30 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 19:38:30 INFO - building 'psutil._psutil_posix' extension 19:38:30 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 19:38:30 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 19:38:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:38:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:38:30 INFO - Successfully installed psutil 19:38:30 INFO - Cleaning up... 19:38:30 INFO - Return code: 0 19:38:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:38:30 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')]} 19:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:30 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')]} 19:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:30 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 0x1e2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c090>, '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 0x219cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2196f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', '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 19:38:30 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 19:38:30 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 19:38:30 INFO - Using env: {'DISPLAY': ':0', 19:38:30 INFO - 'HOME': '/home/cltbld', 19:38:30 INFO - 'LANG': 'en_US.UTF-8', 19:38:30 INFO - 'LANGUAGE': 'en_US:en', 19:38:30 INFO - 'LOGNAME': 'cltbld', 19:38:30 INFO - 'MAIL': '/var/mail/cltbld', 19:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:30 INFO - 'MOZ_NO_REMOTE': '1', 19:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:30 INFO - 'NO_EM_RESTART': '1', 19:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:30 INFO - 'PWD': '/builds/slave/test', 19:38:30 INFO - 'SHELL': '/bin/bash', 19:38:30 INFO - 'SHLVL': '1', 19:38:30 INFO - 'TERM': 'linux', 19:38:30 INFO - 'TMOUT': '86400', 19:38:30 INFO - 'USER': 'cltbld', 19:38:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', 19:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:30 INFO - '_': '/tools/buildbot/bin/python'} 19:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:38:31 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 19:38:31 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 19:38:31 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 19:38:31 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 19:38:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:38:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:38:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:38:32 INFO - Installing collected packages: mozsystemmonitor 19:38:32 INFO - Running setup.py install for mozsystemmonitor 19:38:32 INFO - Successfully installed mozsystemmonitor 19:38:32 INFO - Cleaning up... 19:38:32 INFO - Return code: 0 19:38:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:38:32 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')]} 19:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:32 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')]} 19:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:32 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 0x1e2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c090>, '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 0x219cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2196f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', '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 19:38:32 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 19:38:32 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 19:38:32 INFO - Using env: {'DISPLAY': ':0', 19:38:32 INFO - 'HOME': '/home/cltbld', 19:38:32 INFO - 'LANG': 'en_US.UTF-8', 19:38:32 INFO - 'LANGUAGE': 'en_US:en', 19:38:32 INFO - 'LOGNAME': 'cltbld', 19:38:32 INFO - 'MAIL': '/var/mail/cltbld', 19:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:32 INFO - 'MOZ_NO_REMOTE': '1', 19:38:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:32 INFO - 'NO_EM_RESTART': '1', 19:38:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:32 INFO - 'PWD': '/builds/slave/test', 19:38:32 INFO - 'SHELL': '/bin/bash', 19:38:32 INFO - 'SHLVL': '1', 19:38:32 INFO - 'TERM': 'linux', 19:38:32 INFO - 'TMOUT': '86400', 19:38:32 INFO - 'USER': 'cltbld', 19:38:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', 19:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:32 INFO - '_': '/tools/buildbot/bin/python'} 19:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:32 INFO - Downloading/unpacking jsonschema==2.5.1 19:38:32 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 19:38:32 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 19:38:32 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 19:38:32 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 19:38:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:38:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:38:33 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 19:38:33 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 19:38:33 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 19:38:33 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 19:38:33 INFO - Downloading functools32-3.2.3-2.tar.gz 19:38:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:38:33 INFO - warning: no files found matching '*.txt' 19:38:33 INFO - no previously-included directories found matching 'build' 19:38:33 INFO - no previously-included directories found matching 'dist' 19:38:33 INFO - no previously-included directories found matching '.git*' 19:38:33 INFO - Installing collected packages: jsonschema, functools32 19:38:33 INFO - Running setup.py install for functools32 19:38:34 INFO - warning: no files found matching '*.txt' 19:38:34 INFO - no previously-included directories found matching 'build' 19:38:34 INFO - no previously-included directories found matching 'dist' 19:38:34 INFO - no previously-included directories found matching '.git*' 19:38:34 INFO - Successfully installed jsonschema functools32 19:38:34 INFO - Cleaning up... 19:38:34 INFO - Return code: 0 19:38:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:34 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 0x1e2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c090>, '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 0x219cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2196f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', '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 19:38:34 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 19:38:34 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 19:38:34 INFO - Using env: {'DISPLAY': ':0', 19:38:34 INFO - 'HOME': '/home/cltbld', 19:38:34 INFO - 'LANG': 'en_US.UTF-8', 19:38:34 INFO - 'LANGUAGE': 'en_US:en', 19:38:34 INFO - 'LOGNAME': 'cltbld', 19:38:34 INFO - 'MAIL': '/var/mail/cltbld', 19:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:34 INFO - 'MOZ_NO_REMOTE': '1', 19:38:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:34 INFO - 'NO_EM_RESTART': '1', 19:38:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:34 INFO - 'PWD': '/builds/slave/test', 19:38:34 INFO - 'SHELL': '/bin/bash', 19:38:34 INFO - 'SHLVL': '1', 19:38:34 INFO - 'TERM': 'linux', 19:38:34 INFO - 'TMOUT': '86400', 19:38:34 INFO - 'USER': 'cltbld', 19:38:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', 19:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:34 INFO - '_': '/tools/buildbot/bin/python'} 19:38:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:38:34 INFO - Cleaning up... 19:38:34 INFO - Return code: 0 19:38:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:34 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 0x1e2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c090>, '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 0x219cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2196f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', '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 19:38:34 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 19:38:34 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 19:38:34 INFO - Using env: {'DISPLAY': ':0', 19:38:34 INFO - 'HOME': '/home/cltbld', 19:38:34 INFO - 'LANG': 'en_US.UTF-8', 19:38:34 INFO - 'LANGUAGE': 'en_US:en', 19:38:34 INFO - 'LOGNAME': 'cltbld', 19:38:34 INFO - 'MAIL': '/var/mail/cltbld', 19:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:34 INFO - 'MOZ_NO_REMOTE': '1', 19:38:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:34 INFO - 'NO_EM_RESTART': '1', 19:38:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:34 INFO - 'PWD': '/builds/slave/test', 19:38:34 INFO - 'SHELL': '/bin/bash', 19:38:34 INFO - 'SHLVL': '1', 19:38:34 INFO - 'TERM': 'linux', 19:38:34 INFO - 'TMOUT': '86400', 19:38:34 INFO - 'USER': 'cltbld', 19:38:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', 19:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:34 INFO - '_': '/tools/buildbot/bin/python'} 19:38:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:34 INFO - Downloading/unpacking blobuploader==1.2.4 19:38:34 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 19:38:34 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 19:38:34 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 19:38:34 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 19:38:35 INFO - Downloading blobuploader-1.2.4.tar.gz 19:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:38:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:38:35 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 19:38:35 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 19:38:35 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 19:38:35 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 19:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:38:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:38:36 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 19:38:36 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 19:38:36 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 19:38:36 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 19:38:36 INFO - Downloading docopt-0.6.1.tar.gz 19:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:38:36 INFO - Installing collected packages: blobuploader, requests, docopt 19:38:36 INFO - Running setup.py install for blobuploader 19:38:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:38:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:38:36 INFO - Running setup.py install for requests 19:38:36 INFO - Running setup.py install for docopt 19:38:36 INFO - Successfully installed blobuploader requests docopt 19:38:36 INFO - Cleaning up... 19:38:36 INFO - Return code: 0 19:38:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:38:36 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')]} 19:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:36 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')]} 19:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:36 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 0x1e2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c090>, '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 0x219cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2196f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', '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 19:38:36 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 19:38:36 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 19:38:36 INFO - Using env: {'DISPLAY': ':0', 19:38:36 INFO - 'HOME': '/home/cltbld', 19:38:36 INFO - 'LANG': 'en_US.UTF-8', 19:38:36 INFO - 'LANGUAGE': 'en_US:en', 19:38:36 INFO - 'LOGNAME': 'cltbld', 19:38:36 INFO - 'MAIL': '/var/mail/cltbld', 19:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:36 INFO - 'MOZ_NO_REMOTE': '1', 19:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:36 INFO - 'NO_EM_RESTART': '1', 19:38:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:36 INFO - 'PWD': '/builds/slave/test', 19:38:36 INFO - 'SHELL': '/bin/bash', 19:38:36 INFO - 'SHLVL': '1', 19:38:36 INFO - 'TERM': 'linux', 19:38:36 INFO - 'TMOUT': '86400', 19:38:36 INFO - 'USER': 'cltbld', 19:38:36 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', 19:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:36 INFO - '_': '/tools/buildbot/bin/python'} 19:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:38:37 INFO - Running setup.py (path:/tmp/pip-83WYkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:38:37 INFO - Running setup.py (path:/tmp/pip-4YF4Io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:38:37 INFO - Running setup.py (path:/tmp/pip-t0r0yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:38:37 INFO - Running setup.py (path:/tmp/pip-aR_ZFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:38:37 INFO - Running setup.py (path:/tmp/pip-gTLNlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:38:37 INFO - Running setup.py (path:/tmp/pip-cqr8sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:38:37 INFO - Running setup.py (path:/tmp/pip-YdcZzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:38:37 INFO - Running setup.py (path:/tmp/pip-2dTolG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:38:37 INFO - Running setup.py (path:/tmp/pip-6xBTnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:38:37 INFO - Running setup.py (path:/tmp/pip-gqDVCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:38:37 INFO - Running setup.py (path:/tmp/pip-EYQk9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:38:37 INFO - Running setup.py (path:/tmp/pip-BA3Qxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:38:37 INFO - Running setup.py (path:/tmp/pip-ZZgH6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:38:37 INFO - Running setup.py (path:/tmp/pip-X0mdpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:38:38 INFO - Running setup.py (path:/tmp/pip-q38vA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:38:38 INFO - Running setup.py (path:/tmp/pip-oXKaab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:38:38 INFO - Running setup.py (path:/tmp/pip-Kky3C2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:38:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:38:38 INFO - Running setup.py install for manifestparser 19:38:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:38:38 INFO - Running setup.py install for mozcrash 19:38:38 INFO - Running setup.py install for mozdebug 19:38:38 INFO - Running setup.py install for mozdevice 19:38:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:38:38 INFO - Running setup.py install for mozfile 19:38:38 INFO - Running setup.py install for mozhttpd 19:38:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:38:38 INFO - Running setup.py install for mozinfo 19:38:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:38:38 INFO - Running setup.py install for mozInstall 19:38:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:38:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:38:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:38:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:38:39 INFO - Running setup.py install for mozleak 19:38:39 INFO - Running setup.py install for mozlog 19:38:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:38:39 INFO - Running setup.py install for moznetwork 19:38:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:38:39 INFO - Running setup.py install for mozprocess 19:38:39 INFO - Running setup.py install for mozprofile 19:38:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:38:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:38:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:38:39 INFO - Running setup.py install for mozrunner 19:38:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:38:39 INFO - Running setup.py install for mozscreenshot 19:38:39 INFO - Running setup.py install for moztest 19:38:39 INFO - Running setup.py install for mozversion 19:38:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:38:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:38:39 INFO - Cleaning up... 19:38:39 INFO - Return code: 0 19:38:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:38:39 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')]} 19:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:39 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')]} 19:38:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:40 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 0x1e2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c090>, '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 0x219cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2196f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', '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 19:38:40 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 19:38:40 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 19:38:40 INFO - Using env: {'DISPLAY': ':0', 19:38:40 INFO - 'HOME': '/home/cltbld', 19:38:40 INFO - 'LANG': 'en_US.UTF-8', 19:38:40 INFO - 'LANGUAGE': 'en_US:en', 19:38:40 INFO - 'LOGNAME': 'cltbld', 19:38:40 INFO - 'MAIL': '/var/mail/cltbld', 19:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:40 INFO - 'MOZ_NO_REMOTE': '1', 19:38:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:40 INFO - 'NO_EM_RESTART': '1', 19:38:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:40 INFO - 'PWD': '/builds/slave/test', 19:38:40 INFO - 'SHELL': '/bin/bash', 19:38:40 INFO - 'SHLVL': '1', 19:38:40 INFO - 'TERM': 'linux', 19:38:40 INFO - 'TMOUT': '86400', 19:38:40 INFO - 'USER': 'cltbld', 19:38:40 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', 19:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:40 INFO - '_': '/tools/buildbot/bin/python'} 19:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:38:40 INFO - Running setup.py (path:/tmp/pip-qJ_DzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:38:40 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)) 19:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:38:40 INFO - Running setup.py (path:/tmp/pip-gEB0uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:38:40 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)) 19:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:38:40 INFO - Running setup.py (path:/tmp/pip-ZoEtuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:38:40 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)) 19:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:38:40 INFO - Running setup.py (path:/tmp/pip-cs3b1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:38:40 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)) 19:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:38:40 INFO - Running setup.py (path:/tmp/pip-VsqiMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:38:40 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)) 19:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:38:40 INFO - Running setup.py (path:/tmp/pip-22inX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:38:40 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)) 19:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:38:40 INFO - Running setup.py (path:/tmp/pip-BIzquZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:38:40 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)) 19:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:38:40 INFO - Running setup.py (path:/tmp/pip-iBmNRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:38:40 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)) 19:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:38:40 INFO - Running setup.py (path:/tmp/pip-R4cwFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:38:40 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)) 19:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:38:40 INFO - Running setup.py (path:/tmp/pip-ur079o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:38:40 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)) 19:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:38:40 INFO - Running setup.py (path:/tmp/pip-B95mK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:38:41 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)) 19:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:38:41 INFO - Running setup.py (path:/tmp/pip-L5njDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:38:41 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)) 19:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:38:41 INFO - Running setup.py (path:/tmp/pip-Y1wiuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:38:41 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)) 19:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:38:41 INFO - Running setup.py (path:/tmp/pip-sfB0gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:38:41 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)) 19:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:38:41 INFO - Running setup.py (path:/tmp/pip-lfWfwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:38:41 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)) 19:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:38:41 INFO - Running setup.py (path:/tmp/pip-pdyHZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:38:41 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)) 19:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:38:41 INFO - Running setup.py (path:/tmp/pip-t9l0HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:38:41 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)) 19:38:41 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)) 19:38:41 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)) 19:38:41 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)) 19:38:41 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)) 19:38:41 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)) 19:38:41 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)) 19:38:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:38:41 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 19:38:41 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 19:38:41 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 19:38:41 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 19:38:42 INFO - Downloading blessings-1.6.tar.gz 19:38:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:38:42 INFO - Installing collected packages: blessings 19:38:42 INFO - Running setup.py install for blessings 19:38:42 INFO - Successfully installed blessings 19:38:42 INFO - Cleaning up... 19:38:42 INFO - Return code: 0 19:38:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:38:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:38:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:38:43 INFO - Reading from file tmpfile_stdout 19:38:43 INFO - Current package versions: 19:38:43 INFO - argparse == 1.2.1 19:38:43 INFO - blessings == 1.6 19:38:43 INFO - blobuploader == 1.2.4 19:38:43 INFO - docopt == 0.6.1 19:38:43 INFO - functools32 == 3.2.3-2 19:38:43 INFO - jsonschema == 2.5.1 19:38:43 INFO - manifestparser == 1.1 19:38:43 INFO - mozInstall == 1.13 19:38:43 INFO - mozcrash == 1.0 19:38:43 INFO - mozdebug == 0.1 19:38:43 INFO - mozdevice == 0.51 19:38:43 INFO - mozfile == 1.2 19:38:43 INFO - mozhttpd == 0.7 19:38:43 INFO - mozinfo == 0.10 19:38:43 INFO - mozleak == 0.1 19:38:43 INFO - mozlog == 3.5 19:38:43 INFO - moznetwork == 0.27 19:38:43 INFO - mozprocess == 0.25 19:38:43 INFO - mozprofile == 0.28 19:38:43 INFO - mozrunner == 6.13 19:38:43 INFO - mozscreenshot == 0.1 19:38:43 INFO - mozsystemmonitor == 0.3 19:38:43 INFO - moztest == 0.8 19:38:43 INFO - mozversion == 1.4 19:38:43 INFO - psutil == 3.1.1 19:38:43 INFO - requests == 1.2.3 19:38:43 INFO - wsgiref == 0.1.2 19:38:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:38: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')]} 19:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38: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')]} 19:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:43 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 0x1e2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c090>, '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 0x219cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2196f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', '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 19:38:43 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 19:38:43 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 19:38:43 INFO - Using env: {'DISPLAY': ':0', 19:38:43 INFO - 'HOME': '/home/cltbld', 19:38:43 INFO - 'LANG': 'en_US.UTF-8', 19:38:43 INFO - 'LANGUAGE': 'en_US:en', 19:38:43 INFO - 'LOGNAME': 'cltbld', 19:38:43 INFO - 'MAIL': '/var/mail/cltbld', 19:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:43 INFO - 'MOZ_NO_REMOTE': '1', 19:38:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:43 INFO - 'NO_EM_RESTART': '1', 19:38:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:43 INFO - 'PWD': '/builds/slave/test', 19:38:43 INFO - 'SHELL': '/bin/bash', 19:38:43 INFO - 'SHLVL': '1', 19:38:43 INFO - 'TERM': 'linux', 19:38:43 INFO - 'TMOUT': '86400', 19:38:43 INFO - 'USER': 'cltbld', 19:38:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', 19:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:43 INFO - '_': '/tools/buildbot/bin/python'} 19:38:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:43 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)) 19:38:43 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)) 19:38:43 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)) 19:38:43 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)) 19:38:43 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)) 19:38:43 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)) 19:38:43 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)) 19:38:43 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)) 19:38:43 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)) 19:38:43 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:38:43 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 19:38:43 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 19:38:43 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 19:38:43 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 19:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:38:44 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)) 19:38:44 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)) 19:38:44 INFO - Installing collected packages: simplejson 19:38:44 INFO - Running setup.py install for simplejson 19:38:44 INFO - building 'simplejson._speedups' extension 19:38:44 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 19:38:45 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 19:38:45 INFO - Successfully installed simplejson 19:38:45 INFO - Cleaning up... 19:38:45 INFO - Return code: 0 19:38:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2198a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219c090>, '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 0x219cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2196f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', '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 19:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:38:45 INFO - Using env: {'DISPLAY': ':0', 19:38:45 INFO - 'HOME': '/home/cltbld', 19:38:45 INFO - 'LANG': 'en_US.UTF-8', 19:38:45 INFO - 'LANGUAGE': 'en_US:en', 19:38:45 INFO - 'LOGNAME': 'cltbld', 19:38:45 INFO - 'MAIL': '/var/mail/cltbld', 19:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:45 INFO - 'MOZ_NO_REMOTE': '1', 19:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:45 INFO - 'NO_EM_RESTART': '1', 19:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:45 INFO - 'PWD': '/builds/slave/test', 19:38:45 INFO - 'SHELL': '/bin/bash', 19:38:45 INFO - 'SHLVL': '1', 19:38:45 INFO - 'TERM': 'linux', 19:38:45 INFO - 'TMOUT': '86400', 19:38:45 INFO - 'USER': 'cltbld', 19:38:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', 19:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:45 INFO - '_': '/tools/buildbot/bin/python'} 19:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:38:45 INFO - Cleaning up... 19:38:45 INFO - Return code: 0 19:38:45 INFO - Running post-action listener: _resource_record_post_action 19:38:45 INFO - Running post-action listener: _start_resource_monitoring 19:38:45 INFO - Starting resource monitoring. 19:38:45 INFO - [mozharness: 2017-10-12 02:38:45.712997Z] Finished create-virtualenv step (success) 19:38:45 INFO - [mozharness: 2017-10-12 02:38:45.713585Z] Running install step. 19:38:45 INFO - Running pre-action listener: _resource_record_pre_action 19:38:45 INFO - Running main action method: install 19:38:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:38:45 INFO - Reading from file tmpfile_stdout 19:38:45 INFO - Detecting whether we're running mozinstall >=1.0... 19:38:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:38:46 INFO - Reading from file tmpfile_stdout 19:38:46 INFO - Output received: 19:38:46 INFO - Usage: mozinstall [options] installer 19:38:46 INFO - Options: 19:38:46 INFO - -h, --help show this help message and exit 19:38:46 INFO - -d DEST, --destination=DEST 19:38:46 INFO - Directory to install application into. [default: 19:38:46 INFO - "/builds/slave/test"] 19:38:46 INFO - --app=APP Application being installed. [default: firefox] 19:38:46 INFO - mkdir: /builds/slave/test/build/application 19:38:46 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'] 19:38:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:39:00 INFO - Reading from file tmpfile_stdout 19:39:00 INFO - Output received: 19:39:00 INFO - /builds/slave/test/build/application/firefox/firefox 19:39:00 INFO - Running post-action listener: _resource_record_post_action 19:39:00 INFO - [mozharness: 2017-10-12 02:39:00.664387Z] Finished install step (success) 19:39:00 INFO - [mozharness: 2017-10-12 02:39:00.664638Z] Running setup-mitmproxy step. 19:39:00 INFO - Running pre-action listener: _resource_record_pre_action 19:39:00 INFO - Running main action method: setup_mitmproxy 19:39:00 INFO - Skipping: mitmproxy is not required 19:39:00 INFO - Running post-action listener: _resource_record_post_action 19:39:00 INFO - [mozharness: 2017-10-12 02:39:00.665902Z] Finished setup-mitmproxy step (success) 19:39:00 INFO - [mozharness: 2017-10-12 02:39:00.666124Z] Running run-tests step. 19:39:00 INFO - Running pre-action listener: _resource_record_pre_action 19:39:00 INFO - Running pre-action listener: _set_gcov_prefix 19:39:00 INFO - Running main action method: run_tests 19:39:00 WARNING - Try message not found. 19:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:39:00 INFO - Python 2.7.3 19:39:00 INFO - Return code: 0 19:39:00 INFO - grabbing minidump binary from tooltool 19:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:39:00 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 0x219c090>, '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 0x219cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2196f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:39:00 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 19:39:00 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 19:39:00 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 19:39:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:39:00 INFO - Return code: 0 19:39:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:39:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:39:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:39:00 INFO - ENV: RUST_BACKTRACE is now full 19:39:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:39:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:39:00 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/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 19:39:00 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/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 19:39:00 INFO - Using env: {'DISPLAY': ':0', 19:39:00 INFO - 'HOME': '/home/cltbld', 19:39:00 INFO - 'LANG': 'en_US.UTF-8', 19:39:00 INFO - 'LANGUAGE': 'en_US:en', 19:39:00 INFO - 'LOGNAME': 'cltbld', 19:39:00 INFO - 'MAIL': '/var/mail/cltbld', 19:39:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:39:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:00 INFO - 'MOZ_NO_REMOTE': '1', 19:39:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:39:00 INFO - 'NO_EM_RESTART': '1', 19:39:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:00 INFO - 'PWD': '/builds/slave/test', 19:39:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:39:00 INFO - 'RUST_BACKTRACE': 'full', 19:39:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:39:00 INFO - 'SHELL': '/bin/bash', 19:39:00 INFO - 'SHLVL': '1', 19:39:00 INFO - 'TERM': 'linux', 19:39:00 INFO - 'TMOUT': '86400', 19:39:00 INFO - 'USER': 'cltbld', 19:39:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', 19:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:00 INFO - '_': '/tools/buildbot/bin/python'} 19:39:00 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/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 19:39:01 INFO - mozversion application_buildid: 20171012011729 19:39:01 INFO - mozversion application_changeset: 98a72bed57b730ae8d79d151666deafa4e3caa53 19:39:01 INFO - mozversion application_display_name: Firefox 19:39:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:39:01 INFO - mozversion application_name: Firefox 19:39:01 INFO - mozversion application_remotingname: firefox 19:39:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:39:01 INFO - mozversion application_vendor: Mozilla 19:39:01 INFO - mozversion application_version: 57.0 19:39:01 INFO - mozversion platform_buildid: 20171012011729 19:39:01 INFO - mozversion platform_changeset: 98a72bed57b730ae8d79d151666deafa4e3caa53 19:39:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:39:01 INFO - mozversion platform_version: 57.0 19:39:01 INFO - using testdate: 1507775941 19:39:01 INFO - actual date: 1507775941 19:39:01 INFO - starting webserver on 'localhost:47547' 19:39:01 INFO - SUITE-START | Running 2 tests 19:39:01 INFO - TEST-START | dromaeo_css 19:39:01 INFO - Initialising browser for dromaeo_css test... 19:39:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47547/getInfo.html -profile /tmp/tmpgYlD4j/profile 19:39:01 INFO - TEST-INFO | started process 7724 (/builds/slave/test/build/application/firefox/firefox http://localhost:47547/getInfo.html) 19:39:06 INFO - TEST-INFO | 7724: exit 0 19:39:06 INFO - Browser initialized. 19:39:06 INFO - Running cycle 1/1 for dromaeo_css test... 19:39:06 INFO - Using env: {'DISPLAY': ':0', 19:39:06 INFO - 'HOME': '/home/cltbld', 19:39:06 INFO - 'JSGC_DISABLE_POISONING': '1', 19:39:06 INFO - 'LANG': 'en_US.UTF-8', 19:39:06 INFO - 'LANGUAGE': 'en_US:en', 19:39:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 19:39:06 INFO - 'LOGNAME': 'cltbld', 19:39:06 INFO - 'MAIL': '/var/mail/cltbld', 19:39:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:39:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:39:06 INFO - 'MOZ_CRASHREPORTER': '1', 19:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 19:39:06 INFO - 'MOZ_NO_REMOTE': '1', 19:39:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:39:06 INFO - 'NO_EM_RESTART': '1', 19:39:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:06 INFO - 'PWD': '/builds/slave/test', 19:39:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:39:06 INFO - 'RUST_BACKTRACE': 'full', 19:39:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:39:06 INFO - 'SHELL': '/bin/bash', 19:39:06 INFO - 'SHLVL': '1', 19:39:06 INFO - 'TERM': 'linux', 19:39:06 INFO - 'TMOUT': '86400', 19:39:06 INFO - 'USER': 'cltbld', 19:39:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', 19:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:06 INFO - '_': '/tools/buildbot/bin/python'} 19:39:06 INFO - TEST-INFO | started process 7966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgYlD4j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:39:07 INFO - PID 7966 | 19:39:07 INFO - PID 7966 | (/builds/slave/test/build/application/firefox/firefox:8015): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:39:07 INFO - PID 7966 | 19:39:17 INFO - PID 7966 | RSS: Main: 141836288 19:39:17 INFO - PID 7966 | 19:42:15 INFO - PID 7966 | Cycle 1(1): loaded http://localhost:47547/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47547/tests/dromaeo/cssquery-ext.html) 19:42:16 INFO - PID 7966 | RSS: Main: 145776640 19:42:16 INFO - PID 7966 | 19:45:17 INFO - PID 7966 | Cycle 1(1): loaded http://localhost:47547/tests/dromaeo/cssquery-ext.html (next: http://localhost:47547/tests/dromaeo/cssquery-jquery.html) 19:45:18 INFO - PID 7966 | RSS: Main: 143908864 19:45:18 INFO - PID 7966 | 19:48:19 INFO - PID 7966 | Cycle 1(1): loaded http://localhost:47547/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47547/tests/dromaeo/cssquery-mootools.html) 19:48:20 INFO - PID 7966 | RSS: Main: 145063936 19:48:20 INFO - PID 7966 | 19:51:21 INFO - PID 7966 | Cycle 1(1): loaded http://localhost:47547/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47547/tests/dromaeo/cssquery-prototype.html) 19:51:22 INFO - PID 7966 | RSS: Main: 145215488 19:51:22 INFO - PID 7966 | 19:54:25 INFO - PID 7966 | Cycle 1(1): loaded http://localhost:47547/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47547/tests/dromaeo/cssquery-yui.html) 19:54:25 INFO - PID 7966 | RSS: Main: 146272256 19:54:25 INFO - PID 7966 | 19:57:27 INFO - PID 7966 | Cycle 1(1): loaded http://localhost:47547/tests/dromaeo/cssquery-yui.html (next: http://localhost:47547/tests/dromaeo/cssquery-dojo.html) 19:57:27 INFO - PID 7966 | RSS: Main: 149487616 19:57:27 INFO - PID 7966 | 19:57:27 INFO - PID 7966 | __start_tp_report 19:57:27 INFO - PID 7966 | _x_x_mozilla_page_load 19:57:27 INFO - PID 7966 | _x_x_mozilla_page_load_details 19:57:27 INFO - PID 7966 | |i|pagename|runs| 19:57:27 INFO - PID 7966 | |0;dojo.html;4027.7784721840303;4040.252553277644;4049.53430355509;4074.042599989002;4076.2458945095177;6534.379233972777;6535.444487218586;6562.639054851981;6633.502487313447;6653.800385988422;6600.636964966925;6631.403173714365;6634.933650663492;6636.104125942997;6694.430973367257;5912.467877890989;5974.61165024272;5999.100134979766;6018;6027.186329845481;5892.616979896293;5928.55535834812;5973.253343332083;5975;6069.666168360738;5931.199288096095;5977.7608895644125;5999.340072592033;6016.909746353808;6019.668918209497;5886.20536227608;5907.113932910055;5928.911066334009;5968.253968253968;5982.521398288127;5834.095715164156;5837.532997360244;5876.147958546029;5972.611780234271;5996.880062398727;6506.7722629708205;6509.414152726277;6532.575382600164;6543.411093001605;6594.868102637968;7150.535215211046;7189.352958233784;7267.63661816907;7276.708931642728;7282.672279747424;7130.358267755875;7226.096737907762;7235.819104522377;7283.453740969396;7343.7062517499235;6582.275949645536;6652.900206496906;6654.56745311558;6688.3646053624825;6754;7350.4119670426235;7360.926390736131;7457;7460.888086678704;7465.776026719099;7003.474739394565;7062.046623705836;7166.319199676022;7166.641667916583;7172.354488096096;7113.608751518716;7187.89218161728;7203.639818009078;7203.819904502429;7262.31008054234;7109.786706398816;7165.498415110892;7175.103112110986;7195.92804071963;7225.8554828903125;7161.67772450241;7188.317109874553;7252.927470725331;7265.600391978492;7276.890846637305;5373.838784836461;5376.301080859464;5443.101888188405;5462.7268636568015;5466.426025267289;4801.855944321676;4832.685875418087;4854.490278520775;4874.658773885794;4953.1332016896895;6750.7299708012115;6819.897701534481;6835.760748373783;6838.452923766087;6840.418564421981;7182.2458641842895;7185.568865868065;7189.964050179716;7219.963900180465;7240.312170343915;6604.075429439882;6702.229243637044;6724.9327506725285;6766.69549870257;6802.183737951378;6206.193194884727;6215.409536094064;6231.906521402183;6233.470155036782;6252.280987686383;7224.4581656375985;7405.9629701851145;7408.481406301615;7509.249075092556;7510.286522780327;7084.256153103953;7140.750073747394;7236.34872861445;7243.855122897407;7256.129264488295;7396.482246242711;7407.703691852265;7491.101067871672;7510.098788145458;7513.812154696177;7036.437085033082;7065.929340706527;7095.148582170173;7130.251323610946;7148.177959534512;7248.565086094851;7266.927330726625;7271.854562908607;7277.745278915212;7296.635168241461;6972.407345375497;7035.12060992376;7048.506604537838;7064.858702826017;7071.292870712888;6863.245043045361;6954.8956765647545;6969.407600354027;7062.258462861326;7063.364297213276;6886.173659160932;6887.035814985806;6965.024896514391;6966.407855332151;7025.648717564203;6987.371136597731;6990.9300906990275;7028.6485675714985;7107.324804143598;7123.180834203926;6790.219124800711;6798.76204332846;6811.182658081062;6877.690503927435;6896.379325860496 19:57:27 INFO - PID 7966 | |1;ext.html;969.4619486185169;978.623230056428;1014.9797004059918;1039.5789705169404;1042.4370839746537;46168.769156154216;47220.76389618056;47223.76388118059;47255;47319.76340118299;43215.567844321544;43343.566564334345;43383.132337353316;43622.34566481505;43643.78178109113;8078.798030049252;8160;8199.590020498981;8204.056533498635;8211.917880821175;7907.486013409139;7936.365090792723;7971.282584567388;8008.439409241356;8010.919890801105;8864;9000.504972226525;9036.277097832157;9039.593218305192;9046.3667543272;8865.157810008039;8987.820243595124;9003.86494202581;9004.684836030707;9038.186563209343;8872.8669069964;8967.237784788302;8972.685955991574;8978.551072446417;8992.23565996891;41740;41761.373579396335;41844.58155418437;42077.57922420767;42133.57866421327;3751.868684596026;3812.7140464465274;3821.7515861468914;3839.9248210500823;3855.74937629056;33987.660123398695;34351.656483435094;34405;34471;34481.482777758356;5632.35227948787;5766.163906233614;5820.534357251452;5854.97072514639;5884.529237660977;229185;229329;229590;230249;231658;55734.16398754022;55918.440815592134;55919.16121258184;55944.72027639836;57717.13424298639;59881.401185988456;60946;60962.390376096555;60992;61037.38962610317;19144.712829307573;19166.616667666567;19194.904025479784;19198.712019319722;19305.80694193068;15854.286557104959;15925.203739813194;15930.362785488682;15930.442434514736;15941.123238221777;16336.183190840648;16490;16530.338786448407;16602.91698541524;16680.49958501247;6045.3652366501765;6174.536909731788;6221.2845522764555;6266.122742816009;6392.520560957947;1113.7883802077579;1122.8652561692486;1126.5043380912373;1132.8357388178667;1135.5344308833503;26173.869130654224;26279;26374.20877373682;26520;27011.459770804475;1230.4831970572382;1253.3983687829711;1254.7615952968906;1259.6724851538665;1262.4886920797092;13658.931705341409;13714.794278085838;13865.09876858001;13880;14128.293585320898;275759;276444;277407;277526;278597;63185.68407157935;66573;68212.31787682159;68230.65884670644;68468.6576567114;1552.5497605694447;1565.2643257668879;1590.5307934159218;1602.7515735061083;1608.589809598545;32820.83589582037;32833.34333313368;33093.33813323768;33487.33025339528;33505.49741753827;45162.77418613018;45299.320510193036;45410.31884521669;45425.77287113675;45484;248790;249682;250914;251247;251953;38166.42750358803;39724.40413393744;39853.60146398499;39974.2005159901;40027.19945601014;50507.242391364896;50766.74616627041;51187.488125118274;51208.48791512037;51250;36438.8178059108;36475.45286820647;36500.81749591235;36849.07877303089;37091.44362834613;36819.263614728094;37048;37390.439143413416;37449;37480.437793432575;44022.77988610036;44032;44388.77805610951;44521;44746;35073.123171919884;35162.47256291209;35264;35596.82201588975;35854.28291434104;25975.090871819397;26904.32739181536;26992.190234293004;27177.59233611537;27791.305217368918 19:57:27 INFO - PID 7966 | |2;jquery.html;639.0056022408963;639.7055601805198;641.5819187004553;648.9081157960237;652.4929594224743;23729.406764830866;24623.630645540332;24640.50718985624;24702.135425260098;24739;27174;27598.172054838386;27615.30961725953;27627.447451050968;27699.446011079817;6254.749810007605;6479.838004049913;6559.3112723164095;6586.110875031857;6590.176227971504;6594.571352862049;6689.197296324448;6693.799186024427;6703.731850725965;6704.731810727565;6463.385978332074;6648.036034774955;6653.600783952978;6707.564008339442;6725.495587830932;6703.564268322568;6758.8310292242595;6761.560498567626;6761.594304341731;6766.424853887425;6350.745970161188;6351.714172862186;6362.713677884506;6364;6365.1725275714325;30803.537946930814;31478.213044674067;31903.84048079768;31997.2000699982;32062.679373206203;2380.988095059531;2404.350825277183;2420.6006009008493;2423.430493833948;2423.503181847717;20202.292919747884;20450.181992720274;20613.690794637943;20650.58698826015;20676.379708608765;2573.3052075939577;2609.712931577525;2630.9868450657814;2643.550596398617;2660.2152365052357;149832;156496;175147;178537;179060.10469947697;23884.88057559701;24813.379665508146;25192.622110668355;25342.36644083876;25602.615960760602;48266.75866620644;48424.51575484271;48434.75782621064;48542.514574854504;48572.271415928786;12367.443465044094;12400.503979840705;12415.813762793565;12417.75164496705;12732.80900786489;10112.230359687026;10202.234832387601;10255.641052563275;10380.740481487872;10436.165106791439;12761.425735841724;12911.741765164832;13094.279814610289;13307.733845323039;13308.134971226838;4703.623710103184;4810.6151507879285;4902.90194196114;4937.802487900443;4981.701097934136;1058.793535260632;1069.684443089275;1076.924615276923;1078.1590359519587;1081.9188560857967;22322.10711571519;22525.774742252695;22599.20902768395;22608.773912260996;22671.20650777248;1127.2053202492223;1127.7349822791637;1136.6476392318407;1138.0554140063728;1140.8859114088525;11934.164608477497;12237.449314780857;12251.75496490083;12308.753824923451;12327.445264963098;593340;594342;598207;599402;619287;134490.32754836165;134873;135354;138469.3076534631;142484;1279.8912092472244;1289.1040726694857;1296.0538806670995;1308.574713218208;1317.775978083728;19221.807781922;19550.33239548816;19575.314863979693;19935;19987;59006.70496647489;59077;59501.10748338865;60604.69697651484;60758.69620651868;76466.23533764813;76956;77294.22705773095;77344.61327693326;77985.2201477978;21611.567768644225;21847.890760546095;22020.669689954342;22218.88890555537;22357.329280121623;24414.75585244125;24441.87779061093;24469.632955506037;24718.876405617855;24780.132695355576;20066.598668026265;20113.19547218095;20170.697439538126;20208.49478762984;20495.077721502865;16981.66036679235;17230;17456.214470349118;17580.472585822445;17618.471445856645;20491.69262461094;20559.794402055788;20576.176952922313;20671.68992465084;20724.792752072288;21195.25816596412;21430.571388572454;21576.568468630227;21605.675914861604;21679.241226556995;19541.60916781685;19598.412047638594;19802.108905099016;19829.60340793205;19838.90080549588 19:57:27 INFO - PID 7966 | |3;mootools.html;1452.310152677478;1488.6427257458213;1498;1506.8794496440287;1521.110150561922;17659;18350.44948651541;18353.357632482865;18353.54116147097;18355.63288734228;17827.197776100074;17899;17954.910225448853;17979.101044947765;18005.549861253443;3056.862441190152;3120.4227217964694;3159.7472202223767;3187.3306605612734;3187.9840600796965;3070.2477892916268;3084.506478963366;3088.1661951273145;3102.8758849645988;3109.0672798160576;3055.648600410948;3071.3396619726755;3188.9681103188905;3189.4896816509363;3190.074878285306;3172.74618030557;3185.4266232078216;3204.4872820348633;3209.0693698827545;3218.5976752905885;3025.092472258336;3104.1929098434343;3124.453220686371;3129.4210571044428;3130.8591113399953;17290;17518.562035949075;17625.911870440566;17627;17651.117444127744;8773.956130219372;9038.276937845023;9042.186203241674;9057.275417966546;9059.139381758723;5763.855903602402;5793.333766616809;5862.853428664275;5899.439553242435;5972.64164150148;1976.8813871167777;2015.838732901379;2016.3547664747286;2048.979510204894;2056.239191499155;32600.67399326;32841.50737738936;32848;33265;33289.833550832336;7617.847643047108;7861.1352751198465;7900.407469439815;8066.11272759996;8069.757907262791;21058.578828423346;21061;21088.156473740877;21103.261385851423;21109.577808444054;8992.55037248135;9138.314626403046;9160.496172710566;9164.770880727901;9187.402818816756;8241.423100382915;8258.669653213925;8351;8407.327413806881;8519.361047921431;6216.471599914058;6360.52296077796;6361.395667411589;6410.8076757697345;6681.331866813377;1746.4149509914066;1780.97328540072;1783.652187823362;1882.0965936350628;1895.109298629642;943.9244860411151;958.7075941837807;970.088117169858;970.9465979371203;979.2704435195682;9797.755056123653;9813.607455701835;9885.25860560461;9905.10854023127;9943.30396872212;1071.132382769959;1093.1364222264322;1100.1363929315448;1113.5357005537692;1120.7198200449889;5300.469953004746;6290.716917738713;6315.147455093595;6345.302016778151;6363.5863668861375;26731.465370692476;26900.730992689823;27387.86306068497;27401;27850.72149278522;25998.35004124874;26008.34979125537;26764.732352676612;26780.196594101817;26986;12629.810552841898;12630.179038362478;12667.113302068767;12821.35893205336;12945.417456214493;9774.169195618168;9884.604615815575;9922.40465572068;9927.702168934944;10072.899271007196;22489.43776405603;22511.887440563347;22519.774802251766;22719.09123635036;23233.419164521023;22912.885435572716;23204.53590928138;23268.53462930698;23429.179978700664;23485.76514234836;12757.872421275668;12996.350182490649;13026.804597931228;13044.869551304366;13046.869531304565;16212.756808648115;16244.350225990827;16273.104979226257;16352;16388.918055409646;13197.20816750998;13205.603831885059;13231;13345.799813002619;13361;12981;13003.349832508147;13106.803397949228;13338.399772010476;13443;10740.677779666623;11015.504302306575;11024.779504409706;11025.393603351893;11052.944735276273;8191.426600137933;8307.127751586238;8315.293200077818;8331.625076871434;8440.409171357946;7485.1017877855;7551.660175292015;7582.62086895664;7633.580153091633;7730.342920851791 19:57:27 INFO - PID 7966 | |4;prototype.html;574.9856253593657;586.9999999999999;600.8377738010735;611.3611276216354;622.4087117238622;6545.5599768051015;6569.671516424178;6588.275289718127;6595.472362211023;6633.502487313459;6360.554761166709;6382.712777924993;6446.2264528256555;6462.741490340381;6513.869722605545;5268.130758424855;5281.9207711884355;5333.57331413486;5352.437994010631;5353.357597088336;5061.19020956647;5166.9224961625605;5298.496642818926;5353.839384818461;5356.517913387795;5125.718085505296;5141.717205553693;5160.664556803796;5161.535461808437;5167.844964651048;5071.213961835903;5119.616028797836;5163.432022477525;5170.508801663836;5202.141646628302;4717.905641887178;4723.338732577442;4735.763211839394;4735.928961065587;4743.905121897577;6433.678316084224;6445.291017988017;6475.093486911836;6481.254655714559;6481.83795405114;6185.948388773919;6210.96894515529;6221.377862213788;6224.751009959597;6239.87520249597;6918.481113916477;6934.410575101122;6939.410150137244;6950.3049695030595;6969.58182509046;5104.744762761884;5304.761285742113;5309.88492416593;5318.202269659543;5323.281357016792;7093.432525398008;7157.3200545948575;7220.5667659940045;7257.201707812189;7259;5450.863728406822;5460.426655201226;5468.28912241414;5489.313835770528;5504.614676972654;5453.318335208099;5476.698781567052;5526.198701188305;5531.778728850801;5551.861203469864;6044.667543285162;6084.726187321581;6089.360617135137;6093.2078829751845;6121.816345509642;6894.517973529525;6952.5480843745;6966.512344135862;7000.194977577542;7050.118735158106;1845.4832646858902;1862.7392165096626;1879.1731638079202;1887.5564242403025;1903.8572107092023;1303.4720938020116;1345.2601069411785;1350.2236214176887;1357.8710022547841;1361.0200655528201;6420.839479012969;6484.383983521558;6490.318516555788;6506.739730410731;6590.505712071614;6986.685599148051;7021.719131234693;7075.115610548682;7118.857622847514;7135.429165666734;6493.902591461132;6532.967335163294;6593.142891424084;6593.14289142418;6638.4357329626555;3721.3673675475234;3748.269087527906;3765.134019175605;3770.4155855842387;3792.7294356390366;7267.491275610762;7269.818254543573;7275.199728029913;7301.744438944612;7310.52481588695;7188.460865435113;7219.819504512429;7267.854642907112;7333.156686981066;7349.63251837406;7278.672459739324;7313.963430182815;7331.816704582321;7356.439007815189;7371.152317483558;7118.216996130318;7150.249223831423;7158.785236442915;7164.713411463692;7181;6950.756723514653;6997.545159564612;7004.439644828503;7014.824629384306;7046.577205367695;7160.248173941661;7203.235207374227;7204.586463534774;7246.5289756165685;7293.452991025801;5399.4060653327315;5428.131498960148;5435.782568697366;5469.3983661797965;5474.698891561003;6896.448284137156;6977.825554361181;7108.751193708195;7117.4661900358715;7122.18094919091;6661.533692641662;6762.49281303914;6835.7949261522235;6860.6912688930115;6878.27778083294;6705.530612857053;6787.457003439614;6791.762288319885;6824.986628944374;6863.142107236596;6619;6654.633995130314;6691.76578819739;6803.285655006153;6823.624700641512;6847.691853866688;6915.098347954353;6939.375456208965;6953.79138625842;6956.886898096483;6658.234303055017;6710.966445167743;6763.898541521783;6781.355771201728;6817.216020157745 19:57:27 INFO - PID 7966 | |5;yui.html;982.6511588386119;1025.4565080507332;1027.876654801424;1041.5000799616184;1047.5233768635271;20894.37316880494;21429.249976250834;21479.892600537016;21502.354929352125;21569.24507642229;19175.61648767027;19328.130234139462;19355.419337419866;19384.806151938476;20201.797982020176;1052.195070770863;1077.2674581284762;1077.5582011375338;1077.6874706335154;1078.8112080385902;1065.2277099103128;1091;1091.372460835023;1092.9508172132234;1093.103655002898;1150.4650337593018;1153.1121036801658;1153.3829401270323;1154.8845115488425;1155.3183621663218;1133.2180795251334;1142.7257458210054;1143.679769664491;1144.7481554058095;1145.8281257811311;837.4556538250187;847.3475423923544;850.553459433796;852.5353682243131;852.5779739029158;21503.247386341558;22102.447438813997;22237.555248895093;22398.888005559867;22553.436164095863;23454.76545234543;23464;23907.760922390728;23954.520909581886;24089.397765055837;16494.75257871133;16560.50318490447;16639.33442662292;16724.916375418168;16729.749053764204;3861.9227615447535;4131.091159944807;4159.750414975111;4160.313548264563;4165.333546632524;149305;152412;164484.17757911253;165625;170430;18570.164342604614;19034.714479282822;19101.140448679842;19300.32448864283;19336.8066319335;34892.47661285083;36568.45147322792;36674;36765.63234367622;36783.4482482763;9831.80336393268;9912.454814985245;10008.64969726056;10030.097291243823;10098.343607665478;4503.774811259489;4632.606228470618;4633.721976681342;4639.30410438437;4645.512221216791;6303.212098487689;6346.492280617539;6399.616023038632;6403.775867844603;6427.871442571216;1246.7132559511363;1248.5879659712273;1272.332025686522;1272.3828942962655;1272.6054922973908;680.4148432348177;701.8771714949863;705.7388766156453;712.5510928115255;715.3132992327425;12834.55079072228;13157.736845263042;13534.59396218115;14052.086614370033;14069.85930140706;679.7960611816435;695.4332219241302;698.4098436820879;709.4111887133666;713.2688993781312;6153.8461538461;6179;6180.165677633462;6259.6870156492;6323.30443651198;141324;141830.2908485451;142574.72275831742;143375.2831235837;145716.27141864222;130409;131833;133032;135543;135630;105999.99999999846;106395;106626;106685;109168;11497.252678575866;11661.708457288636;11949.402529873645;12024.33866137371;12095.879041209475;56650.43349566452;56852;57523.71238143783;57830.13254801097;57975;70754.29245707682;71134.64432677804;71465;72341;73754.26245737688;16530.338786448407;16785.32858685639;16862.325506980073;16920.15399230009;16945;16940.068296243826;16973.490795275666;17239.31042758326;17322.22050007778;17430.128493575525;16632.417865374653;16927.915360423118;16930.746038809673;16968.66062678764;16971.406000789913;16836.915815420845;17029.148542573068;17046.232919518898;17101.914490427967;17178.742318864977;16743.07913064793;17103.743443848103;17193.14034298255;17233.39683111085;17281.39515116965;11984.940075299568;12105.455254513745;12156.149069565046;12450.75098498043;12566.057545683927;12809.743805123659;12891.548795792101;12899.290539020443;12932.935335323264;13167.67080822987 19:57:27 INFO - PID 7966 | __end_tp_report 19:57:27 INFO - PID 7966 | __start_cc_report 19:57:27 INFO - PID 7966 | _x_x_mozilla_cycle_collect,259 19:57:27 INFO - PID 7966 | __end_cc_report 19:57:27 INFO - PID 7966 | __startTimestamp1507777047605__endTimestamp 19:57:27 INFO - PID 7966 | 19:57:27 INFO - PID 7966 | ------- Summary: start ------- 19:57:27 INFO - PID 7966 | Number of tests: 6 19:57:27 INFO - PID 7966 | 19:57:27 INFO - PID 7966 | [#0] dojo.html Cycles:165 Average:6648.83 Median:6896.38 stddev:771.82 (11.2%) stddev-sans-first:746.29 19:57:27 INFO - PID 7966 | Values: 4027.8 4040.3 4049.5 4074.0 4076.2 6534.4 6535.4 6562.6 6633.5 6653.8 6600.6 6631.4 6634.9 6636.1 6694.4 5912.5 5974.6 5999.1 6018.0 6027.2 5892.6 5928.6 5973.3 5975.0 6069.7 5931.2 5977.8 5999.3 6016.9 6019.7 5886.2 5907.1 5928.9 5968.3 5982.5 5834.1 5837.5 5876.1 5972.6 5996.9 6506.8 6509.4 6532.6 6543.4 6594.9 7150.5 7189.4 7267.6 7276.7 7282.7 7130.4 7226.1 7235.8 7283.5 7343.7 6582.3 6652.9 6654.6 6688.4 6754.0 7350.4 7360.9 7457.0 7460.9 7465.8 7003.5 7062.0 7166.3 7166.6 7172.4 7113.6 7187.9 7203.6 7203.8 7262.3 7109.8 7165.5 7175.1 7195.9 7225.9 7161.7 7188.3 7252.9 7265.6 7276.9 5373.8 5376.3 5443.1 5462.7 5466.4 4801.9 4832.7 4854.5 4874.7 4953.1 6750.7 6819.9 6835.8 6838.5 6840.4 7182.2 7185.6 7190.0 7220.0 7240.3 6604.1 6702.2 6724.9 6766.7 6802.2 6206.2 6215.4 6231.9 6233.5 6252.3 7224.5 7406.0 7408.5 7509.2 7510.3 7084.3 7140.8 7236.3 7243.9 7256.1 7396.5 7407.7 7491.1 7510.1 7513.8 7036.4 7065.9 7095.1 7130.3 7148.2 7248.6 7266.9 7271.9 7277.7 7296.6 6972.4 7035.1 7048.5 7064.9 7071.3 6863.2 6954.9 6969.4 7062.3 7063.4 6886.2 6887.0 6965.0 6966.4 7025.6 6987.4 6990.9 7028.6 7107.3 7123.2 6790.2 6798.8 6811.2 6877.7 6896.4 19:57:27 INFO - PID 7966 | 19:57:27 INFO - PID 7966 | [#1] ext.html Cycles:180 Average:44828.50 Median:20994.09 stddev:65747.88 (313.2%) stddev-sans-first:65849.85 19:57:27 INFO - PID 7966 | Values: 969.5 978.6 1015.0 1039.6 1042.4 46168.8 47220.8 47223.8 47255.0 47319.8 43215.6 43343.6 43383.1 43622.3 43643.8 8078.8 8160.0 8199.6 8204.1 8211.9 7907.5 7936.4 7971.3 8008.4 8010.9 8864.0 9000.5 9036.3 9039.6 9046.4 8865.2 8987.8 9003.9 9004.7 9038.2 8872.9 8967.2 8972.7 8978.6 8992.2 41740.0 41761.4 41844.6 42077.6 42133.6 3751.9 3812.7 3821.8 3839.9 3855.7 33987.7 34351.7 34405.0 34471.0 34481.5 5632.4 5766.2 5820.5 5855.0 5884.5 229185.0 229329.0 229590.0 230249.0 231658.0 55734.2 55918.4 55919.2 55944.7 57717.1 59881.4 60946.0 60962.4 60992.0 61037.4 19144.7 19166.6 19194.9 19198.7 19305.8 15854.3 15925.2 15930.4 15930.4 15941.1 16336.2 16490.0 16530.3 16602.9 16680.5 6045.4 6174.5 6221.3 6266.1 6392.5 1113.8 1122.9 1126.5 1132.8 1135.5 26173.9 26279.0 26374.2 26520.0 27011.5 1230.5 1253.4 1254.8 1259.7 1262.5 13658.9 13714.8 13865.1 13880.0 14128.3 275759.0 276444.0 277407.0 277526.0 278597.0 63185.7 66573.0 68212.3 68230.7 68468.7 1552.5 1565.3 1590.5 1602.8 1608.6 32820.8 32833.3 33093.3 33487.3 33505.5 45162.8 45299.3 45410.3 45425.8 45484.0 248790.0 249682.0 250914.0 251247.0 251953.0 38166.4 39724.4 39853.6 39974.2 40027.2 50507.2 50766.7 51187.5 51208.5 51250.0 36438.8 36475.5 36500.8 36849.1 37091.4 36819.3 37048.0 37390.4 37449.0 37480.4 44022.8 44032.0 44388.8 44521.0 44746.0 35073.1 35162.5 35264.0 35596.8 35854.3 25975.1 26904.3 26992.2 27177.6 27791.3 19:57:27 INFO - PID 7966 | 19:57:27 INFO - PID 7966 | [#2] jquery.html Cycles:180 Average:41768.46 Median:13055.20 stddev:101056.75 (774.1%) stddev-sans-first:101293.06 19:57:27 INFO - PID 7966 | Values: 639.0 639.7 641.6 648.9 652.5 23729.4 24623.6 24640.5 24702.1 24739.0 27174.0 27598.2 27615.3 27627.4 27699.4 6254.7 6479.8 6559.3 6586.1 6590.2 6594.6 6689.2 6693.8 6703.7 6704.7 6463.4 6648.0 6653.6 6707.6 6725.5 6703.6 6758.8 6761.6 6761.6 6766.4 6350.7 6351.7 6362.7 6364.0 6365.2 30803.5 31478.2 31903.8 31997.2 32062.7 2381.0 2404.4 2420.6 2423.4 2423.5 20202.3 20450.2 20613.7 20650.6 20676.4 2573.3 2609.7 2631.0 2643.6 2660.2 149832.0 156496.0 175147.0 178537.0 179060.1 23884.9 24813.4 25192.6 25342.4 25602.6 48266.8 48424.5 48434.8 48542.5 48572.3 12367.4 12400.5 12415.8 12417.8 12732.8 10112.2 10202.2 10255.6 10380.7 10436.2 12761.4 12911.7 13094.3 13307.7 13308.1 4703.6 4810.6 4902.9 4937.8 4981.7 1058.8 1069.7 1076.9 1078.2 1081.9 22322.1 22525.8 22599.2 22608.8 22671.2 1127.2 1127.7 1136.6 1138.1 1140.9 11934.2 12237.4 12251.8 12308.8 12327.4 593340.0 594342.0 598207.0 599402.0 619287.0 134490.3 134873.0 135354.0 138469.3 142484.0 1279.9 1289.1 1296.1 1308.6 1317.8 19221.8 19550.3 19575.3 19935.0 19987.0 59006.7 59077.0 59501.1 60604.7 60758.7 76466.2 76956.0 77294.2 77344.6 77985.2 21611.6 21847.9 22020.7 22218.9 22357.3 24414.8 24441.9 24469.6 24718.9 24780.1 20066.6 20113.2 20170.7 20208.5 20495.1 16981.7 17230.0 17456.2 17580.5 17618.5 20491.7 20559.8 20576.2 20671.7 20724.8 21195.3 21430.6 21576.6 21605.7 21679.2 19541.6 19598.4 19802.1 19829.6 19838.9 19:57:27 INFO - PID 7966 | 19:57:27 INFO - PID 7966 | [#3] mootools.html Cycles:180 Average:11067.28 Median:15437.91 stddev:8263.59 (53.5%) stddev-sans-first:8255.20 19:57:27 INFO - PID 7966 | Values: 1452.3 1488.6 1498.0 1506.9 1521.1 17659.0 18350.4 18353.4 18353.5 18355.6 17827.2 17899.0 17954.9 17979.1 18005.5 3056.9 3120.4 3159.7 3187.3 3188.0 3070.2 3084.5 3088.2 3102.9 3109.1 3055.6 3071.3 3189.0 3189.5 3190.1 3172.7 3185.4 3204.5 3209.1 3218.6 3025.1 3104.2 3124.5 3129.4 3130.9 17290.0 17518.6 17625.9 17627.0 17651.1 8774.0 9038.3 9042.2 9057.3 9059.1 5763.9 5793.3 5862.9 5899.4 5972.6 1976.9 2015.8 2016.4 2049.0 2056.2 32600.7 32841.5 32848.0 33265.0 33289.8 7617.8 7861.1 7900.4 8066.1 8069.8 21058.6 21061.0 21088.2 21103.3 21109.6 8992.6 9138.3 9160.5 9164.8 9187.4 8241.4 8258.7 8351.0 8407.3 8519.4 6216.5 6360.5 6361.4 6410.8 6681.3 1746.4 1781.0 1783.7 1882.1 1895.1 943.9 958.7 970.1 970.9 979.3 9797.8 9813.6 9885.3 9905.1 9943.3 1071.1 1093.1 1100.1 1113.5 1120.7 5300.5 6290.7 6315.1 6345.3 6363.6 26731.5 26900.7 27387.9 27401.0 27850.7 25998.4 26008.3 26764.7 26780.2 26986.0 12629.8 12630.2 12667.1 12821.4 12945.4 9774.2 9884.6 9922.4 9927.7 10072.9 22489.4 22511.9 22519.8 22719.1 23233.4 22912.9 23204.5 23268.5 23429.2 23485.8 12757.9 12996.4 13026.8 13044.9 13046.9 16212.8 16244.4 16273.1 16352.0 16388.9 13197.2 13205.6 13231.0 13345.8 13361.0 12981.0 13003.3 13106.8 13338.4 13443.0 10740.7 11015.5 11024.8 11025.4 11052.9 8191.4 8307.1 8315.3 8331.6 8440.4 7485.1 7551.7 7582.6 7633.6 7730.3 19:57:27 INFO - PID 7966 | 19:57:27 INFO - PID 7966 | [#4] prototype.html Cycles:180 Average:5894.34 Median:6539.26 stddev:1645.66 (25.2%) stddev-sans-first:1601.11 19:57:27 INFO - PID 7966 | Values: 575.0 587.0 600.8 611.4 622.4 6545.6 6569.7 6588.3 6595.5 6633.5 6360.6 6382.7 6446.2 6462.7 6513.9 5268.1 5281.9 5333.6 5352.4 5353.4 5061.2 5166.9 5298.5 5353.8 5356.5 5125.7 5141.7 5160.7 5161.5 5167.8 5071.2 5119.6 5163.4 5170.5 5202.1 4717.9 4723.3 4735.8 4735.9 4743.9 6433.7 6445.3 6475.1 6481.3 6481.8 6185.9 6211.0 6221.4 6224.8 6239.9 6918.5 6934.4 6939.4 6950.3 6969.6 5104.7 5304.8 5309.9 5318.2 5323.3 7093.4 7157.3 7220.6 7257.2 7259.0 5450.9 5460.4 5468.3 5489.3 5504.6 5453.3 5476.7 5526.2 5531.8 5551.9 6044.7 6084.7 6089.4 6093.2 6121.8 6894.5 6952.5 6966.5 7000.2 7050.1 1845.5 1862.7 1879.2 1887.6 1903.9 1303.5 1345.3 1350.2 1357.9 1361.0 6420.8 6484.4 6490.3 6506.7 6590.5 6986.7 7021.7 7075.1 7118.9 7135.4 6493.9 6533.0 6593.1 6593.1 6638.4 3721.4 3748.3 3765.1 3770.4 3792.7 7267.5 7269.8 7275.2 7301.7 7310.5 7188.5 7219.8 7267.9 7333.2 7349.6 7278.7 7314.0 7331.8 7356.4 7371.2 7118.2 7150.2 7158.8 7164.7 7181.0 6950.8 6997.5 7004.4 7014.8 7046.6 7160.2 7203.2 7204.6 7246.5 7293.5 5399.4 5428.1 5435.8 5469.4 5474.7 6896.4 6977.8 7108.8 7117.5 7122.2 6661.5 6762.5 6835.8 6860.7 6878.3 6705.5 6787.5 6791.8 6825.0 6863.1 6619.0 6654.6 6691.8 6803.3 6823.6 6847.7 6915.1 6939.4 6953.8 6956.9 6658.2 6711.0 6763.9 6781.4 6817.2 19:57:27 INFO - PID 7966 | 19:57:27 INFO - PID 7966 | [#5] yui.html Cycles:180 Average:27989.82 Median:93729.57 stddev:41579.25 (44.4%) stddev-sans-first:41646.44 19:57:27 INFO - PID 7966 | Values: 982.7 1025.5 1027.9 1041.5 1047.5 20894.4 21429.2 21479.9 21502.4 21569.2 19175.6 19328.1 19355.4 19384.8 20201.8 1052.2 1077.3 1077.6 1077.7 1078.8 1065.2 1091.0 1091.4 1093.0 1093.1 1150.5 1153.1 1153.4 1154.9 1155.3 1133.2 1142.7 1143.7 1144.7 1145.8 837.5 847.3 850.6 852.5 852.6 21503.2 22102.4 22237.6 22398.9 22553.4 23454.8 23464.0 23907.8 23954.5 24089.4 16494.8 16560.5 16639.3 16724.9 16729.7 3861.9 4131.1 4159.8 4160.3 4165.3 149305.0 152412.0 164484.2 165625.0 170430.0 18570.2 19034.7 19101.1 19300.3 19336.8 34892.5 36568.5 36674.0 36765.6 36783.4 9831.8 9912.5 10008.6 10030.1 10098.3 4503.8 4632.6 4633.7 4639.3 4645.5 6303.2 6346.5 6399.6 6403.8 6427.9 1246.7 1248.6 1272.3 1272.4 1272.6 680.4 701.9 705.7 712.6 715.3 12834.6 13157.7 13534.6 14052.1 14069.9 679.8 695.4 698.4 709.4 713.3 6153.8 6179.0 6180.2 6259.7 6323.3 141324.0 141830.3 142574.7 143375.3 145716.3 130409.0 131833.0 133032.0 135543.0 135630.0 106000.0 106395.0 106626.0 106685.0 109168.0 11497.3 11661.7 11949.4 12024.3 12095.9 56650.4 56852.0 57523.7 57830.1 57975.0 70754.3 71134.6 71465.0 72341.0 73754.3 16530.3 16785.3 16862.3 16920.2 16945.0 16940.1 16973.5 17239.3 17322.2 17430.1 16632.4 16927.9 16930.7 16968.7 16971.4 16836.9 17029.1 17046.2 17101.9 17178.7 16743.1 17103.7 17193.1 17233.4 17281.4 11984.9 12105.5 12156.1 12450.8 12566.1 12809.7 12891.5 12899.3 12932.9 13167.7 19:57:27 INFO - PID 7966 | -------- Summary: end -------- 19:57:27 INFO - PID 7966 | 19:57:28 INFO - TEST-INFO | 7966: exit 0 19:57:28 INFO - TEST-OK | dromaeo_css | took 1107150ms 19:57:28 INFO - TEST-START | kraken 19:57:28 INFO - Initialising browser for kraken test... 19:57:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47547/getInfo.html -profile /tmp/tmpNAzI1y/profile 19:57:28 INFO - TEST-INFO | started process 8330 (/builds/slave/test/build/application/firefox/firefox http://localhost:47547/getInfo.html) 19:57:33 INFO - TEST-INFO | 8330: exit 0 19:57:33 INFO - Browser initialized. 19:57:33 INFO - Running cycle 1/1 for kraken test... 19:57:33 INFO - Using env: {'DISPLAY': ':0', 19:57:33 INFO - 'HOME': '/home/cltbld', 19:57:33 INFO - 'JSGC_DISABLE_POISONING': '1', 19:57:33 INFO - 'LANG': 'en_US.UTF-8', 19:57:33 INFO - 'LANGUAGE': 'en_US:en', 19:57:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 19:57:33 INFO - 'LOGNAME': 'cltbld', 19:57:33 INFO - 'MAIL': '/var/mail/cltbld', 19:57:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:57:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:57:33 INFO - 'MOZ_CRASHREPORTER': '1', 19:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 19:57:33 INFO - 'MOZ_NO_REMOTE': '1', 19:57:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:33 INFO - 'NO_EM_RESTART': '1', 19:57:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:33 INFO - 'PWD': '/builds/slave/test', 19:57:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:57:33 INFO - 'RUST_BACKTRACE': 'full', 19:57:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:57:33 INFO - 'SHELL': '/bin/bash', 19:57:33 INFO - 'SHLVL': '1', 19:57:33 INFO - 'TERM': 'linux', 19:57:33 INFO - 'TMOUT': '86400', 19:57:33 INFO - 'USER': 'cltbld', 19:57:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999', 19:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:33 INFO - '_': '/tools/buildbot/bin/python'} 19:57:33 INFO - TEST-INFO | started process 8567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNAzI1y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:57:34 INFO - PID 8567 | 19:57:34 INFO - PID 8567 | (/builds/slave/test/build/application/firefox/firefox:8614): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:57:34 INFO - PID 8567 | 19:57:44 INFO - PID 8567 | RSS: Main: 142028800 19:57:44 INFO - PID 8567 | 19:57:46 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:47547/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47547/tests/kraken/driver.html?testName=audio-beat-detection) 19:57:47 INFO - PID 8567 | RSS: Main: 147861504 19:57:47 INFO - PID 8567 | 19:57:50 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:47547/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47547/tests/kraken/driver.html?testName=audio-dft) 19:57:50 INFO - PID 8567 | RSS: Main: 148500480 19:57:50 INFO - PID 8567 | 19:57:53 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:47547/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47547/tests/kraken/driver.html?testName=audio-fft) 19:57:54 INFO - PID 8567 | RSS: Main: 149721088 19:57:54 INFO - PID 8567 | 19:57:56 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:47547/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47547/tests/kraken/driver.html?testName=audio-oscillator) 19:57:56 INFO - PID 8567 | RSS: Main: 149913600 19:57:56 INFO - PID 8567 | 19:57:58 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:47547/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47547/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:57:59 INFO - PID 8567 | RSS: Main: 149753856 19:57:59 INFO - PID 8567 | 19:58:02 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:47547/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47547/tests/kraken/driver.html?testName=imaging-darkroom) 19:58:03 INFO - PID 8567 | RSS: Main: 149475328 19:58:03 INFO - PID 8567 | 19:58:06 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:47547/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47547/tests/kraken/driver.html?testName=imaging-desaturate) 19:58:07 INFO - PID 8567 | RSS: Main: 152059904 19:58:07 INFO - PID 8567 | 19:58:10 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:47547/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47547/tests/kraken/driver.html?testName=json-parse-financial) 19:58:10 INFO - PID 8567 | RSS: Main: 152465408 19:58:10 INFO - PID 8567 | 19:58:12 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:47547/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47547/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:58:12 INFO - PID 8567 | RSS: Main: 152322048 19:58:12 INFO - PID 8567 | 19:58:14 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:47547/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47547/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:58:15 INFO - PID 8567 | RSS: Main: 152002560 19:58:15 INFO - PID 8567 | 19:58:17 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:47547/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47547/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:58:17 INFO - PID 8567 | RSS: Main: 149778432 19:58:17 INFO - PID 8567 | 19:58:20 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:47547/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:58:20 INFO - PID 8567 | RSS: Main: 149262336 19:58:20 INFO - PID 8567 | 19:58:23 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:47547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:58:24 INFO - PID 8567 | RSS: Main: 149684224 19:58:24 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:47547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47547/tests/kraken/driver.html?testName=ai-astar) 19:58:25 INFO - PID 8567 | RSS: Main: 151433216 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | __start_tp_report 19:58:25 INFO - PID 8567 | _x_x_mozilla_page_load 19:58:25 INFO - PID 8567 | _x_x_mozilla_page_load_details 19:58:25 INFO - PID 8567 | |i|pagename|runs| 19:58:25 INFO - PID 8567 | |0;ai-astar;107;107;106;106;105;105;108;105;105;105 19:58:25 INFO - PID 8567 | |1;audio-beat-detection;108;112;113;113;114;144;110;113;110;137 19:58:25 INFO - PID 8567 | |2;audio-dft;162;161;162;161;162;163;163;161;163;165 19:58:25 INFO - PID 8567 | |3;audio-fft;74;75;77;73;74;75;73;76;73;84 19:58:25 INFO - PID 8567 | |4;audio-oscillator;78;77;77;77;77;78;78;77;77;77 19:58:25 INFO - PID 8567 | |5;imaging-gaussian-blur;114;114;114;113;111;115;114;113;114;116 19:58:25 INFO - PID 8567 | |6;imaging-darkroom;149;148;148;149;148;147;147;148;147;148 19:58:25 INFO - PID 8567 | |7;imaging-desaturate;94;93;95;93;94;94;94;96;97;95 19:58:25 INFO - PID 8567 | |8;json-parse-financial;49;44;47;45;45;45;43;46;43;43 19:58:25 INFO - PID 8567 | |9;json-stringify-tinderbox;46;46;46;46;47;47;46;46;46;46 19:58:25 INFO - PID 8567 | |10;stanford-crypto-aes;73;70;68;73;68;69;70;70;69;71 19:58:25 INFO - PID 8567 | |11;stanford-crypto-ccm;108;106;107;113;120;102;103;100;109;106 19:58:25 INFO - PID 8567 | |12;stanford-crypto-pbkdf2;161;155;147;151;153;154;153;143;146;144 19:58:25 INFO - PID 8567 | |13;stanford-crypto-sha256-iterative;57;61;61;57;59;59;60;58;69;58 19:58:25 INFO - PID 8567 | __end_tp_report 19:58:25 INFO - PID 8567 | __start_cc_report 19:58:25 INFO - PID 8567 | _x_x_mozilla_cycle_collect,677 19:58:25 INFO - PID 8567 | __end_cc_report 19:58:25 INFO - PID 8567 | __startTimestamp1507777105938__endTimestamp 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | ------- Summary: start ------- 19:58:25 INFO - PID 8567 | Number of tests: 14 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | [#0] ai-astar Cycles:10 Average:105.90 Median:106.00 stddev:1.10 (1.0%) stddev-sans-first:1.09 19:58:25 INFO - PID 8567 | Values: 107.0 107.0 106.0 106.0 105.0 105.0 108.0 105.0 105.0 105.0 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | [#1] audio-beat-detection Cycles:10 Average:117.40 Median:113.00 stddev:12.42 (11.0%) stddev-sans-first:12.70 19:58:25 INFO - PID 8567 | Values: 108.0 112.0 113.0 113.0 114.0 144.0 110.0 113.0 110.0 137.0 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 19:58:25 INFO - PID 8567 | Values: 162.0 161.0 162.0 161.0 162.0 163.0 163.0 161.0 163.0 165.0 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | [#3] audio-fft Cycles:10 Average:75.40 Median:75.00 stddev:3.31 (4.4%) stddev-sans-first:3.47 19:58:25 INFO - PID 8567 | Values: 74.0 75.0 77.0 73.0 74.0 75.0 73.0 76.0 73.0 84.0 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:77.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 19:58:25 INFO - PID 8567 | Values: 78.0 77.0 77.0 77.0 77.0 78.0 78.0 77.0 77.0 77.0 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:1.32 (1.2%) stddev-sans-first:1.39 19:58:25 INFO - PID 8567 | Values: 114.0 114.0 114.0 113.0 111.0 115.0 114.0 113.0 114.0 116.0 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 19:58:25 INFO - PID 8567 | Values: 149.0 148.0 148.0 149.0 148.0 147.0 147.0 148.0 147.0 148.0 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:1.27 (1.3%) stddev-sans-first:1.33 19:58:25 INFO - PID 8567 | Values: 94.0 93.0 95.0 93.0 94.0 94.0 94.0 96.0 97.0 95.0 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | [#8] json-parse-financial Cycles:10 Average:45.00 Median:45.00 stddev:1.94 (4.3%) stddev-sans-first:1.42 19:58:25 INFO - PID 8567 | Values: 49.0 44.0 47.0 45.0 45.0 45.0 43.0 46.0 43.0 43.0 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | [#9] json-stringify-tinderbox Cycles:10 Average:46.20 Median:46.00 stddev:0.42 (0.9%) stddev-sans-first:0.44 19:58:25 INFO - PID 8567 | Values: 46.0 46.0 46.0 46.0 47.0 47.0 46.0 46.0 46.0 46.0 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | [#10] stanford-crypto-aes Cycles:10 Average:70.10 Median:70.00 stddev:1.79 (2.6%) stddev-sans-first:1.56 19:58:25 INFO - PID 8567 | Values: 73.0 70.0 68.0 73.0 68.0 69.0 70.0 70.0 69.0 71.0 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | [#11] stanford-crypto-ccm Cycles:10 Average:107.40 Median:107.50 stddev:5.78 (5.4%) stddev-sans-first:6.12 19:58:25 INFO - PID 8567 | Values: 108.0 106.0 107.0 113.0 120.0 102.0 103.0 100.0 109.0 106.0 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:153.00 stddev:5.64 (3.7%) stddev-sans-first:4.59 19:58:25 INFO - PID 8567 | Values: 161.0 155.0 147.0 151.0 153.0 154.0 153.0 143.0 146.0 144.0 19:58:25 INFO - PID 8567 | 19:58:25 INFO - PID 8567 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.90 Median:59.50 stddev:3.51 (5.9%) stddev-sans-first:3.56 19:58:25 INFO - PID 8567 | Values: 57.0 61.0 61.0 57.0 59.0 59.0 60.0 58.0 69.0 58.0 19:58:25 INFO - PID 8567 | -------- Summary: end -------- 19:58:25 INFO - PID 8567 | 19:58:26 INFO - PID 8567 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:58:26 INFO - TEST-INFO | 8567: exit 0 19:58:26 INFO - TEST-OK | kraken | took 58329ms 19:58:26 INFO - SUITE-END | took 1165s 19:58:26 INFO - Completed test suite (00:19:25) 19:58:26 INFO - javascript benchmark 19:58:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9566.913958089235, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4027.7784721840303, 4040.252553277644, 4049.53430355509, 4074.042599989002, 4076.2458945095177, 6534.379233972777, 6535.444487218586, 6562.639054851981, 6633.502487313447, 6653.800385988422, 6600.636964966925, 6631.403173714365, 6634.933650663492, 6636.104125942997, 6694.430973367257, 5912.467877890989, 5974.61165024272, 5999.100134979766, 6018.0, 6027.186329845481, 5892.616979896293, 5928.55535834812, 5973.253343332083, 5975.0, 6069.666168360738, 5931.199288096095, 5977.7608895644125, 5999.340072592033, 6016.909746353808, 6019.668918209497, 5886.20536227608, 5907.113932910055, 5928.911066334009, 5968.253968253968, 5982.521398288127, 5834.095715164156, 5837.532997360244, 5876.147958546029, 5972.611780234271, 5996.880062398727, 6506.7722629708205, 6509.414152726277, 6532.575382600164, 6543.411093001605, 6594.868102637968, 7150.535215211046, 7189.352958233784, 7267.63661816907, 7276.708931642728, 7282.672279747424, 7130.358267755875, 7226.096737907762, 7235.819104522377, 7283.453740969396, 7343.7062517499235, 6582.275949645536, 6652.900206496906, 6654.56745311558, 6688.3646053624825, 6754.0, 7350.4119670426235, 7360.926390736131, 7457.0, 7460.888086678704, 7465.776026719099, 7003.474739394565, 7062.046623705836, 7166.319199676022, 7166.641667916583, 7172.354488096096, 7113.608751518716, 7187.89218161728, 7203.639818009078, 7203.819904502429, 7262.31008054234, 7109.786706398816, 7165.498415110892, 7175.103112110986, 7195.92804071963, 7225.8554828903125, 7161.67772450241, 7188.317109874553, 7252.927470725331, 7265.600391978492, 7276.890846637305, 5373.838784836461, 5376.301080859464, 5443.101888188405, 5462.7268636568015, 5466.426025267289, 4801.855944321676, 4832.685875418087, 4854.490278520775, 4874.658773885794, 4953.1332016896895, 6750.7299708012115, 6819.897701534481, 6835.760748373783, 6838.452923766087, 6840.418564421981, 7182.2458641842895, 7185.568865868065, 7189.964050179716, 7219.963900180465, 7240.312170343915, 6604.075429439882, 6702.229243637044, 6724.9327506725285, 6766.69549870257, 6802.183737951378, 6206.193194884727, 6215.409536094064, 6231.906521402183, 6233.470155036782, 6252.280987686383, 7224.4581656375985, 7405.9629701851145, 7408.481406301615, 7509.249075092556, 7510.286522780327, 7084.256153103953, 7140.750073747394, 7236.34872861445, 7243.855122897407, 7256.129264488295, 7396.482246242711, 7407.703691852265, 7491.101067871672, 7510.098788145458, 7513.812154696177, 7036.437085033082, 7065.929340706527, 7095.148582170173, 7130.251323610946, 7148.177959534512, 7248.565086094851, 7266.927330726625, 7271.854562908607, 7277.745278915212, 7296.635168241461, 6972.407345375497, 7035.12060992376, 7048.506604537838, 7064.858702826017, 7071.292870712888, 6863.245043045361, 6954.8956765647545, 6969.407600354027, 7062.258462861326, 7063.364297213276, 6886.173659160932, 6887.035814985806, 6965.024896514391, 6966.407855332151, 7025.648717564203, 6987.371136597731, 6990.9300906990275, 7028.6485675714985, 7107.324804143598, 7123.180834203926, 6790.219124800711, 6798.76204332846, 6811.182658081062, 6877.690503927435, 6896.379325860496], "value": 6597.155538394697, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [969.4619486185169, 978.623230056428, 1014.9797004059918, 1039.5789705169404, 1042.4370839746537, 46168.769156154216, 47220.76389618056, 47223.76388118059, 47255.0, 47319.76340118299, 43215.567844321544, 43343.566564334345, 43383.132337353316, 43622.34566481505, 43643.78178109113, 8078.798030049252, 8160.0, 8199.590020498981, 8204.056533498635, 8211.917880821175, 7907.486013409139, 7936.365090792723, 7971.282584567388, 8008.439409241356, 8010.919890801105, 8864.0, 9000.504972226525, 9036.277097832157, 9039.593218305192, 9046.3667543272, 8865.157810008039, 8987.820243595124, 9003.86494202581, 9004.684836030707, 9038.186563209343, 8872.8669069964, 8967.237784788302, 8972.685955991574, 8978.551072446417, 8992.23565996891, 41740.0, 41761.373579396335, 41844.58155418437, 42077.57922420767, 42133.57866421327, 3751.868684596026, 3812.7140464465274, 3821.7515861468914, 3839.9248210500823, 3855.74937629056, 33987.660123398695, 34351.656483435094, 34405.0, 34471.0, 34481.482777758356, 5632.35227948787, 5766.163906233614, 5820.534357251452, 5854.97072514639, 5884.529237660977, 229185.0, 229329.0, 229590.0, 230249.0, 231658.0, 55734.16398754022, 55918.440815592134, 55919.16121258184, 55944.72027639836, 57717.13424298639, 59881.401185988456, 60946.0, 60962.390376096555, 60992.0, 61037.38962610317, 19144.712829307573, 19166.616667666567, 19194.904025479784, 19198.712019319722, 19305.80694193068, 15854.286557104959, 15925.203739813194, 15930.362785488682, 15930.442434514736, 15941.123238221777, 16336.183190840648, 16490.0, 16530.338786448407, 16602.91698541524, 16680.49958501247, 6045.3652366501765, 6174.536909731788, 6221.2845522764555, 6266.122742816009, 6392.520560957947, 1113.7883802077579, 1122.8652561692486, 1126.5043380912373, 1132.8357388178667, 1135.5344308833503, 26173.869130654224, 26279.0, 26374.20877373682, 26520.0, 27011.459770804475, 1230.4831970572382, 1253.3983687829711, 1254.7615952968906, 1259.6724851538665, 1262.4886920797092, 13658.931705341409, 13714.794278085838, 13865.09876858001, 13880.0, 14128.293585320898, 275759.0, 276444.0, 277407.0, 277526.0, 278597.0, 63185.68407157935, 66573.0, 68212.31787682159, 68230.65884670644, 68468.6576567114, 1552.5497605694447, 1565.2643257668879, 1590.5307934159218, 1602.7515735061083, 1608.589809598545, 32820.83589582037, 32833.34333313368, 33093.33813323768, 33487.33025339528, 33505.49741753827, 45162.77418613018, 45299.320510193036, 45410.31884521669, 45425.77287113675, 45484.0, 248790.0, 249682.0, 250914.0, 251247.0, 251953.0, 38166.42750358803, 39724.40413393744, 39853.60146398499, 39974.2005159901, 40027.19945601014, 50507.242391364896, 50766.74616627041, 51187.488125118274, 51208.48791512037, 51250.0, 36438.8178059108, 36475.45286820647, 36500.81749591235, 36849.07877303089, 37091.44362834613, 36819.263614728094, 37048.0, 37390.439143413416, 37449.0, 37480.437793432575, 44022.77988610036, 44032.0, 44388.77805610951, 44521.0, 44746.0, 35073.123171919884, 35162.47256291209, 35264.0, 35596.82201588975, 35854.28291434104, 25975.090871819397, 26904.32739181536, 26992.190234293004, 27177.59233611537, 27791.305217368918], "value": 19835.61453206281, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.0056022408963, 639.7055601805198, 641.5819187004553, 648.9081157960237, 652.4929594224743, 23729.406764830866, 24623.630645540332, 24640.50718985624, 24702.135425260098, 24739.0, 27174.0, 27598.172054838386, 27615.30961725953, 27627.447451050968, 27699.446011079817, 6254.749810007605, 6479.838004049913, 6559.3112723164095, 6586.110875031857, 6590.176227971504, 6594.571352862049, 6689.197296324448, 6693.799186024427, 6703.731850725965, 6704.731810727565, 6463.385978332074, 6648.036034774955, 6653.600783952978, 6707.564008339442, 6725.495587830932, 6703.564268322568, 6758.8310292242595, 6761.560498567626, 6761.594304341731, 6766.424853887425, 6350.745970161188, 6351.714172862186, 6362.713677884506, 6364.0, 6365.1725275714325, 30803.537946930814, 31478.213044674067, 31903.84048079768, 31997.2000699982, 32062.679373206203, 2380.988095059531, 2404.350825277183, 2420.6006009008493, 2423.430493833948, 2423.503181847717, 20202.292919747884, 20450.181992720274, 20613.690794637943, 20650.58698826015, 20676.379708608765, 2573.3052075939577, 2609.712931577525, 2630.9868450657814, 2643.550596398617, 2660.2152365052357, 149832.0, 156496.0, 175147.0, 178537.0, 179060.10469947697, 23884.88057559701, 24813.379665508146, 25192.622110668355, 25342.36644083876, 25602.615960760602, 48266.75866620644, 48424.51575484271, 48434.75782621064, 48542.514574854504, 48572.271415928786, 12367.443465044094, 12400.503979840705, 12415.813762793565, 12417.75164496705, 12732.80900786489, 10112.230359687026, 10202.234832387601, 10255.641052563275, 10380.740481487872, 10436.165106791439, 12761.425735841724, 12911.741765164832, 13094.279814610289, 13307.733845323039, 13308.134971226838, 4703.623710103184, 4810.6151507879285, 4902.90194196114, 4937.802487900443, 4981.701097934136, 1058.793535260632, 1069.684443089275, 1076.924615276923, 1078.1590359519587, 1081.9188560857967, 22322.10711571519, 22525.774742252695, 22599.20902768395, 22608.773912260996, 22671.20650777248, 1127.2053202492223, 1127.7349822791637, 1136.6476392318407, 1138.0554140063728, 1140.8859114088525, 11934.164608477497, 12237.449314780857, 12251.75496490083, 12308.753824923451, 12327.445264963098, 593340.0, 594342.0, 598207.0, 599402.0, 619287.0, 134490.32754836165, 134873.0, 135354.0, 138469.3076534631, 142484.0, 1279.8912092472244, 1289.1040726694857, 1296.0538806670995, 1308.574713218208, 1317.775978083728, 19221.807781922, 19550.33239548816, 19575.314863979693, 19935.0, 19987.0, 59006.70496647489, 59077.0, 59501.10748338865, 60604.69697651484, 60758.69620651868, 76466.23533764813, 76956.0, 77294.22705773095, 77344.61327693326, 77985.2201477978, 21611.567768644225, 21847.890760546095, 22020.669689954342, 22218.88890555537, 22357.329280121623, 24414.75585244125, 24441.87779061093, 24469.632955506037, 24718.876405617855, 24780.132695355576, 20066.598668026265, 20113.19547218095, 20170.697439538126, 20208.49478762984, 20495.077721502865, 16981.66036679235, 17230.0, 17456.214470349118, 17580.472585822445, 17618.471445856645, 20491.69262461094, 20559.794402055788, 20576.176952922313, 20671.68992465084, 20724.792752072288, 21195.25816596412, 21430.571388572454, 21576.568468630227, 21605.675914861604, 21679.241226556995, 19541.60916781685, 19598.412047638594, 19802.108905099016, 19829.60340793205, 19838.90080549588], "value": 14031.981635086351, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.310152677478, 1488.6427257458213, 1498.0, 1506.8794496440287, 1521.110150561922, 17659.0, 18350.44948651541, 18353.357632482865, 18353.54116147097, 18355.63288734228, 17827.197776100074, 17899.0, 17954.910225448853, 17979.101044947765, 18005.549861253443, 3056.862441190152, 3120.4227217964694, 3159.7472202223767, 3187.3306605612734, 3187.9840600796965, 3070.2477892916268, 3084.506478963366, 3088.1661951273145, 3102.8758849645988, 3109.0672798160576, 3055.648600410948, 3071.3396619726755, 3188.9681103188905, 3189.4896816509363, 3190.074878285306, 3172.74618030557, 3185.4266232078216, 3204.4872820348633, 3209.0693698827545, 3218.5976752905885, 3025.092472258336, 3104.1929098434343, 3124.453220686371, 3129.4210571044428, 3130.8591113399953, 17290.0, 17518.562035949075, 17625.911870440566, 17627.0, 17651.117444127744, 8773.956130219372, 9038.276937845023, 9042.186203241674, 9057.275417966546, 9059.139381758723, 5763.855903602402, 5793.333766616809, 5862.853428664275, 5899.439553242435, 5972.64164150148, 1976.8813871167777, 2015.838732901379, 2016.3547664747286, 2048.979510204894, 2056.239191499155, 32600.67399326, 32841.50737738936, 32848.0, 33265.0, 33289.833550832336, 7617.847643047108, 7861.1352751198465, 7900.407469439815, 8066.11272759996, 8069.757907262791, 21058.578828423346, 21061.0, 21088.156473740877, 21103.261385851423, 21109.577808444054, 8992.55037248135, 9138.314626403046, 9160.496172710566, 9164.770880727901, 9187.402818816756, 8241.423100382915, 8258.669653213925, 8351.0, 8407.327413806881, 8519.361047921431, 6216.471599914058, 6360.52296077796, 6361.395667411589, 6410.8076757697345, 6681.331866813377, 1746.4149509914066, 1780.97328540072, 1783.652187823362, 1882.0965936350628, 1895.109298629642, 943.9244860411151, 958.7075941837807, 970.088117169858, 970.9465979371203, 979.2704435195682, 9797.755056123653, 9813.607455701835, 9885.25860560461, 9905.10854023127, 9943.30396872212, 1071.132382769959, 1093.1364222264322, 1100.1363929315448, 1113.5357005537692, 1120.7198200449889, 5300.469953004746, 6290.716917738713, 6315.147455093595, 6345.302016778151, 6363.5863668861375, 26731.465370692476, 26900.730992689823, 27387.86306068497, 27401.0, 27850.72149278522, 25998.35004124874, 26008.34979125537, 26764.732352676612, 26780.196594101817, 26986.0, 12629.810552841898, 12630.179038362478, 12667.113302068767, 12821.35893205336, 12945.417456214493, 9774.169195618168, 9884.604615815575, 9922.40465572068, 9927.702168934944, 10072.899271007196, 22489.43776405603, 22511.887440563347, 22519.774802251766, 22719.09123635036, 23233.419164521023, 22912.885435572716, 23204.53590928138, 23268.53462930698, 23429.179978700664, 23485.76514234836, 12757.872421275668, 12996.350182490649, 13026.804597931228, 13044.869551304366, 13046.869531304565, 16212.756808648115, 16244.350225990827, 16273.104979226257, 16352.0, 16388.918055409646, 13197.20816750998, 13205.603831885059, 13231.0, 13345.799813002619, 13361.0, 12981.0, 13003.349832508147, 13106.803397949228, 13338.399772010476, 13443.0, 10740.677779666623, 11015.504302306575, 11024.779504409706, 11025.393603351893, 11052.944735276273, 8191.426600137933, 8307.127751586238, 8315.293200077818, 8331.625076871434, 8440.409171357946, 7485.1017877855, 7551.660175292015, 7582.62086895664, 7633.580153091633, 7730.342920851791], "value": 7756.862069183789, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.9856253593657, 586.9999999999999, 600.8377738010735, 611.3611276216354, 622.4087117238622, 6545.5599768051015, 6569.671516424178, 6588.275289718127, 6595.472362211023, 6633.502487313459, 6360.554761166709, 6382.712777924993, 6446.2264528256555, 6462.741490340381, 6513.869722605545, 5268.130758424855, 5281.9207711884355, 5333.57331413486, 5352.437994010631, 5353.357597088336, 5061.19020956647, 5166.9224961625605, 5298.496642818926, 5353.839384818461, 5356.517913387795, 5125.718085505296, 5141.717205553693, 5160.664556803796, 5161.535461808437, 5167.844964651048, 5071.213961835903, 5119.616028797836, 5163.432022477525, 5170.508801663836, 5202.141646628302, 4717.905641887178, 4723.338732577442, 4735.763211839394, 4735.928961065587, 4743.905121897577, 6433.678316084224, 6445.291017988017, 6475.093486911836, 6481.254655714559, 6481.83795405114, 6185.948388773919, 6210.96894515529, 6221.377862213788, 6224.751009959597, 6239.87520249597, 6918.481113916477, 6934.410575101122, 6939.410150137244, 6950.3049695030595, 6969.58182509046, 5104.744762761884, 5304.761285742113, 5309.88492416593, 5318.202269659543, 5323.281357016792, 7093.432525398008, 7157.3200545948575, 7220.5667659940045, 7257.201707812189, 7259.0, 5450.863728406822, 5460.426655201226, 5468.28912241414, 5489.313835770528, 5504.614676972654, 5453.318335208099, 5476.698781567052, 5526.198701188305, 5531.778728850801, 5551.861203469864, 6044.667543285162, 6084.726187321581, 6089.360617135137, 6093.2078829751845, 6121.816345509642, 6894.517973529525, 6952.5480843745, 6966.512344135862, 7000.194977577542, 7050.118735158106, 1845.4832646858902, 1862.7392165096626, 1879.1731638079202, 1887.5564242403025, 1903.8572107092023, 1303.4720938020116, 1345.2601069411785, 1350.2236214176887, 1357.8710022547841, 1361.0200655528201, 6420.839479012969, 6484.383983521558, 6490.318516555788, 6506.739730410731, 6590.505712071614, 6986.685599148051, 7021.719131234693, 7075.115610548682, 7118.857622847514, 7135.429165666734, 6493.902591461132, 6532.967335163294, 6593.142891424084, 6593.14289142418, 6638.4357329626555, 3721.3673675475234, 3748.269087527906, 3765.134019175605, 3770.4155855842387, 3792.7294356390366, 7267.491275610762, 7269.818254543573, 7275.199728029913, 7301.744438944612, 7310.52481588695, 7188.460865435113, 7219.819504512429, 7267.854642907112, 7333.156686981066, 7349.63251837406, 7278.672459739324, 7313.963430182815, 7331.816704582321, 7356.439007815189, 7371.152317483558, 7118.216996130318, 7150.249223831423, 7158.785236442915, 7164.713411463692, 7181.0, 6950.756723514653, 6997.545159564612, 7004.439644828503, 7014.824629384306, 7046.577205367695, 7160.248173941661, 7203.235207374227, 7204.586463534774, 7246.5289756165685, 7293.452991025801, 5399.4060653327315, 5428.131498960148, 5435.782568697366, 5469.3983661797965, 5474.698891561003, 6896.448284137156, 6977.825554361181, 7108.751193708195, 7117.4661900358715, 7122.18094919091, 6661.533692641662, 6762.49281303914, 6835.7949261522235, 6860.6912688930115, 6878.27778083294, 6705.530612857053, 6787.457003439614, 6791.762288319885, 6824.986628944374, 6863.142107236596, 6619.0, 6654.633995130314, 6691.76578819739, 6803.285655006153, 6823.624700641512, 6847.691853866688, 6915.098347954353, 6939.375456208965, 6953.79138625842, 6956.886898096483, 6658.234303055017, 6710.966445167743, 6763.898541521783, 6781.355771201728, 6817.216020157745], "value": 5422.121586831183, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [982.6511588386119, 1025.4565080507332, 1027.876654801424, 1041.5000799616184, 1047.5233768635271, 20894.37316880494, 21429.249976250834, 21479.892600537016, 21502.354929352125, 21569.24507642229, 19175.61648767027, 19328.130234139462, 19355.419337419866, 19384.806151938476, 20201.797982020176, 1052.195070770863, 1077.2674581284762, 1077.5582011375338, 1077.6874706335154, 1078.8112080385902, 1065.2277099103128, 1091.0, 1091.372460835023, 1092.9508172132234, 1093.103655002898, 1150.4650337593018, 1153.1121036801658, 1153.3829401270323, 1154.8845115488425, 1155.3183621663218, 1133.2180795251334, 1142.7257458210054, 1143.679769664491, 1144.7481554058095, 1145.8281257811311, 837.4556538250187, 847.3475423923544, 850.553459433796, 852.5353682243131, 852.5779739029158, 21503.247386341558, 22102.447438813997, 22237.555248895093, 22398.888005559867, 22553.436164095863, 23454.76545234543, 23464.0, 23907.760922390728, 23954.520909581886, 24089.397765055837, 16494.75257871133, 16560.50318490447, 16639.33442662292, 16724.916375418168, 16729.749053764204, 3861.9227615447535, 4131.091159944807, 4159.750414975111, 4160.313548264563, 4165.333546632524, 149305.0, 152412.0, 164484.17757911253, 165625.0, 170430.0, 18570.164342604614, 19034.714479282822, 19101.140448679842, 19300.32448864283, 19336.8066319335, 34892.47661285083, 36568.45147322792, 36674.0, 36765.63234367622, 36783.4482482763, 9831.80336393268, 9912.454814985245, 10008.64969726056, 10030.097291243823, 10098.343607665478, 4503.774811259489, 4632.606228470618, 4633.721976681342, 4639.30410438437, 4645.512221216791, 6303.212098487689, 6346.492280617539, 6399.616023038632, 6403.775867844603, 6427.871442571216, 1246.7132559511363, 1248.5879659712273, 1272.332025686522, 1272.3828942962655, 1272.6054922973908, 680.4148432348177, 701.8771714949863, 705.7388766156453, 712.5510928115255, 715.3132992327425, 12834.55079072228, 13157.736845263042, 13534.59396218115, 14052.086614370033, 14069.85930140706, 679.7960611816435, 695.4332219241302, 698.4098436820879, 709.4111887133666, 713.2688993781312, 6153.8461538461, 6179.0, 6180.165677633462, 6259.6870156492, 6323.30443651198, 141324.0, 141830.2908485451, 142574.72275831742, 143375.2831235837, 145716.27141864222, 130409.0, 131833.0, 133032.0, 135543.0, 135630.0, 105999.99999999846, 106395.0, 106626.0, 106685.0, 109168.0, 11497.252678575866, 11661.708457288636, 11949.402529873645, 12024.33866137371, 12095.879041209475, 56650.43349566452, 56852.0, 57523.71238143783, 57830.13254801097, 57975.0, 70754.29245707682, 71134.64432677804, 71465.0, 72341.0, 73754.26245737688, 16530.338786448407, 16785.32858685639, 16862.325506980073, 16920.15399230009, 16945.0, 16940.068296243826, 16973.490795275666, 17239.31042758326, 17322.22050007778, 17430.128493575525, 16632.417865374653, 16927.915360423118, 16930.746038809673, 16968.66062678764, 16971.406000789913, 16836.915815420845, 17029.148542573068, 17046.232919518898, 17101.914490427967, 17178.742318864977, 16743.07913064793, 17103.743443848103, 17193.14034298255, 17233.39683111085, 17281.39515116965, 11984.940075299568, 12105.455254513745, 12156.149069565046, 12450.75098498043, 12566.057545683927, 12809.743805123659, 12891.548795792101, 12899.290539020443, 12932.935335323264, 13167.67080822987], "value": 9927.236450214508, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1373.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 106.0, 106.0, 105.0, 105.0, 108.0, 105.0, 105.0, 105.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 113.0, 113.0, 114.0, 144.0, 110.0, 113.0, 110.0, 137.0], "value": 117.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 162.0, 163.0, 163.0, 161.0, 163.0, 165.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 73.0, 74.0, 75.0, 73.0, 76.0, 73.0, 84.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 77.0, 77.0, 78.0, 78.0, 77.0, 77.0, 77.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 111.0, 115.0, 114.0, 113.0, 114.0, 116.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 149.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 95.0, 93.0, 94.0, 94.0, 94.0, 96.0, 97.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 44.0, 47.0, 45.0, 45.0, 45.0, 43.0, 46.0, 43.0, 43.0], "value": 45.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 46.0, 46.0, 46.0, 47.0, 47.0, 46.0, 46.0, 46.0, 46.0], "value": 46.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 68.0, 73.0, 68.0, 69.0, 70.0, 70.0, 69.0, 71.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 107.0, 113.0, 120.0, 102.0, 103.0, 100.0, 109.0, 106.0], "value": 107.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 155.0, 147.0, 151.0, 153.0, 154.0, 153.0, 143.0, 146.0, 144.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 61.0, 57.0, 59.0, 59.0, 60.0, 58.0, 69.0, 58.0], "value": 59.9, "unit": "score"}]}]} 19:58:26 INFO - Return code: 0 19:58:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:58:26 INFO - # TBPL SUCCESS # 19:58:26 INFO - Running post-action listener: _package_coverage_data 19:58:26 INFO - Running post-action listener: _resource_record_post_action 19:58:26 INFO - [mozharness: 2017-10-12 02:58:26.752202Z] Finished run-tests step (success) 19:58:26 INFO - Running post-run listener: _resource_record_post_run 19:58:26 INFO - Total resource usage - Wall time: 1181s; CPU: 13.0%; Read bytes: 81920; Write bytes: 376406016; Read time: 252; Write time: 176360 19:58:26 INFO - TinderboxPrint: CPU usage
13.0% 19:58:26 INFO - TinderboxPrint: I/O read bytes / time
81,920 / 252 19:58:26 INFO - TinderboxPrint: I/O write bytes / time
376,406,016 / 176,360 19:58:26 INFO - TinderboxPrint: CPU idle
8,187.6 (86.9%) 19:58:26 INFO - TinderboxPrint: CPU user
1,179.1 (12.5%) 19:58:26 INFO - TinderboxPrint: Swap in / out
0 / 0 19:58:26 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 97619968; Read time: 0; Write time: 66364 19:58:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:58:26 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 81920; Write bytes: 278786048; Read time: 252; Write time: 109996 19:58:27 INFO - Running post-run listener: _upload_blobber_files 19:58:27 INFO - Blob upload gear active. 19:58:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:58:27 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 19:58:27 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'] 19:58:27 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 19:58:27 INFO - (blobuploader) - INFO - Open directory for files ... 19:58:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:58:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:58:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:58:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:58:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:58:28 INFO - (blobuploader) - INFO - Done attempting. 19:58:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:58:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:58:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:58:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:58:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:58:29 INFO - (blobuploader) - INFO - Done attempting. 19:58:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:58:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:58:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:58:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:58:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:58:30 INFO - (blobuploader) - INFO - Done attempting. 19:58:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:58:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:58:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:58:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:58:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:58:37 INFO - (blobuploader) - INFO - Done attempting. 19:58:37 INFO - (blobuploader) - INFO - Iteration through files over. 19:58:37 INFO - Return code: 0 19:58:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:58:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:58:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ad90fbb67a05345fcf831adf7e3cc4176b57162a82bfe3ea43955c0c8dec465def240c76b776bbd9914adb4e1c700ff9123c71ebc9f146501373f24777eef57d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/29aea40d9f00707c9d6c46992d5f9816d9e5d387819f239ff58f057c9b3052b331f7ace0f911c1a09872705e458832607534b94376f163a5ef74468f1980a36d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/238f94a7af527669e8c44c15f31a70ca7d52799ab9f4f8eb29722ec58de012cd4a63ffe3ab7c9008993353cb3e608c20527183bb809c3938ca43f5a09aca03a6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/782e56f64704831b83f460d927b67fe360f073cd98cf525b3580615a884213402bdc2dc66b671b5c25b446be0b11ec822534a6862824fce7379c695e1c757a12"} 19:58:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:58:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:58:37 INFO - Contents: 19:58:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ad90fbb67a05345fcf831adf7e3cc4176b57162a82bfe3ea43955c0c8dec465def240c76b776bbd9914adb4e1c700ff9123c71ebc9f146501373f24777eef57d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/29aea40d9f00707c9d6c46992d5f9816d9e5d387819f239ff58f057c9b3052b331f7ace0f911c1a09872705e458832607534b94376f163a5ef74468f1980a36d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/238f94a7af527669e8c44c15f31a70ca7d52799ab9f4f8eb29722ec58de012cd4a63ffe3ab7c9008993353cb3e608c20527183bb809c3938ca43f5a09aca03a6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/782e56f64704831b83f460d927b67fe360f073cd98cf525b3580615a884213402bdc2dc66b671b5c25b446be0b11ec822534a6862824fce7379c695e1c757a12"} 19:58:37 INFO - Running post-run listener: copy_logs_to_upload_dir 19:58:37 INFO - Copying logs to upload dir... 19:58:37 INFO - mkdir: /builds/slave/test/build/upload/logs 19:58:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.660330 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-10-11 19:58:37.088573) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-11 19:58:37.093507) ========= 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=6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ad90fbb67a05345fcf831adf7e3cc4176b57162a82bfe3ea43955c0c8dec465def240c76b776bbd9914adb4e1c700ff9123c71ebc9f146501373f24777eef57d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/29aea40d9f00707c9d6c46992d5f9816d9e5d387819f239ff58f057c9b3052b331f7ace0f911c1a09872705e458832607534b94376f163a5ef74468f1980a36d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/238f94a7af527669e8c44c15f31a70ca7d52799ab9f4f8eb29722ec58de012cd4a63ffe3ab7c9008993353cb3e608c20527183bb809c3938ca43f5a09aca03a6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/782e56f64704831b83f460d927b67fe360f073cd98cf525b3580615a884213402bdc2dc66b671b5c25b446be0b11ec822534a6862824fce7379c695e1c757a12"} build_url:https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/OpVO2stQRAyM3PPX6g7-Ew/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ad90fbb67a05345fcf831adf7e3cc4176b57162a82bfe3ea43955c0c8dec465def240c76b776bbd9914adb4e1c700ff9123c71ebc9f146501373f24777eef57d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/29aea40d9f00707c9d6c46992d5f9816d9e5d387819f239ff58f057c9b3052b331f7ace0f911c1a09872705e458832607534b94376f163a5ef74468f1980a36d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/238f94a7af527669e8c44c15f31a70ca7d52799ab9f4f8eb29722ec58de012cd4a63ffe3ab7c9008993353cb3e608c20527183bb809c3938ca43f5a09aca03a6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/782e56f64704831b83f460d927b67fe360f073cd98cf525b3580615a884213402bdc2dc66b671b5c25b446be0b11ec822534a6862824fce7379c695e1c757a12"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-11 19:58:37.122441) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 19:58:37.122755) ========= 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=6d15e502d8e29d5d2676d664000001c3-1507775881.461994-372751999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 19:58:37.207731) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-11 19:58:37.208010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-11 19:58:37.211295) ========= ========= Total master_lag: 0.27 =========