builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1506871225.12 results: success (0) revision: 7b7e1bd82717a0d965f172c3a2ad223ddfb3a796 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-01 08:20:25.124112) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-01 08:20:25.124546) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-01 08:20:25.124842) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-01 08:20:25.163012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 08:20:25.163362) ========= 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=fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-01 08:20:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2017-10-01 08:20:25 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139548 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 08:20:25.345412) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 08:20:25.345742) ========= 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=fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020620 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 08:20:25.412435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-01 08:20:25.415762) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7b7e1bd82717a0d965f172c3a2ad223ddfb3a796 --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 7b7e1bd82717a0d965f172c3a2ad223ddfb3a796 --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=fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-01 08:20:25,667 truncating revision to first 12 chars 2017-10-01 08:20:25,667 Setting DEBUG logging. 2017-10-01 08:20:25,667 attempt 1/10 2017-10-01 08:20:25,667 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7b7e1bd82717?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-01 08:20:26,421 unpacking tar archive at: mozilla-beta-7b7e1bd82717/testing/mozharness/ program finished with exit code 0 elapsedTime=1.088574 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-01 08:20:26.523263) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-01 08:20:26.523553) ========= script_repo_revision: 7b7e1bd82717a0d965f172c3a2ad223ddfb3a796 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-01 08:20:26.523950) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-01 08:20:26.524216) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-01 08:20:26.539867) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-10-01 08:20:26.540268) ========= /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=fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:20:26 INFO - MultiFileLogger online at 20171001 08:20:26 in /builds/slave/test 08:20:26 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:20:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:20:26 INFO - {'append_to_log': False, 08:20:26 INFO - 'base_work_dir': '/builds/slave/test', 08:20:26 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 08:20:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:20:26 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 08:20:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:20:26 INFO - 'code_coverage': False, 08:20:26 INFO - 'config_files': ('talos/linux_config.py',), 08:20:26 INFO - 'default_actions': ('clobber', 08:20:26 INFO - 'read-buildbot-config', 08:20:26 INFO - 'download-and-extract', 08:20:26 INFO - 'populate-webroot', 08:20:26 INFO - 'create-virtualenv', 08:20:26 INFO - 'install', 08:20:26 INFO - 'setup-mitmproxy', 08:20:26 INFO - 'run-tests'), 08:20:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:20:26 INFO - 'disable_ccov_upload': False, 08:20:26 INFO - 'disable_stylo': False, 08:20:26 INFO - 'download_minidump_stackwalk': True, 08:20:26 INFO - 'download_symbols': 'ondemand', 08:20:26 INFO - 'enable_stylo': False, 08:20:26 INFO - 'enable_webrender': False, 08:20:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 08:20:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:20:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:20:26 INFO - 'gecko_profile': False, 08:20:26 INFO - 'gecko_profile_interval': 0, 08:20:26 INFO - 'installer_path': 'installer.exe', 08:20:26 INFO - 'log_level': 'info', 08:20:26 INFO - 'log_name': 'talos', 08:20:26 INFO - 'log_to_console': True, 08:20:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:20:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:20:26 INFO - 'opt_config_files': (), 08:20:26 INFO - 'pip_index': False, 08:20:26 INFO - 'suite': 'dromaeojs-e10s', 08:20:26 INFO - 'system_bits': '32', 08:20:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:20:26 INFO - 'title': 'talos-linux64-ix-048', 08:20:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:20:26 INFO - 'use_talos_json': True, 08:20:26 INFO - 'verify': 'False', 08:20:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:20:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:20:26 INFO - 'work_dir': 'build'} 08:20:26 INFO - [mozharness: 2017-10-01 15:20:26.930439Z] Running clobber step. 08:20:26 INFO - Running pre-action listener: _resource_record_pre_action 08:20:26 INFO - Running main action method: clobber 08:20:26 INFO - rmtree: /builds/slave/test/build 08:20:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:20:27 INFO - Running post-action listener: _resource_record_post_action 08:20:27 INFO - [mozharness: 2017-10-01 15:20:27.928689Z] Finished clobber step (success) 08:20:27 INFO - [mozharness: 2017-10-01 15:20:27.928787Z] Running read-buildbot-config step. 08:20:27 INFO - Running pre-action listener: _resource_record_pre_action 08:20:27 INFO - Running main action method: read_buildbot_config 08:20:27 INFO - Using buildbot properties: 08:20:27 INFO - { 08:20:27 INFO - "project": "", 08:20:27 INFO - "product": "firefox", 08:20:27 INFO - "who": "ffxbld@noreply.mozilla.org", 08:20:27 INFO - "installer_path": "public/build/target.tar.bz2", 08:20:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:20:27 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 08:20:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 08:20:27 INFO - "stage_platform": "linux64", 08:20:27 INFO - "basedir": "/builds/slave/test", 08:20:27 INFO - "buildnumber": 139, 08:20:27 INFO - "platform": "ubuntu64_hw", 08:20:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:20:27 INFO - "slavebuilddir": "test", 08:20:27 INFO - "taskId": "PGjzATJXRFKcphaevNuHhg", 08:20:27 INFO - "branch": "mozilla-beta", 08:20:27 INFO - "script_repo_revision": "production", 08:20:27 INFO - "revision": "7b7e1bd82717a0d965f172c3a2ad223ddfb3a796", 08:20:27 INFO - "slavename": "talos-linux64-ix-048", 08:20:27 INFO - "repo_path": "releases/mozilla-beta" 08:20:27 INFO - } 08:20:27 INFO - Finding installer, test and symbols from parent task. 08:20:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PGjzATJXRFKcphaevNuHhg'}, attempt #1 08:20:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PGjzATJXRFKcphaevNuHhg'}, attempt #1 08:20:28 INFO - Task dependencies: eHEvjhAdTZ23u2aNa5TtfA 08:20:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA'}, attempt #1 08:20:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.tar.bz2 08:20:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.test_packages.json 08:20:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.crashreporter-symbols.zip 08:20:29 INFO - Running post-action listener: _resource_record_post_action 08:20:29 INFO - [mozharness: 2017-10-01 15:20:29.250396Z] Finished read-buildbot-config step (success) 08:20:29 INFO - [mozharness: 2017-10-01 15:20:29.250611Z] Running download-and-extract step. 08:20:29 INFO - Running pre-action listener: _resource_record_pre_action 08:20:29 INFO - Running main action method: download_and_extract 08:20:29 INFO - mkdir: /builds/slave/test/build/tests 08:20:29 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:20:29 INFO - trying https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.test_packages.json 08:20:29 INFO - Downloading https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:20:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:20:30 INFO - Downloaded 989 bytes. 08:20:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:20:30 INFO - Using the following test package requirements: 08:20:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:20:30 INFO - u'common': [u'target.common.tests.zip'], 08:20:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:20:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:20:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:20:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:20:30 INFO - u'mozbase': [u'target.common.tests.zip'], 08:20:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:20:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:20:30 INFO - u'web-platform': [u'target.common.tests.zip', 08:20:30 INFO - u'target.web-platform.tests.tar.gz'], 08:20:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:20:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 08:20:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.common.tests.zip 08:20:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:20:30 INFO - Fetch https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.common.tests.zip into memory 08:20:33 INFO - Content-Length response header: 55177430 08:20:33 INFO - Bytes received: 55177430 08:20:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.talos.tests.zip 08:20:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:20:43 INFO - Fetch https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.talos.tests.zip into memory 08:20:45 INFO - Content-Length response header: 14509184 08:20:45 INFO - Bytes received: 14509184 08:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:45 INFO - trying https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.tar.bz2 08:20:45 INFO - Downloading https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:20:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:20:47 INFO - Downloaded 53484361 bytes. 08:20:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.tar.bz2 08:20:47 INFO - mkdir: /builds/slave/test/properties 08:20:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:20:47 INFO - Writing to file /builds/slave/test/properties/build_url 08:20:47 INFO - Contents: 08:20:47 INFO - build_url:https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.tar.bz2 08:20:47 INFO - Running post-action listener: _resource_record_post_action 08:20:47 INFO - Running post-action listener: find_tests_for_verification 08:20:47 INFO - Running post-action listener: set_extra_try_arguments 08:20:47 INFO - [mozharness: 2017-10-01 15:20:47.578550Z] Finished download-and-extract step (success) 08:20:47 INFO - [mozharness: 2017-10-01 15:20:47.578648Z] Running populate-webroot step. 08:20:47 INFO - Running pre-action listener: _resource_record_pre_action 08:20:47 INFO - Running main action method: populate_webroot 08:20:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:20:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:20:47 INFO - 'tests': ['tresize', 08:20:47 INFO - 'tcanvasmark']}, 08:20:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:20:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:20:47 INFO - 'tests': ['dromaeo_css', 08:20:47 INFO - 'kraken']}, 08:20:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:20:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:20:47 INFO - 'talos_options': ['--disable-stylo'], 08:20:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:20:47 INFO - 'tests': ['damp', 'tps']}, 08:20:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:20:47 INFO - 'talos_options': ['--disable-stylo'], 08:20:47 INFO - 'tests': ['damp', 'tps']}, 08:20:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:20:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:20:47 INFO - 'tests': ['dromaeo_dom']}, 08:20:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:20:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:20:47 INFO - 'tests': ['basic_compositor_video', 08:20:47 INFO - 'glvideo']}, 08:20:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:20:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:20:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:20:47 INFO - 'talos_options': ['--disable-stylo'], 08:20:47 INFO - 'tests': ['ts_paint_webext', 08:20:47 INFO - 'tp5o_webext']}, 08:20:47 INFO - 'other-e10s': {'tests': ['a11yr', 08:20:47 INFO - 'ts_paint', 08:20:47 INFO - 'tpaint', 08:20:47 INFO - 'sessionrestore', 08:20:47 INFO - 'sessionrestore_many_windows', 08:20:47 INFO - 'sessionrestore_no_auto_restore', 08:20:47 INFO - 'tabpaint']}, 08:20:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:20:47 INFO - 'tests': ['a11yr', 08:20:47 INFO - 'ts_paint', 08:20:47 INFO - 'tpaint', 08:20:47 INFO - 'sessionrestore', 08:20:47 INFO - 'sessionrestore_many_windows', 08:20:47 INFO - 'sessionrestore_no_auto_restore', 08:20:47 INFO - 'tabpaint']}, 08:20:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:20:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 08:20:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:20:47 INFO - 'tests': ['perf_reftest_singletons']}, 08:20:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:20:47 INFO - 'tests': ['bloom_basic']}, 08:20:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:20:47 INFO - 'tsvgr_opacity', 08:20:47 INFO - 'tart', 08:20:47 INFO - 'tscrollx', 08:20:47 INFO - 'tsvg_static']}, 08:20:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:20:47 INFO - 'tests': ['tsvgx', 08:20:47 INFO - 'tsvgr_opacity', 08:20:47 INFO - 'tart', 08:20:47 INFO - 'tscrollx', 08:20:47 INFO - 'tsvg_static']}, 08:20:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:20:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:20:47 INFO - 'talos_options': ['--disable-stylo'], 08:20:47 INFO - 'tests': ['tp5o']}, 08:20:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:20:47 INFO - 'talos_options': ['--mitmproxy', 08:20:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:20:47 INFO - '--firstNonBlankPaint'], 08:20:47 INFO - 'tests': ['tp6_google', 08:20:47 INFO - 'tp6_youtube', 08:20:47 INFO - 'tp6_amazon', 08:20:47 INFO - 'tp6_facebook']}, 08:20:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:20:47 INFO - 'talos_options': ['--disable-stylo', 08:20:47 INFO - '--mitmproxy', 08:20:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:20:47 INFO - '--firstNonBlankPaint'], 08:20:47 INFO - 'tests': ['tp6_google', 08:20:47 INFO - 'tp6_youtube', 08:20:47 INFO - 'tp6_amazon', 08:20:47 INFO - 'tp6_facebook']}, 08:20:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:20:47 INFO - 'talos_options': ['--stylo-threads=1', 08:20:47 INFO - '--mitmproxy', 08:20:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:20:47 INFO - '--firstNonBlankPaint'], 08:20:47 INFO - 'tests': ['tp6_google', 08:20:47 INFO - 'tp6_youtube', 08:20:47 INFO - 'tp6_amazon', 08:20:47 INFO - 'tp6_facebook']}, 08:20:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:20:47 INFO - 'talos_options': ['--xperf_path', 08:20:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:47 INFO - 'tests': ['tp5n']}, 08:20:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:20:47 INFO - 'talos_options': ['--disable-stylo', 08:20:47 INFO - '--xperf_path', 08:20:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:47 INFO - 'tests': ['tp5n']}}} 08:20:47 INFO - Running post-action listener: _resource_record_post_action 08:20:47 INFO - [mozharness: 2017-10-01 15:20:47.595418Z] Finished populate-webroot step (success) 08:20:47 INFO - [mozharness: 2017-10-01 15:20:47.595527Z] Running create-virtualenv step. 08:20:47 INFO - Running pre-action listener: _resource_record_pre_action 08:20:47 INFO - Running main action method: create_virtualenv 08:20:47 INFO - Creating virtualenv /builds/slave/test/build/venv 08:20:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:20:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:20:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:20:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:20:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:20:48 INFO - Installing distribute.............................................................................................................................................................................................done. 08:20:48 INFO - Installing pip...............done. 08:20:48 INFO - Return code: 0 08:20:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:20:48 INFO - Reading from file tmpfile_stdout 08:20:48 INFO - Output received: 08:20:48 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:20:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:20: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:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20: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:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', '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:20: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', 'pip>=1.5'] in /builds/slave/test/build 08:20: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 pip>=1.5 08:20:48 INFO - Using env: {'DISPLAY': ':0', 08:20:48 INFO - 'HOME': '/home/cltbld', 08:20:48 INFO - 'LANG': 'en_US.UTF-8', 08:20:48 INFO - 'LANGUAGE': 'en_US:en', 08:20:48 INFO - 'LOGNAME': 'cltbld', 08:20:48 INFO - 'MAIL': '/var/mail/cltbld', 08:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:48 INFO - 'MOZ_NO_REMOTE': '1', 08:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:48 INFO - 'NO_EM_RESTART': '1', 08:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:48 INFO - 'PWD': '/builds/slave/test', 08:20:48 INFO - 'SHELL': '/bin/bash', 08:20:48 INFO - 'SHLVL': '1', 08:20:48 INFO - 'TERM': 'linux', 08:20:48 INFO - 'TMOUT': '86400', 08:20:48 INFO - 'USER': 'cltbld', 08:20:48 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', 08:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:48 INFO - '_': '/tools/buildbot/bin/python'} 08:20:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:20:49 INFO - Downloading/unpacking pip>=1.5 08:20:49 INFO - Running setup.py egg_info for package pip 08:20:49 INFO - warning: no files found matching 'pip/cacert.pem' 08:20:49 INFO - warning: no files found matching '*.html' under directory 'docs' 08:20:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:20:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:20:49 INFO - Installing collected packages: pip 08:20:49 INFO - Found existing installation: pip 1.1 08:20:49 INFO - Uninstalling pip: 08:20:49 INFO - Successfully uninstalled pip 08:20:49 INFO - Running setup.py install for pip 08:20:49 INFO - warning: no files found matching 'pip/cacert.pem' 08:20:49 INFO - warning: no files found matching '*.html' under directory 'docs' 08:20:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:20:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:20:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:20:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:20:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:20:49 INFO - Successfully installed pip 08:20:49 INFO - Cleaning up... 08:20:49 INFO - Return code: 0 08:20:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', '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:20:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:20:49 INFO - Using env: {'DISPLAY': ':0', 08:20:49 INFO - 'HOME': '/home/cltbld', 08:20:49 INFO - 'LANG': 'en_US.UTF-8', 08:20:49 INFO - 'LANGUAGE': 'en_US:en', 08:20:49 INFO - 'LOGNAME': 'cltbld', 08:20:49 INFO - 'MAIL': '/var/mail/cltbld', 08:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:49 INFO - 'MOZ_NO_REMOTE': '1', 08:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:49 INFO - 'NO_EM_RESTART': '1', 08:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:49 INFO - 'PWD': '/builds/slave/test', 08:20:49 INFO - 'SHELL': '/bin/bash', 08:20:49 INFO - 'SHLVL': '1', 08:20:49 INFO - 'TERM': 'linux', 08:20:49 INFO - 'TMOUT': '86400', 08:20:49 INFO - 'USER': 'cltbld', 08:20:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', 08:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:49 INFO - '_': '/tools/buildbot/bin/python'} 08:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:50 INFO - Downloading/unpacking psutil>=3.1.1 08:20: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:20: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:20: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:20: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:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:20:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:51 INFO - Installing collected packages: psutil 08:20:51 INFO - Running setup.py install for psutil 08:20:51 INFO - building 'psutil._psutil_linux' extension 08:20:51 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:20:51 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:20:51 INFO - building 'psutil._psutil_posix' extension 08:20:51 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:20:51 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:20:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:51 INFO - Successfully installed psutil 08:20:51 INFO - Cleaning up... 08:20:51 INFO - Return code: 0 08:20:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', '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:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:20:51 INFO - Using env: {'DISPLAY': ':0', 08:20:51 INFO - 'HOME': '/home/cltbld', 08:20:51 INFO - 'LANG': 'en_US.UTF-8', 08:20:51 INFO - 'LANGUAGE': 'en_US:en', 08:20:51 INFO - 'LOGNAME': 'cltbld', 08:20:51 INFO - 'MAIL': '/var/mail/cltbld', 08:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:51 INFO - 'MOZ_NO_REMOTE': '1', 08:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:51 INFO - 'NO_EM_RESTART': '1', 08:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:51 INFO - 'PWD': '/builds/slave/test', 08:20:51 INFO - 'SHELL': '/bin/bash', 08:20:51 INFO - 'SHLVL': '1', 08:20:51 INFO - 'TERM': 'linux', 08:20:51 INFO - 'TMOUT': '86400', 08:20:51 INFO - 'USER': 'cltbld', 08:20:51 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', 08:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:51 INFO - '_': '/tools/buildbot/bin/python'} 08:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:20: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:20: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:20: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:20: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:20:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:20:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:20:53 INFO - Installing collected packages: mozsystemmonitor 08:20:53 INFO - Running setup.py install for mozsystemmonitor 08:20:53 INFO - Successfully installed mozsystemmonitor 08:20:53 INFO - Cleaning up... 08:20:53 INFO - Return code: 0 08:20:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:20: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:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20: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:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:53 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 0x1c041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', '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:20:53 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:20:53 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:20:53 INFO - Using env: {'DISPLAY': ':0', 08:20:53 INFO - 'HOME': '/home/cltbld', 08:20:53 INFO - 'LANG': 'en_US.UTF-8', 08:20:53 INFO - 'LANGUAGE': 'en_US:en', 08:20:53 INFO - 'LOGNAME': 'cltbld', 08:20:53 INFO - 'MAIL': '/var/mail/cltbld', 08:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:53 INFO - 'MOZ_NO_REMOTE': '1', 08:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:53 INFO - 'NO_EM_RESTART': '1', 08:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:53 INFO - 'PWD': '/builds/slave/test', 08:20:53 INFO - 'SHELL': '/bin/bash', 08:20:53 INFO - 'SHLVL': '1', 08:20:53 INFO - 'TERM': 'linux', 08:20:53 INFO - 'TMOUT': '86400', 08:20:53 INFO - 'USER': 'cltbld', 08:20:53 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', 08:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:53 INFO - '_': '/tools/buildbot/bin/python'} 08:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:53 INFO - Downloading/unpacking jsonschema==2.5.1 08:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:20:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:20:55 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:20:55 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:20:55 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:20:55 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:20:55 INFO - Downloading functools32-3.2.3-2.tar.gz 08:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:20:55 INFO - warning: no files found matching '*.txt' 08:20:55 INFO - no previously-included directories found matching 'build' 08:20:55 INFO - no previously-included directories found matching 'dist' 08:20:55 INFO - no previously-included directories found matching '.git*' 08:20:55 INFO - Installing collected packages: jsonschema, functools32 08:20:55 INFO - Running setup.py install for functools32 08:20:55 INFO - warning: no files found matching '*.txt' 08:20:55 INFO - no previously-included directories found matching 'build' 08:20:55 INFO - no previously-included directories found matching 'dist' 08:20:55 INFO - no previously-included directories found matching '.git*' 08:20:55 INFO - Successfully installed jsonschema functools32 08:20:55 INFO - Cleaning up... 08:20:55 INFO - Return code: 0 08:20:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:20:55 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:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:55 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:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:55 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 0x1c041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', '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:20:55 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:20:55 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:20:55 INFO - Using env: {'DISPLAY': ':0', 08:20:55 INFO - 'HOME': '/home/cltbld', 08:20:55 INFO - 'LANG': 'en_US.UTF-8', 08:20:55 INFO - 'LANGUAGE': 'en_US:en', 08:20:55 INFO - 'LOGNAME': 'cltbld', 08:20:55 INFO - 'MAIL': '/var/mail/cltbld', 08:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:55 INFO - 'MOZ_NO_REMOTE': '1', 08:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:55 INFO - 'NO_EM_RESTART': '1', 08:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:55 INFO - 'PWD': '/builds/slave/test', 08:20:55 INFO - 'SHELL': '/bin/bash', 08:20:55 INFO - 'SHLVL': '1', 08:20:55 INFO - 'TERM': 'linux', 08:20:55 INFO - 'TMOUT': '86400', 08:20:55 INFO - 'USER': 'cltbld', 08:20:55 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', 08:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:55 INFO - '_': '/tools/buildbot/bin/python'} 08:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:20:55 INFO - Cleaning up... 08:20:55 INFO - Return code: 0 08:20:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:20:55 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:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:55 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:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:55 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 0x1c041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', '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:20:55 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:20:55 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:20:55 INFO - Using env: {'DISPLAY': ':0', 08:20:55 INFO - 'HOME': '/home/cltbld', 08:20:55 INFO - 'LANG': 'en_US.UTF-8', 08:20:55 INFO - 'LANGUAGE': 'en_US:en', 08:20:55 INFO - 'LOGNAME': 'cltbld', 08:20:55 INFO - 'MAIL': '/var/mail/cltbld', 08:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:56 INFO - 'MOZ_NO_REMOTE': '1', 08:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:56 INFO - 'NO_EM_RESTART': '1', 08:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:56 INFO - 'PWD': '/builds/slave/test', 08:20:56 INFO - 'SHELL': '/bin/bash', 08:20:56 INFO - 'SHLVL': '1', 08:20:56 INFO - 'TERM': 'linux', 08:20:56 INFO - 'TMOUT': '86400', 08:20:56 INFO - 'USER': 'cltbld', 08:20:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', 08:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:56 INFO - '_': '/tools/buildbot/bin/python'} 08:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:56 INFO - Downloading/unpacking blobuploader==1.2.4 08:20:56 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:20:56 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:20:56 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:20:56 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:20:57 INFO - Downloading blobuploader-1.2.4.tar.gz 08:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:20:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:20: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:20: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:20: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:20: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:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:20:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:58 INFO - Downloading docopt-0.6.1.tar.gz 08:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:20:58 INFO - Installing collected packages: blobuploader, requests, docopt 08:20:58 INFO - Running setup.py install for blobuploader 08:20:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:20:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:20:58 INFO - Running setup.py install for requests 08:20:59 INFO - Running setup.py install for docopt 08:20:59 INFO - Successfully installed blobuploader requests docopt 08:20:59 INFO - Cleaning up... 08:20:59 INFO - Return code: 0 08:20:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20: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:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20: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:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:59 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 0x1c041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', '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:20:59 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:20:59 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:20:59 INFO - Using env: {'DISPLAY': ':0', 08:20:59 INFO - 'HOME': '/home/cltbld', 08:20:59 INFO - 'LANG': 'en_US.UTF-8', 08:20:59 INFO - 'LANGUAGE': 'en_US:en', 08:20:59 INFO - 'LOGNAME': 'cltbld', 08:20:59 INFO - 'MAIL': '/var/mail/cltbld', 08:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:59 INFO - 'MOZ_NO_REMOTE': '1', 08:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:59 INFO - 'NO_EM_RESTART': '1', 08:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:59 INFO - 'PWD': '/builds/slave/test', 08:20:59 INFO - 'SHELL': '/bin/bash', 08:20:59 INFO - 'SHLVL': '1', 08:20:59 INFO - 'TERM': 'linux', 08:20:59 INFO - 'TMOUT': '86400', 08:20:59 INFO - 'USER': 'cltbld', 08:20:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', 08:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:59 INFO - '_': '/tools/buildbot/bin/python'} 08:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:20:59 INFO - Running setup.py (path:/tmp/pip-HAPLYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:20:59 INFO - Running setup.py (path:/tmp/pip-j4DG1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:20:59 INFO - Running setup.py (path:/tmp/pip-GHXN0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:20:59 INFO - Running setup.py (path:/tmp/pip-QWCYsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:20:59 INFO - Running setup.py (path:/tmp/pip-Bo_I72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:20:59 INFO - Running setup.py (path:/tmp/pip-4EDJEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:20:59 INFO - Running setup.py (path:/tmp/pip-CKV5kS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:20:59 INFO - Running setup.py (path:/tmp/pip-fY2JlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:20:59 INFO - Running setup.py (path:/tmp/pip-p4AE3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:00 INFO - Running setup.py (path:/tmp/pip-A_ybZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:00 INFO - Running setup.py (path:/tmp/pip-enJfET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:00 INFO - Running setup.py (path:/tmp/pip-WZgobJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:00 INFO - Running setup.py (path:/tmp/pip-ClBQCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:00 INFO - Running setup.py (path:/tmp/pip-iLxEhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:00 INFO - Running setup.py (path:/tmp/pip-o2EJKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:00 INFO - Running setup.py (path:/tmp/pip-vCGBom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:00 INFO - Running setup.py (path:/tmp/pip-vf_Zbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:21:00 INFO - Running setup.py install for manifestparser 08:21:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:21:00 INFO - Running setup.py install for mozcrash 08:21:00 INFO - Running setup.py install for mozdebug 08:21:00 INFO - Running setup.py install for mozdevice 08:21:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:21:00 INFO - Running setup.py install for mozfile 08:21:01 INFO - Running setup.py install for mozhttpd 08:21:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Running setup.py install for mozinfo 08:21:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Running setup.py install for mozInstall 08:21:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Running setup.py install for mozleak 08:21:01 INFO - Running setup.py install for mozlog 08:21:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Running setup.py install for moznetwork 08:21:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Running setup.py install for mozprocess 08:21:01 INFO - Running setup.py install for mozprofile 08:21:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:21:01 INFO - Running setup.py install for mozrunner 08:21:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:21:02 INFO - Running setup.py install for mozscreenshot 08:21:02 INFO - Running setup.py install for moztest 08:21:02 INFO - Running setup.py install for mozversion 08:21:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:21:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:21:02 INFO - Cleaning up... 08:21:02 INFO - Return code: 0 08:21:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21: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:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21: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:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:02 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 0x1c041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', '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:21:02 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:21:02 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:21:02 INFO - Using env: {'DISPLAY': ':0', 08:21:02 INFO - 'HOME': '/home/cltbld', 08:21:02 INFO - 'LANG': 'en_US.UTF-8', 08:21:02 INFO - 'LANGUAGE': 'en_US:en', 08:21:02 INFO - 'LOGNAME': 'cltbld', 08:21:02 INFO - 'MAIL': '/var/mail/cltbld', 08:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:02 INFO - 'MOZ_NO_REMOTE': '1', 08:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:02 INFO - 'NO_EM_RESTART': '1', 08:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:02 INFO - 'PWD': '/builds/slave/test', 08:21:02 INFO - 'SHELL': '/bin/bash', 08:21:02 INFO - 'SHLVL': '1', 08:21:02 INFO - 'TERM': 'linux', 08:21:02 INFO - 'TMOUT': '86400', 08:21:02 INFO - 'USER': 'cltbld', 08:21:02 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', 08:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:02 INFO - '_': '/tools/buildbot/bin/python'} 08:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:02 INFO - Running setup.py (path:/tmp/pip-TuB00Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:02 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:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:02 INFO - Running setup.py (path:/tmp/pip-Zny1gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:02 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:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:02 INFO - Running setup.py (path:/tmp/pip-fFt443-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:02 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:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:02 INFO - Running setup.py (path:/tmp/pip-NLG6Yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:02 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:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:02 INFO - Running setup.py (path:/tmp/pip-dTa54i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:02 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:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:02 INFO - Running setup.py (path:/tmp/pip-QYk20v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:03 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:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:03 INFO - Running setup.py (path:/tmp/pip-DiOIKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:03 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:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:03 INFO - Running setup.py (path:/tmp/pip-x2H3GL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:03 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:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:03 INFO - Running setup.py (path:/tmp/pip-DQonMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:03 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:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:03 INFO - Running setup.py (path:/tmp/pip-wKtR5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:03 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:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:03 INFO - Running setup.py (path:/tmp/pip-BuPuUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:03 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:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:03 INFO - Running setup.py (path:/tmp/pip-7zKwSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:03 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:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:03 INFO - Running setup.py (path:/tmp/pip-7ude2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:03 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:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:03 INFO - Running setup.py (path:/tmp/pip-zZY5qG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:03 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:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:03 INFO - Running setup.py (path:/tmp/pip-zQiaHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:03 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:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:03 INFO - Running setup.py (path:/tmp/pip-eaf3Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:03 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:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:03 INFO - Running setup.py (path:/tmp/pip-B8w9oW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:03 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:21:03 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:21:03 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:21:03 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:21:03 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:21:03 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:21:03 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:21:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:04 INFO - Downloading blessings-1.6.tar.gz 08:21:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:21:05 INFO - Installing collected packages: blessings 08:21:05 INFO - Running setup.py install for blessings 08:21:05 INFO - Successfully installed blessings 08:21:05 INFO - Cleaning up... 08:21:05 INFO - Return code: 0 08:21:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:21:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:05 INFO - Reading from file tmpfile_stdout 08:21:05 INFO - Current package versions: 08:21:05 INFO - argparse == 1.2.1 08:21:05 INFO - blessings == 1.6 08:21:05 INFO - blobuploader == 1.2.4 08:21:05 INFO - docopt == 0.6.1 08:21:05 INFO - functools32 == 3.2.3-2 08:21:05 INFO - jsonschema == 2.5.1 08:21:05 INFO - manifestparser == 1.1 08:21:05 INFO - mozInstall == 1.13 08:21:05 INFO - mozcrash == 1.0 08:21:05 INFO - mozdebug == 0.1 08:21:05 INFO - mozdevice == 0.51 08:21:05 INFO - mozfile == 1.2 08:21:05 INFO - mozhttpd == 0.7 08:21:05 INFO - mozinfo == 0.10 08:21:05 INFO - mozleak == 0.1 08:21:05 INFO - mozlog == 3.5 08:21:05 INFO - moznetwork == 0.27 08:21:05 INFO - mozprocess == 0.25 08:21:05 INFO - mozprofile == 0.28 08:21:05 INFO - mozrunner == 6.13 08:21:05 INFO - mozscreenshot == 0.1 08:21:05 INFO - mozsystemmonitor == 0.3 08:21:05 INFO - moztest == 0.8 08:21:05 INFO - mozversion == 1.4 08:21:05 INFO - psutil == 3.1.1 08:21:05 INFO - requests == 1.2.3 08:21:05 INFO - wsgiref == 0.1.2 08:21:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:05 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 0x1c041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', '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:21:05 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:21:05 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:21:05 INFO - Using env: {'DISPLAY': ':0', 08:21:05 INFO - 'HOME': '/home/cltbld', 08:21:05 INFO - 'LANG': 'en_US.UTF-8', 08:21:05 INFO - 'LANGUAGE': 'en_US:en', 08:21:05 INFO - 'LOGNAME': 'cltbld', 08:21:05 INFO - 'MAIL': '/var/mail/cltbld', 08:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:05 INFO - 'MOZ_NO_REMOTE': '1', 08:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:05 INFO - 'NO_EM_RESTART': '1', 08:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:05 INFO - 'PWD': '/builds/slave/test', 08:21:05 INFO - 'SHELL': '/bin/bash', 08:21:05 INFO - 'SHLVL': '1', 08:21:05 INFO - 'TERM': 'linux', 08:21:05 INFO - 'TMOUT': '86400', 08:21:05 INFO - 'USER': 'cltbld', 08:21:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', 08:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:05 INFO - '_': '/tools/buildbot/bin/python'} 08:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:05 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:21:05 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:21:05 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:21:05 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:21:05 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:21:05 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:21:05 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:21:05 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:21:05 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:21:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:21:06 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:21:06 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:21:06 INFO - Installing collected packages: simplejson 08:21:06 INFO - Running setup.py install for simplejson 08:21:06 INFO - building 'simplejson._speedups' extension 08:21:06 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:21:07 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:21:07 INFO - Successfully installed simplejson 08:21:07 INFO - Cleaning up... 08:21:07 INFO - Return code: 0 08:21:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', '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:21:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:21:07 INFO - Using env: {'DISPLAY': ':0', 08:21:07 INFO - 'HOME': '/home/cltbld', 08:21:07 INFO - 'LANG': 'en_US.UTF-8', 08:21:07 INFO - 'LANGUAGE': 'en_US:en', 08:21:07 INFO - 'LOGNAME': 'cltbld', 08:21:07 INFO - 'MAIL': '/var/mail/cltbld', 08:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:07 INFO - 'MOZ_NO_REMOTE': '1', 08:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:07 INFO - 'NO_EM_RESTART': '1', 08:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:07 INFO - 'PWD': '/builds/slave/test', 08:21:07 INFO - 'SHELL': '/bin/bash', 08:21:07 INFO - 'SHLVL': '1', 08:21:07 INFO - 'TERM': 'linux', 08:21:07 INFO - 'TMOUT': '86400', 08:21:07 INFO - 'USER': 'cltbld', 08:21:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', 08:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:07 INFO - '_': '/tools/buildbot/bin/python'} 08:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:21:08 INFO - Cleaning up... 08:21:08 INFO - Return code: 0 08:21:08 INFO - Running post-action listener: _resource_record_post_action 08:21:08 INFO - Running post-action listener: _start_resource_monitoring 08:21:08 INFO - Starting resource monitoring. 08:21:08 INFO - [mozharness: 2017-10-01 15:21:08.115079Z] Finished create-virtualenv step (success) 08:21:08 INFO - [mozharness: 2017-10-01 15:21:08.115659Z] Running install step. 08:21:08 INFO - Running pre-action listener: _resource_record_pre_action 08:21:08 INFO - Running main action method: install 08:21:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:08 INFO - Reading from file tmpfile_stdout 08:21:08 INFO - Detecting whether we're running mozinstall >=1.0... 08:21:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:21:08 INFO - Reading from file tmpfile_stdout 08:21:08 INFO - Output received: 08:21:08 INFO - Usage: mozinstall [options] installer 08:21:08 INFO - Options: 08:21:08 INFO - -h, --help show this help message and exit 08:21:08 INFO - -d DEST, --destination=DEST 08:21:08 INFO - Directory to install application into. [default: 08:21:08 INFO - "/builds/slave/test"] 08:21:08 INFO - --app=APP Application being installed. [default: firefox] 08:21:08 INFO - mkdir: /builds/slave/test/build/application 08:21:08 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:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:21:23 INFO - Reading from file tmpfile_stdout 08:21:23 INFO - Output received: 08:21:23 INFO - /builds/slave/test/build/application/firefox/firefox 08:21:23 INFO - Running post-action listener: _resource_record_post_action 08:21:23 INFO - [mozharness: 2017-10-01 15:21:23.019954Z] Finished install step (success) 08:21:23 INFO - [mozharness: 2017-10-01 15:21:23.020203Z] Running setup-mitmproxy step. 08:21:23 INFO - Running pre-action listener: _resource_record_pre_action 08:21:23 INFO - Running main action method: setup_mitmproxy 08:21:23 INFO - Skipping: mitmproxy is not required 08:21:23 INFO - Running post-action listener: _resource_record_post_action 08:21:23 INFO - [mozharness: 2017-10-01 15:21:23.021324Z] Finished setup-mitmproxy step (success) 08:21:23 INFO - [mozharness: 2017-10-01 15:21:23.021543Z] Running run-tests step. 08:21:23 INFO - Running pre-action listener: _resource_record_pre_action 08:21:23 INFO - Running pre-action listener: _set_gcov_prefix 08:21:23 INFO - Running main action method: run_tests 08:21:23 WARNING - Try message not found. 08:21:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:21:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:21:23 INFO - Python 2.7.3 08:21:23 INFO - Return code: 0 08:21:23 INFO - grabbing minidump binary from tooltool 08:21: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:21:23 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 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:21:23 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:21:23 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:21:23 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:21:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:21:23 INFO - Return code: 0 08:21:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:21:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:21:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:21:23 INFO - ENV: RUST_BACKTRACE is now full 08:21:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:21:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:21:23 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/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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:21:23 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/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --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:21:23 INFO - Using env: {'DISPLAY': ':0', 08:21:23 INFO - 'HOME': '/home/cltbld', 08:21:23 INFO - 'LANG': 'en_US.UTF-8', 08:21:23 INFO - 'LANGUAGE': 'en_US:en', 08:21:23 INFO - 'LOGNAME': 'cltbld', 08:21:23 INFO - 'MAIL': '/var/mail/cltbld', 08:21:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:21:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:23 INFO - 'MOZ_NO_REMOTE': '1', 08:21:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:23 INFO - 'NO_EM_RESTART': '1', 08:21:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:23 INFO - 'PWD': '/builds/slave/test', 08:21:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:21:23 INFO - 'RUST_BACKTRACE': 'full', 08:21:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:21:23 INFO - 'SHELL': '/bin/bash', 08:21:23 INFO - 'SHLVL': '1', 08:21:23 INFO - 'TERM': 'linux', 08:21:23 INFO - 'TMOUT': '86400', 08:21:23 INFO - 'USER': 'cltbld', 08:21:23 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', 08:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:23 INFO - '_': '/tools/buildbot/bin/python'} 08:21:23 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/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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:21:23 INFO - mozversion application_buildid: 20171001140022 08:21:23 INFO - mozversion application_changeset: 7b7e1bd82717a0d965f172c3a2ad223ddfb3a796 08:21:23 INFO - mozversion application_display_name: Firefox 08:21:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:21:23 INFO - mozversion application_name: Firefox 08:21:23 INFO - mozversion application_remotingname: firefox 08:21:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:21:23 INFO - mozversion application_vendor: Mozilla 08:21:23 INFO - mozversion application_version: 57.0 08:21:23 INFO - mozversion platform_buildid: 20171001140022 08:21:23 INFO - mozversion platform_changeset: 7b7e1bd82717a0d965f172c3a2ad223ddfb3a796 08:21:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:21:23 INFO - mozversion platform_version: 57.0 08:21:23 INFO - using testdate: 1506871283 08:21:23 INFO - actual date: 1506871283 08:21:23 INFO - starting webserver on 'localhost:56318' 08:21:23 INFO - SUITE-START | Running 2 tests 08:21:23 INFO - TEST-START | dromaeo_css 08:21:23 INFO - Initialising browser for dromaeo_css test... 08:21:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56318/getInfo.html -profile /tmp/tmpsp236U/profile 08:21:23 INFO - TEST-INFO | started process 10473 (/builds/slave/test/build/application/firefox/firefox http://localhost:56318/getInfo.html) 08:21:29 INFO - TEST-INFO | 10473: exit 0 08:21:29 INFO - Browser initialized. 08:21:29 INFO - Running cycle 1/1 for dromaeo_css test... 08:21:29 INFO - Using env: {'DISPLAY': ':0', 08:21:29 INFO - 'HOME': '/home/cltbld', 08:21:29 INFO - 'JSGC_DISABLE_POISONING': '1', 08:21:29 INFO - 'LANG': 'en_US.UTF-8', 08:21:29 INFO - 'LANGUAGE': 'en_US:en', 08:21:29 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:21:29 INFO - 'LOGNAME': 'cltbld', 08:21:29 INFO - 'MAIL': '/var/mail/cltbld', 08:21:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:21:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:21:29 INFO - 'MOZ_CRASHREPORTER': '1', 08:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:29 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:21:29 INFO - 'MOZ_NO_REMOTE': '1', 08:21:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:29 INFO - 'NO_EM_RESTART': '1', 08:21:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:29 INFO - 'PWD': '/builds/slave/test', 08:21:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:21:29 INFO - 'RUST_BACKTRACE': 'full', 08:21:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:21:29 INFO - 'SHELL': '/bin/bash', 08:21:29 INFO - 'SHLVL': '1', 08:21:29 INFO - 'TERM': 'linux', 08:21:29 INFO - 'TMOUT': '86400', 08:21:29 INFO - 'USER': 'cltbld', 08:21:29 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', 08:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:29 INFO - '_': '/tools/buildbot/bin/python'} 08:21:29 INFO - TEST-INFO | started process 10663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsp236U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:30 INFO - PID 10663 | 08:21:30 INFO - PID 10663 | (/builds/slave/test/build/application/firefox/firefox:10712): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:21:30 INFO - PID 10663 | 08:21:40 INFO - PID 10663 | RSS: Main: 141660160 08:21:40 INFO - PID 10663 | 08:24:38 INFO - PID 10663 | Cycle 1(1): loaded http://localhost:56318/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56318/tests/dromaeo/cssquery-ext.html) 08:24:38 INFO - PID 10663 | RSS: Main: 145072128 08:24:38 INFO - PID 10663 | 08:27:40 INFO - PID 10663 | Cycle 1(1): loaded http://localhost:56318/tests/dromaeo/cssquery-ext.html (next: http://localhost:56318/tests/dromaeo/cssquery-jquery.html) 08:27:41 INFO - PID 10663 | RSS: Main: 143986688 08:27:41 INFO - PID 10663 | 08:30:42 INFO - PID 10663 | Cycle 1(1): loaded http://localhost:56318/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56318/tests/dromaeo/cssquery-mootools.html) 08:30:43 INFO - PID 10663 | RSS: Main: 144941056 08:30:43 INFO - PID 10663 | 08:33:44 INFO - PID 10663 | Cycle 1(1): loaded http://localhost:56318/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56318/tests/dromaeo/cssquery-prototype.html) 08:33:45 INFO - PID 10663 | RSS: Main: 144588800 08:33:45 INFO - PID 10663 | 08:36:48 INFO - PID 10663 | Cycle 1(1): loaded http://localhost:56318/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56318/tests/dromaeo/cssquery-yui.html) 08:36:48 INFO - PID 10663 | RSS: Main: 145805312 08:36:48 INFO - PID 10663 | 08:39:50 INFO - PID 10663 | Cycle 1(1): loaded http://localhost:56318/tests/dromaeo/cssquery-yui.html (next: http://localhost:56318/tests/dromaeo/cssquery-dojo.html) 08:39:50 INFO - PID 10663 | RSS: Main: 148680704 08:39:50 INFO - PID 10663 | 08:39:50 INFO - PID 10663 | __start_tp_report 08:39:50 INFO - PID 10663 | _x_x_mozilla_page_load 08:39:50 INFO - PID 10663 | _x_x_mozilla_page_load_details 08:39:50 INFO - PID 10663 | |i|pagename|runs| 08:39:50 INFO - PID 10663 | |0;dojo.html;3993.7803420811856;4009.2182024505223;4028.1138149607077;4030.415589739486;4045.1505183911377;6444.677766111693;6468.708908099135;6489.1239682642945;6583.506237032229;6586.374294442032;6538.346165383459;6552;6580.341965803429;6607.603543787376;6634.369734875191;5877.030290002144;5877.617954832944;5909.852253693671;5915.349311575723;5936;5823.592348535604;5828.912566311508;5832.096025116092;5893.705314734246;6008.188894499231;5885.382034886339;5912.231409916705;5926.288845338566;5927.377625349341;5927.8221653350465;5869.559783016248;5897.292324920994;5911.674857882815;5941.049432090845;5989.760409583655;5817.34841313336;5843.065109582489;5895.587308888379;5933.762649494015;5963.403659634002;6414.679266036679;6446.677666116675;6467.611943283418;6560;6657.367550082734;6874.2782007889455;6975.651217439107;7049.541779784349;7099.787006389816;7102.68037938294;7054.717811287543;7125.608091554963;7138.571685698823;7175.784726458214;7179.92820071803;6393.456556192729;6523.93476065238;6529.836754081139;6627.602343859384;6632.005199220155;7204.459665525106;7242.130944286614;7308.488405811542;7350.4119670426235;7354.227806080285;6915.827104322432;6961.93038069623;6979.581225126509;7011.6143612100805;7047.929520704727;6928.16861976566;7022.227554968949;7032.92967070333;7077.893831592531;7164.785056448315;7050.330218629325;7060.858782824314;7076.610786406694;7087.433005359662;7088.893666595005;7018.75434359795;7027.754028608974;7105.644717764091;7109.395701365442;7112.893306600405;5216.26972223889;5218.582513398919;5276.498732620395;5277.076511610453;5287.339082614673;4659.4175728034;4663.3937588114;4724.102420540086;4741.193997020515;4755.405574303212;6636.8672626547195;6655.267920528738;6668.0331351954665;6670.599764014175;6688.933110668831;6971.79084627462;7046.6828992695455;7069.858602827914;7156.463265255126;7160.462965277625;6500.512461565401;6581.736730530725;6599.934000659932;6661.933380666132;6669.066330713704;5884.293884733859;5965.940340596539;5972.552058595623;5996.610220335664;5997.220361352996;7379.446541509408;7404.555726656418;7449.068866391701;7458.70165193397;7465.925340746631;6926.995585640155;7048.506604537633;7060.364567188875;7149.213586505584;7149.53528020677;7335.303146201102;7361.484696071224;7409.296116868889;7444.590547519939;7461.179270280156;6980.650967451708;6993.125859267591;7065.364117229474;7067.5052746307265;7073.646317684198;6981.825454363681;7070.434365250665;7095;7122.85754284901;7147.356737893615;6803.863922721419;6804.829879253059;6812.557183783038;6882.8967565485555;6892.414144797748;6861.279565645735;6895.448364130958;6899.75850845218;6900.964855271549;6919.723211071702;6747.527673062838;6749.291324410866;6761.121054262914;6765.695543700644;6842.93157068423;6884.208316043719;6943.79168624942;6953.687084081127;6964.268751781193;6977.441804655717;6653.367930046637;6677.098591690254;6709.865802684017;6759.831004224737;6767.796966091025 08:39:50 INFO - PID 10663 | |1;ext.html;963.4749061761344;965.5461932891541;1006.8489726541019;1025.4821315235804;1030.9587616495342;44273.11453770927;46083.30875036873;46091.07817843641;46147;46290.30564541535;43459.56540434594;43964;44070.33894491577;44336.77831610837;44381;8081.393895457834;8195.221453961894;8209.58952052398;8214.219649133323;8219.917800822004;8034.638441270157;8083.595820208995;8101.756947291591;8105.1489593592705;8132.552709600969;8678.86981695275;8961.327900407463;8987.685431009915;9017.684381046665;9023.05257947916;8901.643934242655;8949.149830766068;8959.238464730506;8966.820663586757;8967.46195228285;8692.826143477096;8753.47479151253;8783.429077109968;8790.208881200659;8800.559972001438;41095.7945210275;41219;41224.587754122374;41319.7934010331;41751;3815.790131542764;3826.4451654510217;3858.614138586147;3858.614138586147;3885.1841113366227;33805.49291760601;34072.48891266633;34227;34321.31357372839;34420.31159376824;5599.468050535193;5601;5663.773449062032;5666.348369937468;5690.516306113986;235248;238130;238383;238524;240475;54351.72824135933;54425;54472.18291725627;54533;54542.72728636331;56996.145057824164;57014.714926425935;57345.71327143338;57351.71324143353;57519.42480575224;18098.547536311435;18340.724889126675;18428.539286517676;18437.1703273353;18443.63112737738;15341.693166136614;15421.460248891235;15424.074555526704;15450.304736286895;15465.922670386575;15294.082355058732;15690.215489225722;15799.210039497979;15800.36798528069;15812.60468488297;5884.941150588439;5901.468867801833;5948.107783832374;5984.222051133324;5994.310654274815;1094.885037071112;1116.7989761842784;1125.487903004131;1126.3354620773782;1132.1395739238073;26220.73779262183;26302.21093367202;26364.472710546066;26439.603405948925;26582.335441614116;1211.2974474804591;1228.91397602167;1241.1436109084702;1242.78163478191;1248.4881198708485;13749.312534373441;13937.303134843218;14000.649983750487;14100.85899141016;14210.147391156564;291175;292103;295804;296373;297567;64933;65572.67213663997;65803.34196658067;65806;66111.33888661052;1521.9771703424235;1525.161161361269;1527.602823265959;1534.99232503839;1550.4340915565963;30811.53782693306;30849.537256941614;31029.8448507756;31108.066757997298;31526.369472610877;42716.145677086904;42997.35503967381;43123.56876431195;43178.568214317456;43282.35076473918;255321;256696;257519;259288;261511;37560.624393755716;39051.21897561976;39288;39432.6056739429;39694;47221.527784721715;47410.288845666655;47443.28835067546;48417;48425.27362089642;34938.12654683551;35188.29623407466;35508.64491355053;35618.46572301366;35706.821465892506;34828.30343393169;35015;35282.647173527934;35446.645533545365;36297;39604.80197599109;40674;40847.591524084375;40879.18241635091;41060.38409423801;34085;34177.48733769045;34303.65696343104;34518;34782.304353912274;25401.618975715748;25728.871355643103;26036.609450858632;26228.344291392867;26431.735682642928 08:39:50 INFO - PID 10663 | |2;jquery.html;647.8874628352225;649.5269213114915;651.1789010119007;652.6079485065509;657.1632287755722;23785.5242895142;24703;24714.505709885838;24794.132205372836;24845.87577062112;26099.869500652516;26440.338991525223;26544;26653;26691.73308266917;6485.902711459332;6757.5269731118715;6781.220159681626;6828.146481689789;6861.9656901715425;6692.498062645297;6818.045473633695;6820.2838701936325;6825.35159159879;6826.931730682704;6792.796216113525;6793.4225590824835;6794.796156115324;7094.751683691072;7107.609081500541;6958.79123626292;6971.651417429108;7029.718811247544;7030;7034.8944765828555;6475.384838440341;6492.188476440445;6510.576812507172;6516.576422532567;6568.67156642166;29885.850570747225;30236.697633023607;30330.84834575835;30843.84578077118;30868.53697194544;2362.362162216209;2402.771736685012;2403.723571789249;2404.723456802473;2405.350555350046;21200.893995529925;21673.024713887757;21688.13247470115;21810.890945545172;21818.345449636538;2567.6918769747563;2632.605109233611;2639.696434909991;2650.3904102056636;2654.8008899332626;144310;150022;172037;178207;179090;16492.25784839685;16813.66372672564;16916.392942670427;16919.407820726214;17054.57363565896;27339.453210936066;27348.58977115345;27348.58977115345;27356.45287094247;27379.178624641292;11712.824307635392;11736.94131529354;11827.940860295816;11894.405279736151;11986.700332491757;10678.359298442118;10887.401192934465;10935.781284374427;10941.398223097647;11048.613298534674;10045.146162576117;10065.144462720604;10151.238657100746;10250.336097075813;10575.841362379571;2737.54830452977;2800.957985630217;2841.4317136572768;2859.0993836941298;2906.302487403008;1001.9849702254472;1050.6900464363032;1050.9421981790922;1059.9311044782064;1064.1858977881927;21031.684524731834;21274.36176914695;21676.674849877265;21792;21955.67066494004;1120.7366268926958;1126.3636045634191;1131.2759833706434;1133.4729350851894;1138.0838425067734;11650.941745291218;11694.941525292319;11792.528298868121;11808.409579520989;11895.88104118965;601780;615096;616970;617735;623526;134348;136874;142369;142586.28706856607;143325.28337358247;1022.5296363672794;1023.9334443261164;1067.567635107767;1237.2761934268553;1256.0705078242217;22058.88970555137;22601.852823981695;22689.43276418037;22748.81516587662;22777.894305776073;65598;65641.67179164074;65692;65709.67145164244;66486.33513664802;77950.22049779429;79000.60499697465;81499.5925020371;82423.17576824155;83344;16045.117518536126;16223.918880405523;16332.836671633131;16355.509334719978;16376.672466550364;24759.38101547476;24796;24848.50302993966;25170.748292517572;25279.494410112064;18772.15525301392;18960.52598685044;18988.145533451305;19001.714974275674;19028;17277.740833887252;17700.46898593044;17907.73138402899;18201.54496137554;18313.725294120333;19758.40724778259;20756;20883.26908558193;20926.68609970821;21085.683714743984;15761;15811.367545298059;15842.207889605705;15877.444289449813;16019.199040047717;20324.390268291976;20412.591748164657;20416.693749593473;20675.17299308011;20684.793152068287 08:39:50 INFO - PID 10663 | |3;mootools.html;1399.769038108712;1458.329168582452;1459.6788706484576;1472.867441930226;1480.1415179196067;17405.390811321606;18169.818301816977;18170.81829181708;18182.727259091123;18193.090345482724;17704.1147942603;17767.64464710705;17774.022428766413;17801.643967120683;17823.910880445612;3035.9848200758966;3164.477861152907;3194.0417874637515;3194.2174167329035;3197.9840100799465;2522.331582130737;2528.329992551975;2532.392225865797;2532.936676583091;2533.9746602533924;2733.658292713411;2832.3768770870374;2840.133759203442;2843.6018957345987;2844.303145729299;3050.877964881402;3067.125869127299;3073.7694672899397;3079.32254903923;3097.2876238465165;2931.428371467565;2950.8229506229695;2991.880324787006;2999.5650630658433;3003.564483149953;17353.479395618153;17546.210420531108;17683.469495915142;17788.110594470225;17814.643707125786;8708.17272359125;9059.456432614064;9063.954680226623;9153.588088536031;9160.450372977642;5827.650340979555;5942.494887934531;6116.418940200674;6133.1413602095745;6158.938410615926;2053.8459615528745;2069.9482512937147;2103.5687684024892;2121.342383861008;2145.1633862793524;28771;29533.556996645068;31332.37335253305;32377.514337285196;32432.18919527007;7601.695932162652;7718.961405192938;7719.575423351657;7859.52842829432;7950.324222441157;20896.79103208979;20922.163113475595;20926.37220883376;20992.580148396948;21065.473363166042;8776.16626420489;9067.138621830916;9095.31785116119;9110.59002344896;9111.271098312252;8102.311303539147;8166.550839703755;8179.79550511242;8229.547374894319;8317.792055198548;5965.821025369246;6228.380621038563;6243.219597550306;6275.874482510324;6351.96824015877;1798.235749806327;1820.654075725608;1820.7724034495689;1831.7801863776165;1845.6585531676683;914.4284821986258;920.7053742802373;927.8051609162017;930.6184464369711;935.3546053223254;9065.59204835784;9073.54632268384;9084.137006984325;9139.177474027236;9197.402168859002;812.7236739508477;816.5590581086147;829.3282441222628;832.8334333133398;837.5016864965336;5477.260569823023;5520.392756796749;5574.968630803314;5658.603897727202;5853.326867410217;25826;26194.345141371618;27403.588946165823;27526.587101193498;27528.724712753017;25587.872060639576;26613.866930665223;26884.59673104905;27136.321591960357;27142.185734428;12837.550685725955;13012.674683132998;13230.669233269246;13277;13345.666358340924;9764.316497845082;9842.62203291554;9969.35199212049;10069.546870390703;10083.193344532274;22138.999999999356;22277.77722222757;22767;22832.885835570716;23318.883405582863;23447.882760586086;23468.295951121494;23705.40736481602;23887.880560597085;23980.160694375612;12354.320512371905;12819.423125959167;12830.67923301925;12836.679083022625;12839.807402889151;15089.54731358061;15173.924130379277;15324.923375383052;15374.692506150039;15447.691046179238;13272.469101235842;13355.465781369025;13404.262765547988;13405.530806421728;13463.259520726062;12881.227126372447;13087.869121309046;13136.27750473733;13155.473781048651;13282.203067815963;11264.098872090377;11480.196386252883;11492.31046137201;11496.252743571642;11499.08007359426;8542.701005464778;8646.795067257808;8691.478511289342;8719.782005449915;8787.121287871418;8655.350848686248;8884.822303553763;8931.776705582412;8940.821183576421;9026.593803279 08:39:50 INFO - PID 10663 | |4;prototype.html;552.8645481856943;577.662067690401;589.2075158911265;590.2621722846443;604.1873679900535;6330.33531479195;6384.904226436607;6388.393102655246;6427.839304017396;6441.162648855654;6184.381561843813;6208.192934918454;6237.5009999200065;6238.1266622672865;6241.251049874021;4960.727160006199;5138.816003198635;5182.170852663575;5193.740312984354;5197.194434862584;5104.438511763703;5106.64253502255;5109.974450127763;5137.666051706646;5147.915094386761;5040.6471546991725;5061.721605311706;5070.163423035213;5074.822381216658;5091.618128640348;5053.873653158664;5055.368078990126;5092.6180536459915;5104.081265372231;5128.153854613985;4645.187092258841;4658.836940707093;4661.417322834645;4661.673682842203;4671.602913752336;6244.563750337448;6250.7812226572305;6267.153934218868;6312.936870631281;6348.523860710419;5907.261592300963;5932.377100404438;5934.406559344075;5977.801875996364;5987.101934709828;6645.5680380775575;6657.866842663119;6700.731970721165;6743.763968261087;6790.660466976631;4960.181570040939;5147.371103372114;5157.896842063138;5159.019786240602;5191.805884646553;6583.967080164569;6833.145856767904;6914.478814660817;6923.238443771181;6960.364314386115;5238.449962753856;5272.815451459257;5292.047431462373;5296.841094767163;5299.5230429261555;5389.67661940277;5397.622166448311;5401.216823560561;5401.59558514789;5413.404525502192;5865.618734782225;5875.091829544317;5885;5925.140854576062;5947.256592925884;6549.6070235786;6624.635645039569;6646.169228846395;6678.799636010927;6694.430973367221;1795.5097269266478;1823.8176182381922;1832.6334733053443;1836.7979522252542;1839.6688596052838;1270.6442196185083;1281.2223338539025;1305.484333688188;1329.4017692038622;1345.6299517632533;6101.84745381369;6169.321374648785;6176.752929882754;6229.314775374705;6247.781327653511;6626.801195964129;6696;6726.730930762715;6742.325767423218;6799.776040312692;6251.156093927352;6261.843453913689;6283.5287353448675;6283.874322513524;6293.905591416133;3545.432730763117;3550.289942011608;3552.626974167727;3568.2863427314123;3590.9461358079648;6918.238993710688;7016.158061032709;7020.157581090302;7024.297570243037;7036.683349249296;6764.864702706017;6822.351876571718;6866.210385805596;6898.172219333712;6914.55055421396;6872.62200578973;6995.93004069963;6996.6851491683;7012.509124361246;7046.929530704628;6731.798046058626;6756.594604323756;6779.966010196823;6785.762498312535;6801.625910574966;6693.866122677422;6710.16122984627;6720.764773232913;6736.696848641921;6756.831079223059;6967.372936435542;6974.58152510851;7044.823879403056;7071.681774320271;7124.145102587722;5248.9737551312;5293.629445938747;5296.364436267672;5300;5312.442193569619;6515.348465153446;6702.966485167543;6722.394984451423;6742.292059333699;6742.359475849787;6352.555321127662;6578.506612004023;6596.80209593713;6599.0761293418;6659.866802663822;6490.091387205889;6502.60984340941;6558.934410656023;6571.488557631676;6609.669516524251;6450.645214513247;6502.252240992347;6505.642189679613;6514.120593719977;6616.933830661632;6638.302978187221;6667.533272670867;6691.1636045494315;6754.729810807513;6776.322367763184;6489.448396886318;6525.804225873231;6532.9346706534225;6565.573237739532;6577.177852768404 08:39:50 INFO - PID 10663 | |5;yui.html;978.3249557805118;1010.9292349535531;1012.1497941728951;1013.2147585621143;1041.8489319048736;18825.811741882593;19115.522111947208;19232.90383548082;19245.230190792387;19290.131944062534;18828;18888.62222755544;19296.228150873983;20393;20564;1064.3454275620495;1097.5719469406938;1097.8023955687972;1098.6758906122673;1099.769048499816;1076.5747529725754;1101.1686176936403;1105.5135740274254;1106.1980064453248;1109.4452773613193;1170.5025364220214;1171.876952919944;1172.5427083437423;1175.3829239649167;1182.0484509969472;1161.0537412009185;1167.1246565076192;1172.1619042384737;1173.9413029348584;1174.6828356343783;861.9655213791441;861.9827603447959;864.6454953469048;868.5309932636369;868.8088620503479;18418.907905460386;21000.789992100035;21259.787402125934;21370.358889233346;21461.248856290113;23430.531389372118;23709.170179043824;23854.165104221443;23874.283771486884;23910.28269151928;17023.57441063971;17053.573660658458;17095.658086838193;17116.74324885128;17176.312947482085;4072.2059198456313;4157.147784704129;4168.874933751992;4176.937345939813;4189.685773566965;151352;162522;163200;165511;166251;18794.248230070916;18852.340168094324;19046.904765476083;19054.809451905305;19261.903690481457;34368;35842.64157358445;36010.45984310185;36170.19149042537;36394;9797.608095676092;9821.508924553744;9976.102150806462;10116.696499104892;10191.643292484727;4800.66395352329;4894.216925291937;4901.681390709664;4906.411230652345;4921.729304888266;5988.8802223956145;6060.818175454743;6074.179985701874;6096.664683442365;6098.664573448503;1162.616336608917;1171.9824202636967;1190.6487586162102;1191.3328536019856;1193.570314686712;754.0235395163277;764.896738940247;773.7794728502349;778.9376849851998;787.9960600196962;13049.739005219843;13751.312434378242;13816.309184540733;13889.861101388857;13892.583222503341;697.1738489889498;702.9543079699905;708.348319546019;711.5837235217456;717.8671945690064;6282.874342513124;6464.935350646433;6495.967520162369;6513.348665133449;6537.1174891389055;139589;143044;144395;146274;146804;129742;132826.2358003533;136791.31604341915;138229;141696.29151854175;117225;119806.4009679946;127719;128881.35559322144;130065;14154.716905662035;14370.3533341002;14502;14685.779713304522;14768.563187074013;56417.71791141018;57555.13667295078;58310;58565;59876.10185847129;74865.6256718713;74995.62502187454;75457.24542754721;76076.61961690156;77288.61355693186;21471.677924831452;22404.439889002904;22405;22482.437939051655;22511.774882250967;24494.14270500524;24606.507869842862;24640.137595184082;24730.752692473565;24955.001799928526;23483;23582.292531223404;23680;23728.644070339305;23840.40398990039;22317.44206394788;22412.215572454887;22438.551228975655;22510.09959601663;22535.549289014456;22158.77841221567;22205.888970555043;22429.32712018642;22477.887610561844;22771.430714232276;15935.521934341989;16177;16205.351785928431;16279.755803662718;16491.83508164903;15657.608559786097;16107.194640267706;16433.589160271087;16664.16679166061;16732.41436549715 08:39:50 INFO - PID 10663 | __end_tp_report 08:39:50 INFO - PID 10663 | __start_cc_report 08:39:50 INFO - PID 10663 | _x_x_mozilla_cycle_collect,254 08:39:50 INFO - PID 10663 | __end_cc_report 08:39:50 INFO - PID 10663 | __startTimestamp1506872390480__endTimestamp 08:39:50 INFO - PID 10663 | 08:39:50 INFO - PID 10663 | ------- Summary: start ------- 08:39:50 INFO - PID 10663 | Number of tests: 6 08:39:50 INFO - PID 10663 | 08:39:50 INFO - PID 10663 | [#0] dojo.html Cycles:165 Average:6538.27 Median:6765.70 stddev:763.43 (11.3%) stddev-sans-first:739.21 08:39:50 INFO - PID 10663 | Values: 3993.8 4009.2 4028.1 4030.4 4045.2 6444.7 6468.7 6489.1 6583.5 6586.4 6538.3 6552.0 6580.3 6607.6 6634.4 5877.0 5877.6 5909.9 5915.3 5936.0 5823.6 5828.9 5832.1 5893.7 6008.2 5885.4 5912.2 5926.3 5927.4 5927.8 5869.6 5897.3 5911.7 5941.0 5989.8 5817.3 5843.1 5895.6 5933.8 5963.4 6414.7 6446.7 6467.6 6560.0 6657.4 6874.3 6975.7 7049.5 7099.8 7102.7 7054.7 7125.6 7138.6 7175.8 7179.9 6393.5 6523.9 6529.8 6627.6 6632.0 7204.5 7242.1 7308.5 7350.4 7354.2 6915.8 6961.9 6979.6 7011.6 7047.9 6928.2 7022.2 7032.9 7077.9 7164.8 7050.3 7060.9 7076.6 7087.4 7088.9 7018.8 7027.8 7105.6 7109.4 7112.9 5216.3 5218.6 5276.5 5277.1 5287.3 4659.4 4663.4 4724.1 4741.2 4755.4 6636.9 6655.3 6668.0 6670.6 6688.9 6971.8 7046.7 7069.9 7156.5 7160.5 6500.5 6581.7 6599.9 6661.9 6669.1 5884.3 5965.9 5972.6 5996.6 5997.2 7379.4 7404.6 7449.1 7458.7 7465.9 6927.0 7048.5 7060.4 7149.2 7149.5 7335.3 7361.5 7409.3 7444.6 7461.2 6980.7 6993.1 7065.4 7067.5 7073.6 6981.8 7070.4 7095.0 7122.9 7147.4 6803.9 6804.8 6812.6 6882.9 6892.4 6861.3 6895.4 6899.8 6901.0 6919.7 6747.5 6749.3 6761.1 6765.7 6842.9 6884.2 6943.8 6953.7 6964.3 6977.4 6653.4 6677.1 6709.9 6759.8 6767.8 08:39:50 INFO - PID 10663 | 08:39:50 INFO - PID 10663 | [#1] ext.html Cycles:180 Average:44977.63 Median:3842.53 stddev:68821.15 (1791.0%) stddev-sans-first:68934.86 08:39:50 INFO - PID 10663 | Values: 963.5 965.5 1006.8 1025.5 1031.0 44273.1 46083.3 46091.1 46147.0 46290.3 43459.6 43964.0 44070.3 44336.8 44381.0 8081.4 8195.2 8209.6 8214.2 8219.9 8034.6 8083.6 8101.8 8105.1 8132.6 8678.9 8961.3 8987.7 9017.7 9023.1 8901.6 8949.1 8959.2 8966.8 8967.5 8692.8 8753.5 8783.4 8790.2 8800.6 41095.8 41219.0 41224.6 41319.8 41751.0 3815.8 3826.4 3858.6 3858.6 3885.2 33805.5 34072.5 34227.0 34321.3 34420.3 5599.5 5601.0 5663.8 5666.3 5690.5 235248.0 238130.0 238383.0 238524.0 240475.0 54351.7 54425.0 54472.2 54533.0 54542.7 56996.1 57014.7 57345.7 57351.7 57519.4 18098.5 18340.7 18428.5 18437.2 18443.6 15341.7 15421.5 15424.1 15450.3 15465.9 15294.1 15690.2 15799.2 15800.4 15812.6 5884.9 5901.5 5948.1 5984.2 5994.3 1094.9 1116.8 1125.5 1126.3 1132.1 26220.7 26302.2 26364.5 26439.6 26582.3 1211.3 1228.9 1241.1 1242.8 1248.5 13749.3 13937.3 14000.6 14100.9 14210.1 291175.0 292103.0 295804.0 296373.0 297567.0 64933.0 65572.7 65803.3 65806.0 66111.3 1522.0 1525.2 1527.6 1535.0 1550.4 30811.5 30849.5 31029.8 31108.1 31526.4 42716.1 42997.4 43123.6 43178.6 43282.4 255321.0 256696.0 257519.0 259288.0 261511.0 37560.6 39051.2 39288.0 39432.6 39694.0 47221.5 47410.3 47443.3 48417.0 48425.3 34938.1 35188.3 35508.6 35618.5 35706.8 34828.3 35015.0 35282.6 35446.6 36297.0 39604.8 40674.0 40847.6 40879.2 41060.4 34085.0 34177.5 34303.7 34518.0 34782.3 25401.6 25728.9 26036.6 26228.3 26431.7 08:39:50 INFO - PID 10663 | 08:39:50 INFO - PID 10663 | [#2] jquery.html Cycles:180 Average:41204.80 Median:22330.37 stddev:103449.11 (463.3%) stddev-sans-first:103694.50 08:39:50 INFO - PID 10663 | Values: 647.9 649.5 651.2 652.6 657.2 23785.5 24703.0 24714.5 24794.1 24845.9 26099.9 26440.3 26544.0 26653.0 26691.7 6485.9 6757.5 6781.2 6828.1 6862.0 6692.5 6818.0 6820.3 6825.4 6826.9 6792.8 6793.4 6794.8 7094.8 7107.6 6958.8 6971.7 7029.7 7030.0 7034.9 6475.4 6492.2 6510.6 6516.6 6568.7 29885.9 30236.7 30330.8 30843.8 30868.5 2362.4 2402.8 2403.7 2404.7 2405.4 21200.9 21673.0 21688.1 21810.9 21818.3 2567.7 2632.6 2639.7 2650.4 2654.8 144310.0 150022.0 172037.0 178207.0 179090.0 16492.3 16813.7 16916.4 16919.4 17054.6 27339.5 27348.6 27348.6 27356.5 27379.2 11712.8 11736.9 11827.9 11894.4 11986.7 10678.4 10887.4 10935.8 10941.4 11048.6 10045.1 10065.1 10151.2 10250.3 10575.8 2737.5 2801.0 2841.4 2859.1 2906.3 1002.0 1050.7 1050.9 1059.9 1064.2 21031.7 21274.4 21676.7 21792.0 21955.7 1120.7 1126.4 1131.3 1133.5 1138.1 11650.9 11694.9 11792.5 11808.4 11895.9 601780.0 615096.0 616970.0 617735.0 623526.0 134348.0 136874.0 142369.0 142586.3 143325.3 1022.5 1023.9 1067.6 1237.3 1256.1 22058.9 22601.9 22689.4 22748.8 22777.9 65598.0 65641.7 65692.0 65709.7 66486.3 77950.2 79000.6 81499.6 82423.2 83344.0 16045.1 16223.9 16332.8 16355.5 16376.7 24759.4 24796.0 24848.5 25170.7 25279.5 18772.2 18960.5 18988.1 19001.7 19028.0 17277.7 17700.5 17907.7 18201.5 18313.7 19758.4 20756.0 20883.3 20926.7 21085.7 15761.0 15811.4 15842.2 15877.4 16019.2 20324.4 20412.6 20416.7 20675.2 20684.8 08:39:50 INFO - PID 10663 | 08:39:50 INFO - PID 10663 | [#3] mootools.html Cycles:180 Average:10958.79 Median:27465.09 stddev:8142.84 (29.6%) stddev-sans-first:8134.01 08:39:50 INFO - PID 10663 | Values: 1399.8 1458.3 1459.7 1472.9 1480.1 17405.4 18169.8 18170.8 18182.7 18193.1 17704.1 17767.6 17774.0 17801.6 17823.9 3036.0 3164.5 3194.0 3194.2 3198.0 2522.3 2528.3 2532.4 2532.9 2534.0 2733.7 2832.4 2840.1 2843.6 2844.3 3050.9 3067.1 3073.8 3079.3 3097.3 2931.4 2950.8 2991.9 2999.6 3003.6 17353.5 17546.2 17683.5 17788.1 17814.6 8708.2 9059.5 9064.0 9153.6 9160.5 5827.7 5942.5 6116.4 6133.1 6158.9 2053.8 2069.9 2103.6 2121.3 2145.2 28771.0 29533.6 31332.4 32377.5 32432.2 7601.7 7719.0 7719.6 7859.5 7950.3 20896.8 20922.2 20926.4 20992.6 21065.5 8776.2 9067.1 9095.3 9110.6 9111.3 8102.3 8166.6 8179.8 8229.5 8317.8 5965.8 6228.4 6243.2 6275.9 6352.0 1798.2 1820.7 1820.8 1831.8 1845.7 914.4 920.7 927.8 930.6 935.4 9065.6 9073.5 9084.1 9139.2 9197.4 812.7 816.6 829.3 832.8 837.5 5477.3 5520.4 5575.0 5658.6 5853.3 25826.0 26194.3 27403.6 27526.6 27528.7 25587.9 26613.9 26884.6 27136.3 27142.2 12837.6 13012.7 13230.7 13277.0 13345.7 9764.3 9842.6 9969.4 10069.5 10083.2 22139.0 22277.8 22767.0 22832.9 23318.9 23447.9 23468.3 23705.4 23887.9 23980.2 12354.3 12819.4 12830.7 12836.7 12839.8 15089.5 15173.9 15324.9 15374.7 15447.7 13272.5 13355.5 13404.3 13405.5 13463.3 12881.2 13087.9 13136.3 13155.5 13282.2 11264.1 11480.2 11492.3 11496.3 11499.1 8542.7 8646.8 8691.5 8719.8 8787.1 8655.4 8884.8 8931.8 8940.8 9026.6 08:39:50 INFO - PID 10663 | 08:39:50 INFO - PID 10663 | [#4] prototype.html Cycles:180 Average:5680.01 Median:6283.70 stddev:1566.95 (24.9%) stddev-sans-first:1523.35 08:39:50 INFO - PID 10663 | Values: 552.9 577.7 589.2 590.3 604.2 6330.3 6384.9 6388.4 6427.8 6441.2 6184.4 6208.2 6237.5 6238.1 6241.3 4960.7 5138.8 5182.2 5193.7 5197.2 5104.4 5106.6 5110.0 5137.7 5147.9 5040.6 5061.7 5070.2 5074.8 5091.6 5053.9 5055.4 5092.6 5104.1 5128.2 4645.2 4658.8 4661.4 4661.7 4671.6 6244.6 6250.8 6267.2 6312.9 6348.5 5907.3 5932.4 5934.4 5977.8 5987.1 6645.6 6657.9 6700.7 6743.8 6790.7 4960.2 5147.4 5157.9 5159.0 5191.8 6584.0 6833.1 6914.5 6923.2 6960.4 5238.4 5272.8 5292.0 5296.8 5299.5 5389.7 5397.6 5401.2 5401.6 5413.4 5865.6 5875.1 5885.0 5925.1 5947.3 6549.6 6624.6 6646.2 6678.8 6694.4 1795.5 1823.8 1832.6 1836.8 1839.7 1270.6 1281.2 1305.5 1329.4 1345.6 6101.8 6169.3 6176.8 6229.3 6247.8 6626.8 6696.0 6726.7 6742.3 6799.8 6251.2 6261.8 6283.5 6283.9 6293.9 3545.4 3550.3 3552.6 3568.3 3590.9 6918.2 7016.2 7020.2 7024.3 7036.7 6764.9 6822.4 6866.2 6898.2 6914.6 6872.6 6995.9 6996.7 7012.5 7046.9 6731.8 6756.6 6780.0 6785.8 6801.6 6693.9 6710.2 6720.8 6736.7 6756.8 6967.4 6974.6 7044.8 7071.7 7124.1 5249.0 5293.6 5296.4 5300.0 5312.4 6515.3 6703.0 6722.4 6742.3 6742.4 6352.6 6578.5 6596.8 6599.1 6659.9 6490.1 6502.6 6558.9 6571.5 6609.7 6450.6 6502.3 6505.6 6514.1 6616.9 6638.3 6667.5 6691.2 6754.7 6776.3 6489.4 6525.8 6532.9 6565.6 6577.2 08:39:50 INFO - PID 10663 | 08:39:50 INFO - PID 10663 | [#5] yui.html Cycles:180 Average:29780.42 Median:20478.50 stddev:42840.27 (209.2%) stddev-sans-first:42905.86 08:39:50 INFO - PID 10663 | Values: 978.3 1010.9 1012.1 1013.2 1041.8 18825.8 19115.5 19232.9 19245.2 19290.1 18828.0 18888.6 19296.2 20393.0 20564.0 1064.3 1097.6 1097.8 1098.7 1099.8 1076.6 1101.2 1105.5 1106.2 1109.4 1170.5 1171.9 1172.5 1175.4 1182.0 1161.1 1167.1 1172.2 1173.9 1174.7 862.0 862.0 864.6 868.5 868.8 18418.9 21000.8 21259.8 21370.4 21461.2 23430.5 23709.2 23854.2 23874.3 23910.3 17023.6 17053.6 17095.7 17116.7 17176.3 4072.2 4157.1 4168.9 4176.9 4189.7 151352.0 162522.0 163200.0 165511.0 166251.0 18794.2 18852.3 19046.9 19054.8 19261.9 34368.0 35842.6 36010.5 36170.2 36394.0 9797.6 9821.5 9976.1 10116.7 10191.6 4800.7 4894.2 4901.7 4906.4 4921.7 5988.9 6060.8 6074.2 6096.7 6098.7 1162.6 1172.0 1190.6 1191.3 1193.6 754.0 764.9 773.8 778.9 788.0 13049.7 13751.3 13816.3 13889.9 13892.6 697.2 703.0 708.3 711.6 717.9 6282.9 6464.9 6496.0 6513.3 6537.1 139589.0 143044.0 144395.0 146274.0 146804.0 129742.0 132826.2 136791.3 138229.0 141696.3 117225.0 119806.4 127719.0 128881.4 130065.0 14154.7 14370.4 14502.0 14685.8 14768.6 56417.7 57555.1 58310.0 58565.0 59876.1 74865.6 74995.6 75457.2 76076.6 77288.6 21471.7 22404.4 22405.0 22482.4 22511.8 24494.1 24606.5 24640.1 24730.8 24955.0 23483.0 23582.3 23680.0 23728.6 23840.4 22317.4 22412.2 22438.6 22510.1 22535.5 22158.8 22205.9 22429.3 22477.9 22771.4 15935.5 16177.0 16205.4 16279.8 16491.8 15657.6 16107.2 16433.6 16664.2 16732.4 08:39:50 INFO - PID 10663 | -------- Summary: end -------- 08:39:50 INFO - PID 10663 | 08:39:51 INFO - TEST-INFO | 10663: exit 0 08:39:51 INFO - TEST-OK | dromaeo_css | took 1107827ms 08:39:51 INFO - TEST-START | kraken 08:39:51 INFO - Initialising browser for kraken test... 08:39:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56318/getInfo.html -profile /tmp/tmpJ8n8D1/profile 08:39:51 INFO - TEST-INFO | started process 11028 (/builds/slave/test/build/application/firefox/firefox http://localhost:56318/getInfo.html) 08:39:56 INFO - TEST-INFO | 11028: exit 0 08:39:56 INFO - Browser initialized. 08:39:56 INFO - Running cycle 1/1 for kraken test... 08:39:56 INFO - Using env: {'DISPLAY': ':0', 08:39:56 INFO - 'HOME': '/home/cltbld', 08:39:56 INFO - 'JSGC_DISABLE_POISONING': '1', 08:39:56 INFO - 'LANG': 'en_US.UTF-8', 08:39:56 INFO - 'LANGUAGE': 'en_US:en', 08:39:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:39:56 INFO - 'LOGNAME': 'cltbld', 08:39:56 INFO - 'MAIL': '/var/mail/cltbld', 08:39:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:39:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:39:56 INFO - 'MOZ_CRASHREPORTER': '1', 08:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:39:56 INFO - 'MOZ_NO_REMOTE': '1', 08:39:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:56 INFO - 'NO_EM_RESTART': '1', 08:39:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:56 INFO - 'PWD': '/builds/slave/test', 08:39:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:39:56 INFO - 'RUST_BACKTRACE': 'full', 08:39:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:39:56 INFO - 'SHELL': '/bin/bash', 08:39:56 INFO - 'SHLVL': '1', 08:39:56 INFO - 'TERM': 'linux', 08:39:56 INFO - 'TMOUT': '86400', 08:39:56 INFO - 'USER': 'cltbld', 08:39:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636', 08:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:56 INFO - '_': '/tools/buildbot/bin/python'} 08:39:56 INFO - TEST-INFO | started process 11213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ8n8D1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:57 INFO - PID 11213 | 08:39:57 INFO - PID 11213 | (/builds/slave/test/build/application/firefox/firefox:11261): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:39:57 INFO - PID 11213 | 08:40:07 INFO - PID 11213 | RSS: Main: 143278080 08:40:07 INFO - PID 11213 | 08:40:09 INFO - PID 11213 | Cycle 1(1): loaded http://localhost:56318/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56318/tests/kraken/driver.html?testName=audio-beat-detection) 08:40:10 INFO - PID 11213 | RSS: Main: 149331968 08:40:10 INFO - PID 11213 | 08:40:13 INFO - PID 11213 | Cycle 1(1): loaded http://localhost:56318/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56318/tests/kraken/driver.html?testName=audio-dft) 08:40:13 INFO - PID 11213 | RSS: Main: 149622784 08:40:13 INFO - PID 11213 | 08:40:16 INFO - PID 11213 | Cycle 1(1): loaded http://localhost:56318/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56318/tests/kraken/driver.html?testName=audio-fft) 08:40:17 INFO - PID 11213 | RSS: Main: 151158784 08:40:17 INFO - PID 11213 | 08:40:19 INFO - PID 11213 | Cycle 1(1): loaded http://localhost:56318/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56318/tests/kraken/driver.html?testName=audio-oscillator) 08:40:20 INFO - PID 11213 | RSS: Main: 150765568 08:40:20 INFO - PID 11213 | 08:40:22 INFO - PID 11213 | Cycle 1(1): loaded http://localhost:56318/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56318/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:40:22 INFO - PID 11213 | RSS: Main: 150818816 08:40:22 INFO - PID 11213 | 08:40:25 INFO - PID 11213 | Cycle 1(1): loaded http://localhost:56318/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56318/tests/kraken/driver.html?testName=imaging-darkroom) 08:40:26 INFO - PID 11213 | RSS: Main: 150740992 08:40:26 INFO - PID 11213 | 08:40:29 INFO - PID 11213 | Cycle 1(1): loaded http://localhost:56318/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56318/tests/kraken/driver.html?testName=imaging-desaturate) 08:40:30 INFO - PID 11213 | RSS: Main: 151269376 08:40:30 INFO - PID 11213 | 08:40:33 INFO - PID 11213 | Cycle 1(1): loaded http://localhost:56318/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56318/tests/kraken/driver.html?testName=json-parse-financial) 08:40:33 INFO - PID 11213 | RSS: Main: 153227264 08:40:33 INFO - PID 11213 | 08:40:35 INFO - PID 11213 | Cycle 1(1): loaded http://localhost:56318/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56318/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:40:36 INFO - PID 11213 | RSS: Main: 153112576 08:40:36 INFO - PID 11213 | 08:40:37 INFO - PID 11213 | Cycle 1(1): loaded http://localhost:56318/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56318/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:40:38 INFO - PID 11213 | RSS: Main: 153440256 08:40:38 INFO - PID 11213 | 08:40:40 INFO - PID 11213 | Cycle 1(1): loaded http://localhost:56318/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56318/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:40:40 INFO - PID 11213 | RSS: Main: 150093824 08:40:40 INFO - PID 11213 | 08:40:43 INFO - PID 11213 | Cycle 1(1): loaded http://localhost:56318/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:40:43 INFO - PID 11213 | RSS: Main: 150163456 08:40:43 INFO - PID 11213 | 08:40:46 INFO - PID 11213 | Cycle 1(1): loaded http://localhost:56318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:40:47 INFO - PID 11213 | RSS: Main: 151060480 08:40:47 INFO - PID 11213 | 08:40:48 INFO - PID 11213 | Cycle 1(1): loaded http://localhost:56318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56318/tests/kraken/driver.html?testName=ai-astar) 08:40:49 INFO - PID 11213 | RSS: Main: 152465408 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | __start_tp_report 08:40:49 INFO - PID 11213 | _x_x_mozilla_page_load 08:40:49 INFO - PID 11213 | _x_x_mozilla_page_load_details 08:40:49 INFO - PID 11213 | |i|pagename|runs| 08:40:49 INFO - PID 11213 | |0;ai-astar;106;105;106;117;107;106;106;105;104;105 08:40:49 INFO - PID 11213 | |1;audio-beat-detection;119;111;111;110;111;111;111;111;115;115 08:40:49 INFO - PID 11213 | |2;audio-dft;162;164;163;166;163;172;163;163;164;162 08:40:49 INFO - PID 11213 | |3;audio-fft;73;73;72;74;73;74;72;74;73;73 08:40:49 INFO - PID 11213 | |4;audio-oscillator;78;78;77;77;77;78;78;78;77;78 08:40:49 INFO - PID 11213 | |5;imaging-gaussian-blur;114;113;113;115;113;114;110;114;111;117 08:40:49 INFO - PID 11213 | |6;imaging-darkroom;149;148;149;148;148;148;149;148;151;148 08:40:49 INFO - PID 11213 | |7;imaging-desaturate;94;95;94;94;94;94;94;95;101;94 08:40:49 INFO - PID 11213 | |8;json-parse-financial;44;44;43;44;45;48;44;46;46;43 08:40:49 INFO - PID 11213 | |9;json-stringify-tinderbox;39;38;39;39;39;38;39;38;38;39 08:40:49 INFO - PID 11213 | |10;stanford-crypto-aes;73;74;69;71;70;70;70;71;71;73 08:40:49 INFO - PID 11213 | |11;stanford-crypto-ccm;105;110;102;104;105;110;109;107;111;102 08:40:49 INFO - PID 11213 | |12;stanford-crypto-pbkdf2;162;160;156;156;148;150;155;159;151;151 08:40:49 INFO - PID 11213 | |13;stanford-crypto-sha256-iterative;59;60;58;60;60;60;60;59;60;59 08:40:49 INFO - PID 11213 | __end_tp_report 08:40:49 INFO - PID 11213 | __start_cc_report 08:40:49 INFO - PID 11213 | _x_x_mozilla_cycle_collect,686 08:40:49 INFO - PID 11213 | __end_cc_report 08:40:49 INFO - PID 11213 | __startTimestamp1506872449093__endTimestamp 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | ------- Summary: start ------- 08:40:49 INFO - PID 11213 | Number of tests: 14 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | [#0] ai-astar Cycles:10 Average:106.70 Median:106.00 stddev:3.71 (3.5%) stddev-sans-first:3.93 08:40:49 INFO - PID 11213 | Values: 106.0 105.0 106.0 117.0 107.0 106.0 106.0 105.0 104.0 105.0 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | [#1] audio-beat-detection Cycles:10 Average:112.50 Median:111.00 stddev:2.88 (2.6%) stddev-sans-first:1.86 08:40:49 INFO - PID 11213 | Values: 119.0 111.0 111.0 110.0 111.0 111.0 111.0 111.0 115.0 115.0 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:2.97 (1.8%) stddev-sans-first:3.05 08:40:49 INFO - PID 11213 | Values: 162.0 164.0 163.0 166.0 163.0 172.0 163.0 163.0 164.0 162.0 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | [#3] audio-fft Cycles:10 Average:73.10 Median:73.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 08:40:49 INFO - PID 11213 | Values: 73.0 73.0 72.0 74.0 73.0 74.0 72.0 74.0 73.0 73.0 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 08:40:49 INFO - PID 11213 | Values: 78.0 78.0 77.0 77.0 77.0 78.0 78.0 78.0 77.0 78.0 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:114.00 stddev:1.96 (1.7%) stddev-sans-first:2.06 08:40:49 INFO - PID 11213 | Values: 114.0 113.0 113.0 115.0 113.0 114.0 110.0 114.0 111.0 117.0 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 08:40:49 INFO - PID 11213 | Values: 149.0 148.0 149.0 148.0 148.0 148.0 149.0 148.0 151.0 148.0 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.00 stddev:2.18 (2.3%) stddev-sans-first:2.29 08:40:49 INFO - PID 11213 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 101.0 94.0 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | [#8] json-parse-financial Cycles:10 Average:44.70 Median:44.50 stddev:1.57 (3.5%) stddev-sans-first:1.64 08:40:49 INFO - PID 11213 | Values: 44.0 44.0 43.0 44.0 45.0 48.0 44.0 46.0 46.0 43.0 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | [#9] json-stringify-tinderbox Cycles:10 Average:38.60 Median:39.00 stddev:0.52 (1.3%) stddev-sans-first:0.53 08:40:49 INFO - PID 11213 | Values: 39.0 38.0 39.0 39.0 39.0 38.0 39.0 38.0 38.0 39.0 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | [#10] stanford-crypto-aes Cycles:10 Average:71.20 Median:71.00 stddev:1.62 (2.3%) stddev-sans-first:1.58 08:40:49 INFO - PID 11213 | Values: 73.0 74.0 69.0 71.0 70.0 70.0 70.0 71.0 71.0 73.0 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | [#11] stanford-crypto-ccm Cycles:10 Average:106.50 Median:108.00 stddev:3.37 (3.1%) stddev-sans-first:3.54 08:40:49 INFO - PID 11213 | Values: 105.0 110.0 102.0 104.0 105.0 110.0 109.0 107.0 111.0 102.0 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:156.00 stddev:4.69 (3.0%) stddev-sans-first:4.18 08:40:49 INFO - PID 11213 | Values: 162.0 160.0 156.0 156.0 148.0 150.0 155.0 159.0 151.0 151.0 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.50 Median:60.00 stddev:0.71 (1.2%) stddev-sans-first:0.73 08:40:49 INFO - PID 11213 | Values: 59.0 60.0 58.0 60.0 60.0 60.0 60.0 59.0 60.0 59.0 08:40:49 INFO - PID 11213 | -------- Summary: end -------- 08:40:49 INFO - PID 11213 | 08:40:49 INFO - PID 11213 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:40:49 INFO - TEST-INFO | 11213: exit 0 08:40:49 INFO - TEST-OK | kraken | took 58575ms 08:40:49 INFO - SUITE-END | took 1166s 08:40:50 INFO - Completed test suite (00:19:26) 08:40:50 INFO - javascript benchmark 08:40:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9433.84107772624, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3993.7803420811856, 4009.2182024505223, 4028.1138149607077, 4030.415589739486, 4045.1505183911377, 6444.677766111693, 6468.708908099135, 6489.1239682642945, 6583.506237032229, 6586.374294442032, 6538.346165383459, 6552.0, 6580.341965803429, 6607.603543787376, 6634.369734875191, 5877.030290002144, 5877.617954832944, 5909.852253693671, 5915.349311575723, 5936.0, 5823.592348535604, 5828.912566311508, 5832.096025116092, 5893.705314734246, 6008.188894499231, 5885.382034886339, 5912.231409916705, 5926.288845338566, 5927.377625349341, 5927.8221653350465, 5869.559783016248, 5897.292324920994, 5911.674857882815, 5941.049432090845, 5989.760409583655, 5817.34841313336, 5843.065109582489, 5895.587308888379, 5933.762649494015, 5963.403659634002, 6414.679266036679, 6446.677666116675, 6467.611943283418, 6560.0, 6657.367550082734, 6874.2782007889455, 6975.651217439107, 7049.541779784349, 7099.787006389816, 7102.68037938294, 7054.717811287543, 7125.608091554963, 7138.571685698823, 7175.784726458214, 7179.92820071803, 6393.456556192729, 6523.93476065238, 6529.836754081139, 6627.602343859384, 6632.005199220155, 7204.459665525106, 7242.130944286614, 7308.488405811542, 7350.4119670426235, 7354.227806080285, 6915.827104322432, 6961.93038069623, 6979.581225126509, 7011.6143612100805, 7047.929520704727, 6928.16861976566, 7022.227554968949, 7032.92967070333, 7077.893831592531, 7164.785056448315, 7050.330218629325, 7060.858782824314, 7076.610786406694, 7087.433005359662, 7088.893666595005, 7018.75434359795, 7027.754028608974, 7105.644717764091, 7109.395701365442, 7112.893306600405, 5216.26972223889, 5218.582513398919, 5276.498732620395, 5277.076511610453, 5287.339082614673, 4659.4175728034, 4663.3937588114, 4724.102420540086, 4741.193997020515, 4755.405574303212, 6636.8672626547195, 6655.267920528738, 6668.0331351954665, 6670.599764014175, 6688.933110668831, 6971.79084627462, 7046.6828992695455, 7069.858602827914, 7156.463265255126, 7160.462965277625, 6500.512461565401, 6581.736730530725, 6599.934000659932, 6661.933380666132, 6669.066330713704, 5884.293884733859, 5965.940340596539, 5972.552058595623, 5996.610220335664, 5997.220361352996, 7379.446541509408, 7404.555726656418, 7449.068866391701, 7458.70165193397, 7465.925340746631, 6926.995585640155, 7048.506604537633, 7060.364567188875, 7149.213586505584, 7149.53528020677, 7335.303146201102, 7361.484696071224, 7409.296116868889, 7444.590547519939, 7461.179270280156, 6980.650967451708, 6993.125859267591, 7065.364117229474, 7067.5052746307265, 7073.646317684198, 6981.825454363681, 7070.434365250665, 7095.0, 7122.85754284901, 7147.356737893615, 6803.863922721419, 6804.829879253059, 6812.557183783038, 6882.8967565485555, 6892.414144797748, 6861.279565645735, 6895.448364130958, 6899.75850845218, 6900.964855271549, 6919.723211071702, 6747.527673062838, 6749.291324410866, 6761.121054262914, 6765.695543700644, 6842.93157068423, 6884.208316043719, 6943.79168624942, 6953.687084081127, 6964.268751781193, 6977.441804655717, 6653.367930046637, 6677.098591690254, 6709.865802684017, 6759.831004224737, 6767.796966091025], "value": 6486.972897805221, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [963.4749061761344, 965.5461932891541, 1006.8489726541019, 1025.4821315235804, 1030.9587616495342, 44273.11453770927, 46083.30875036873, 46091.07817843641, 46147.0, 46290.30564541535, 43459.56540434594, 43964.0, 44070.33894491577, 44336.77831610837, 44381.0, 8081.393895457834, 8195.221453961894, 8209.58952052398, 8214.219649133323, 8219.917800822004, 8034.638441270157, 8083.595820208995, 8101.756947291591, 8105.1489593592705, 8132.552709600969, 8678.86981695275, 8961.327900407463, 8987.685431009915, 9017.684381046665, 9023.05257947916, 8901.643934242655, 8949.149830766068, 8959.238464730506, 8966.820663586757, 8967.46195228285, 8692.826143477096, 8753.47479151253, 8783.429077109968, 8790.208881200659, 8800.559972001438, 41095.7945210275, 41219.0, 41224.587754122374, 41319.7934010331, 41751.0, 3815.790131542764, 3826.4451654510217, 3858.614138586147, 3858.614138586147, 3885.1841113366227, 33805.49291760601, 34072.48891266633, 34227.0, 34321.31357372839, 34420.31159376824, 5599.468050535193, 5601.0, 5663.773449062032, 5666.348369937468, 5690.516306113986, 235248.0, 238130.0, 238383.0, 238524.0, 240475.0, 54351.72824135933, 54425.0, 54472.18291725627, 54533.0, 54542.72728636331, 56996.145057824164, 57014.714926425935, 57345.71327143338, 57351.71324143353, 57519.42480575224, 18098.547536311435, 18340.724889126675, 18428.539286517676, 18437.1703273353, 18443.63112737738, 15341.693166136614, 15421.460248891235, 15424.074555526704, 15450.304736286895, 15465.922670386575, 15294.082355058732, 15690.215489225722, 15799.210039497979, 15800.36798528069, 15812.60468488297, 5884.941150588439, 5901.468867801833, 5948.107783832374, 5984.222051133324, 5994.310654274815, 1094.885037071112, 1116.7989761842784, 1125.487903004131, 1126.3354620773782, 1132.1395739238073, 26220.73779262183, 26302.21093367202, 26364.472710546066, 26439.603405948925, 26582.335441614116, 1211.2974474804591, 1228.91397602167, 1241.1436109084702, 1242.78163478191, 1248.4881198708485, 13749.312534373441, 13937.303134843218, 14000.649983750487, 14100.85899141016, 14210.147391156564, 291175.0, 292103.0, 295804.0, 296373.0, 297567.0, 64933.0, 65572.67213663997, 65803.34196658067, 65806.0, 66111.33888661052, 1521.9771703424235, 1525.161161361269, 1527.602823265959, 1534.99232503839, 1550.4340915565963, 30811.53782693306, 30849.537256941614, 31029.8448507756, 31108.066757997298, 31526.369472610877, 42716.145677086904, 42997.35503967381, 43123.56876431195, 43178.568214317456, 43282.35076473918, 255321.0, 256696.0, 257519.0, 259288.0, 261511.0, 37560.624393755716, 39051.21897561976, 39288.0, 39432.6056739429, 39694.0, 47221.527784721715, 47410.288845666655, 47443.28835067546, 48417.0, 48425.27362089642, 34938.12654683551, 35188.29623407466, 35508.64491355053, 35618.46572301366, 35706.821465892506, 34828.30343393169, 35015.0, 35282.647173527934, 35446.645533545365, 36297.0, 39604.80197599109, 40674.0, 40847.591524084375, 40879.18241635091, 41060.38409423801, 34085.0, 34177.48733769045, 34303.65696343104, 34518.0, 34782.304353912274, 25401.618975715748, 25728.871355643103, 26036.609450858632, 26228.344291392867, 26431.735682642928], "value": 19442.663723770333, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.8874628352225, 649.5269213114915, 651.1789010119007, 652.6079485065509, 657.1632287755722, 23785.5242895142, 24703.0, 24714.505709885838, 24794.132205372836, 24845.87577062112, 26099.869500652516, 26440.338991525223, 26544.0, 26653.0, 26691.73308266917, 6485.902711459332, 6757.5269731118715, 6781.220159681626, 6828.146481689789, 6861.9656901715425, 6692.498062645297, 6818.045473633695, 6820.2838701936325, 6825.35159159879, 6826.931730682704, 6792.796216113525, 6793.4225590824835, 6794.796156115324, 7094.751683691072, 7107.609081500541, 6958.79123626292, 6971.651417429108, 7029.718811247544, 7030.0, 7034.8944765828555, 6475.384838440341, 6492.188476440445, 6510.576812507172, 6516.576422532567, 6568.67156642166, 29885.850570747225, 30236.697633023607, 30330.84834575835, 30843.84578077118, 30868.53697194544, 2362.362162216209, 2402.771736685012, 2403.723571789249, 2404.723456802473, 2405.350555350046, 21200.893995529925, 21673.024713887757, 21688.13247470115, 21810.890945545172, 21818.345449636538, 2567.6918769747563, 2632.605109233611, 2639.696434909991, 2650.3904102056636, 2654.8008899332626, 144310.0, 150022.0, 172037.0, 178207.0, 179090.0, 16492.25784839685, 16813.66372672564, 16916.392942670427, 16919.407820726214, 17054.57363565896, 27339.453210936066, 27348.58977115345, 27348.58977115345, 27356.45287094247, 27379.178624641292, 11712.824307635392, 11736.94131529354, 11827.940860295816, 11894.405279736151, 11986.700332491757, 10678.359298442118, 10887.401192934465, 10935.781284374427, 10941.398223097647, 11048.613298534674, 10045.146162576117, 10065.144462720604, 10151.238657100746, 10250.336097075813, 10575.841362379571, 2737.54830452977, 2800.957985630217, 2841.4317136572768, 2859.0993836941298, 2906.302487403008, 1001.9849702254472, 1050.6900464363032, 1050.9421981790922, 1059.9311044782064, 1064.1858977881927, 21031.684524731834, 21274.36176914695, 21676.674849877265, 21792.0, 21955.67066494004, 1120.7366268926958, 1126.3636045634191, 1131.2759833706434, 1133.4729350851894, 1138.0838425067734, 11650.941745291218, 11694.941525292319, 11792.528298868121, 11808.409579520989, 11895.88104118965, 601780.0, 615096.0, 616970.0, 617735.0, 623526.0, 134348.0, 136874.0, 142369.0, 142586.28706856607, 143325.28337358247, 1022.5296363672794, 1023.9334443261164, 1067.567635107767, 1237.2761934268553, 1256.0705078242217, 22058.88970555137, 22601.852823981695, 22689.43276418037, 22748.81516587662, 22777.894305776073, 65598.0, 65641.67179164074, 65692.0, 65709.67145164244, 66486.33513664802, 77950.22049779429, 79000.60499697465, 81499.5925020371, 82423.17576824155, 83344.0, 16045.117518536126, 16223.918880405523, 16332.836671633131, 16355.509334719978, 16376.672466550364, 24759.38101547476, 24796.0, 24848.50302993966, 25170.748292517572, 25279.494410112064, 18772.15525301392, 18960.52598685044, 18988.145533451305, 19001.714974275674, 19028.0, 17277.740833887252, 17700.46898593044, 17907.73138402899, 18201.54496137554, 18313.725294120333, 19758.40724778259, 20756.0, 20883.26908558193, 20926.68609970821, 21085.683714743984, 15761.0, 15811.367545298059, 15842.207889605705, 15877.444289449813, 16019.199040047717, 20324.390268291976, 20412.591748164657, 20416.693749593473, 20675.17299308011, 20684.793152068287], "value": 13221.513354138759, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.769038108712, 1458.329168582452, 1459.6788706484576, 1472.867441930226, 1480.1415179196067, 17405.390811321606, 18169.818301816977, 18170.81829181708, 18182.727259091123, 18193.090345482724, 17704.1147942603, 17767.64464710705, 17774.022428766413, 17801.643967120683, 17823.910880445612, 3035.9848200758966, 3164.477861152907, 3194.0417874637515, 3194.2174167329035, 3197.9840100799465, 2522.331582130737, 2528.329992551975, 2532.392225865797, 2532.936676583091, 2533.9746602533924, 2733.658292713411, 2832.3768770870374, 2840.133759203442, 2843.6018957345987, 2844.303145729299, 3050.877964881402, 3067.125869127299, 3073.7694672899397, 3079.32254903923, 3097.2876238465165, 2931.428371467565, 2950.8229506229695, 2991.880324787006, 2999.5650630658433, 3003.564483149953, 17353.479395618153, 17546.210420531108, 17683.469495915142, 17788.110594470225, 17814.643707125786, 8708.17272359125, 9059.456432614064, 9063.954680226623, 9153.588088536031, 9160.450372977642, 5827.650340979555, 5942.494887934531, 6116.418940200674, 6133.1413602095745, 6158.938410615926, 2053.8459615528745, 2069.9482512937147, 2103.5687684024892, 2121.342383861008, 2145.1633862793524, 28771.0, 29533.556996645068, 31332.37335253305, 32377.514337285196, 32432.18919527007, 7601.695932162652, 7718.961405192938, 7719.575423351657, 7859.52842829432, 7950.324222441157, 20896.79103208979, 20922.163113475595, 20926.37220883376, 20992.580148396948, 21065.473363166042, 8776.16626420489, 9067.138621830916, 9095.31785116119, 9110.59002344896, 9111.271098312252, 8102.311303539147, 8166.550839703755, 8179.79550511242, 8229.547374894319, 8317.792055198548, 5965.821025369246, 6228.380621038563, 6243.219597550306, 6275.874482510324, 6351.96824015877, 1798.235749806327, 1820.654075725608, 1820.7724034495689, 1831.7801863776165, 1845.6585531676683, 914.4284821986258, 920.7053742802373, 927.8051609162017, 930.6184464369711, 935.3546053223254, 9065.59204835784, 9073.54632268384, 9084.137006984325, 9139.177474027236, 9197.402168859002, 812.7236739508477, 816.5590581086147, 829.3282441222628, 832.8334333133398, 837.5016864965336, 5477.260569823023, 5520.392756796749, 5574.968630803314, 5658.603897727202, 5853.326867410217, 25826.0, 26194.345141371618, 27403.588946165823, 27526.587101193498, 27528.724712753017, 25587.872060639576, 26613.866930665223, 26884.59673104905, 27136.321591960357, 27142.185734428, 12837.550685725955, 13012.674683132998, 13230.669233269246, 13277.0, 13345.666358340924, 9764.316497845082, 9842.62203291554, 9969.35199212049, 10069.546870390703, 10083.193344532274, 22138.999999999356, 22277.77722222757, 22767.0, 22832.885835570716, 23318.883405582863, 23447.882760586086, 23468.295951121494, 23705.40736481602, 23887.880560597085, 23980.160694375612, 12354.320512371905, 12819.423125959167, 12830.67923301925, 12836.679083022625, 12839.807402889151, 15089.54731358061, 15173.924130379277, 15324.923375383052, 15374.692506150039, 15447.691046179238, 13272.469101235842, 13355.465781369025, 13404.262765547988, 13405.530806421728, 13463.259520726062, 12881.227126372447, 13087.869121309046, 13136.27750473733, 13155.473781048651, 13282.203067815963, 11264.098872090377, 11480.196386252883, 11492.31046137201, 11496.252743571642, 11499.08007359426, 8542.701005464778, 8646.795067257808, 8691.478511289342, 8719.782005449915, 8787.121287871418, 8655.350848686248, 8884.822303553763, 8931.776705582412, 8940.821183576421, 9026.593803279], "value": 7589.30726557673, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.8645481856943, 577.662067690401, 589.2075158911265, 590.2621722846443, 604.1873679900535, 6330.33531479195, 6384.904226436607, 6388.393102655246, 6427.839304017396, 6441.162648855654, 6184.381561843813, 6208.192934918454, 6237.5009999200065, 6238.1266622672865, 6241.251049874021, 4960.727160006199, 5138.816003198635, 5182.170852663575, 5193.740312984354, 5197.194434862584, 5104.438511763703, 5106.64253502255, 5109.974450127763, 5137.666051706646, 5147.915094386761, 5040.6471546991725, 5061.721605311706, 5070.163423035213, 5074.822381216658, 5091.618128640348, 5053.873653158664, 5055.368078990126, 5092.6180536459915, 5104.081265372231, 5128.153854613985, 4645.187092258841, 4658.836940707093, 4661.417322834645, 4661.673682842203, 4671.602913752336, 6244.563750337448, 6250.7812226572305, 6267.153934218868, 6312.936870631281, 6348.523860710419, 5907.261592300963, 5932.377100404438, 5934.406559344075, 5977.801875996364, 5987.101934709828, 6645.5680380775575, 6657.866842663119, 6700.731970721165, 6743.763968261087, 6790.660466976631, 4960.181570040939, 5147.371103372114, 5157.896842063138, 5159.019786240602, 5191.805884646553, 6583.967080164569, 6833.145856767904, 6914.478814660817, 6923.238443771181, 6960.364314386115, 5238.449962753856, 5272.815451459257, 5292.047431462373, 5296.841094767163, 5299.5230429261555, 5389.67661940277, 5397.622166448311, 5401.216823560561, 5401.59558514789, 5413.404525502192, 5865.618734782225, 5875.091829544317, 5885.0, 5925.140854576062, 5947.256592925884, 6549.6070235786, 6624.635645039569, 6646.169228846395, 6678.799636010927, 6694.430973367221, 1795.5097269266478, 1823.8176182381922, 1832.6334733053443, 1836.7979522252542, 1839.6688596052838, 1270.6442196185083, 1281.2223338539025, 1305.484333688188, 1329.4017692038622, 1345.6299517632533, 6101.84745381369, 6169.321374648785, 6176.752929882754, 6229.314775374705, 6247.781327653511, 6626.801195964129, 6696.0, 6726.730930762715, 6742.325767423218, 6799.776040312692, 6251.156093927352, 6261.843453913689, 6283.5287353448675, 6283.874322513524, 6293.905591416133, 3545.432730763117, 3550.289942011608, 3552.626974167727, 3568.2863427314123, 3590.9461358079648, 6918.238993710688, 7016.158061032709, 7020.157581090302, 7024.297570243037, 7036.683349249296, 6764.864702706017, 6822.351876571718, 6866.210385805596, 6898.172219333712, 6914.55055421396, 6872.62200578973, 6995.93004069963, 6996.6851491683, 7012.509124361246, 7046.929530704628, 6731.798046058626, 6756.594604323756, 6779.966010196823, 6785.762498312535, 6801.625910574966, 6693.866122677422, 6710.16122984627, 6720.764773232913, 6736.696848641921, 6756.831079223059, 6967.372936435542, 6974.58152510851, 7044.823879403056, 7071.681774320271, 7124.145102587722, 5248.9737551312, 5293.629445938747, 5296.364436267672, 5300.0, 5312.442193569619, 6515.348465153446, 6702.966485167543, 6722.394984451423, 6742.292059333699, 6742.359475849787, 6352.555321127662, 6578.506612004023, 6596.80209593713, 6599.0761293418, 6659.866802663822, 6490.091387205889, 6502.60984340941, 6558.934410656023, 6571.488557631676, 6609.669516524251, 6450.645214513247, 6502.252240992347, 6505.642189679613, 6514.120593719977, 6616.933830661632, 6638.302978187221, 6667.533272670867, 6691.1636045494315, 6754.729810807513, 6776.322367763184, 6489.448396886318, 6525.804225873231, 6532.9346706534225, 6565.573237739532, 6577.177852768404], "value": 5231.720355902795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [978.3249557805118, 1010.9292349535531, 1012.1497941728951, 1013.2147585621143, 1041.8489319048736, 18825.811741882593, 19115.522111947208, 19232.90383548082, 19245.230190792387, 19290.131944062534, 18828.0, 18888.62222755544, 19296.228150873983, 20393.0, 20564.0, 1064.3454275620495, 1097.5719469406938, 1097.8023955687972, 1098.6758906122673, 1099.769048499816, 1076.5747529725754, 1101.1686176936403, 1105.5135740274254, 1106.1980064453248, 1109.4452773613193, 1170.5025364220214, 1171.876952919944, 1172.5427083437423, 1175.3829239649167, 1182.0484509969472, 1161.0537412009185, 1167.1246565076192, 1172.1619042384737, 1173.9413029348584, 1174.6828356343783, 861.9655213791441, 861.9827603447959, 864.6454953469048, 868.5309932636369, 868.8088620503479, 18418.907905460386, 21000.789992100035, 21259.787402125934, 21370.358889233346, 21461.248856290113, 23430.531389372118, 23709.170179043824, 23854.165104221443, 23874.283771486884, 23910.28269151928, 17023.57441063971, 17053.573660658458, 17095.658086838193, 17116.74324885128, 17176.312947482085, 4072.2059198456313, 4157.147784704129, 4168.874933751992, 4176.937345939813, 4189.685773566965, 151352.0, 162522.0, 163200.0, 165511.0, 166251.0, 18794.248230070916, 18852.340168094324, 19046.904765476083, 19054.809451905305, 19261.903690481457, 34368.0, 35842.64157358445, 36010.45984310185, 36170.19149042537, 36394.0, 9797.608095676092, 9821.508924553744, 9976.102150806462, 10116.696499104892, 10191.643292484727, 4800.66395352329, 4894.216925291937, 4901.681390709664, 4906.411230652345, 4921.729304888266, 5988.8802223956145, 6060.818175454743, 6074.179985701874, 6096.664683442365, 6098.664573448503, 1162.616336608917, 1171.9824202636967, 1190.6487586162102, 1191.3328536019856, 1193.570314686712, 754.0235395163277, 764.896738940247, 773.7794728502349, 778.9376849851998, 787.9960600196962, 13049.739005219843, 13751.312434378242, 13816.309184540733, 13889.861101388857, 13892.583222503341, 697.1738489889498, 702.9543079699905, 708.348319546019, 711.5837235217456, 717.8671945690064, 6282.874342513124, 6464.935350646433, 6495.967520162369, 6513.348665133449, 6537.1174891389055, 139589.0, 143044.0, 144395.0, 146274.0, 146804.0, 129742.0, 132826.2358003533, 136791.31604341915, 138229.0, 141696.29151854175, 117225.0, 119806.4009679946, 127719.0, 128881.35559322144, 130065.0, 14154.716905662035, 14370.3533341002, 14502.0, 14685.779713304522, 14768.563187074013, 56417.71791141018, 57555.13667295078, 58310.0, 58565.0, 59876.10185847129, 74865.6256718713, 74995.62502187454, 75457.24542754721, 76076.61961690156, 77288.61355693186, 21471.677924831452, 22404.439889002904, 22405.0, 22482.437939051655, 22511.774882250967, 24494.14270500524, 24606.507869842862, 24640.137595184082, 24730.752692473565, 24955.001799928526, 23483.0, 23582.292531223404, 23680.0, 23728.644070339305, 23840.40398990039, 22317.44206394788, 22412.215572454887, 22438.551228975655, 22510.09959601663, 22535.549289014456, 22158.77841221567, 22205.888970555043, 22429.32712018642, 22477.887610561844, 22771.430714232276, 15935.521934341989, 16177.0, 16205.351785928431, 16279.755803662718, 16491.83508164903, 15657.608559786097, 16107.194640267706, 16433.589160271087, 16664.16679166061, 16732.41436549715], "value": 10645.81013910691, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1366.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 106.0, 117.0, 107.0, 106.0, 106.0, 105.0, 104.0, 105.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 111.0, 111.0, 110.0, 111.0, 111.0, 111.0, 111.0, 115.0, 115.0], "value": 112.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 166.0, 163.0, 172.0, 163.0, 163.0, 164.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 74.0, 73.0, 74.0, 72.0, 74.0, 73.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 77.0, 77.0, 78.0, 78.0, 78.0, 77.0, 78.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 115.0, 113.0, 114.0, 110.0, 114.0, 111.0, 117.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0, 151.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 101.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 43.0, 44.0, 45.0, 48.0, 44.0, 46.0, 46.0, 43.0], "value": 44.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 39.0, 39.0, 39.0, 38.0, 39.0, 38.0, 38.0, 39.0], "value": 38.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 69.0, 71.0, 70.0, 70.0, 70.0, 71.0, 71.0, 73.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 110.0, 102.0, 104.0, 105.0, 110.0, 109.0, 107.0, 111.0, 102.0], "value": 106.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 156.0, 156.0, 148.0, 150.0, 155.0, 159.0, 151.0, 151.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0], "value": 59.5, "unit": "score"}]}]} 08:40:50 INFO - Return code: 0 08:40:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:40:50 INFO - # TBPL SUCCESS # 08:40:50 INFO - Running post-action listener: _package_coverage_data 08:40:50 INFO - Running post-action listener: _resource_record_post_action 08:40:50 INFO - [mozharness: 2017-10-01 15:40:50.386238Z] Finished run-tests step (success) 08:40:50 INFO - Running post-run listener: _resource_record_post_run 08:40:50 INFO - Total resource usage - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290934784; Read time: 156; Write time: 199752 08:40:50 INFO - TinderboxPrint: CPU usage
13.0% 08:40:50 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 156 08:40:50 INFO - TinderboxPrint: I/O write bytes / time
290,934,784 / 199,752 08:40:50 INFO - TinderboxPrint: CPU idle
8,193.8 (86.9%) 08:40:50 INFO - TinderboxPrint: CPU user
1,180.7 (12.5%) 08:40:50 INFO - TinderboxPrint: Swap in / out
0 / 0 08:40:50 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9322496; Read time: 0; Write time: 1772 08:40:50 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:40:50 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 8192; Write bytes: 281194496; Read time: 156; Write time: 197956 08:40:51 INFO - Running post-run listener: _upload_blobber_files 08:40:51 INFO - Blob upload gear active. 08:40:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:40:51 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:40:51 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:40:51 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:40:51 INFO - (blobuploader) - INFO - Open directory for files ... 08:40:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:40:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:40:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:52 INFO - (blobuploader) - INFO - Done attempting. 08:40:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:40:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:40:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:53 INFO - (blobuploader) - INFO - Done attempting. 08:40:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:40:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:40:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:56 INFO - (blobuploader) - INFO - Done attempting. 08:40:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:40:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:40:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:57 INFO - (blobuploader) - INFO - Done attempting. 08:40:57 INFO - (blobuploader) - INFO - Iteration through files over. 08:40:57 INFO - Return code: 0 08:40:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:40:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:40:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e67fe27be78acd6dbb6fd95ad5ed04ea845943f968eac0eafc5755f5f2c187e7318dd529f9ab5e941d5f99b4e3cf48ace349f669dd311379649306fb60929596", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f1d555f0f761518c64910705123b895d5e23c18da26a8434011072026a904299ce310603466dcacad053d9aa88e11cf2ec4b7a2e4fe6e3fd5e2205a891f65ee9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b990dc8aef8978e2812710688f7ef6b4bdefe20d0a76dfd75635bdd856944d24a36bb6efce72dd4825c0a913e8198ce686a5708a47e9f744280fb9b397f3a6ab", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea6fb046da05b3acdd33ae9de4f260bdbc9d5fec115cceb371b27c4f2ce88c23d5eb56a1ec6ebcbf4c18d8b54e63e639763b8687f146e085a65e1197b68631cf"} 08:40:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:40:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:40:57 INFO - Contents: 08:40:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e67fe27be78acd6dbb6fd95ad5ed04ea845943f968eac0eafc5755f5f2c187e7318dd529f9ab5e941d5f99b4e3cf48ace349f669dd311379649306fb60929596", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f1d555f0f761518c64910705123b895d5e23c18da26a8434011072026a904299ce310603466dcacad053d9aa88e11cf2ec4b7a2e4fe6e3fd5e2205a891f65ee9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b990dc8aef8978e2812710688f7ef6b4bdefe20d0a76dfd75635bdd856944d24a36bb6efce72dd4825c0a913e8198ce686a5708a47e9f744280fb9b397f3a6ab", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea6fb046da05b3acdd33ae9de4f260bdbc9d5fec115cceb371b27c4f2ce88c23d5eb56a1ec6ebcbf4c18d8b54e63e639763b8687f146e085a65e1197b68631cf"} 08:40:57 INFO - Running post-run listener: copy_logs_to_upload_dir 08:40:57 INFO - Copying logs to upload dir... 08:40:57 INFO - mkdir: /builds/slave/test/build/upload/logs 08:40:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.976836 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-10-01 08:40:57.583797) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-01 08:40:57.594029) ========= 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=fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636 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/e67fe27be78acd6dbb6fd95ad5ed04ea845943f968eac0eafc5755f5f2c187e7318dd529f9ab5e941d5f99b4e3cf48ace349f669dd311379649306fb60929596", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f1d555f0f761518c64910705123b895d5e23c18da26a8434011072026a904299ce310603466dcacad053d9aa88e11cf2ec4b7a2e4fe6e3fd5e2205a891f65ee9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b990dc8aef8978e2812710688f7ef6b4bdefe20d0a76dfd75635bdd856944d24a36bb6efce72dd4825c0a913e8198ce686a5708a47e9f744280fb9b397f3a6ab", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea6fb046da05b3acdd33ae9de4f260bdbc9d5fec115cceb371b27c4f2ce88c23d5eb56a1ec6ebcbf4c18d8b54e63e639763b8687f146e085a65e1197b68631cf"} build_url:https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/eHEvjhAdTZ23u2aNa5TtfA/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/e67fe27be78acd6dbb6fd95ad5ed04ea845943f968eac0eafc5755f5f2c187e7318dd529f9ab5e941d5f99b4e3cf48ace349f669dd311379649306fb60929596", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f1d555f0f761518c64910705123b895d5e23c18da26a8434011072026a904299ce310603466dcacad053d9aa88e11cf2ec4b7a2e4fe6e3fd5e2205a891f65ee9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b990dc8aef8978e2812710688f7ef6b4bdefe20d0a76dfd75635bdd856944d24a36bb6efce72dd4825c0a913e8198ce686a5708a47e9f744280fb9b397f3a6ab", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea6fb046da05b3acdd33ae9de4f260bdbc9d5fec115cceb371b27c4f2ce88c23d5eb56a1ec6ebcbf4c18d8b54e63e639763b8687f146e085a65e1197b68631cf"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-01 08:40:57.635205) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 08:40:57.638570) ========= 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=fa44defc139c4ba8574fe040000001db-1506857241.467945-1049959636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 08:40:57.715526) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-01 08:40:57.715874) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-01 08:40:57.716210) ========= ========= Total master_lag: 0.28 =========