builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-078 starttime: 1505575039.1 results: success (0) revision: 55d0a2aa99de0d2f646cb6d2ab9026630de2d16b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 08:17:19.103026) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 08:17:19.103475) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 08:17:19.103758) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 08:17:19.247549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 08:17:19.247863) ========= 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=dac658600622fd96716c9acf000001b3-1505574700.378350-294110153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 08:17:19-- 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% 49.8M=0s 2017-09-16 08:17:19 (49.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114989 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 08:17:19.397165) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 08:17:19.397440) ========= 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=dac658600622fd96716c9acf000001b3-1505574700.378350-294110153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020693 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 08:17:19.446731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 08:17:19.447070) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 55d0a2aa99de0d2f646cb6d2ab9026630de2d16b --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 55d0a2aa99de0d2f646cb6d2ab9026630de2d16b --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=dac658600622fd96716c9acf000001b3-1505574700.378350-294110153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 08:17:19,761 truncating revision to first 12 chars 2017-09-16 08:17:19,761 Setting DEBUG logging. 2017-09-16 08:17:19,761 attempt 1/10 2017-09-16 08:17:19,761 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/55d0a2aa99de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 08:17:20,419 unpacking tar archive at: mozilla-beta-55d0a2aa99de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.941002 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 08:17:20.417067) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 08:17:20.417377) ========= script_repo_revision: 55d0a2aa99de0d2f646cb6d2ab9026630de2d16b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 08:17:20.418111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 08:17:20.418371) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 08:17:20.434327) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-16 08:17:20.434607) ========= /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=dac658600622fd96716c9acf000001b3-1505574700.378350-294110153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:17:20 INFO - MultiFileLogger online at 20170916 08:17:20 in /builds/slave/test 08:17:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 08:17:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:17:20 INFO - {'append_to_log': False, 08:17:20 INFO - 'base_work_dir': '/builds/slave/test', 08:17:20 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 08:17:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:17:20 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 08:17:20 INFO - 'buildbot_json_path': 'buildprops.json', 08:17:20 INFO - 'code_coverage': False, 08:17:20 INFO - 'config_files': ('talos/linux_config.py',), 08:17:20 INFO - 'default_actions': ('clobber', 08:17:20 INFO - 'read-buildbot-config', 08:17:20 INFO - 'download-and-extract', 08:17:20 INFO - 'populate-webroot', 08:17:20 INFO - 'create-virtualenv', 08:17:20 INFO - 'install', 08:17:20 INFO - 'setup-mitmproxy', 08:17:20 INFO - 'run-tests'), 08:17:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:17:20 INFO - 'disable_ccov_upload': False, 08:17:20 INFO - 'disable_stylo': False, 08:17:20 INFO - 'download_minidump_stackwalk': True, 08:17:20 INFO - 'download_symbols': 'ondemand', 08:17:20 INFO - 'enable_stylo': False, 08:17:20 INFO - 'enable_webrender': False, 08:17:20 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 08:17:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:17:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:17:20 INFO - 'gecko_profile': False, 08:17:20 INFO - 'gecko_profile_interval': 0, 08:17:20 INFO - 'installer_path': 'installer.exe', 08:17:20 INFO - 'log_level': 'info', 08:17:20 INFO - 'log_name': 'talos', 08:17:20 INFO - 'log_to_console': True, 08:17:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:17:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:17:20 INFO - 'opt_config_files': (), 08:17:20 INFO - 'pip_index': False, 08:17:20 INFO - 'suite': 'dromaeojs-e10s', 08:17:20 INFO - 'system_bits': '32', 08:17:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:17:20 INFO - 'title': 'talos-linux64-ix-078', 08:17:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:17:20 INFO - 'use_talos_json': True, 08:17:20 INFO - 'verify': 'False', 08:17:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:17:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:17:20 INFO - 'work_dir': 'build'} 08:17:20 INFO - [mozharness: 2017-09-16 15:17:20.993756Z] Running clobber step. 08:17:20 INFO - Running pre-action listener: _resource_record_pre_action 08:17:20 INFO - Running main action method: clobber 08:17:20 INFO - rmtree: /builds/slave/test/build 08:17:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:17:21 INFO - Running post-action listener: _resource_record_post_action 08:17:21 INFO - [mozharness: 2017-09-16 15:17:21.965345Z] Finished clobber step (success) 08:17:21 INFO - [mozharness: 2017-09-16 15:17:21.965442Z] Running read-buildbot-config step. 08:17:21 INFO - Running pre-action listener: _resource_record_pre_action 08:17:21 INFO - Running main action method: read_buildbot_config 08:17:21 INFO - Using buildbot properties: 08:17:21 INFO - { 08:17:21 INFO - "project": "", 08:17:21 INFO - "product": "firefox", 08:17:21 INFO - "who": "raliiev@mozilla.com", 08:17:21 INFO - "installer_path": "public/build/target.tar.bz2", 08:17:21 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:17:21 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 08:17:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 08:17:21 INFO - "stage_platform": "linux64", 08:17:21 INFO - "basedir": "/builds/slave/test", 08:17:21 INFO - "buildnumber": 88, 08:17:21 INFO - "platform": "ubuntu64_hw", 08:17:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:17:21 INFO - "slavebuilddir": "test", 08:17:21 INFO - "taskId": "JQu4FbfyRZaQNF7cdxZKWg", 08:17:21 INFO - "branch": "mozilla-beta", 08:17:21 INFO - "script_repo_revision": "production", 08:17:21 INFO - "revision": "55d0a2aa99de0d2f646cb6d2ab9026630de2d16b", 08:17:21 INFO - "slavename": "talos-linux64-ix-078", 08:17:21 INFO - "repo_path": "releases/mozilla-beta" 08:17:21 INFO - } 08:17:21 INFO - Finding installer, test and symbols from parent task. 08:17:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JQu4FbfyRZaQNF7cdxZKWg'}, attempt #1 08:17:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JQu4FbfyRZaQNF7cdxZKWg'}, attempt #1 08:17:22 INFO - Task dependencies: Z862lKMWTPqPl_vfofmXeQ 08:17:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ'}, attempt #1 08:17:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.tar.bz2 08:17:23 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.test_packages.json 08:17:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.crashreporter-symbols.zip 08:17:23 INFO - Running post-action listener: _resource_record_post_action 08:17:23 INFO - [mozharness: 2017-09-16 15:17:23.319295Z] Finished read-buildbot-config step (success) 08:17:23 INFO - [mozharness: 2017-09-16 15:17:23.319511Z] Running download-and-extract step. 08:17:23 INFO - Running pre-action listener: _resource_record_pre_action 08:17:23 INFO - Running main action method: download_and_extract 08:17:23 INFO - mkdir: /builds/slave/test/build/tests 08:17: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')]} 08:17:23 INFO - trying https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.test_packages.json 08:17:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:17:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:17:23 INFO - Downloaded 989 bytes. 08:17:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:17:23 INFO - Using the following test package requirements: 08:17:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:17:23 INFO - u'common': [u'target.common.tests.zip'], 08:17:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:17:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:17:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:17:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:17:23 INFO - u'mozbase': [u'target.common.tests.zip'], 08:17:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:17:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:17:23 INFO - u'web-platform': [u'target.common.tests.zip', 08:17:23 INFO - u'target.web-platform.tests.tar.gz'], 08:17:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:17:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 08:17:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.common.tests.zip 08:17:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:17:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.common.tests.zip into memory 08:17:26 INFO - Content-Length response header: 55168862 08:17:26 INFO - Bytes received: 55168862 08:17:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.talos.tests.zip 08:17:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:17:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.talos.tests.zip into memory 08:17:38 INFO - Content-Length response header: 14500356 08:17:38 INFO - Bytes received: 14500356 08:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:38 INFO - trying https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.tar.bz2 08:17:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:17:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:17:40 INFO - Downloaded 53228962 bytes. 08:17:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.tar.bz2 08:17:40 INFO - mkdir: /builds/slave/test/properties 08:17:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:17:40 INFO - Writing to file /builds/slave/test/properties/build_url 08:17:40 INFO - Contents: 08:17:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.tar.bz2 08:17:40 INFO - Running post-action listener: _resource_record_post_action 08:17:40 INFO - Running post-action listener: find_tests_for_verification 08:17:40 INFO - Running post-action listener: set_extra_try_arguments 08:17:40 INFO - [mozharness: 2017-09-16 15:17:40.662270Z] Finished download-and-extract step (success) 08:17:40 INFO - [mozharness: 2017-09-16 15:17:40.662422Z] Running populate-webroot step. 08:17:40 INFO - Running pre-action listener: _resource_record_pre_action 08:17:40 INFO - Running main action method: populate_webroot 08:17:40 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:17:40 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:17:40 INFO - 'tests': ['tresize', 08:17:40 INFO - 'tcanvasmark']}, 08:17:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:17:40 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:17:40 INFO - 'tests': ['dromaeo_css', 08:17:40 INFO - 'kraken']}, 08:17:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:17:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:17:40 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:17:40 INFO - 'talos_options': ['--disable-stylo'], 08:17:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:17:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:17:40 INFO - 'tests': ['damp', 'tps']}, 08:17:40 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:17:40 INFO - 'talos_options': ['--disable-stylo'], 08:17:40 INFO - 'tests': ['damp', 'tps']}, 08:17:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:17:40 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:17:40 INFO - 'tests': ['dromaeo_dom']}, 08:17:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:17:40 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:17:40 INFO - 'tests': ['basic_compositor_video', 08:17:40 INFO - 'glvideo']}, 08:17:40 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:17:40 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:17:40 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:17:40 INFO - 'talos_options': ['--disable-stylo'], 08:17:40 INFO - 'tests': ['ts_paint_webext', 08:17:40 INFO - 'tp5o_webext']}, 08:17:40 INFO - 'other-e10s': {'tests': ['a11yr', 08:17:40 INFO - 'ts_paint', 08:17:40 INFO - 'tpaint', 08:17:40 INFO - 'sessionrestore', 08:17:40 INFO - 'sessionrestore_many_windows', 08:17:40 INFO - 'sessionrestore_no_auto_restore', 08:17:40 INFO - 'tabpaint']}, 08:17:40 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:17:40 INFO - 'tests': ['a11yr', 08:17:40 INFO - 'ts_paint', 08:17:40 INFO - 'tpaint', 08:17:40 INFO - 'sessionrestore', 08:17:40 INFO - 'sessionrestore_many_windows', 08:17:40 INFO - 'sessionrestore_no_auto_restore', 08:17:40 INFO - 'tabpaint']}, 08:17:40 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:17:40 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:17:40 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:17:40 INFO - 'tests': ['bloom_basic_singleton']}, 08:17:40 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:17:40 INFO - 'tests': ['bloom_basic']}, 08:17:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:17:40 INFO - 'tsvgr_opacity', 08:17:40 INFO - 'tart', 08:17:40 INFO - 'tscrollx', 08:17:40 INFO - 'tsvg_static']}, 08:17:40 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:17:40 INFO - 'tests': ['tsvgx', 08:17:40 INFO - 'tsvgr_opacity', 08:17:40 INFO - 'tart', 08:17:40 INFO - 'tscrollx', 08:17:40 INFO - 'tsvg_static']}, 08:17:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:17:40 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:17:40 INFO - 'talos_options': ['--disable-stylo'], 08:17:40 INFO - 'tests': ['tp5o']}, 08:17:40 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:17:40 INFO - 'talos_options': ['--mitmproxy', 08:17:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:17:40 INFO - '--firstNonBlankPaint'], 08:17:40 INFO - 'tests': ['tp6_google', 08:17:40 INFO - 'tp6_youtube', 08:17:40 INFO - 'tp6_amazon', 08:17:40 INFO - 'tp6_facebook']}, 08:17:40 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:17:40 INFO - 'talos_options': ['--disable-stylo', 08:17:40 INFO - '--mitmproxy', 08:17:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:17:40 INFO - '--firstNonBlankPaint'], 08:17:40 INFO - 'tests': ['tp6_google', 08:17:40 INFO - 'tp6_youtube', 08:17:40 INFO - 'tp6_amazon', 08:17:40 INFO - 'tp6_facebook']}, 08:17:40 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:17:40 INFO - 'talos_options': ['--stylo-threads=1', 08:17:40 INFO - '--mitmproxy', 08:17:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:17:40 INFO - '--firstNonBlankPaint'], 08:17:40 INFO - 'tests': ['tp6_google', 08:17:40 INFO - 'tp6_youtube', 08:17:40 INFO - 'tp6_amazon', 08:17:40 INFO - 'tp6_facebook']}, 08:17:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:17:40 INFO - 'talos_options': ['--xperf_path', 08:17:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:17:40 INFO - 'tests': ['tp5n']}, 08:17:40 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:17:40 INFO - 'talos_options': ['--disable-stylo', 08:17:40 INFO - '--xperf_path', 08:17:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:17:40 INFO - 'tests': ['tp5n']}}} 08:17:40 INFO - Running post-action listener: _resource_record_post_action 08:17:40 INFO - [mozharness: 2017-09-16 15:17:40.679222Z] Finished populate-webroot step (success) 08:17:40 INFO - [mozharness: 2017-09-16 15:17:40.679311Z] Running create-virtualenv step. 08:17:40 INFO - Running pre-action listener: _resource_record_pre_action 08:17:40 INFO - Running main action method: create_virtualenv 08:17:40 INFO - Creating virtualenv /builds/slave/test/build/venv 08:17:40 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:17:40 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:17:40 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:17:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:17:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:17:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:17:41 INFO - Installing pip...............done. 08:17:41 INFO - Return code: 0 08:17:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:17:42 INFO - Reading from file tmpfile_stdout 08:17:42 INFO - Output received: 08:17:42 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 08:17:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:42 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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504090>, '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 0x2504d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fef90>, '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': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:17:42 INFO - Using env: {'DISPLAY': ':0', 08:17:42 INFO - 'HOME': '/home/cltbld', 08:17:42 INFO - 'LANG': 'en_US.UTF-8', 08:17:42 INFO - 'LANGUAGE': 'en_US:en', 08:17:42 INFO - 'LOGNAME': 'cltbld', 08:17:42 INFO - 'MAIL': '/var/mail/cltbld', 08:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:42 INFO - 'MOZ_NO_REMOTE': '1', 08:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:42 INFO - 'NO_EM_RESTART': '1', 08:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:42 INFO - 'PWD': '/builds/slave/test', 08:17:42 INFO - 'SHELL': '/bin/bash', 08:17:42 INFO - 'SHLVL': '1', 08:17:42 INFO - 'TERM': 'linux', 08:17:42 INFO - 'TMOUT': '86400', 08:17:42 INFO - 'USER': 'cltbld', 08:17:42 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 08:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:42 INFO - '_': '/tools/buildbot/bin/python'} 08:17:43 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:17:43 INFO - Downloading/unpacking pip>=1.5 08:17:43 INFO - Running setup.py egg_info for package pip 08:17:43 INFO - warning: no files found matching 'pip/cacert.pem' 08:17:43 INFO - warning: no files found matching '*.html' under directory 'docs' 08:17:43 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:17:43 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:17:43 INFO - Installing collected packages: pip 08:17:43 INFO - Found existing installation: pip 1.1 08:17:43 INFO - Uninstalling pip: 08:17:43 INFO - Successfully uninstalled pip 08:17:43 INFO - Running setup.py install for pip 08:17:43 INFO - warning: no files found matching 'pip/cacert.pem' 08:17:43 INFO - warning: no files found matching '*.html' under directory 'docs' 08:17:43 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:17:43 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:17:43 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:17:43 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:17:43 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:17:43 INFO - Successfully installed pip 08:17:43 INFO - Cleaning up... 08:17:43 INFO - Return code: 0 08:17:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:43 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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504090>, '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 0x2504d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fef90>, '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': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:17:43 INFO - Using env: {'DISPLAY': ':0', 08:17:43 INFO - 'HOME': '/home/cltbld', 08:17:43 INFO - 'LANG': 'en_US.UTF-8', 08:17:43 INFO - 'LANGUAGE': 'en_US:en', 08:17:43 INFO - 'LOGNAME': 'cltbld', 08:17:43 INFO - 'MAIL': '/var/mail/cltbld', 08:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:43 INFO - 'MOZ_NO_REMOTE': '1', 08:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:43 INFO - 'NO_EM_RESTART': '1', 08:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:43 INFO - 'PWD': '/builds/slave/test', 08:17:43 INFO - 'SHELL': '/bin/bash', 08:17:43 INFO - 'SHLVL': '1', 08:17:43 INFO - 'TERM': 'linux', 08:17:43 INFO - 'TMOUT': '86400', 08:17:43 INFO - 'USER': 'cltbld', 08:17:43 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 08:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:43 INFO - '_': '/tools/buildbot/bin/python'} 08:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:44 INFO - Downloading/unpacking psutil>=3.1.1 08:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:17:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:45 INFO - Installing collected packages: psutil 08:17:45 INFO - Running setup.py install for psutil 08:17:45 INFO - building 'psutil._psutil_linux' extension 08:17:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:17:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:17:46 INFO - building 'psutil._psutil_posix' extension 08:17:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:17:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:17:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:46 INFO - Successfully installed psutil 08:17:46 INFO - Cleaning up... 08:17:46 INFO - Return code: 0 08:17:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:46 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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504090>, '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 0x2504d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fef90>, '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': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:17:46 INFO - Using env: {'DISPLAY': ':0', 08:17:46 INFO - 'HOME': '/home/cltbld', 08:17:46 INFO - 'LANG': 'en_US.UTF-8', 08:17:46 INFO - 'LANGUAGE': 'en_US:en', 08:17:46 INFO - 'LOGNAME': 'cltbld', 08:17:46 INFO - 'MAIL': '/var/mail/cltbld', 08:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:46 INFO - 'MOZ_NO_REMOTE': '1', 08:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:46 INFO - 'NO_EM_RESTART': '1', 08:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:46 INFO - 'PWD': '/builds/slave/test', 08:17:46 INFO - 'SHELL': '/bin/bash', 08:17:46 INFO - 'SHLVL': '1', 08:17:46 INFO - 'TERM': 'linux', 08:17:46 INFO - 'TMOUT': '86400', 08:17:46 INFO - 'USER': 'cltbld', 08:17:46 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 08:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:46 INFO - '_': '/tools/buildbot/bin/python'} 08:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:17:48 INFO - Installing collected packages: mozsystemmonitor 08:17:48 INFO - Running setup.py install for mozsystemmonitor 08:17:48 INFO - Successfully installed mozsystemmonitor 08:17:48 INFO - Cleaning up... 08:17:48 INFO - Return code: 0 08:17:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:48 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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504090>, '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 0x2504d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fef90>, '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': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:17:48 INFO - Using env: {'DISPLAY': ':0', 08:17:48 INFO - 'HOME': '/home/cltbld', 08:17:48 INFO - 'LANG': 'en_US.UTF-8', 08:17:48 INFO - 'LANGUAGE': 'en_US:en', 08:17:48 INFO - 'LOGNAME': 'cltbld', 08:17:48 INFO - 'MAIL': '/var/mail/cltbld', 08:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:48 INFO - 'MOZ_NO_REMOTE': '1', 08:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:48 INFO - 'NO_EM_RESTART': '1', 08:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:48 INFO - 'PWD': '/builds/slave/test', 08:17:48 INFO - 'SHELL': '/bin/bash', 08:17:48 INFO - 'SHLVL': '1', 08:17:48 INFO - 'TERM': 'linux', 08:17:48 INFO - 'TMOUT': '86400', 08:17:48 INFO - 'USER': 'cltbld', 08:17:48 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 08:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:48 INFO - '_': '/tools/buildbot/bin/python'} 08:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:49 INFO - Downloading/unpacking jsonschema==2.5.1 08:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:17:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:50 INFO - Downloading functools32-3.2.3-2.tar.gz 08:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:17:50 INFO - warning: no files found matching '*.txt' 08:17:50 INFO - no previously-included directories found matching 'build' 08:17:50 INFO - no previously-included directories found matching 'dist' 08:17:50 INFO - no previously-included directories found matching '.git*' 08:17:50 INFO - Installing collected packages: jsonschema, functools32 08:17:50 INFO - Running setup.py install for functools32 08:17:50 INFO - warning: no files found matching '*.txt' 08:17:50 INFO - no previously-included directories found matching 'build' 08:17:50 INFO - no previously-included directories found matching 'dist' 08:17:50 INFO - no previously-included directories found matching '.git*' 08:17:50 INFO - Successfully installed jsonschema functools32 08:17:50 INFO - Cleaning up... 08:17:50 INFO - Return code: 0 08:17:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:50 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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504090>, '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 0x2504d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fef90>, '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': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:17:50 INFO - Using env: {'DISPLAY': ':0', 08:17:50 INFO - 'HOME': '/home/cltbld', 08:17:50 INFO - 'LANG': 'en_US.UTF-8', 08:17:50 INFO - 'LANGUAGE': 'en_US:en', 08:17:50 INFO - 'LOGNAME': 'cltbld', 08:17:50 INFO - 'MAIL': '/var/mail/cltbld', 08:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:50 INFO - 'MOZ_NO_REMOTE': '1', 08:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:50 INFO - 'NO_EM_RESTART': '1', 08:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:50 INFO - 'PWD': '/builds/slave/test', 08:17:50 INFO - 'SHELL': '/bin/bash', 08:17:50 INFO - 'SHLVL': '1', 08:17:50 INFO - 'TERM': 'linux', 08:17:50 INFO - 'TMOUT': '86400', 08:17:50 INFO - 'USER': 'cltbld', 08:17:50 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 08:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:50 INFO - '_': '/tools/buildbot/bin/python'} 08:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:17:50 INFO - Cleaning up... 08:17:50 INFO - Return code: 0 08:17:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:50 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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504090>, '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 0x2504d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fef90>, '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': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:17:50 INFO - Using env: {'DISPLAY': ':0', 08:17:50 INFO - 'HOME': '/home/cltbld', 08:17:50 INFO - 'LANG': 'en_US.UTF-8', 08:17:50 INFO - 'LANGUAGE': 'en_US:en', 08:17:50 INFO - 'LOGNAME': 'cltbld', 08:17:50 INFO - 'MAIL': '/var/mail/cltbld', 08:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:50 INFO - 'MOZ_NO_REMOTE': '1', 08:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:50 INFO - 'NO_EM_RESTART': '1', 08:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:50 INFO - 'PWD': '/builds/slave/test', 08:17:50 INFO - 'SHELL': '/bin/bash', 08:17:50 INFO - 'SHLVL': '1', 08:17:50 INFO - 'TERM': 'linux', 08:17:50 INFO - 'TMOUT': '86400', 08:17:50 INFO - 'USER': 'cltbld', 08:17:50 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 08:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:50 INFO - '_': '/tools/buildbot/bin/python'} 08:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:51 INFO - Downloading/unpacking blobuploader==1.2.4 08:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:17:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:17:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:52 INFO - Downloading docopt-0.6.1.tar.gz 08:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:17:52 INFO - Installing collected packages: blobuploader, requests, docopt 08:17:52 INFO - Running setup.py install for blobuploader 08:17:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:17:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:17:52 INFO - Running setup.py install for requests 08:17:53 INFO - Running setup.py install for docopt 08:17:53 INFO - Successfully installed blobuploader requests docopt 08:17:53 INFO - Cleaning up... 08:17:53 INFO - Return code: 0 08:17:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504090>, '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 0x2504d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fef90>, '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': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:17:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:17:53 INFO - Using env: {'DISPLAY': ':0', 08:17:53 INFO - 'HOME': '/home/cltbld', 08:17:53 INFO - 'LANG': 'en_US.UTF-8', 08:17:53 INFO - 'LANGUAGE': 'en_US:en', 08:17:53 INFO - 'LOGNAME': 'cltbld', 08:17:53 INFO - 'MAIL': '/var/mail/cltbld', 08:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:53 INFO - 'MOZ_NO_REMOTE': '1', 08:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:53 INFO - 'NO_EM_RESTART': '1', 08:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:53 INFO - 'PWD': '/builds/slave/test', 08:17:53 INFO - 'SHELL': '/bin/bash', 08:17:53 INFO - 'SHLVL': '1', 08:17:53 INFO - 'TERM': 'linux', 08:17:53 INFO - 'TMOUT': '86400', 08:17:53 INFO - 'USER': 'cltbld', 08:17:53 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 08:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:53 INFO - '_': '/tools/buildbot/bin/python'} 08:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:53 INFO - Running setup.py (path:/tmp/pip-aDO0h9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:53 INFO - Running setup.py (path:/tmp/pip-_J6_rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:53 INFO - Running setup.py (path:/tmp/pip-QNILxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:53 INFO - Running setup.py (path:/tmp/pip-LBXMaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:53 INFO - Running setup.py (path:/tmp/pip-GM4OPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:53 INFO - Running setup.py (path:/tmp/pip-SbmYwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:53 INFO - Running setup.py (path:/tmp/pip-dxCm9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:54 INFO - Running setup.py (path:/tmp/pip-We3XXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:54 INFO - Running setup.py (path:/tmp/pip-7cSuzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:54 INFO - Running setup.py (path:/tmp/pip-AjOI8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:54 INFO - Running setup.py (path:/tmp/pip-lwJaug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:54 INFO - Running setup.py (path:/tmp/pip-ek9_ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:54 INFO - Running setup.py (path:/tmp/pip-WCn_FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:54 INFO - Running setup.py (path:/tmp/pip-Il_Npf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:54 INFO - Running setup.py (path:/tmp/pip-AYda_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:54 INFO - Running setup.py (path:/tmp/pip-VqmBUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:54 INFO - Running setup.py (path:/tmp/pip-7Ogurd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:17:54 INFO - Running setup.py install for manifestparser 08:17:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:17:54 INFO - Running setup.py install for mozcrash 08:17:54 INFO - Running setup.py install for mozdebug 08:17:55 INFO - Running setup.py install for mozdevice 08:17:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:17:55 INFO - Running setup.py install for mozfile 08:17:55 INFO - Running setup.py install for mozhttpd 08:17:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:17:55 INFO - Running setup.py install for mozinfo 08:17:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:17:55 INFO - Running setup.py install for mozInstall 08:17:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:17:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:17:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:17:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:17:55 INFO - Running setup.py install for mozleak 08:17:55 INFO - Running setup.py install for mozlog 08:17:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:17:55 INFO - Running setup.py install for moznetwork 08:17:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:17:55 INFO - Running setup.py install for mozprocess 08:17:55 INFO - Running setup.py install for mozprofile 08:17:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:17:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:17:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:17:56 INFO - Running setup.py install for mozrunner 08:17:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:17:56 INFO - Running setup.py install for mozscreenshot 08:17:56 INFO - Running setup.py install for moztest 08:17:56 INFO - Running setup.py install for mozversion 08:17:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:17:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:17:56 INFO - Cleaning up... 08:17:56 INFO - Return code: 0 08:17:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:56 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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504090>, '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 0x2504d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fef90>, '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': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:17:56 INFO - Using env: {'DISPLAY': ':0', 08:17:56 INFO - 'HOME': '/home/cltbld', 08:17:56 INFO - 'LANG': 'en_US.UTF-8', 08:17:56 INFO - 'LANGUAGE': 'en_US:en', 08:17:56 INFO - 'LOGNAME': 'cltbld', 08:17:56 INFO - 'MAIL': '/var/mail/cltbld', 08:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:56 INFO - 'MOZ_NO_REMOTE': '1', 08:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:56 INFO - 'NO_EM_RESTART': '1', 08:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:56 INFO - 'PWD': '/builds/slave/test', 08:17:56 INFO - 'SHELL': '/bin/bash', 08:17:56 INFO - 'SHLVL': '1', 08:17:56 INFO - 'TERM': 'linux', 08:17:56 INFO - 'TMOUT': '86400', 08:17:56 INFO - 'USER': 'cltbld', 08:17:56 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 08:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:56 INFO - '_': '/tools/buildbot/bin/python'} 08:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:56 INFO - Running setup.py (path:/tmp/pip-ScKlaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:56 INFO - Running setup.py (path:/tmp/pip-aA21rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:56 INFO - Running setup.py (path:/tmp/pip-SjiVfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:56 INFO - Running setup.py (path:/tmp/pip-VppTKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:57 INFO - Running setup.py (path:/tmp/pip-pzT1zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:57 INFO - Running setup.py (path:/tmp/pip-wli7B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:57 INFO - Running setup.py (path:/tmp/pip-iA77dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:57 INFO - Running setup.py (path:/tmp/pip-v0ufBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:57 INFO - Running setup.py (path:/tmp/pip-GrNI5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:57 INFO - Running setup.py (path:/tmp/pip-zxcVyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:57 INFO - Running setup.py (path:/tmp/pip-B7Fzgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:57 INFO - Running setup.py (path:/tmp/pip-H3DC_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:57 INFO - Running setup.py (path:/tmp/pip-ExswzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:57 INFO - Running setup.py (path:/tmp/pip-xbIHJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:57 INFO - Running setup.py (path:/tmp/pip-6tnfVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:57 INFO - Running setup.py (path:/tmp/pip-4VYPf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:57 INFO - Running setup.py (path:/tmp/pip-jqeJTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:17:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:59 INFO - Downloading blessings-1.6.tar.gz 08:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:17:59 INFO - Installing collected packages: blessings 08:17:59 INFO - Running setup.py install for blessings 08:17:59 INFO - Successfully installed blessings 08:17:59 INFO - Cleaning up... 08:17:59 INFO - Return code: 0 08:17:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:17:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:59 INFO - Reading from file tmpfile_stdout 08:17:59 INFO - Current package versions: 08:17:59 INFO - argparse == 1.2.1 08:17:59 INFO - blessings == 1.6 08:17:59 INFO - blobuploader == 1.2.4 08:17:59 INFO - docopt == 0.6.1 08:17:59 INFO - functools32 == 3.2.3-2 08:17:59 INFO - jsonschema == 2.5.1 08:17:59 INFO - manifestparser == 1.1 08:17:59 INFO - mozInstall == 1.13 08:17:59 INFO - mozcrash == 1.0 08:17:59 INFO - mozdebug == 0.1 08:17:59 INFO - mozdevice == 0.51 08:17:59 INFO - mozfile == 1.2 08:17:59 INFO - mozhttpd == 0.7 08:17:59 INFO - mozinfo == 0.10 08:17:59 INFO - mozleak == 0.1 08:17:59 INFO - mozlog == 3.5 08:17:59 INFO - moznetwork == 0.27 08:17:59 INFO - mozprocess == 0.25 08:17:59 INFO - mozprofile == 0.28 08:17:59 INFO - mozrunner == 6.13 08:17:59 INFO - mozscreenshot == 0.1 08:17:59 INFO - mozsystemmonitor == 0.3 08:17:59 INFO - moztest == 0.8 08:17:59 INFO - mozversion == 1.4 08:17:59 INFO - psutil == 3.1.1 08:17:59 INFO - requests == 1.2.3 08:17:59 INFO - wsgiref == 0.1.2 08:17:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:59 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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504090>, '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 0x2504d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fef90>, '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': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:17:59 INFO - Using env: {'DISPLAY': ':0', 08:17:59 INFO - 'HOME': '/home/cltbld', 08:17:59 INFO - 'LANG': 'en_US.UTF-8', 08:17:59 INFO - 'LANGUAGE': 'en_US:en', 08:17:59 INFO - 'LOGNAME': 'cltbld', 08:17:59 INFO - 'MAIL': '/var/mail/cltbld', 08:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:59 INFO - 'MOZ_NO_REMOTE': '1', 08:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:59 INFO - 'NO_EM_RESTART': '1', 08:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:59 INFO - 'PWD': '/builds/slave/test', 08:17:59 INFO - 'SHELL': '/bin/bash', 08:17:59 INFO - 'SHLVL': '1', 08:17:59 INFO - 'TERM': 'linux', 08:17:59 INFO - 'TMOUT': '86400', 08:17:59 INFO - 'USER': 'cltbld', 08:17:59 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 08:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:59 INFO - '_': '/tools/buildbot/bin/python'} 08:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:17:59 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:18:00 INFO - Installing collected packages: simplejson 08:18:00 INFO - Running setup.py install for simplejson 08:18:01 INFO - building 'simplejson._speedups' extension 08:18:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 08:18:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 08:18:01 INFO - Successfully installed simplejson 08:18:01 INFO - Cleaning up... 08:18:02 INFO - Return code: 0 08:18:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2500a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504090>, '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 0x2504d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fef90>, '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': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:18:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:18:02 INFO - Using env: {'DISPLAY': ':0', 08:18:02 INFO - 'HOME': '/home/cltbld', 08:18:02 INFO - 'LANG': 'en_US.UTF-8', 08:18:02 INFO - 'LANGUAGE': 'en_US:en', 08:18:02 INFO - 'LOGNAME': 'cltbld', 08:18:02 INFO - 'MAIL': '/var/mail/cltbld', 08:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:02 INFO - 'MOZ_NO_REMOTE': '1', 08:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:02 INFO - 'NO_EM_RESTART': '1', 08:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:02 INFO - 'PWD': '/builds/slave/test', 08:18:02 INFO - 'SHELL': '/bin/bash', 08:18:02 INFO - 'SHLVL': '1', 08:18:02 INFO - 'TERM': 'linux', 08:18:02 INFO - 'TMOUT': '86400', 08:18:02 INFO - 'USER': 'cltbld', 08:18:02 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 08:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:02 INFO - '_': '/tools/buildbot/bin/python'} 08:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:18:02 INFO - Cleaning up... 08:18:02 INFO - Return code: 0 08:18:02 INFO - Running post-action listener: _resource_record_post_action 08:18:02 INFO - Running post-action listener: _start_resource_monitoring 08:18:02 INFO - Starting resource monitoring. 08:18:02 INFO - [mozharness: 2017-09-16 15:18:02.308269Z] Finished create-virtualenv step (success) 08:18:02 INFO - [mozharness: 2017-09-16 15:18:02.309216Z] Running install step. 08:18:02 INFO - Running pre-action listener: _resource_record_pre_action 08:18:02 INFO - Running main action method: install 08:18:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:18:02 INFO - Reading from file tmpfile_stdout 08:18:02 INFO - Detecting whether we're running mozinstall >=1.0... 08:18:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:18:02 INFO - Reading from file tmpfile_stdout 08:18:02 INFO - Output received: 08:18:02 INFO - Usage: mozinstall [options] installer 08:18:02 INFO - Options: 08:18:02 INFO - -h, --help show this help message and exit 08:18:02 INFO - -d DEST, --destination=DEST 08:18:02 INFO - Directory to install application into. [default: 08:18:02 INFO - "/builds/slave/test"] 08:18:02 INFO - --app=APP Application being installed. [default: firefox] 08:18:02 INFO - mkdir: /builds/slave/test/build/application 08:18:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:18:17 INFO - Reading from file tmpfile_stdout 08:18:17 INFO - Output received: 08:18:17 INFO - /builds/slave/test/build/application/firefox/firefox 08:18:17 INFO - Running post-action listener: _resource_record_post_action 08:18:17 INFO - [mozharness: 2017-09-16 15:18:17.285322Z] Finished install step (success) 08:18:17 INFO - [mozharness: 2017-09-16 15:18:17.285568Z] Running setup-mitmproxy step. 08:18:17 INFO - Running pre-action listener: _resource_record_pre_action 08:18:17 INFO - Running main action method: setup_mitmproxy 08:18:17 INFO - Skipping: mitmproxy is not required 08:18:17 INFO - Running post-action listener: _resource_record_post_action 08:18:17 INFO - [mozharness: 2017-09-16 15:18:17.286677Z] Finished setup-mitmproxy step (success) 08:18:17 INFO - [mozharness: 2017-09-16 15:18:17.286957Z] Running run-tests step. 08:18:17 INFO - Running pre-action listener: _resource_record_pre_action 08:18:17 INFO - Running pre-action listener: _set_gcov_prefix 08:18:17 INFO - Running main action method: run_tests 08:18:17 WARNING - Try message not found. 08:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:18:17 INFO - Python 2.7.3 08:18:17 INFO - Return code: 0 08:18:17 INFO - grabbing minidump binary from tooltool 08:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504090>, '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 0x2504d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:18:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:18:17 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:18:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:18:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:18:17 INFO - Return code: 0 08:18:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:18:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:18:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:18:17 INFO - ENV: RUST_BACKTRACE is now full 08:18:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:18:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-078 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:18:17 INFO - Using env: {'DISPLAY': ':0', 08:18:17 INFO - 'HOME': '/home/cltbld', 08:18:17 INFO - 'LANG': 'en_US.UTF-8', 08:18:17 INFO - 'LANGUAGE': 'en_US:en', 08:18:17 INFO - 'LOGNAME': 'cltbld', 08:18:17 INFO - 'MAIL': '/var/mail/cltbld', 08:18:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:18:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:17 INFO - 'MOZ_NO_REMOTE': '1', 08:18:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:17 INFO - 'NO_EM_RESTART': '1', 08:18:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:17 INFO - 'PWD': '/builds/slave/test', 08:18:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:18:17 INFO - 'RUST_BACKTRACE': 'full', 08:18:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:18:17 INFO - 'SHELL': '/bin/bash', 08:18:17 INFO - 'SHLVL': '1', 08:18:17 INFO - 'TERM': 'linux', 08:18:17 INFO - 'TMOUT': '86400', 08:18:17 INFO - 'USER': 'cltbld', 08:18:17 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 08:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:17 INFO - '_': '/tools/buildbot/bin/python'} 08:18:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:18:17 INFO - mozversion application_buildid: 20170916140111 08:18:17 INFO - mozversion application_changeset: 55d0a2aa99de0d2f646cb6d2ab9026630de2d16b 08:18:17 INFO - mozversion application_display_name: Firefox 08:18:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:18:17 INFO - mozversion application_name: Firefox 08:18:17 INFO - mozversion application_remotingname: firefox 08:18:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:18:17 INFO - mozversion application_vendor: Mozilla 08:18:17 INFO - mozversion application_version: 57.0 08:18:17 INFO - mozversion platform_buildid: 20170916140111 08:18:17 INFO - mozversion platform_changeset: 55d0a2aa99de0d2f646cb6d2ab9026630de2d16b 08:18:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:18:17 INFO - mozversion platform_version: 57.0 08:18:17 INFO - using testdate: 1505575097 08:18:17 INFO - actual date: 1505575097 08:18:17 INFO - starting webserver on 'localhost:42556' 08:18:17 INFO - SUITE-START | Running 2 tests 08:18:17 INFO - TEST-START | dromaeo_css 08:18:17 INFO - Initialising browser for dromaeo_css test... 08:18:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42556/getInfo.html -profile /tmp/tmpCikEfb/profile 08:18:17 INFO - TEST-INFO | started process 3531 (/builds/slave/test/build/application/firefox/firefox http://localhost:42556/getInfo.html) 08:18:25 INFO - TEST-INFO | 3531: exit 0 08:18:25 INFO - Browser initialized. 08:18:25 INFO - Running cycle 1/1 for dromaeo_css test... 08:18:25 INFO - Using env: {'DISPLAY': ':0', 08:18:25 INFO - 'HOME': '/home/cltbld', 08:18:25 INFO - 'JSGC_DISABLE_POISONING': '1', 08:18:25 INFO - 'LANG': 'en_US.UTF-8', 08:18:25 INFO - 'LANGUAGE': 'en_US:en', 08:18:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:18:25 INFO - 'LOGNAME': 'cltbld', 08:18:25 INFO - 'MAIL': '/var/mail/cltbld', 08:18:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:18:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:18:25 INFO - 'MOZ_CRASHREPORTER': '1', 08:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:18:25 INFO - 'MOZ_NO_REMOTE': '1', 08:18:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:25 INFO - 'NO_EM_RESTART': '1', 08:18:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:25 INFO - 'PWD': '/builds/slave/test', 08:18:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:18:25 INFO - 'RUST_BACKTRACE': 'full', 08:18:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:18:25 INFO - 'SHELL': '/bin/bash', 08:18:25 INFO - 'SHLVL': '1', 08:18:25 INFO - 'TERM': 'linux', 08:18:25 INFO - 'TMOUT': '86400', 08:18:25 INFO - 'USER': 'cltbld', 08:18:25 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 08:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:25 INFO - '_': '/tools/buildbot/bin/python'} 08:18:25 INFO - TEST-INFO | started process 3718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCikEfb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:18:37 INFO - PID 3718 | RSS: Main: 162402304 08:18:37 INFO - PID 3718 | 08:21:33 INFO - PID 3718 | Cycle 1(1): loaded http://localhost:42556/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42556/tests/dromaeo/cssquery-ext.html) 08:21:34 INFO - PID 3718 | RSS: Main: 166928384 08:21:34 INFO - PID 3718 | 08:24:36 INFO - PID 3718 | Cycle 1(1): loaded http://localhost:42556/tests/dromaeo/cssquery-ext.html (next: http://localhost:42556/tests/dromaeo/cssquery-jquery.html) 08:24:37 INFO - PID 3718 | RSS: Main: 161456128 08:24:37 INFO - PID 3718 | 08:27:38 INFO - PID 3718 | Cycle 1(1): loaded http://localhost:42556/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42556/tests/dromaeo/cssquery-mootools.html) 08:27:39 INFO - PID 3718 | RSS: Main: 164380672 08:27:39 INFO - PID 3718 | 08:30:40 INFO - PID 3718 | Cycle 1(1): loaded http://localhost:42556/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42556/tests/dromaeo/cssquery-prototype.html) 08:30:41 INFO - PID 3718 | RSS: Main: 164274176 08:30:41 INFO - PID 3718 | 08:33:44 INFO - PID 3718 | Cycle 1(1): loaded http://localhost:42556/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42556/tests/dromaeo/cssquery-yui.html) 08:33:44 INFO - PID 3718 | RSS: Main: 165711872 08:33:44 INFO - PID 3718 | 08:36:46 INFO - PID 3718 | Cycle 1(1): loaded http://localhost:42556/tests/dromaeo/cssquery-yui.html (next: http://localhost:42556/tests/dromaeo/cssquery-dojo.html) 08:36:46 INFO - PID 3718 | RSS: Main: 168644608 08:36:46 INFO - PID 3718 | 08:36:46 INFO - PID 3718 | __start_tp_report 08:36:46 INFO - PID 3718 | _x_x_mozilla_page_load 08:36:46 INFO - PID 3718 | _x_x_mozilla_page_load_details 08:36:46 INFO - PID 3718 | |i|pagename|runs| 08:36:46 INFO - PID 3718 | |0;dojo.html;3982.5220973483188;3989.7606143631374;3999.240144372569;3999.8800035998893;4003.879883603493;6366;6385.233771947367;6410.391012853783;6411.967940160304;6487.513436492264;6404.647744374058;6423.743050277995;6499.935000649992;6504.967475162629;6513.250976137746;5666.263385759846;5710.229119068935;5757.42425757423;5782.24830771999;5786.218860453827;5698.458646428603;5705.4579814917515;5717.228174196493;5747.59766816323;5789.305283366002;5723.427657234264;5765.2216950711745;5769.798057068004;5801.100829371454;5844.473997340238;5760.711964401763;5779.711014449261;5801.970990145064;5875.471207591316;5877.5591830612875;5688.402717714663;5749.223854779635;5788.710564471759;5796.768129274824;5846.853828654275;6226.844328891769;6253.749850005995;6259.311475737665;6315.400036996524;6354.046892966046;6978;7051.048108505389;7074.7170113195925;7079.61062141582;7083.256258092929;6988.6855091521;7016.298370162994;7027;7111.964440177766;7113.502054856162;6323.715432805535;6432.678366081677;6434.324395938406;6436.098946147543;6476.384743449365;7198.928010719826;7215.963920180366;7226.349628533457;7226.74706385274;7239.963800181071;6853.931460685429;6863.10779598659;6870.072540207008;6881.518293719491;6964.93035069653;6886.2769409212315;6995.79012629622;6998.75504357345;7003.089598352181;7082.362587367059;6824.351686589766;6876.965615171992;6883.7590684325805;6889.242183359826;6980.616066116412;6814.114165158498;6841.726330946706;6893.4829887758615;6900.2409734929115;6902;5077.720725360066;5094.133997220481;5152.433232344439;5157.200633901752;5157.793688252428;4640.025594625099;4684.391029166187;4684.718916864999;4699;4767.928481072787;6457.644829534327;6518.511111666644;6521.380468855451;6522.673866306665;6524.771632992823;6896.27589103137;6911.308869113049;6912.205096413977;6915.170179578483;6998.650067496605;6423.74305027803;6484.092227088211;6518.054882042077;6541.672916354163;6542.149520562297;5783.1325301204315;5814.79648212319;5826.650400975955;5828.504577110908;5829.417058294137;7186.317299856505;7194.676239569128;7212.278772122746;7269.854602908018;7288.562686238843;6877.140357455318;6930.757423490154;6942.652867356511;6983;6983.441324694114;7055.929440705732;7058.188308344606;7065.152181738019;7067.363937245673;7134.143902731706;6656.23453302857;6779.389854913082;6856.348646878539;6863.828404289933;6875.724971001104;6911.239763626098;6929.411000065051;6942.409895158968;6996.265392133752;7006.894896576454;6562.770303039561;6638.800835974928;6693;6724.394804467622;6725.260221375547;6629.867402652017;6637.336266373324;6687.398134167948;6712.429443497357;6797.422219111431;6626.072349870926;6626.171728533934;6630.53586248958;6645.867082658223;6656.467482601477;6673.733050677918;6703.363180497845;6751.831204219934;6762.289959554176;6796.76211332601;6461.353864613689;6465.806025819233;6559.508036897348;6569.770058047945;6576.704048317742 08:36:46 INFO - PID 3718 | |1;ext.html;960.9615615375385;966.5988614724889;995.9999999999999;1019.6686077024966;1027.871516060493;46697.766511167436;47341;47684.523154768445;47862.76068619656;47865.52134478658;43490.78254608731;43649.563504364945;43695.344569831395;43744.343834842424;43763.12473750531;7816.179301173366;7917.287444130027;7953.125156232839;7955;7958.840823183533;7790.259925307115;7800.336971357441;7800.765977020698;7805.804854878616;7813.531188128702;7761.146273909865;7781.727639532617;7810.414218933574;7839.8432031359625;8478.491290522557;8504.914950850505;8582.699605513808;8587.355948303839;8588.570571471433;8589.141085891424;8398.706045288447;8485.83028339436;8490.448120872123;8491.44805587641;8492.53291068991;44100.3384949226;44169;44215.77892110551;44285.114297714186;44316;3554.7689400189165;3595.137167079908;3595.586507551639;3598.2803439312243;3598.6581274778855;35501.82249088764;35542;35547.82226088853;35623.64376356229;35656.465153022466;5539.390667026664;5545;5565.693886836222;5581.05122129239;5622.606417550773;247530;249282.75358623272;249457;249585;251008;54577.181342279895;54597.45402546003;55192.17211741827;55491.72254138784;55495;58219.70890145522;58328.41671583315;58346.41653583495;58360.41639583635;58384;18369.908150459163;18617.162227699788;18669.533261668566;18770.249190032246;18816.247350106118;15421.074735515906;15583.220838958006;15590.688186236212;15598;15607.297671604805;15695.607609809618;15918.602034948988;16000.199990000687;16034.358625654842;16082.115483648511;6221.968890155611;6378.840528986812;6437.774677886251;6442.871142577123;6499.350064993558;1099.4173088263233;1101.730076131337;1103.7185517692938;1106.833974903771;1109.4674556213063;25932.740672593034;26095.478090438086;26135.73864261333;26349;26483;1198.940052997364;1202.7173614200656;1211.9091068169923;1217.2696382170627;1244.3591550351575;13667.284786748556;13728.725425491435;13835.723285534234;13874.098183618033;14017.789733154012;281503;281930;284055;290908;295000;62276.688616556625;62580.68709656422;63344.36655633384;63449.68275158595;63528.682356587924;1577.5188567487028;1577.716011117987;1582.074486425431;1594.1471312847802;1597.7044246814144;31305.8434707825;31387.215319617193;31426.68573314329;32207.194820129684;32486.187845304055;42914.35628465638;43230.70307890768;43333;43355;43393;252191;252327;252441;253154;253404;37211.25577488489;38531.42202867015;38565.80717096396;38736.22527549489;38806.2238755229;47601;49133;49165.75417122892;49179.508204917496;49339.25991110064;36747;36749.44875826918;37145.81427092847;37152.628473715995;37246.62753372431;36704.449433259055;36880.63119368772;36977.815110924275;36999.26001480009;37619;42410.787946060074;43839.34240986451;43903.12193756171;43930.56069439265;43940.340894885965;35160;35178;35317.29365412729;35535.46696799498;36291.45562816507;25820;25873.22380328593;25908.481830363664;26304.34239144037;26434.471310574067 08:36:46 INFO - PID 3718 | |2;jquery.html;603.8580933480634;612.8712970276242;618.2056057965515;619.4115590189318;623.6133597169754;24062;24961.25116246511;25044.874775626144;25081;25123.371915702093;27577.862110689468;28296.434071318563;28309.29226769332;28322.291942701442;28415.289617759565;6714.227863795665;6970.372666460017;6974.302569743036;6983.89524157138;7005.124359455068;6610.801675949705;6817.454603631722;6819.215790184118;6827.112475378219;6835.7949261522235;6760.3577660122455;6771;6785.185777706657;6800.183977922631;6805.047293378931;6745;6793.45652347811;6800.863982720342;6802.863942721167;6811.761588344434;6342.4926005919415;6358.491320694333;6359;6368.968155159195;6380.425761681471;29873.954411595707;32172.517412238834;32916.341673166644;33129;33165.33669326624;2411.5900296949385;2424.35754525051;2450.48539806639;2453.251758213744;2454.509098180371;20619.69070463944;20621.278255261142;20979.26572569968;21012.5797484051;21037.789622103737;2317.7102862142233;2449.216250799745;2648.0334677842643;2648.298200976743;2665.187117929031;147102.26448867793;154173;155091;160980.19509902375;161602.1919890393;16246.593835154215;16908.830911690726;17032.914835425745;17050.57373565646;17206.483805485605;26573.601395979076;26627.068052618066;26731.19806405811;26782;26786.330341741614;11266.774664506664;11769.88230117705;11804.11469139818;11830.645080647595;11877.524899003944;10810.56757729682;10987.121030317556;11010.222997520175;11020.669379918616;11079.113670906308;9904.257180711475;9908.35595686278;9977.401355918668;10216.335938163995;10284.485775711184;2914.493535559417;2969.124108388031;3006.3987202559574;3024.7126522980284;3078.8146563573187;1033.5142483032962;1058.5818601652304;1064.3986147826454;1077.369738702852;1083.414955923808;22258.666120008213;22336.664950025763;22470.887645561666;22600.434989125075;22693.773062269494;1145.4730823821135;1148.2765857509883;1156.988430115705;1161.4076820821442;1165.0272022860836;12074.637760867188;12213.938930305292;12423.565175219004;12531.624051278477;12533.185342952678;709057.0502803333;714678;720097;724021;730991;134785.32607337096;135133.3243333777;135697;135904;137307;1236.116176933497;1286.3246795432474;1294.7151626641935;1297.7469393468373;1307.1176955554963;19239.615207696046;19306.4208073758;19312.517187070436;19835.504112397306;19845.404637860887;63378.36621633724;63801.36198637954;64119;66251.99999999806;66356;79648;80351.19648803437;80860;81385.18614813776;82211.17788822035;15230.619234519225;15841.603959901095;16037.839621603634;16052.438164664181;16074.35702571884;25234.116805911704;25263.621045684697;25503.36241593975;25629.10298139556;25683.743162568884;20408.38774836757;20455.693164602246;20670.689939650616;20866.37400877976;20885.582288353842;17838.821611783715;18161.545961351072;18367.632647346712;18691.345802896834;18832.34086806955;20068.09693563764;20797.1681132753;21047;21251.681224781332;21308;15720.842791571939;15809.841901580838;15821.208939552746;15828.44600438979;15840.44558440449;19987.500312492302;20082.297119601328;20088.39734807958;20142.798572014093;20298 08:36:46 INFO - PID 3718 | |3;mootools.html;1368.609946165343;1463.5609317204842;1465.6702241995545;1476.033198255143;1489.255372313843;16949.745753813702;17284.567885802862;17547.64904701907;17623.823761762378;17776.64446711065;17420.65158696825;17557;17569.385071522498;17613.207405666744;17629.7355539667;3047.512398016318;3057.602511673485;3104.6895310469;3107.409592177479;3108.564800927872;3099.256178517162;3100.178452710022;3114.906552803408;3132.326549791794;3133.1853718033362;2807.705190954951;3079.461094308487;3081.9845900770465;3084.028531012735;3086.429010633029;2883.5530492773655;2915.3440475892753;2920.868560914743;3044.90865274041;3058.4953482675332;2961.763058955278;2996.8501574921165;3014.0505740691833;3014.291641464254;3020.5469179623014;16968.066756328397;17074.402395916208;17121.22954467052;17130.743038854427;17383;8599.44103633268;8871.689490867788;8884.689035883714;8890.4665720057;8902.109789021111;5718.542516598662;5887.941120588825;6060.363661815534;6068;6072.271327440735;2173.369722780392;2179.5967745967046;2220.0786673530465;2256.4697296135396;2272.681824544565;31789.205269868206;31797.364052718814;32016;32043.519347209578;32046.519302210487;7517.812054698677;7576.507527010726;7613.847723045508;7794.610269486503;7848.21517848222;20171.193152273743;20185.697214541793;20269.898650506653;20304.593908121755;20358.389248322277;8681.131886811268;8827.426217295855;8831;8841.248493877963;8848.734537963743;7966.9601651992525;8047.114817370201;8160.795980100426;8262.628181731716;8264.586770661443;5820.912686309709;5917.615355001911;5988.580799344004;6037.72830222641;6339.207599050119;1575.0785790312566;1593.4343308125449;1645.6132808789926;1737.860971122307;1783.4738752068172;999.1307562420741;1011.8026984737905;1013.5996281468779;1015.4059874973224;1026.1175389165312;9990;10019.79960400788;10035.297529172887;10174.69475915709;10205.74485637865;1040.6409788622914;1071.2608300272786;1076.252004856617;1099.1811100730008;1104.447776111944;4958.727270000112;5206.349206349207;6133.662648554372;6202.56582039262;6327.303996560375;26312.86843565808;26544.734552654227;26857.86571067171;27137.592936105975;27243.863780681368;25054.624180637304;25371;26127.216183514523;26338.078167264055;26389.604155937675;13020.674483137997;13056.543020994219;13065.412056457482;13230.404631791593;13231.669208269677;10201;10270.435126068138;10281.280310378203;10299.7425064371;10311.123554497952;22146.22488212905;22352.441188970406;22477.550448991256;22527.32418027462;22694.205702800322;23035.769642303363;23315.183968561018;23589.758972897547;23601.52796944086;24196.758032420155;12832.101752877208;12984.285864277555;13065.412056457291;13066.934665326613;13078.411471483616;16225.269862856436;16365.427210047592;16474.83525164733;16503.17484125813;16533.751993720343;12691.048171386998;12703.555375561811;12831.871681283068;12836.422360993964;12889.291088990196;12904.290264035568;13109.213447193199;13139.671508212372;13226.537071202461;13293.667658308234;11073.667789966314;11359.091272697999;11374.43127843621;11381.918717721803;11402.087832973177;8198.221168988937;8277.668893244443;8318.750437486886;8339.916600834156;8443.620037098468;7950.045994480699;8074.515529068275;8103.959480202797;8106.878396823934;8116.391270654606 08:36:46 INFO - PID 3718 | |4;prototype.html;558.4136656510663;576.9528306124387;580.0545111468306;582.7639805878619;586.1910563422476;6391.936080639192;6418.550701450895;6439.4204521593165;6490.415862572373;6520.9347906520925;6333.429991300782;6340.7463701452;6359.58662686925;6376.713047912844;6403.103565500822;4992.625553083515;5086.41506226785;5185.248139019849;5194.558462530689;5196.194589838562;5077.162268225738;5101.974490127544;5108.948910510884;5112.488751124895;5125.179971204608;5014.671112155282;5050.974745126269;5055.545000949914;5059.6458247922665;5113.6931784092885;5012.423571289312;5057.519535644126;5057.797688092472;5066.088104141253;5066.974665126688;4672.602828759559;4677.251639737659;4692.343071969927;4707.340972263886;4713.929291060603;6333.429991300759;6379;6404.967975160141;6416.839579010515;6439.742410303582;5997.820065398045;6004.879902401927;6008.3390827009;6018.766152938637;6028.879422411527;6687.899681504781;6769.458443324522;6773.491988100912;6794.45644348451;6834.726610935557;5145.151050076733;5146.871328216825;5147.510986456281;5154.355705536808;5168.8966220675375;6795.18457785064;6804.76183333581;6933.1333583302085;7018.263082376379;7109.644517774091;5239.921401178985;5270.78916843322;5298.284731561267;5306.177542480922;5307.363116426053;5347.331583552056;5352.2506849041165;5383.2194331821665;5388.326459192601;5417.783288668488;5980.43185897339;5995.910061349084;5996.370381110008;6011.699415029231;6040.214772079689;6854.485913556503;6859.5541289816;6876.140482439695;6877.2091209510545;6880.65596720162;1857.3406440713622;1861.7207418887003;1867.4491025147613;1873.381784011273;1874.9906250468932;1281.3080936294298;1312.6587087357166;1312.822768926202;1318.2222488731695;1325.2512330533218;6432;6434.453071488882;6439.710213040425;6455.160829092188;6469.029645553111;6819.147606549182;6828.658567071627;6868.828279293058;6886.8622627547165;6892;6439.678016099177;6500.512461565401;6503.804885853432;6506.967465162644;6542.54202205841;3632.1282892106233;3655.738770124303;3661.0664280608275;3671.6695497405362;3679.5584529856055;7241.89137162943;7275.236100209508;7291.234420385783;7293.635318234067;7337.633118344062;7068;7135.536190147727;7168.498205125591;7198.496105272686;7234.997476047487;7213.242609525924;7257.8548429031125;7264.128304603481;7279.526830755984;7306.780796576111;6786.93213067863;6883.900410374684;6951;6959.373656370951;6963.303669632996;6768.357006084414;6860.451163906975;6912.101426814482;6913.412359949461;6963.6866341013765;7252.601106939169;7287.4534409920525;7304.8539029218055;7319.670614822239;7336.816579585553;5332.120200166929;5341.813036543703;5342.866428339323;5353.892922141613;5375.919361209507;6701.865962680817;6804.659767011729;6874.9656251718425;6889.448844092561;6920.9307906920285;6527.836804079746;6669;6681.064650948968;6690.364415380725;6821.669774394144;6686.498512611476;6727.360900714424;6750.2237242715755;6754.5609535380045;6781.6270105144695;6434.64609446485;6610.272869984202;6700.899486507804;6737.191537015589;6779.220389655253;6674.599524028574;6705.262421133574;6843.863122737617;6867.622280774605;6874.484413668894;6590.439812615789;6610.239822420291;6612.338766123349;6635.336466353326;6654.401103900672 08:36:46 INFO - PID 3718 | |5;yui.html;975.4976187263557;1014.2291858187776;1027.3476342522497;1044.2794471814448;1051.8369652703832;17688.469345919628;17810.91094544527;17951.551211219725;17982.64034719305;18018.918864868116;18313.90843045783;18619.348322808706;18837.623247535077;18895.905520472377;19227.711584326247;1061.209398997746;1074.7152004718755;1079.2445288298184;1079.282277285604;1079.2984560035961;1096.3476731344838;1096.4736926275393;1102.2119184782878;1104.6741211342674;1138.60148947868;1176.1531697178061;1181.1259667845818;1181.3384504677365;1181.5451051345208;1186.1696812231473;1161.790877642024;1171.3206340322636;1174.9060075193963;1178.581603530747;1179.039083147241;861.2808305065278;869.3740506835069;871.3377832847018;872.1975782280253;875.1073904617318;20103.497412564655;20658.58682826335;20861.165553377847;20884.477888052767;21277.25529606472;24218.878905605536;24251.151209707576;24498.510029799305;24686.876565617236;24695.87652061746;19567.21731130767;19648.508787280432;19682.606347873105;19685.31101411444;19914.20343186271;4125.422440858282;4168.124693814302;4186.895327616803;4211.073563815956;4219.135077309144;167111;171902;172851.13574432174;173135;174008;18710.906445467685;18775.061246937872;18868.43394698161;19048.71426928597;19234.422967310722;35489.29021419609;35610;35791.82104089515;35827.641723582434;35988;9788.902110978941;9991.750206244902;10042.246831487668;10044.347117437343;10078.244131690153;4986.850394488171;5078.7460626968505;5097.8215762448135;5102.132637451642;5107.693538387709;6293.842653933688;6484.610923344614;6528.640924749089;6529.902051469232;6553.148090748267;1152.8270759385991;1188.5305304404712;1198.221156248428;1202.7113492761848;1209.7640960012714;776.8446310737762;782.8629989751771;793.9047314322319;800.7677773445636;802.7029998900327;13153.53962611304;13626.386812593457;14655.706885862222;14893.18087505176;15273.236338183046;765.6248438265321;773.0684525147184;773.5590713293369;774.8334108166771;786.1313248860042;6355.315841302058;6552.705128269239;6591.670416479157;6616.503762217853;6667.533272670867;153188;157191;161806.1909690444;163370;163799;146491;146570;148496;148737;148760;121257;122545.38727306484;122804;123552.38223809004;125823;12519.436625351698;12529.749405012031;12559.560415385418;12680.619581412573;12693;59258;59311;60157.69921150366;60825.69587152036;62458.68770656118;74107;75410;75995.62002189954;75997;76885;18060.277588896297;19231.807681923;19253.614927701088;19296.903515482332;19368.70946935825;21005.264815731374;21158.259460918795;21173.7882621178;21194;21298.680519792524;19151.329703460313;19248.422547323604;19552.8044719551;19649.60700786005;19806.405807825788;18223.179956901706;18349.724754128965;18476.445706628823;18567.16447759881;18644.533886652942;17495.737563936298;17513.649727005642;17571.385001524886;17580;17727.91136044363;12644.241345519298;12784.232946023269;12889.548865789653;13020.348982551024;13125.474981000652;13978.580642580739;14071.296435178405;14086.577402677936;14112.153270803785;14139.787903181666 08:36:46 INFO - PID 3718 | __end_tp_report 08:36:46 INFO - PID 3718 | __start_cc_report 08:36:46 INFO - PID 3718 | _x_x_mozilla_cycle_collect,314 08:36:46 INFO - PID 3718 | __end_cc_report 08:36:46 INFO - PID 3718 | __startTimestamp1505576206573__endTimestamp 08:36:46 INFO - PID 3718 | 08:36:46 INFO - PID 3718 | ------- Summary: start ------- 08:36:46 INFO - PID 3718 | Number of tests: 6 08:36:46 INFO - PID 3718 | 08:36:46 INFO - PID 3718 | [#0] dojo.html Cycles:165 Average:6401.41 Median:6626.17 stddev:738.03 (11.1%) stddev-sans-first:715.48 08:36:46 INFO - PID 3718 | Values: 3982.5 3989.8 3999.2 3999.9 4003.9 6366.0 6385.2 6410.4 6412.0 6487.5 6404.6 6423.7 6499.9 6505.0 6513.3 5666.3 5710.2 5757.4 5782.2 5786.2 5698.5 5705.5 5717.2 5747.6 5789.3 5723.4 5765.2 5769.8 5801.1 5844.5 5760.7 5779.7 5802.0 5875.5 5877.6 5688.4 5749.2 5788.7 5796.8 5846.9 6226.8 6253.7 6259.3 6315.4 6354.0 6978.0 7051.0 7074.7 7079.6 7083.3 6988.7 7016.3 7027.0 7112.0 7113.5 6323.7 6432.7 6434.3 6436.1 6476.4 7198.9 7216.0 7226.3 7226.7 7240.0 6853.9 6863.1 6870.1 6881.5 6964.9 6886.3 6995.8 6998.8 7003.1 7082.4 6824.4 6877.0 6883.8 6889.2 6980.6 6814.1 6841.7 6893.5 6900.2 6902.0 5077.7 5094.1 5152.4 5157.2 5157.8 4640.0 4684.4 4684.7 4699.0 4767.9 6457.6 6518.5 6521.4 6522.7 6524.8 6896.3 6911.3 6912.2 6915.2 6998.7 6423.7 6484.1 6518.1 6541.7 6542.1 5783.1 5814.8 5826.7 5828.5 5829.4 7186.3 7194.7 7212.3 7269.9 7288.6 6877.1 6930.8 6942.7 6983.0 6983.4 7055.9 7058.2 7065.2 7067.4 7134.1 6656.2 6779.4 6856.3 6863.8 6875.7 6911.2 6929.4 6942.4 6996.3 7006.9 6562.8 6638.8 6693.0 6724.4 6725.3 6629.9 6637.3 6687.4 6712.4 6797.4 6626.1 6626.2 6630.5 6645.9 6656.5 6673.7 6703.4 6751.8 6762.3 6796.8 6461.4 6465.8 6559.5 6569.8 6576.7 08:36:46 INFO - PID 3718 | 08:36:46 INFO - PID 3718 | [#1] ext.html Cycles:180 Average:45248.56 Median:37228.94 stddev:68465.80 (183.9%) stddev-sans-first:68577.11 08:36:46 INFO - PID 3718 | Values: 961.0 966.6 996.0 1019.7 1027.9 46697.8 47341.0 47684.5 47862.8 47865.5 43490.8 43649.6 43695.3 43744.3 43763.1 7816.2 7917.3 7953.1 7955.0 7958.8 7790.3 7800.3 7800.8 7805.8 7813.5 7761.1 7781.7 7810.4 7839.8 8478.5 8504.9 8582.7 8587.4 8588.6 8589.1 8398.7 8485.8 8490.4 8491.4 8492.5 44100.3 44169.0 44215.8 44285.1 44316.0 3554.8 3595.1 3595.6 3598.3 3598.7 35501.8 35542.0 35547.8 35623.6 35656.5 5539.4 5545.0 5565.7 5581.1 5622.6 247530.0 249282.8 249457.0 249585.0 251008.0 54577.2 54597.5 55192.2 55491.7 55495.0 58219.7 58328.4 58346.4 58360.4 58384.0 18369.9 18617.2 18669.5 18770.2 18816.2 15421.1 15583.2 15590.7 15598.0 15607.3 15695.6 15918.6 16000.2 16034.4 16082.1 6222.0 6378.8 6437.8 6442.9 6499.4 1099.4 1101.7 1103.7 1106.8 1109.5 25932.7 26095.5 26135.7 26349.0 26483.0 1198.9 1202.7 1211.9 1217.3 1244.4 13667.3 13728.7 13835.7 13874.1 14017.8 281503.0 281930.0 284055.0 290908.0 295000.0 62276.7 62580.7 63344.4 63449.7 63528.7 1577.5 1577.7 1582.1 1594.1 1597.7 31305.8 31387.2 31426.7 32207.2 32486.2 42914.4 43230.7 43333.0 43355.0 43393.0 252191.0 252327.0 252441.0 253154.0 253404.0 37211.3 38531.4 38565.8 38736.2 38806.2 47601.0 49133.0 49165.8 49179.5 49339.3 36747.0 36749.4 37145.8 37152.6 37246.6 36704.4 36880.6 36977.8 36999.3 37619.0 42410.8 43839.3 43903.1 43930.6 43940.3 35160.0 35178.0 35317.3 35535.5 36291.5 25820.0 25873.2 25908.5 26304.3 26434.5 08:36:46 INFO - PID 3718 | 08:36:46 INFO - PID 3718 | [#2] jquery.html Cycles:180 Average:43798.04 Median:22647.10 stddev:119453.23 (527.5%) stddev-sans-first:119744.30 08:36:46 INFO - PID 3718 | Values: 603.9 612.9 618.2 619.4 623.6 24062.0 24961.3 25044.9 25081.0 25123.4 27577.9 28296.4 28309.3 28322.3 28415.3 6714.2 6970.4 6974.3 6983.9 7005.1 6610.8 6817.5 6819.2 6827.1 6835.8 6760.4 6771.0 6785.2 6800.2 6805.0 6745.0 6793.5 6800.9 6802.9 6811.8 6342.5 6358.5 6359.0 6369.0 6380.4 29874.0 32172.5 32916.3 33129.0 33165.3 2411.6 2424.4 2450.5 2453.3 2454.5 20619.7 20621.3 20979.3 21012.6 21037.8 2317.7 2449.2 2648.0 2648.3 2665.2 147102.3 154173.0 155091.0 160980.2 161602.2 16246.6 16908.8 17032.9 17050.6 17206.5 26573.6 26627.1 26731.2 26782.0 26786.3 11266.8 11769.9 11804.1 11830.6 11877.5 10810.6 10987.1 11010.2 11020.7 11079.1 9904.3 9908.4 9977.4 10216.3 10284.5 2914.5 2969.1 3006.4 3024.7 3078.8 1033.5 1058.6 1064.4 1077.4 1083.4 22258.7 22336.7 22470.9 22600.4 22693.8 1145.5 1148.3 1157.0 1161.4 1165.0 12074.6 12213.9 12423.6 12531.6 12533.2 709057.1 714678.0 720097.0 724021.0 730991.0 134785.3 135133.3 135697.0 135904.0 137307.0 1236.1 1286.3 1294.7 1297.7 1307.1 19239.6 19306.4 19312.5 19835.5 19845.4 63378.4 63801.4 64119.0 66252.0 66356.0 79648.0 80351.2 80860.0 81385.2 82211.2 15230.6 15841.6 16037.8 16052.4 16074.4 25234.1 25263.6 25503.4 25629.1 25683.7 20408.4 20455.7 20670.7 20866.4 20885.6 17838.8 18161.5 18367.6 18691.3 18832.3 20068.1 20797.2 21047.0 21251.7 21308.0 15720.8 15809.8 15821.2 15828.4 15840.4 19987.5 20082.3 20088.4 20142.8 20298.0 08:36:46 INFO - PID 3718 | 08:36:46 INFO - PID 3718 | [#3] mootools.html Cycles:180 Average:10926.23 Median:23595.64 stddev:8095.52 (34.3%) stddev-sans-first:8086.39 08:36:46 INFO - PID 3718 | Values: 1368.6 1463.6 1465.7 1476.0 1489.3 16949.7 17284.6 17547.6 17623.8 17776.6 17420.7 17557.0 17569.4 17613.2 17629.7 3047.5 3057.6 3104.7 3107.4 3108.6 3099.3 3100.2 3114.9 3132.3 3133.2 2807.7 3079.5 3082.0 3084.0 3086.4 2883.6 2915.3 2920.9 3044.9 3058.5 2961.8 2996.9 3014.1 3014.3 3020.5 16968.1 17074.4 17121.2 17130.7 17383.0 8599.4 8871.7 8884.7 8890.5 8902.1 5718.5 5887.9 6060.4 6068.0 6072.3 2173.4 2179.6 2220.1 2256.5 2272.7 31789.2 31797.4 32016.0 32043.5 32046.5 7517.8 7576.5 7613.8 7794.6 7848.2 20171.2 20185.7 20269.9 20304.6 20358.4 8681.1 8827.4 8831.0 8841.2 8848.7 7967.0 8047.1 8160.8 8262.6 8264.6 5820.9 5917.6 5988.6 6037.7 6339.2 1575.1 1593.4 1645.6 1737.9 1783.5 999.1 1011.8 1013.6 1015.4 1026.1 9990.0 10019.8 10035.3 10174.7 10205.7 1040.6 1071.3 1076.3 1099.2 1104.4 4958.7 5206.3 6133.7 6202.6 6327.3 26312.9 26544.7 26857.9 27137.6 27243.9 25054.6 25371.0 26127.2 26338.1 26389.6 13020.7 13056.5 13065.4 13230.4 13231.7 10201.0 10270.4 10281.3 10299.7 10311.1 22146.2 22352.4 22477.6 22527.3 22694.2 23035.8 23315.2 23589.8 23601.5 24196.8 12832.1 12984.3 13065.4 13066.9 13078.4 16225.3 16365.4 16474.8 16503.2 16533.8 12691.0 12703.6 12831.9 12836.4 12889.3 12904.3 13109.2 13139.7 13226.5 13293.7 11073.7 11359.1 11374.4 11381.9 11402.1 8198.2 8277.7 8318.8 8339.9 8443.6 7950.0 8074.5 8104.0 8106.9 8116.4 08:36:46 INFO - PID 3718 | 08:36:46 INFO - PID 3718 | [#4] prototype.html Cycles:180 Average:5787.52 Median:6439.69 stddev:1624.43 (25.2%) stddev-sans-first:1580.86 08:36:46 INFO - PID 3718 | Values: 558.4 577.0 580.1 582.8 586.2 6391.9 6418.6 6439.4 6490.4 6520.9 6333.4 6340.7 6359.6 6376.7 6403.1 4992.6 5086.4 5185.2 5194.6 5196.2 5077.2 5102.0 5108.9 5112.5 5125.2 5014.7 5051.0 5055.5 5059.6 5113.7 5012.4 5057.5 5057.8 5066.1 5067.0 4672.6 4677.3 4692.3 4707.3 4713.9 6333.4 6379.0 6405.0 6416.8 6439.7 5997.8 6004.9 6008.3 6018.8 6028.9 6687.9 6769.5 6773.5 6794.5 6834.7 5145.2 5146.9 5147.5 5154.4 5168.9 6795.2 6804.8 6933.1 7018.3 7109.6 5239.9 5270.8 5298.3 5306.2 5307.4 5347.3 5352.3 5383.2 5388.3 5417.8 5980.4 5995.9 5996.4 6011.7 6040.2 6854.5 6859.6 6876.1 6877.2 6880.7 1857.3 1861.7 1867.4 1873.4 1875.0 1281.3 1312.7 1312.8 1318.2 1325.3 6432.0 6434.5 6439.7 6455.2 6469.0 6819.1 6828.7 6868.8 6886.9 6892.0 6439.7 6500.5 6503.8 6507.0 6542.5 3632.1 3655.7 3661.1 3671.7 3679.6 7241.9 7275.2 7291.2 7293.6 7337.6 7068.0 7135.5 7168.5 7198.5 7235.0 7213.2 7257.9 7264.1 7279.5 7306.8 6786.9 6883.9 6951.0 6959.4 6963.3 6768.4 6860.5 6912.1 6913.4 6963.7 7252.6 7287.5 7304.9 7319.7 7336.8 5332.1 5341.8 5342.9 5353.9 5375.9 6701.9 6804.7 6875.0 6889.4 6920.9 6527.8 6669.0 6681.1 6690.4 6821.7 6686.5 6727.4 6750.2 6754.6 6781.6 6434.6 6610.3 6700.9 6737.2 6779.2 6674.6 6705.3 6843.9 6867.6 6874.5 6590.4 6610.2 6612.3 6635.3 6654.4 08:36:46 INFO - PID 3718 | 08:36:46 INFO - PID 3718 | [#5] yui.html Cycles:180 Average:30169.43 Median:18742.98 stddev:45853.07 (244.6%) stddev-sans-first:45929.30 08:36:46 INFO - PID 3718 | Values: 975.5 1014.2 1027.3 1044.3 1051.8 17688.5 17810.9 17951.6 17982.6 18018.9 18313.9 18619.3 18837.6 18895.9 19227.7 1061.2 1074.7 1079.2 1079.3 1079.3 1096.3 1096.5 1102.2 1104.7 1138.6 1176.2 1181.1 1181.3 1181.5 1186.2 1161.8 1171.3 1174.9 1178.6 1179.0 861.3 869.4 871.3 872.2 875.1 20103.5 20658.6 20861.2 20884.5 21277.3 24218.9 24251.2 24498.5 24686.9 24695.9 19567.2 19648.5 19682.6 19685.3 19914.2 4125.4 4168.1 4186.9 4211.1 4219.1 167111.0 171902.0 172851.1 173135.0 174008.0 18710.9 18775.1 18868.4 19048.7 19234.4 35489.3 35610.0 35791.8 35827.6 35988.0 9788.9 9991.8 10042.2 10044.3 10078.2 4986.9 5078.7 5097.8 5102.1 5107.7 6293.8 6484.6 6528.6 6529.9 6553.1 1152.8 1188.5 1198.2 1202.7 1209.8 776.8 782.9 793.9 800.8 802.7 13153.5 13626.4 14655.7 14893.2 15273.2 765.6 773.1 773.6 774.8 786.1 6355.3 6552.7 6591.7 6616.5 6667.5 153188.0 157191.0 161806.2 163370.0 163799.0 146491.0 146570.0 148496.0 148737.0 148760.0 121257.0 122545.4 122804.0 123552.4 125823.0 12519.4 12529.7 12559.6 12680.6 12693.0 59258.0 59311.0 60157.7 60825.7 62458.7 74107.0 75410.0 75995.6 75997.0 76885.0 18060.3 19231.8 19253.6 19296.9 19368.7 21005.3 21158.3 21173.8 21194.0 21298.7 19151.3 19248.4 19552.8 19649.6 19806.4 18223.2 18349.7 18476.4 18567.2 18644.5 17495.7 17513.6 17571.4 17580.0 17727.9 12644.2 12784.2 12889.5 13020.3 13125.5 13978.6 14071.3 14086.6 14112.2 14139.8 08:36:46 INFO - PID 3718 | -------- Summary: end -------- 08:36:46 INFO - PID 3718 | 08:36:47 INFO - TEST-INFO | 3718: exit 0 08:36:47 INFO - TEST-OK | dromaeo_css | took 1109581ms 08:36:47 INFO - TEST-START | kraken 08:36:47 INFO - Initialising browser for kraken test... 08:36:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42556/getInfo.html -profile /tmp/tmpyZrZAs/profile 08:36:47 INFO - TEST-INFO | started process 4084 (/builds/slave/test/build/application/firefox/firefox http://localhost:42556/getInfo.html) 08:36:52 INFO - TEST-INFO | 4084: exit 0 08:36:52 INFO - Browser initialized. 08:36:52 INFO - Running cycle 1/1 for kraken test... 08:36:52 INFO - Using env: {'DISPLAY': ':0', 08:36:52 INFO - 'HOME': '/home/cltbld', 08:36:52 INFO - 'JSGC_DISABLE_POISONING': '1', 08:36:52 INFO - 'LANG': 'en_US.UTF-8', 08:36:52 INFO - 'LANGUAGE': 'en_US:en', 08:36:52 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:36:52 INFO - 'LOGNAME': 'cltbld', 08:36:52 INFO - 'MAIL': '/var/mail/cltbld', 08:36:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:36:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:36:52 INFO - 'MOZ_CRASHREPORTER': '1', 08:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:52 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:36:52 INFO - 'MOZ_NO_REMOTE': '1', 08:36:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:36:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:52 INFO - 'NO_EM_RESTART': '1', 08:36:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:52 INFO - 'PWD': '/builds/slave/test', 08:36:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:36:52 INFO - 'RUST_BACKTRACE': 'full', 08:36:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:36:52 INFO - 'SHELL': '/bin/bash', 08:36:52 INFO - 'SHLVL': '1', 08:36:52 INFO - 'TERM': 'linux', 08:36:52 INFO - 'TMOUT': '86400', 08:36:52 INFO - 'USER': 'cltbld', 08:36:52 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505574700.378350-294110153', 08:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:52 INFO - '_': '/tools/buildbot/bin/python'} 08:36:52 INFO - TEST-INFO | started process 4270 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyZrZAs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:37:03 INFO - PID 4270 | RSS: Main: 162652160 08:37:03 INFO - PID 4270 | 08:37:05 INFO - PID 4270 | Cycle 1(1): loaded http://localhost:42556/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42556/tests/kraken/driver.html?testName=audio-beat-detection) 08:37:06 INFO - PID 4270 | RSS: Main: 167972864 08:37:06 INFO - PID 4270 | 08:37:09 INFO - PID 4270 | Cycle 1(1): loaded http://localhost:42556/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42556/tests/kraken/driver.html?testName=audio-dft) 08:37:09 INFO - PID 4270 | RSS: Main: 168275968 08:37:09 INFO - PID 4270 | 08:37:12 INFO - PID 4270 | Cycle 1(1): loaded http://localhost:42556/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42556/tests/kraken/driver.html?testName=audio-fft) 08:37:13 INFO - PID 4270 | RSS: Main: 169910272 08:37:13 INFO - PID 4270 | 08:37:15 INFO - PID 4270 | Cycle 1(1): loaded http://localhost:42556/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42556/tests/kraken/driver.html?testName=audio-oscillator) 08:37:16 INFO - PID 4270 | RSS: Main: 169816064 08:37:16 INFO - PID 4270 | 08:37:18 INFO - PID 4270 | Cycle 1(1): loaded http://localhost:42556/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42556/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:37:18 INFO - PID 4270 | RSS: Main: 169254912 08:37:18 INFO - PID 4270 | 08:37:21 INFO - PID 4270 | Cycle 1(1): loaded http://localhost:42556/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42556/tests/kraken/driver.html?testName=imaging-darkroom) 08:37:22 INFO - PID 4270 | RSS: Main: 169586688 08:37:22 INFO - PID 4270 | 08:37:25 INFO - PID 4270 | Cycle 1(1): loaded http://localhost:42556/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42556/tests/kraken/driver.html?testName=imaging-desaturate) 08:37:26 INFO - PID 4270 | RSS: Main: 171917312 08:37:26 INFO - PID 4270 | 08:37:29 INFO - PID 4270 | Cycle 1(1): loaded http://localhost:42556/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42556/tests/kraken/driver.html?testName=json-parse-financial) 08:37:30 INFO - PID 4270 | RSS: Main: 172146688 08:37:30 INFO - PID 4270 | 08:37:31 INFO - PID 4270 | Cycle 1(1): loaded http://localhost:42556/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42556/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:37:32 INFO - PID 4270 | RSS: Main: 172027904 08:37:32 INFO - PID 4270 | 08:37:33 INFO - PID 4270 | Cycle 1(1): loaded http://localhost:42556/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42556/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:37:34 INFO - PID 4270 | RSS: Main: 171999232 08:37:34 INFO - PID 4270 | 08:37:36 INFO - PID 4270 | Cycle 1(1): loaded http://localhost:42556/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42556/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:37:37 INFO - PID 4270 | RSS: Main: 168992768 08:37:37 INFO - PID 4270 | 08:37:39 INFO - PID 4270 | Cycle 1(1): loaded http://localhost:42556/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42556/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:37:40 INFO - PID 4270 | RSS: Main: 169054208 08:37:40 INFO - PID 4270 | 08:37:43 INFO - PID 4270 | Cycle 1(1): loaded http://localhost:42556/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42556/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:37:43 INFO - PID 4270 | RSS: Main: 169869312 08:37:43 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | Cycle 1(1): loaded http://localhost:42556/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42556/tests/kraken/driver.html?testName=ai-astar) 08:37:45 INFO - PID 4270 | RSS: Main: 171515904 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | __start_tp_report 08:37:45 INFO - PID 4270 | _x_x_mozilla_page_load 08:37:45 INFO - PID 4270 | _x_x_mozilla_page_load_details 08:37:45 INFO - PID 4270 | |i|pagename|runs| 08:37:45 INFO - PID 4270 | |0;ai-astar;107;104;107;104;106;106;109;107;104;105 08:37:45 INFO - PID 4270 | |1;audio-beat-detection;110;110;113;112;110;110;111;111;115;114 08:37:45 INFO - PID 4270 | |2;audio-dft;161;162;160;160;160;161;159;163;161;162 08:37:45 INFO - PID 4270 | |3;audio-fft;73;73;73;73;74;72;75;75;76;75 08:37:45 INFO - PID 4270 | |4;audio-oscillator;79;78;76;85;76;78;77;77;77;77 08:37:45 INFO - PID 4270 | |5;imaging-gaussian-blur;109;115;113;113;114;113;113;114;113;114 08:37:45 INFO - PID 4270 | |6;imaging-darkroom;148;147;147;149;148;148;149;148;148;148 08:37:45 INFO - PID 4270 | |7;imaging-desaturate;94;94;98;94;95;94;93;94;93;95 08:37:45 INFO - PID 4270 | |8;json-parse-financial;48;48;49;45;49;44;45;44;43;43 08:37:45 INFO - PID 4270 | |9;json-stringify-tinderbox;38;38;38;37;38;38;38;38;38;37 08:37:45 INFO - PID 4270 | |10;stanford-crypto-aes;75;73;72;77;71;69;70;73;70;69 08:37:45 INFO - PID 4270 | |11;stanford-crypto-ccm;103;106;100;106;101;101;98;106;100;100 08:37:45 INFO - PID 4270 | |12;stanford-crypto-pbkdf2;154;150;152;156;149;151;153;151;152;162 08:37:45 INFO - PID 4270 | |13;stanford-crypto-sha256-iterative;59;57;58;57;59;57;58;57;57;58 08:37:45 INFO - PID 4270 | __end_tp_report 08:37:45 INFO - PID 4270 | __start_cc_report 08:37:45 INFO - PID 4270 | _x_x_mozilla_cycle_collect,876 08:37:45 INFO - PID 4270 | __end_cc_report 08:37:45 INFO - PID 4270 | __startTimestamp1505576265765__endTimestamp 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | ------- Summary: start ------- 08:37:45 INFO - PID 4270 | Number of tests: 14 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | [#0] ai-astar Cycles:10 Average:105.90 Median:106.50 stddev:1.66 (1.6%) stddev-sans-first:1.72 08:37:45 INFO - PID 4270 | Values: 107.0 104.0 107.0 104.0 106.0 106.0 109.0 107.0 104.0 105.0 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | [#1] audio-beat-detection Cycles:10 Average:111.60 Median:111.50 stddev:1.84 (1.6%) stddev-sans-first:1.86 08:37:45 INFO - PID 4270 | Values: 110.0 110.0 113.0 112.0 110.0 110.0 111.0 111.0 115.0 114.0 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 08:37:45 INFO - PID 4270 | Values: 161.0 162.0 160.0 160.0 160.0 161.0 159.0 163.0 161.0 162.0 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | [#3] audio-fft Cycles:10 Average:73.90 Median:74.50 stddev:1.29 (1.7%) stddev-sans-first:1.32 08:37:45 INFO - PID 4270 | Values: 73.0 73.0 73.0 73.0 74.0 72.0 75.0 75.0 76.0 75.0 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:77.50 stddev:2.62 (3.4%) stddev-sans-first:2.76 08:37:45 INFO - PID 4270 | Values: 79.0 78.0 76.0 85.0 76.0 78.0 77.0 77.0 77.0 77.0 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.50 stddev:1.60 (1.4%) stddev-sans-first:0.73 08:37:45 INFO - PID 4270 | Values: 109.0 115.0 113.0 113.0 114.0 113.0 113.0 114.0 113.0 114.0 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:37:45 INFO - PID 4270 | Values: 148.0 147.0 147.0 149.0 148.0 148.0 149.0 148.0 148.0 148.0 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.43 (1.5%) stddev-sans-first:1.51 08:37:45 INFO - PID 4270 | Values: 94.0 94.0 98.0 94.0 95.0 94.0 93.0 94.0 93.0 95.0 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | [#8] json-parse-financial Cycles:10 Average:45.80 Median:46.50 stddev:2.44 (5.2%) stddev-sans-first:2.46 08:37:45 INFO - PID 4270 | Values: 48.0 48.0 49.0 45.0 49.0 44.0 45.0 44.0 43.0 43.0 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 08:37:45 INFO - PID 4270 | Values: 38.0 38.0 38.0 37.0 38.0 38.0 38.0 38.0 38.0 37.0 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | [#10] stanford-crypto-aes Cycles:10 Average:71.90 Median:72.50 stddev:2.64 (3.6%) stddev-sans-first:2.55 08:37:45 INFO - PID 4270 | Values: 75.0 73.0 72.0 77.0 71.0 69.0 70.0 73.0 70.0 69.0 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | [#11] stanford-crypto-ccm Cycles:10 Average:102.10 Median:104.50 stddev:2.96 (2.8%) stddev-sans-first:3.12 08:37:45 INFO - PID 4270 | Values: 103.0 106.0 100.0 106.0 101.0 101.0 98.0 106.0 100.0 100.0 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:152.50 stddev:3.74 (2.5%) stddev-sans-first:3.95 08:37:45 INFO - PID 4270 | Values: 154.0 150.0 152.0 156.0 149.0 151.0 153.0 151.0 152.0 162.0 08:37:45 INFO - PID 4270 | 08:37:45 INFO - PID 4270 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:57.70 Median:58.00 stddev:0.82 (1.4%) stddev-sans-first:0.73 08:37:45 INFO - PID 4270 | Values: 59.0 57.0 58.0 57.0 59.0 57.0 58.0 57.0 57.0 58.0 08:37:45 INFO - PID 4270 | -------- Summary: end -------- 08:37:45 INFO - PID 4270 | 08:37:46 INFO - PID 4270 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:37:46 INFO - TEST-INFO | 4270: exit 0 08:37:46 INFO - TEST-OK | kraken | took 59170ms 08:37:46 INFO - SUITE-END | took 1168s 08:37:46 INFO - Completed test suite (00:19:29) 08:37:46 INFO - javascript benchmark 08:37:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9423.89903097262, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3982.5220973483188, 3989.7606143631374, 3999.240144372569, 3999.8800035998893, 4003.879883603493, 6366.0, 6385.233771947367, 6410.391012853783, 6411.967940160304, 6487.513436492264, 6404.647744374058, 6423.743050277995, 6499.935000649992, 6504.967475162629, 6513.250976137746, 5666.263385759846, 5710.229119068935, 5757.42425757423, 5782.24830771999, 5786.218860453827, 5698.458646428603, 5705.4579814917515, 5717.228174196493, 5747.59766816323, 5789.305283366002, 5723.427657234264, 5765.2216950711745, 5769.798057068004, 5801.100829371454, 5844.473997340238, 5760.711964401763, 5779.711014449261, 5801.970990145064, 5875.471207591316, 5877.5591830612875, 5688.402717714663, 5749.223854779635, 5788.710564471759, 5796.768129274824, 5846.853828654275, 6226.844328891769, 6253.749850005995, 6259.311475737665, 6315.400036996524, 6354.046892966046, 6978.0, 7051.048108505389, 7074.7170113195925, 7079.61062141582, 7083.256258092929, 6988.6855091521, 7016.298370162994, 7027.0, 7111.964440177766, 7113.502054856162, 6323.715432805535, 6432.678366081677, 6434.324395938406, 6436.098946147543, 6476.384743449365, 7198.928010719826, 7215.963920180366, 7226.349628533457, 7226.74706385274, 7239.963800181071, 6853.931460685429, 6863.10779598659, 6870.072540207008, 6881.518293719491, 6964.93035069653, 6886.2769409212315, 6995.79012629622, 6998.75504357345, 7003.089598352181, 7082.362587367059, 6824.351686589766, 6876.965615171992, 6883.7590684325805, 6889.242183359826, 6980.616066116412, 6814.114165158498, 6841.726330946706, 6893.4829887758615, 6900.2409734929115, 6902.0, 5077.720725360066, 5094.133997220481, 5152.433232344439, 5157.200633901752, 5157.793688252428, 4640.025594625099, 4684.391029166187, 4684.718916864999, 4699.0, 4767.928481072787, 6457.644829534327, 6518.511111666644, 6521.380468855451, 6522.673866306665, 6524.771632992823, 6896.27589103137, 6911.308869113049, 6912.205096413977, 6915.170179578483, 6998.650067496605, 6423.74305027803, 6484.092227088211, 6518.054882042077, 6541.672916354163, 6542.149520562297, 5783.1325301204315, 5814.79648212319, 5826.650400975955, 5828.504577110908, 5829.417058294137, 7186.317299856505, 7194.676239569128, 7212.278772122746, 7269.854602908018, 7288.562686238843, 6877.140357455318, 6930.757423490154, 6942.652867356511, 6983.0, 6983.441324694114, 7055.929440705732, 7058.188308344606, 7065.152181738019, 7067.363937245673, 7134.143902731706, 6656.23453302857, 6779.389854913082, 6856.348646878539, 6863.828404289933, 6875.724971001104, 6911.239763626098, 6929.411000065051, 6942.409895158968, 6996.265392133752, 7006.894896576454, 6562.770303039561, 6638.800835974928, 6693.0, 6724.394804467622, 6725.260221375547, 6629.867402652017, 6637.336266373324, 6687.398134167948, 6712.429443497357, 6797.422219111431, 6626.072349870926, 6626.171728533934, 6630.53586248958, 6645.867082658223, 6656.467482601477, 6673.733050677918, 6703.363180497845, 6751.831204219934, 6762.289959554176, 6796.76211332601, 6461.353864613689, 6465.806025819233, 6559.508036897348, 6569.770058047945, 6576.704048317742], "value": 6352.832154996562, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [960.9615615375385, 966.5988614724889, 995.9999999999999, 1019.6686077024966, 1027.871516060493, 46697.766511167436, 47341.0, 47684.523154768445, 47862.76068619656, 47865.52134478658, 43490.78254608731, 43649.563504364945, 43695.344569831395, 43744.343834842424, 43763.12473750531, 7816.179301173366, 7917.287444130027, 7953.125156232839, 7955.0, 7958.840823183533, 7790.259925307115, 7800.336971357441, 7800.765977020698, 7805.804854878616, 7813.531188128702, 7761.146273909865, 7781.727639532617, 7810.414218933574, 7839.8432031359625, 8478.491290522557, 8504.914950850505, 8582.699605513808, 8587.355948303839, 8588.570571471433, 8589.141085891424, 8398.706045288447, 8485.83028339436, 8490.448120872123, 8491.44805587641, 8492.53291068991, 44100.3384949226, 44169.0, 44215.77892110551, 44285.114297714186, 44316.0, 3554.7689400189165, 3595.137167079908, 3595.586507551639, 3598.2803439312243, 3598.6581274778855, 35501.82249088764, 35542.0, 35547.82226088853, 35623.64376356229, 35656.465153022466, 5539.390667026664, 5545.0, 5565.693886836222, 5581.05122129239, 5622.606417550773, 247530.0, 249282.75358623272, 249457.0, 249585.0, 251008.0, 54577.181342279895, 54597.45402546003, 55192.17211741827, 55491.72254138784, 55495.0, 58219.70890145522, 58328.41671583315, 58346.41653583495, 58360.41639583635, 58384.0, 18369.908150459163, 18617.162227699788, 18669.533261668566, 18770.249190032246, 18816.247350106118, 15421.074735515906, 15583.220838958006, 15590.688186236212, 15598.0, 15607.297671604805, 15695.607609809618, 15918.602034948988, 16000.199990000687, 16034.358625654842, 16082.115483648511, 6221.968890155611, 6378.840528986812, 6437.774677886251, 6442.871142577123, 6499.350064993558, 1099.4173088263233, 1101.730076131337, 1103.7185517692938, 1106.833974903771, 1109.4674556213063, 25932.740672593034, 26095.478090438086, 26135.73864261333, 26349.0, 26483.0, 1198.940052997364, 1202.7173614200656, 1211.9091068169923, 1217.2696382170627, 1244.3591550351575, 13667.284786748556, 13728.725425491435, 13835.723285534234, 13874.098183618033, 14017.789733154012, 281503.0, 281930.0, 284055.0, 290908.0, 295000.0, 62276.688616556625, 62580.68709656422, 63344.36655633384, 63449.68275158595, 63528.682356587924, 1577.5188567487028, 1577.716011117987, 1582.074486425431, 1594.1471312847802, 1597.7044246814144, 31305.8434707825, 31387.215319617193, 31426.68573314329, 32207.194820129684, 32486.187845304055, 42914.35628465638, 43230.70307890768, 43333.0, 43355.0, 43393.0, 252191.0, 252327.0, 252441.0, 253154.0, 253404.0, 37211.25577488489, 38531.42202867015, 38565.80717096396, 38736.22527549489, 38806.2238755229, 47601.0, 49133.0, 49165.75417122892, 49179.508204917496, 49339.25991110064, 36747.0, 36749.44875826918, 37145.81427092847, 37152.628473715995, 37246.62753372431, 36704.449433259055, 36880.63119368772, 36977.815110924275, 36999.26001480009, 37619.0, 42410.787946060074, 43839.34240986451, 43903.12193756171, 43930.56069439265, 43940.340894885965, 35160.0, 35178.0, 35317.29365412729, 35535.46696799498, 36291.45562816507, 25820.0, 25873.22380328593, 25908.481830363664, 26304.34239144037, 26434.471310574067], "value": 19498.24188104502, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.8580933480634, 612.8712970276242, 618.2056057965515, 619.4115590189318, 623.6133597169754, 24062.0, 24961.25116246511, 25044.874775626144, 25081.0, 25123.371915702093, 27577.862110689468, 28296.434071318563, 28309.29226769332, 28322.291942701442, 28415.289617759565, 6714.227863795665, 6970.372666460017, 6974.302569743036, 6983.89524157138, 7005.124359455068, 6610.801675949705, 6817.454603631722, 6819.215790184118, 6827.112475378219, 6835.7949261522235, 6760.3577660122455, 6771.0, 6785.185777706657, 6800.183977922631, 6805.047293378931, 6745.0, 6793.45652347811, 6800.863982720342, 6802.863942721167, 6811.761588344434, 6342.4926005919415, 6358.491320694333, 6359.0, 6368.968155159195, 6380.425761681471, 29873.954411595707, 32172.517412238834, 32916.341673166644, 33129.0, 33165.33669326624, 2411.5900296949385, 2424.35754525051, 2450.48539806639, 2453.251758213744, 2454.509098180371, 20619.69070463944, 20621.278255261142, 20979.26572569968, 21012.5797484051, 21037.789622103737, 2317.7102862142233, 2449.216250799745, 2648.0334677842643, 2648.298200976743, 2665.187117929031, 147102.26448867793, 154173.0, 155091.0, 160980.19509902375, 161602.1919890393, 16246.593835154215, 16908.830911690726, 17032.914835425745, 17050.57373565646, 17206.483805485605, 26573.601395979076, 26627.068052618066, 26731.19806405811, 26782.0, 26786.330341741614, 11266.774664506664, 11769.88230117705, 11804.11469139818, 11830.645080647595, 11877.524899003944, 10810.56757729682, 10987.121030317556, 11010.222997520175, 11020.669379918616, 11079.113670906308, 9904.257180711475, 9908.35595686278, 9977.401355918668, 10216.335938163995, 10284.485775711184, 2914.493535559417, 2969.124108388031, 3006.3987202559574, 3024.7126522980284, 3078.8146563573187, 1033.5142483032962, 1058.5818601652304, 1064.3986147826454, 1077.369738702852, 1083.414955923808, 22258.666120008213, 22336.664950025763, 22470.887645561666, 22600.434989125075, 22693.773062269494, 1145.4730823821135, 1148.2765857509883, 1156.988430115705, 1161.4076820821442, 1165.0272022860836, 12074.637760867188, 12213.938930305292, 12423.565175219004, 12531.624051278477, 12533.185342952678, 709057.0502803333, 714678.0, 720097.0, 724021.0, 730991.0, 134785.32607337096, 135133.3243333777, 135697.0, 135904.0, 137307.0, 1236.116176933497, 1286.3246795432474, 1294.7151626641935, 1297.7469393468373, 1307.1176955554963, 19239.615207696046, 19306.4208073758, 19312.517187070436, 19835.504112397306, 19845.404637860887, 63378.36621633724, 63801.36198637954, 64119.0, 66251.99999999806, 66356.0, 79648.0, 80351.19648803437, 80860.0, 81385.18614813776, 82211.17788822035, 15230.619234519225, 15841.603959901095, 16037.839621603634, 16052.438164664181, 16074.35702571884, 25234.116805911704, 25263.621045684697, 25503.36241593975, 25629.10298139556, 25683.743162568884, 20408.38774836757, 20455.693164602246, 20670.689939650616, 20866.37400877976, 20885.582288353842, 17838.821611783715, 18161.545961351072, 18367.632647346712, 18691.345802896834, 18832.34086806955, 20068.09693563764, 20797.1681132753, 21047.0, 21251.681224781332, 21308.0, 15720.842791571939, 15809.841901580838, 15821.208939552746, 15828.44600438979, 15840.44558440449, 19987.500312492302, 20082.297119601328, 20088.39734807958, 20142.798572014093, 20298.0], "value": 13318.737441119565, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.609946165343, 1463.5609317204842, 1465.6702241995545, 1476.033198255143, 1489.255372313843, 16949.745753813702, 17284.567885802862, 17547.64904701907, 17623.823761762378, 17776.64446711065, 17420.65158696825, 17557.0, 17569.385071522498, 17613.207405666744, 17629.7355539667, 3047.512398016318, 3057.602511673485, 3104.6895310469, 3107.409592177479, 3108.564800927872, 3099.256178517162, 3100.178452710022, 3114.906552803408, 3132.326549791794, 3133.1853718033362, 2807.705190954951, 3079.461094308487, 3081.9845900770465, 3084.028531012735, 3086.429010633029, 2883.5530492773655, 2915.3440475892753, 2920.868560914743, 3044.90865274041, 3058.4953482675332, 2961.763058955278, 2996.8501574921165, 3014.0505740691833, 3014.291641464254, 3020.5469179623014, 16968.066756328397, 17074.402395916208, 17121.22954467052, 17130.743038854427, 17383.0, 8599.44103633268, 8871.689490867788, 8884.689035883714, 8890.4665720057, 8902.109789021111, 5718.542516598662, 5887.941120588825, 6060.363661815534, 6068.0, 6072.271327440735, 2173.369722780392, 2179.5967745967046, 2220.0786673530465, 2256.4697296135396, 2272.681824544565, 31789.205269868206, 31797.364052718814, 32016.0, 32043.519347209578, 32046.519302210487, 7517.812054698677, 7576.507527010726, 7613.847723045508, 7794.610269486503, 7848.21517848222, 20171.193152273743, 20185.697214541793, 20269.898650506653, 20304.593908121755, 20358.389248322277, 8681.131886811268, 8827.426217295855, 8831.0, 8841.248493877963, 8848.734537963743, 7966.9601651992525, 8047.114817370201, 8160.795980100426, 8262.628181731716, 8264.586770661443, 5820.912686309709, 5917.615355001911, 5988.580799344004, 6037.72830222641, 6339.207599050119, 1575.0785790312566, 1593.4343308125449, 1645.6132808789926, 1737.860971122307, 1783.4738752068172, 999.1307562420741, 1011.8026984737905, 1013.5996281468779, 1015.4059874973224, 1026.1175389165312, 9990.0, 10019.79960400788, 10035.297529172887, 10174.69475915709, 10205.74485637865, 1040.6409788622914, 1071.2608300272786, 1076.252004856617, 1099.1811100730008, 1104.447776111944, 4958.727270000112, 5206.349206349207, 6133.662648554372, 6202.56582039262, 6327.303996560375, 26312.86843565808, 26544.734552654227, 26857.86571067171, 27137.592936105975, 27243.863780681368, 25054.624180637304, 25371.0, 26127.216183514523, 26338.078167264055, 26389.604155937675, 13020.674483137997, 13056.543020994219, 13065.412056457482, 13230.404631791593, 13231.669208269677, 10201.0, 10270.435126068138, 10281.280310378203, 10299.7425064371, 10311.123554497952, 22146.22488212905, 22352.441188970406, 22477.550448991256, 22527.32418027462, 22694.205702800322, 23035.769642303363, 23315.183968561018, 23589.758972897547, 23601.52796944086, 24196.758032420155, 12832.101752877208, 12984.285864277555, 13065.412056457291, 13066.934665326613, 13078.411471483616, 16225.269862856436, 16365.427210047592, 16474.83525164733, 16503.17484125813, 16533.751993720343, 12691.048171386998, 12703.555375561811, 12831.871681283068, 12836.422360993964, 12889.291088990196, 12904.290264035568, 13109.213447193199, 13139.671508212372, 13226.537071202461, 13293.667658308234, 11073.667789966314, 11359.091272697999, 11374.43127843621, 11381.918717721803, 11402.087832973177, 8198.221168988937, 8277.668893244443, 8318.750437486886, 8339.916600834156, 8443.620037098468, 7950.045994480699, 8074.515529068275, 8103.959480202797, 8106.878396823934, 8116.391270654606], "value": 7668.248226875937, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.4136656510663, 576.9528306124387, 580.0545111468306, 582.7639805878619, 586.1910563422476, 6391.936080639192, 6418.550701450895, 6439.4204521593165, 6490.415862572373, 6520.9347906520925, 6333.429991300782, 6340.7463701452, 6359.58662686925, 6376.713047912844, 6403.103565500822, 4992.625553083515, 5086.41506226785, 5185.248139019849, 5194.558462530689, 5196.194589838562, 5077.162268225738, 5101.974490127544, 5108.948910510884, 5112.488751124895, 5125.179971204608, 5014.671112155282, 5050.974745126269, 5055.545000949914, 5059.6458247922665, 5113.6931784092885, 5012.423571289312, 5057.519535644126, 5057.797688092472, 5066.088104141253, 5066.974665126688, 4672.602828759559, 4677.251639737659, 4692.343071969927, 4707.340972263886, 4713.929291060603, 6333.429991300759, 6379.0, 6404.967975160141, 6416.839579010515, 6439.742410303582, 5997.820065398045, 6004.879902401927, 6008.3390827009, 6018.766152938637, 6028.879422411527, 6687.899681504781, 6769.458443324522, 6773.491988100912, 6794.45644348451, 6834.726610935557, 5145.151050076733, 5146.871328216825, 5147.510986456281, 5154.355705536808, 5168.8966220675375, 6795.18457785064, 6804.76183333581, 6933.1333583302085, 7018.263082376379, 7109.644517774091, 5239.921401178985, 5270.78916843322, 5298.284731561267, 5306.177542480922, 5307.363116426053, 5347.331583552056, 5352.2506849041165, 5383.2194331821665, 5388.326459192601, 5417.783288668488, 5980.43185897339, 5995.910061349084, 5996.370381110008, 6011.699415029231, 6040.214772079689, 6854.485913556503, 6859.5541289816, 6876.140482439695, 6877.2091209510545, 6880.65596720162, 1857.3406440713622, 1861.7207418887003, 1867.4491025147613, 1873.381784011273, 1874.9906250468932, 1281.3080936294298, 1312.6587087357166, 1312.822768926202, 1318.2222488731695, 1325.2512330533218, 6432.0, 6434.453071488882, 6439.710213040425, 6455.160829092188, 6469.029645553111, 6819.147606549182, 6828.658567071627, 6868.828279293058, 6886.8622627547165, 6892.0, 6439.678016099177, 6500.512461565401, 6503.804885853432, 6506.967465162644, 6542.54202205841, 3632.1282892106233, 3655.738770124303, 3661.0664280608275, 3671.6695497405362, 3679.5584529856055, 7241.89137162943, 7275.236100209508, 7291.234420385783, 7293.635318234067, 7337.633118344062, 7068.0, 7135.536190147727, 7168.498205125591, 7198.496105272686, 7234.997476047487, 7213.242609525924, 7257.8548429031125, 7264.128304603481, 7279.526830755984, 7306.780796576111, 6786.93213067863, 6883.900410374684, 6951.0, 6959.373656370951, 6963.303669632996, 6768.357006084414, 6860.451163906975, 6912.101426814482, 6913.412359949461, 6963.6866341013765, 7252.601106939169, 7287.4534409920525, 7304.8539029218055, 7319.670614822239, 7336.816579585553, 5332.120200166929, 5341.813036543703, 5342.866428339323, 5353.892922141613, 5375.919361209507, 6701.865962680817, 6804.659767011729, 6874.9656251718425, 6889.448844092561, 6920.9307906920285, 6527.836804079746, 6669.0, 6681.064650948968, 6690.364415380725, 6821.669774394144, 6686.498512611476, 6727.360900714424, 6750.2237242715755, 6754.5609535380045, 6781.6270105144695, 6434.64609446485, 6610.272869984202, 6700.899486507804, 6737.191537015589, 6779.220389655253, 6674.599524028574, 6705.262421133574, 6843.863122737617, 6867.622280774605, 6874.484413668894, 6590.439812615789, 6610.239822420291, 6612.338766123349, 6635.336466353326, 6654.401103900672], "value": 5319.717082801369, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [975.4976187263557, 1014.2291858187776, 1027.3476342522497, 1044.2794471814448, 1051.8369652703832, 17688.469345919628, 17810.91094544527, 17951.551211219725, 17982.64034719305, 18018.918864868116, 18313.90843045783, 18619.348322808706, 18837.623247535077, 18895.905520472377, 19227.711584326247, 1061.209398997746, 1074.7152004718755, 1079.2445288298184, 1079.282277285604, 1079.2984560035961, 1096.3476731344838, 1096.4736926275393, 1102.2119184782878, 1104.6741211342674, 1138.60148947868, 1176.1531697178061, 1181.1259667845818, 1181.3384504677365, 1181.5451051345208, 1186.1696812231473, 1161.790877642024, 1171.3206340322636, 1174.9060075193963, 1178.581603530747, 1179.039083147241, 861.2808305065278, 869.3740506835069, 871.3377832847018, 872.1975782280253, 875.1073904617318, 20103.497412564655, 20658.58682826335, 20861.165553377847, 20884.477888052767, 21277.25529606472, 24218.878905605536, 24251.151209707576, 24498.510029799305, 24686.876565617236, 24695.87652061746, 19567.21731130767, 19648.508787280432, 19682.606347873105, 19685.31101411444, 19914.20343186271, 4125.422440858282, 4168.124693814302, 4186.895327616803, 4211.073563815956, 4219.135077309144, 167111.0, 171902.0, 172851.13574432174, 173135.0, 174008.0, 18710.906445467685, 18775.061246937872, 18868.43394698161, 19048.71426928597, 19234.422967310722, 35489.29021419609, 35610.0, 35791.82104089515, 35827.641723582434, 35988.0, 9788.902110978941, 9991.750206244902, 10042.246831487668, 10044.347117437343, 10078.244131690153, 4986.850394488171, 5078.7460626968505, 5097.8215762448135, 5102.132637451642, 5107.693538387709, 6293.842653933688, 6484.610923344614, 6528.640924749089, 6529.902051469232, 6553.148090748267, 1152.8270759385991, 1188.5305304404712, 1198.221156248428, 1202.7113492761848, 1209.7640960012714, 776.8446310737762, 782.8629989751771, 793.9047314322319, 800.7677773445636, 802.7029998900327, 13153.53962611304, 13626.386812593457, 14655.706885862222, 14893.18087505176, 15273.236338183046, 765.6248438265321, 773.0684525147184, 773.5590713293369, 774.8334108166771, 786.1313248860042, 6355.315841302058, 6552.705128269239, 6591.670416479157, 6616.503762217853, 6667.533272670867, 153188.0, 157191.0, 161806.1909690444, 163370.0, 163799.0, 146491.0, 146570.0, 148496.0, 148737.0, 148760.0, 121257.0, 122545.38727306484, 122804.0, 123552.38223809004, 125823.0, 12519.436625351698, 12529.749405012031, 12559.560415385418, 12680.619581412573, 12693.0, 59258.0, 59311.0, 60157.69921150366, 60825.69587152036, 62458.68770656118, 74107.0, 75410.0, 75995.62002189954, 75997.0, 76885.0, 18060.277588896297, 19231.807681923, 19253.614927701088, 19296.903515482332, 19368.70946935825, 21005.264815731374, 21158.259460918795, 21173.7882621178, 21194.0, 21298.680519792524, 19151.329703460313, 19248.422547323604, 19552.8044719551, 19649.60700786005, 19806.405807825788, 18223.179956901706, 18349.724754128965, 18476.445706628823, 18567.16447759881, 18644.533886652942, 17495.737563936298, 17513.649727005642, 17571.385001524886, 17580.0, 17727.91136044363, 12644.241345519298, 12784.232946023269, 12889.548865789653, 13020.348982551024, 13125.474981000652, 13978.580642580739, 14071.296435178405, 14086.577402677936, 14112.153270803785, 14139.787903181666], "value": 10407.500021955702, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1354.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 104.0, 107.0, 104.0, 106.0, 106.0, 109.0, 107.0, 104.0, 105.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 113.0, 112.0, 110.0, 110.0, 111.0, 111.0, 115.0, 114.0], "value": 111.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 160.0, 160.0, 161.0, 159.0, 163.0, 161.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 73.0, 74.0, 72.0, 75.0, 75.0, 76.0, 75.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 76.0, 85.0, 76.0, 78.0, 77.0, 77.0, 77.0, 77.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 149.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 98.0, 94.0, 95.0, 94.0, 93.0, 94.0, 93.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 49.0, 45.0, 49.0, 44.0, 45.0, 44.0, 43.0, 43.0], "value": 45.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0, 38.0, 37.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 72.0, 77.0, 71.0, 69.0, 70.0, 73.0, 70.0, 69.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 106.0, 100.0, 106.0, 101.0, 101.0, 98.0, 106.0, 100.0, 100.0], "value": 102.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 152.0, 156.0, 149.0, 151.0, 153.0, 151.0, 152.0, 162.0], "value": 153.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 58.0, 57.0, 59.0, 57.0, 58.0, 57.0, 57.0, 58.0], "value": 57.7, "unit": "score"}]}]} 08:37:46 INFO - Return code: 0 08:37:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:37:47 INFO - # TBPL SUCCESS # 08:37:47 INFO - Running post-action listener: _package_coverage_data 08:37:47 INFO - Running post-action listener: _resource_record_post_action 08:37:47 INFO - [mozharness: 2017-09-16 15:37:47.055367Z] Finished run-tests step (success) 08:37:47 INFO - Running post-run listener: _resource_record_post_run 08:37:47 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 10891264; Write bytes: 407625728; Read time: 3960; Write time: 357204 08:37:47 INFO - TinderboxPrint: CPU usage
13.1% 08:37:47 INFO - TinderboxPrint: I/O read bytes / time
10,891,264 / 3,960 08:37:47 INFO - TinderboxPrint: I/O write bytes / time
407,625,728 / 357,204 08:37:47 INFO - TinderboxPrint: CPU idle
8,206.0 (86.9%) 08:37:47 INFO - TinderboxPrint: CPU user
1,179.6 (12.5%) 08:37:47 INFO - TinderboxPrint: Swap in / out
0 / 0 08:37:47 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 3268608; Read time: 0; Write time: 152 08:37:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:37:47 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 10891264; Write bytes: 404357120; Read time: 3960; Write time: 357052 08:37:47 INFO - Running post-run listener: _upload_blobber_files 08:37:47 INFO - Blob upload gear active. 08:37:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:37:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:37:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:37:48 INFO - (blobuploader) - INFO - Open directory for files ... 08:37:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:37:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:37:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:54 INFO - (blobuploader) - INFO - Done attempting. 08:37:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:37:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:37:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:56 INFO - (blobuploader) - INFO - Done attempting. 08:37:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:37:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:37:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:57 INFO - (blobuploader) - INFO - Done attempting. 08:37:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:37:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:37:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:58 INFO - (blobuploader) - INFO - Done attempting. 08:37:58 INFO - (blobuploader) - INFO - Iteration through files over. 08:37:58 INFO - Return code: 0 08:37:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:37:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:37:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cd613f7c7d5b46183637c5565240e6a9eafe39f1dbdf59931bcc7bdfa06f5b723823a88dcb898165077a89a54d501cf1faa4d6dd0213e81e7723c0727f23b867", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/68763e4cf8fb1ad2d221ea99cf805cff425626e55677daf09e72d792d4cffaf290914fbcc351f493b6c12c41957cc5466b48aa10de7bba393eb57c6745241b0a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cb1a1b7e824a700056bca26a4ea63a5a764ea4215f399ace7750e2d6a95af429f9fa21a4ad79c7f3cc07e4cfb1e758a42508e8a73230135740fc8cd625e1c449", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e1ec4e52d9a61e79ffeffff09ac3c4a5302d921d6711f4fc66e5ecac1bd5e3ed8c68f848404ac5fe668b0d3f4702879bb377449650d8bc7821af3802499875d0"} 08:37:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:37:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:37:58 INFO - Contents: 08:37:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cd613f7c7d5b46183637c5565240e6a9eafe39f1dbdf59931bcc7bdfa06f5b723823a88dcb898165077a89a54d501cf1faa4d6dd0213e81e7723c0727f23b867", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/68763e4cf8fb1ad2d221ea99cf805cff425626e55677daf09e72d792d4cffaf290914fbcc351f493b6c12c41957cc5466b48aa10de7bba393eb57c6745241b0a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cb1a1b7e824a700056bca26a4ea63a5a764ea4215f399ace7750e2d6a95af429f9fa21a4ad79c7f3cc07e4cfb1e758a42508e8a73230135740fc8cd625e1c449", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e1ec4e52d9a61e79ffeffff09ac3c4a5302d921d6711f4fc66e5ecac1bd5e3ed8c68f848404ac5fe668b0d3f4702879bb377449650d8bc7821af3802499875d0"} 08:37:58 INFO - Running post-run listener: copy_logs_to_upload_dir 08:37:58 INFO - Copying logs to upload dir... 08:37:58 INFO - mkdir: /builds/slave/test/build/upload/logs 08:37:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.582997 ========= master_lag: -0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-16 08:37:57.931188) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 08:37:57.938370) ========= 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=dac658600622fd96716c9acf000001b3-1505574700.378350-294110153 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/cd613f7c7d5b46183637c5565240e6a9eafe39f1dbdf59931bcc7bdfa06f5b723823a88dcb898165077a89a54d501cf1faa4d6dd0213e81e7723c0727f23b867", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/68763e4cf8fb1ad2d221ea99cf805cff425626e55677daf09e72d792d4cffaf290914fbcc351f493b6c12c41957cc5466b48aa10de7bba393eb57c6745241b0a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cb1a1b7e824a700056bca26a4ea63a5a764ea4215f399ace7750e2d6a95af429f9fa21a4ad79c7f3cc07e4cfb1e758a42508e8a73230135740fc8cd625e1c449", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e1ec4e52d9a61e79ffeffff09ac3c4a5302d921d6711f4fc66e5ecac1bd5e3ed8c68f848404ac5fe668b0d3f4702879bb377449650d8bc7821af3802499875d0"} build_url:https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011185 build_url: 'https://queue.taskcluster.net/v1/task/Z862lKMWTPqPl_vfofmXeQ/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/cd613f7c7d5b46183637c5565240e6a9eafe39f1dbdf59931bcc7bdfa06f5b723823a88dcb898165077a89a54d501cf1faa4d6dd0213e81e7723c0727f23b867", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/68763e4cf8fb1ad2d221ea99cf805cff425626e55677daf09e72d792d4cffaf290914fbcc351f493b6c12c41957cc5466b48aa10de7bba393eb57c6745241b0a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cb1a1b7e824a700056bca26a4ea63a5a764ea4215f399ace7750e2d6a95af429f9fa21a4ad79c7f3cc07e4cfb1e758a42508e8a73230135740fc8cd625e1c449", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e1ec4e52d9a61e79ffeffff09ac3c4a5302d921d6711f4fc66e5ecac1bd5e3ed8c68f848404ac5fe668b0d3f4702879bb377449650d8bc7821af3802499875d0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 08:37:57.969503) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 08:37:57.969963) ========= 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=dac658600622fd96716c9acf000001b3-1505574700.378350-294110153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 08:37:58.048805) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 08:37:58.052153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 08:37:58.052472) ========= ========= Total master_lag: 0.10 =========