builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1507857185.84 results: success (0) revision: c50a31492fe7fe38a75c8b4722f24685ba7dac03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-12 18:13:05.838879) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-12 18:13:05.839369) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-12 18:13:05.839834) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-12 18:13:05.931345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 18:13:05.931640) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-12 18:13:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2017-10-12 18:13:06 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.180306 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 18:13:06.153677) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 18:13:06.154246) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016938 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 18:13:06.204873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 18:13:06.205247) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c50a31492fe7fe38a75c8b4722f24685ba7dac03 --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 c50a31492fe7fe38a75c8b4722f24685ba7dac03 --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=97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-12 18:13:06,252 truncating revision to first 12 chars 2017-10-12 18:13:06,252 Setting DEBUG logging. 2017-10-12 18:13:06,252 attempt 1/10 2017-10-12 18:13:06,252 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c50a31492fe7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-12 18:13:06,659 unpacking tar archive at: mozilla-beta-c50a31492fe7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684448 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 18:13:06.907735) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-12 18:13:06.908091) ========= script_repo_revision: c50a31492fe7fe38a75c8b4722f24685ba7dac03 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-12 18:13:06.908520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-12 18:13:06.908823) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-12 18:13:06.923523) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-10-12 18:13:06.923872) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:13:07 INFO - MultiFileLogger online at 20171012 18:13:07 in /builds/slave/test 18:13:07 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 18:13:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:13:07 INFO - {'append_to_log': False, 18:13:07 INFO - 'base_work_dir': '/builds/slave/test', 18:13:07 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 18:13:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:13:07 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 18:13:07 INFO - 'buildbot_json_path': 'buildprops.json', 18:13:07 INFO - 'code_coverage': False, 18:13:07 INFO - 'config_files': ('talos/linux_config.py',), 18:13:07 INFO - 'default_actions': ('clobber', 18:13:07 INFO - 'read-buildbot-config', 18:13:07 INFO - 'download-and-extract', 18:13:07 INFO - 'populate-webroot', 18:13:07 INFO - 'create-virtualenv', 18:13:07 INFO - 'install', 18:13:07 INFO - 'setup-mitmproxy', 18:13:07 INFO - 'run-tests'), 18:13:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:13:07 INFO - 'disable_ccov_upload': False, 18:13:07 INFO - 'disable_stylo': False, 18:13:07 INFO - 'download_minidump_stackwalk': True, 18:13:07 INFO - 'download_symbols': 'ondemand', 18:13:07 INFO - 'enable_stylo': False, 18:13:07 INFO - 'enable_webrender': False, 18:13:07 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 18:13:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:13:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:13:07 INFO - 'gecko_profile': False, 18:13:07 INFO - 'gecko_profile_interval': 0, 18:13:07 INFO - 'installer_path': 'installer.exe', 18:13:07 INFO - 'log_level': 'info', 18:13:07 INFO - 'log_name': 'talos', 18:13:07 INFO - 'log_to_console': True, 18:13:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:13:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:13:07 INFO - 'opt_config_files': (), 18:13:07 INFO - 'pip_index': False, 18:13:07 INFO - 'suite': 'dromaeojs-e10s', 18:13:07 INFO - 'system_bits': '32', 18:13:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:13:07 INFO - 'title': 'talos-linux64-ix-068', 18:13:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:13:07 INFO - 'use_talos_json': True, 18:13:07 INFO - 'verify': 'False', 18:13:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:13:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:13:07 INFO - 'work_dir': 'build'} 18:13:07 INFO - [mozharness: 2017-10-13 01:13:07.252888Z] Running clobber step. 18:13:07 INFO - Running pre-action listener: _resource_record_pre_action 18:13:07 INFO - Running main action method: clobber 18:13:07 INFO - rmtree: /builds/slave/test/build 18:13:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:13:08 INFO - Running post-action listener: _resource_record_post_action 18:13:08 INFO - [mozharness: 2017-10-13 01:13:08.246947Z] Finished clobber step (success) 18:13:08 INFO - [mozharness: 2017-10-13 01:13:08.247049Z] Running read-buildbot-config step. 18:13:08 INFO - Running pre-action listener: _resource_record_pre_action 18:13:08 INFO - Running main action method: read_buildbot_config 18:13:08 INFO - Using buildbot properties: 18:13:08 INFO - { 18:13:08 INFO - "project": "", 18:13:08 INFO - "product": "firefox", 18:13:08 INFO - "who": "nthomas@mozilla.com", 18:13:08 INFO - "installer_path": "public/build/target.tar.bz2", 18:13:08 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 18:13:08 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 18:13:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 18:13:08 INFO - "stage_platform": "linux64", 18:13:08 INFO - "basedir": "/builds/slave/test", 18:13:08 INFO - "buildnumber": 139, 18:13:08 INFO - "platform": "ubuntu64_hw", 18:13:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:13:08 INFO - "slavebuilddir": "test", 18:13:08 INFO - "taskId": "LoZ4ZRY8RA6WRA3AfJdMyA", 18:13:08 INFO - "branch": "mozilla-beta", 18:13:08 INFO - "script_repo_revision": "production", 18:13:08 INFO - "revision": "c50a31492fe7fe38a75c8b4722f24685ba7dac03", 18:13:08 INFO - "slavename": "talos-linux64-ix-068", 18:13:08 INFO - "repo_path": "releases/mozilla-beta" 18:13:08 INFO - } 18:13:08 INFO - Finding installer, test and symbols from parent task. 18:13:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LoZ4ZRY8RA6WRA3AfJdMyA'}, attempt #1 18:13:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LoZ4ZRY8RA6WRA3AfJdMyA'}, attempt #1 18:13:09 INFO - Task dependencies: S9AoryBmT7Kb5uUhBT01vw 18:13:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw'}, attempt #1 18:13:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.tar.bz2 18:13:09 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.test_packages.json 18:13:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.crashreporter-symbols.zip 18:13:09 INFO - Running post-action listener: _resource_record_post_action 18:13:09 INFO - [mozharness: 2017-10-13 01:13:09.583411Z] Finished read-buildbot-config step (success) 18:13:09 INFO - [mozharness: 2017-10-13 01:13:09.583630Z] Running download-and-extract step. 18:13:09 INFO - Running pre-action listener: _resource_record_pre_action 18:13:09 INFO - Running main action method: download_and_extract 18:13:09 INFO - mkdir: /builds/slave/test/build/tests 18:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:09 INFO - trying https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.test_packages.json 18:13:09 INFO - Downloading https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:13:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:13:10 INFO - Downloaded 989 bytes. 18:13:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:13:10 INFO - Using the following test package requirements: 18:13:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:13:10 INFO - u'common': [u'target.common.tests.zip'], 18:13:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:13:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:13:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:13:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:13:10 INFO - u'mozbase': [u'target.common.tests.zip'], 18:13:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:13:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:13:10 INFO - u'web-platform': [u'target.common.tests.zip', 18:13:10 INFO - u'target.web-platform.tests.tar.gz'], 18:13:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:13:10 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 18:13:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.common.tests.zip 18:13:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:13:10 INFO - Fetch https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.common.tests.zip into memory 18:13:12 INFO - Content-Length response header: 55181009 18:13:12 INFO - Bytes received: 55181009 18:13:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.talos.tests.zip 18:13:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:13:23 INFO - Fetch https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.talos.tests.zip into memory 18:13:24 INFO - Content-Length response header: 14509251 18:13:24 INFO - Bytes received: 14509251 18:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:25 INFO - trying https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.tar.bz2 18:13:25 INFO - Downloading https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:13:27 INFO - Downloaded 53648278 bytes. 18:13:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.tar.bz2 18:13:27 INFO - mkdir: /builds/slave/test/properties 18:13:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:13:27 INFO - Writing to file /builds/slave/test/properties/build_url 18:13:27 INFO - Contents: 18:13:27 INFO - build_url:https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.tar.bz2 18:13:27 INFO - Running post-action listener: _resource_record_post_action 18:13:27 INFO - Running post-action listener: find_tests_for_verification 18:13:27 INFO - Running post-action listener: set_extra_try_arguments 18:13:27 INFO - [mozharness: 2017-10-13 01:13:27.764655Z] Finished download-and-extract step (success) 18:13:27 INFO - [mozharness: 2017-10-13 01:13:27.764884Z] Running populate-webroot step. 18:13:27 INFO - Running pre-action listener: _resource_record_pre_action 18:13:27 INFO - Running main action method: populate_webroot 18:13:27 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:13:27 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:13:27 INFO - 'tests': ['tresize', 18:13:27 INFO - 'tcanvasmark']}, 18:13:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:13:27 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:13:27 INFO - 'tests': ['dromaeo_css', 18:13:27 INFO - 'kraken']}, 18:13:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:13:27 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:13:27 INFO - 'talos_options': ['--disable-stylo'], 18:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:13:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:13:27 INFO - 'tests': ['damp', 'tps']}, 18:13:27 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:13:27 INFO - 'talos_options': ['--disable-stylo'], 18:13:27 INFO - 'tests': ['damp', 'tps']}, 18:13:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:13:27 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:13:27 INFO - 'tests': ['dromaeo_dom']}, 18:13:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:13:27 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:13:27 INFO - 'tests': ['basic_compositor_video', 18:13:27 INFO - 'glvideo']}, 18:13:27 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:13:27 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:13:27 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:13:27 INFO - 'talos_options': ['--disable-stylo'], 18:13:27 INFO - 'tests': ['ts_paint_webext', 18:13:27 INFO - 'tp5o_webext']}, 18:13:27 INFO - 'other-e10s': {'tests': ['a11yr', 18:13:27 INFO - 'ts_paint', 18:13:27 INFO - 'tpaint', 18:13:27 INFO - 'sessionrestore', 18:13:27 INFO - 'sessionrestore_many_windows', 18:13:27 INFO - 'sessionrestore_no_auto_restore', 18:13:27 INFO - 'tabpaint']}, 18:13:27 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:13:27 INFO - 'tests': ['a11yr', 18:13:27 INFO - 'ts_paint', 18:13:27 INFO - 'tpaint', 18:13:27 INFO - 'sessionrestore', 18:13:27 INFO - 'sessionrestore_many_windows', 18:13:27 INFO - 'sessionrestore_no_auto_restore', 18:13:27 INFO - 'tabpaint']}, 18:13:27 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:13:27 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 18:13:27 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:13:27 INFO - 'tests': ['perf_reftest_singletons']}, 18:13:27 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:13:27 INFO - 'tests': ['bloom_basic']}, 18:13:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:13:27 INFO - 'tsvgr_opacity', 18:13:27 INFO - 'tart', 18:13:27 INFO - 'tscrollx', 18:13:27 INFO - 'tsvg_static']}, 18:13:27 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:13:27 INFO - 'tests': ['tsvgx', 18:13:27 INFO - 'tsvgr_opacity', 18:13:27 INFO - 'tart', 18:13:27 INFO - 'tscrollx', 18:13:27 INFO - 'tsvg_static']}, 18:13:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:13:27 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:13:27 INFO - 'talos_options': ['--disable-stylo'], 18:13:27 INFO - 'tests': ['tp5o']}, 18:13:27 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:13:27 INFO - 'talos_options': ['--mitmproxy', 18:13:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:13:27 INFO - '--firstNonBlankPaint'], 18:13:27 INFO - 'tests': ['tp6_google', 18:13:27 INFO - 'tp6_youtube', 18:13:27 INFO - 'tp6_amazon', 18:13:27 INFO - 'tp6_facebook']}, 18:13:27 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:13:27 INFO - 'talos_options': ['--disable-stylo', 18:13:27 INFO - '--mitmproxy', 18:13:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:13:27 INFO - '--firstNonBlankPaint'], 18:13:27 INFO - 'tests': ['tp6_google', 18:13:27 INFO - 'tp6_youtube', 18:13:27 INFO - 'tp6_amazon', 18:13:27 INFO - 'tp6_facebook']}, 18:13:27 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:13:27 INFO - 'talos_options': ['--stylo-threads=1', 18:13:27 INFO - '--mitmproxy', 18:13:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:13:27 INFO - '--firstNonBlankPaint'], 18:13:27 INFO - 'tests': ['tp6_google', 18:13:27 INFO - 'tp6_youtube', 18:13:27 INFO - 'tp6_amazon', 18:13:27 INFO - 'tp6_facebook']}, 18:13:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:13:27 INFO - 'talos_options': ['--xperf_path', 18:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:13:27 INFO - 'tests': ['tp5n']}, 18:13:27 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:13:27 INFO - 'talos_options': ['--disable-stylo', 18:13:27 INFO - '--xperf_path', 18:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:13:27 INFO - 'tests': ['tp5n']}}} 18:13:27 INFO - Running post-action listener: _resource_record_post_action 18:13:27 INFO - [mozharness: 2017-10-13 01:13:27.783837Z] Finished populate-webroot step (success) 18:13:27 INFO - [mozharness: 2017-10-13 01:13:27.783927Z] Running create-virtualenv step. 18:13:27 INFO - Running pre-action listener: _resource_record_pre_action 18:13:27 INFO - Running main action method: create_virtualenv 18:13:27 INFO - Creating virtualenv /builds/slave/test/build/venv 18:13:27 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:13:27 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 18:13:27 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:13:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:13:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:13:29 INFO - Installing distribute.............................................................................................................................................................................................done. 18:13:29 INFO - Installing pip...............done. 18:13:29 INFO - Return code: 0 18:13:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:13:29 INFO - Reading from file tmpfile_stdout 18:13:29 INFO - Output received: 18:13:29 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 18:13:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:13: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')]} 18:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13: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')]} 18:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:29 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc090>, '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 0x18dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d6f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', '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 18:13:29 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 18:13:29 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 18:13:29 INFO - Using env: {'DISPLAY': ':0', 18:13:29 INFO - 'HOME': '/home/cltbld', 18:13:29 INFO - 'LANG': 'en_US.UTF-8', 18:13:29 INFO - 'LANGUAGE': 'en_US:en', 18:13:29 INFO - 'LOGNAME': 'cltbld', 18:13:29 INFO - 'MAIL': '/var/mail/cltbld', 18:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:29 INFO - 'MOZ_NO_REMOTE': '1', 18:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:29 INFO - 'NO_EM_RESTART': '1', 18:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:29 INFO - 'PWD': '/builds/slave/test', 18:13:29 INFO - 'SHELL': '/bin/bash', 18:13:29 INFO - 'SHLVL': '1', 18:13:29 INFO - 'TERM': 'linux', 18:13:29 INFO - 'TMOUT': '86400', 18:13:29 INFO - 'USER': 'cltbld', 18:13:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', 18:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:29 INFO - '_': '/tools/buildbot/bin/python'} 18:13:30 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:13:30 INFO - Downloading/unpacking pip>=1.5 18:13:30 INFO - Running setup.py egg_info for package pip 18:13:30 INFO - warning: no files found matching 'pip/cacert.pem' 18:13:30 INFO - warning: no files found matching '*.html' under directory 'docs' 18:13:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:13:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:13:30 INFO - Installing collected packages: pip 18:13:30 INFO - Found existing installation: pip 1.1 18:13:30 INFO - Uninstalling pip: 18:13:30 INFO - Successfully uninstalled pip 18:13:30 INFO - Running setup.py install for pip 18:13:30 INFO - warning: no files found matching 'pip/cacert.pem' 18:13:30 INFO - warning: no files found matching '*.html' under directory 'docs' 18:13:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:13:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:13:30 INFO - Installing pip script to /builds/slave/test/build/venv/bin 18:13:30 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 18:13:30 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 18:13:30 INFO - Successfully installed pip 18:13:30 INFO - Cleaning up... 18:13:30 INFO - Return code: 0 18:13:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc090>, '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 0x18dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d6f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', '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 18:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:13:30 INFO - Using env: {'DISPLAY': ':0', 18:13:30 INFO - 'HOME': '/home/cltbld', 18:13:30 INFO - 'LANG': 'en_US.UTF-8', 18:13:30 INFO - 'LANGUAGE': 'en_US:en', 18:13:30 INFO - 'LOGNAME': 'cltbld', 18:13:30 INFO - 'MAIL': '/var/mail/cltbld', 18:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:30 INFO - 'MOZ_NO_REMOTE': '1', 18:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:30 INFO - 'NO_EM_RESTART': '1', 18:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:30 INFO - 'PWD': '/builds/slave/test', 18:13:30 INFO - 'SHELL': '/bin/bash', 18:13:30 INFO - 'SHLVL': '1', 18:13:30 INFO - 'TERM': 'linux', 18:13:30 INFO - 'TMOUT': '86400', 18:13:30 INFO - 'USER': 'cltbld', 18:13:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', 18:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:30 INFO - '_': '/tools/buildbot/bin/python'} 18:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:30 INFO - Downloading/unpacking psutil>=3.1.1 18:13:30 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 18:13:30 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 18:13:30 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 18:13:30 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 18:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:13:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:13:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:13:32 INFO - Installing collected packages: psutil 18:13:32 INFO - Running setup.py install for psutil 18:13:32 INFO - building 'psutil._psutil_linux' extension 18:13:32 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 18:13:34 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 18:13:35 INFO - building 'psutil._psutil_posix' extension 18:13:35 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 18:13:35 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 18:13:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:13:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:13:35 INFO - Successfully installed psutil 18:13:35 INFO - Cleaning up... 18:13:35 INFO - Return code: 0 18:13:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:13:35 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')]} 18:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:35 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')]} 18:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:35 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc090>, '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 0x18dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d6f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', '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 18:13:35 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 18:13:35 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 18:13:35 INFO - Using env: {'DISPLAY': ':0', 18:13:35 INFO - 'HOME': '/home/cltbld', 18:13:35 INFO - 'LANG': 'en_US.UTF-8', 18:13:35 INFO - 'LANGUAGE': 'en_US:en', 18:13:35 INFO - 'LOGNAME': 'cltbld', 18:13:35 INFO - 'MAIL': '/var/mail/cltbld', 18:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:35 INFO - 'MOZ_NO_REMOTE': '1', 18:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:35 INFO - 'NO_EM_RESTART': '1', 18:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:35 INFO - 'PWD': '/builds/slave/test', 18:13:35 INFO - 'SHELL': '/bin/bash', 18:13:35 INFO - 'SHLVL': '1', 18:13:35 INFO - 'TERM': 'linux', 18:13:35 INFO - 'TMOUT': '86400', 18:13:35 INFO - 'USER': 'cltbld', 18:13:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', 18:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:35 INFO - '_': '/tools/buildbot/bin/python'} 18:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:13:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:13:36 INFO - Installing collected packages: mozsystemmonitor 18:13:36 INFO - Running setup.py install for mozsystemmonitor 18:13:36 INFO - Successfully installed mozsystemmonitor 18:13:36 INFO - Cleaning up... 18:13:36 INFO - Return code: 0 18:13:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:36 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc090>, '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 0x18dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d6f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', '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 18:13:36 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 18:13:36 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 18:13:36 INFO - Using env: {'DISPLAY': ':0', 18:13:36 INFO - 'HOME': '/home/cltbld', 18:13:36 INFO - 'LANG': 'en_US.UTF-8', 18:13:36 INFO - 'LANGUAGE': 'en_US:en', 18:13:36 INFO - 'LOGNAME': 'cltbld', 18:13:36 INFO - 'MAIL': '/var/mail/cltbld', 18:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:36 INFO - 'MOZ_NO_REMOTE': '1', 18:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:36 INFO - 'NO_EM_RESTART': '1', 18:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:36 INFO - 'PWD': '/builds/slave/test', 18:13:36 INFO - 'SHELL': '/bin/bash', 18:13:36 INFO - 'SHLVL': '1', 18:13:36 INFO - 'TERM': 'linux', 18:13:36 INFO - 'TMOUT': '86400', 18:13:36 INFO - 'USER': 'cltbld', 18:13:36 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', 18:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:36 INFO - '_': '/tools/buildbot/bin/python'} 18:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:37 INFO - Downloading/unpacking jsonschema==2.5.1 18:13:37 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 18:13:37 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 18:13:37 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 18:13:37 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 18:13:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:13:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:13:38 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 18:13:38 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 18:13:38 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 18:13:38 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 18:13:38 INFO - Downloading functools32-3.2.3-2.tar.gz 18:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:13:38 INFO - warning: no files found matching '*.txt' 18:13:38 INFO - no previously-included directories found matching 'build' 18:13:38 INFO - no previously-included directories found matching 'dist' 18:13:38 INFO - no previously-included directories found matching '.git*' 18:13:38 INFO - Installing collected packages: jsonschema, functools32 18:13:38 INFO - Running setup.py install for functools32 18:13:38 INFO - warning: no files found matching '*.txt' 18:13:38 INFO - no previously-included directories found matching 'build' 18:13:38 INFO - no previously-included directories found matching 'dist' 18:13:38 INFO - no previously-included directories found matching '.git*' 18:13:38 INFO - Successfully installed jsonschema functools32 18:13:38 INFO - Cleaning up... 18:13:38 INFO - Return code: 0 18:13:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:38 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc090>, '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 0x18dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d6f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', '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 18:13:38 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 18:13:38 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 18:13:38 INFO - Using env: {'DISPLAY': ':0', 18:13:38 INFO - 'HOME': '/home/cltbld', 18:13:38 INFO - 'LANG': 'en_US.UTF-8', 18:13:38 INFO - 'LANGUAGE': 'en_US:en', 18:13:38 INFO - 'LOGNAME': 'cltbld', 18:13:38 INFO - 'MAIL': '/var/mail/cltbld', 18:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:38 INFO - 'MOZ_NO_REMOTE': '1', 18:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:38 INFO - 'NO_EM_RESTART': '1', 18:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:38 INFO - 'PWD': '/builds/slave/test', 18:13:38 INFO - 'SHELL': '/bin/bash', 18:13:38 INFO - 'SHLVL': '1', 18:13:38 INFO - 'TERM': 'linux', 18:13:38 INFO - 'TMOUT': '86400', 18:13:38 INFO - 'USER': 'cltbld', 18:13:38 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', 18:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:38 INFO - '_': '/tools/buildbot/bin/python'} 18:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:13:38 INFO - Cleaning up... 18:13:38 INFO - Return code: 0 18:13:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:38 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc090>, '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 0x18dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d6f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', '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 18:13:38 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 18:13:38 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 18:13:38 INFO - Using env: {'DISPLAY': ':0', 18:13:38 INFO - 'HOME': '/home/cltbld', 18:13:38 INFO - 'LANG': 'en_US.UTF-8', 18:13:38 INFO - 'LANGUAGE': 'en_US:en', 18:13:38 INFO - 'LOGNAME': 'cltbld', 18:13:38 INFO - 'MAIL': '/var/mail/cltbld', 18:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:38 INFO - 'MOZ_NO_REMOTE': '1', 18:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:38 INFO - 'NO_EM_RESTART': '1', 18:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:38 INFO - 'PWD': '/builds/slave/test', 18:13:38 INFO - 'SHELL': '/bin/bash', 18:13:38 INFO - 'SHLVL': '1', 18:13:38 INFO - 'TERM': 'linux', 18:13:38 INFO - 'TMOUT': '86400', 18:13:38 INFO - 'USER': 'cltbld', 18:13:38 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', 18:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:38 INFO - '_': '/tools/buildbot/bin/python'} 18:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:38 INFO - Downloading/unpacking blobuploader==1.2.4 18:13:38 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 18:13:38 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 18:13:38 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 18:13:38 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 18:13:40 INFO - Downloading blobuploader-1.2.4.tar.gz 18:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:13:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:13:40 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 18:13:40 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 18:13:40 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 18:13:40 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 18:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:13:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:13:40 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 18:13:40 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 18:13:40 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 18:13:40 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 18:13:40 INFO - Downloading docopt-0.6.1.tar.gz 18:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:13:40 INFO - Installing collected packages: blobuploader, requests, docopt 18:13:40 INFO - Running setup.py install for blobuploader 18:13:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:13:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:13:40 INFO - Running setup.py install for requests 18:13:41 INFO - Running setup.py install for docopt 18:13:41 INFO - Successfully installed blobuploader requests docopt 18:13:41 INFO - Cleaning up... 18:13:41 INFO - Return code: 0 18:13:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:13:41 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')]} 18:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:41 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')]} 18:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:41 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc090>, '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 0x18dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d6f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', '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 18:13:41 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 18:13:41 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 18:13:41 INFO - Using env: {'DISPLAY': ':0', 18:13:41 INFO - 'HOME': '/home/cltbld', 18:13:41 INFO - 'LANG': 'en_US.UTF-8', 18:13:41 INFO - 'LANGUAGE': 'en_US:en', 18:13:41 INFO - 'LOGNAME': 'cltbld', 18:13:41 INFO - 'MAIL': '/var/mail/cltbld', 18:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:41 INFO - 'MOZ_NO_REMOTE': '1', 18:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:41 INFO - 'NO_EM_RESTART': '1', 18:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:41 INFO - 'PWD': '/builds/slave/test', 18:13:41 INFO - 'SHELL': '/bin/bash', 18:13:41 INFO - 'SHLVL': '1', 18:13:41 INFO - 'TERM': 'linux', 18:13:41 INFO - 'TMOUT': '86400', 18:13:41 INFO - 'USER': 'cltbld', 18:13:41 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', 18:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:41 INFO - '_': '/tools/buildbot/bin/python'} 18:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:13:41 INFO - Running setup.py (path:/tmp/pip-Qzex6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:13:41 INFO - Running setup.py (path:/tmp/pip-DOIE9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:13:41 INFO - Running setup.py (path:/tmp/pip-DmuB32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:13:41 INFO - Running setup.py (path:/tmp/pip-Sp5x_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:13:41 INFO - Running setup.py (path:/tmp/pip-P29iUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:13:41 INFO - Running setup.py (path:/tmp/pip-nIk_WC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:13:41 INFO - Running setup.py (path:/tmp/pip-LS9Obf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:13:42 INFO - Running setup.py (path:/tmp/pip-uSQQHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:13:42 INFO - Running setup.py (path:/tmp/pip-rB_jRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:13:42 INFO - Running setup.py (path:/tmp/pip-5Bbq6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:13:42 INFO - Running setup.py (path:/tmp/pip-9x4uV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:13:42 INFO - Running setup.py (path:/tmp/pip-_xjQ57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:13:42 INFO - Running setup.py (path:/tmp/pip-1yhcDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:13:42 INFO - Running setup.py (path:/tmp/pip-skjc5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:13:42 INFO - Running setup.py (path:/tmp/pip-qd8UDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:13:42 INFO - Running setup.py (path:/tmp/pip-O5z4xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:13:42 INFO - Running setup.py (path:/tmp/pip-vswSiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:13:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:13:42 INFO - Running setup.py install for manifestparser 18:13:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:13:42 INFO - Running setup.py install for mozcrash 18:13:42 INFO - Running setup.py install for mozdebug 18:13:43 INFO - Running setup.py install for mozdevice 18:13:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:13:43 INFO - Running setup.py install for mozfile 18:13:43 INFO - Running setup.py install for mozhttpd 18:13:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:13:43 INFO - Running setup.py install for mozinfo 18:13:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:13:43 INFO - Running setup.py install for mozInstall 18:13:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:13:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:13:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:13:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:13:43 INFO - Running setup.py install for mozleak 18:13:43 INFO - Running setup.py install for mozlog 18:13:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:13:43 INFO - Running setup.py install for moznetwork 18:13:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:13:43 INFO - Running setup.py install for mozprocess 18:13:43 INFO - Running setup.py install for mozprofile 18:13:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:13:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:13:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:13:44 INFO - Running setup.py install for mozrunner 18:13:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:13:44 INFO - Running setup.py install for mozscreenshot 18:13:44 INFO - Running setup.py install for moztest 18:13:44 INFO - Running setup.py install for mozversion 18:13:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:13:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:13:44 INFO - Cleaning up... 18:13:44 INFO - Return code: 0 18:13:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:13:44 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')]} 18:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:44 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')]} 18:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:44 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc090>, '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 0x18dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d6f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', '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 18:13:44 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 18:13:44 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 18:13:44 INFO - Using env: {'DISPLAY': ':0', 18:13:44 INFO - 'HOME': '/home/cltbld', 18:13:44 INFO - 'LANG': 'en_US.UTF-8', 18:13:44 INFO - 'LANGUAGE': 'en_US:en', 18:13:44 INFO - 'LOGNAME': 'cltbld', 18:13:44 INFO - 'MAIL': '/var/mail/cltbld', 18:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:44 INFO - 'MOZ_NO_REMOTE': '1', 18:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:44 INFO - 'NO_EM_RESTART': '1', 18:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:44 INFO - 'PWD': '/builds/slave/test', 18:13:44 INFO - 'SHELL': '/bin/bash', 18:13:44 INFO - 'SHLVL': '1', 18:13:44 INFO - 'TERM': 'linux', 18:13:44 INFO - 'TMOUT': '86400', 18:13:44 INFO - 'USER': 'cltbld', 18:13:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', 18:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:44 INFO - '_': '/tools/buildbot/bin/python'} 18:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:13:44 INFO - Running setup.py (path:/tmp/pip-N56kjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:13:44 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)) 18:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:13:44 INFO - Running setup.py (path:/tmp/pip-CW31w9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:13:44 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)) 18:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:13:44 INFO - Running setup.py (path:/tmp/pip-JYjuco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:13:44 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)) 18:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:13:44 INFO - Running setup.py (path:/tmp/pip-qWrIU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:13:45 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)) 18:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:13:45 INFO - Running setup.py (path:/tmp/pip-LlktlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:13:45 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)) 18:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:13:45 INFO - Running setup.py (path:/tmp/pip-wHZvys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:13:45 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)) 18:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:13:45 INFO - Running setup.py (path:/tmp/pip-WWj0Kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:13:45 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)) 18:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:13:45 INFO - Running setup.py (path:/tmp/pip-cXKmok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:13:45 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)) 18:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:13:45 INFO - Running setup.py (path:/tmp/pip-nQku0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:13:45 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)) 18:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:13:45 INFO - Running setup.py (path:/tmp/pip-XDXwC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:13:45 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)) 18:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:13:45 INFO - Running setup.py (path:/tmp/pip-wpgKpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:13:45 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)) 18:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:13:45 INFO - Running setup.py (path:/tmp/pip-W_tUmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:13:45 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)) 18:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:13:45 INFO - Running setup.py (path:/tmp/pip-oDT8Na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:13:45 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)) 18:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:13:45 INFO - Running setup.py (path:/tmp/pip-BbEiDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:13:45 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)) 18:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:13:45 INFO - Running setup.py (path:/tmp/pip-PbeEq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:13:45 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)) 18:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:13:45 INFO - Running setup.py (path:/tmp/pip-k2KbL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:13:45 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)) 18:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:13:45 INFO - Running setup.py (path:/tmp/pip-ux8fB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:13:45 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)) 18:13:45 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)) 18:13:45 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)) 18:13:45 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)) 18:13:45 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)) 18:13:45 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)) 18:13:45 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)) 18:13:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:13:45 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 18:13:45 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 18:13:45 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 18:13:45 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 18:13:47 INFO - Downloading blessings-1.6.tar.gz 18:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:13:47 INFO - Installing collected packages: blessings 18:13:47 INFO - Running setup.py install for blessings 18:13:47 INFO - Successfully installed blessings 18:13:47 INFO - Cleaning up... 18:13:47 INFO - Return code: 0 18:13:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:13:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:13:47 INFO - Reading from file tmpfile_stdout 18:13:47 INFO - Current package versions: 18:13:47 INFO - argparse == 1.2.1 18:13:47 INFO - blessings == 1.6 18:13:47 INFO - blobuploader == 1.2.4 18:13:47 INFO - docopt == 0.6.1 18:13:47 INFO - functools32 == 3.2.3-2 18:13:47 INFO - jsonschema == 2.5.1 18:13:47 INFO - manifestparser == 1.1 18:13:47 INFO - mozInstall == 1.13 18:13:47 INFO - mozcrash == 1.0 18:13:47 INFO - mozdebug == 0.1 18:13:47 INFO - mozdevice == 0.51 18:13:47 INFO - mozfile == 1.2 18:13:47 INFO - mozhttpd == 0.7 18:13:47 INFO - mozinfo == 0.10 18:13:47 INFO - mozleak == 0.1 18:13:47 INFO - mozlog == 3.5 18:13:47 INFO - moznetwork == 0.27 18:13:47 INFO - mozprocess == 0.25 18:13:47 INFO - mozprofile == 0.28 18:13:47 INFO - mozrunner == 6.13 18:13:47 INFO - mozscreenshot == 0.1 18:13:47 INFO - mozsystemmonitor == 0.3 18:13:47 INFO - moztest == 0.8 18:13:47 INFO - mozversion == 1.4 18:13:47 INFO - psutil == 3.1.1 18:13:47 INFO - requests == 1.2.3 18:13:47 INFO - wsgiref == 0.1.2 18:13:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:13:47 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')]} 18:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:47 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')]} 18:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:47 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc090>, '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 0x18dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d6f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', '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 18:13:47 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 18:13:47 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 18:13:47 INFO - Using env: {'DISPLAY': ':0', 18:13:47 INFO - 'HOME': '/home/cltbld', 18:13:47 INFO - 'LANG': 'en_US.UTF-8', 18:13:47 INFO - 'LANGUAGE': 'en_US:en', 18:13:47 INFO - 'LOGNAME': 'cltbld', 18:13:47 INFO - 'MAIL': '/var/mail/cltbld', 18:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:47 INFO - 'MOZ_NO_REMOTE': '1', 18:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:47 INFO - 'NO_EM_RESTART': '1', 18:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:47 INFO - 'PWD': '/builds/slave/test', 18:13:47 INFO - 'SHELL': '/bin/bash', 18:13:47 INFO - 'SHLVL': '1', 18:13:47 INFO - 'TERM': 'linux', 18:13:47 INFO - 'TMOUT': '86400', 18:13:47 INFO - 'USER': 'cltbld', 18:13:47 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', 18:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:47 INFO - '_': '/tools/buildbot/bin/python'} 18:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:47 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)) 18:13:47 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)) 18:13:47 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)) 18:13:47 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)) 18:13:47 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)) 18:13:47 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)) 18:13:47 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)) 18:13:47 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)) 18:13:47 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)) 18:13:47 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:13:48 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)) 18:13:48 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)) 18:13:48 INFO - Installing collected packages: simplejson 18:13:48 INFO - Running setup.py install for simplejson 18:13:49 INFO - building 'simplejson._speedups' extension 18:13:49 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 18:13:49 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 18:13:49 INFO - Successfully installed simplejson 18:13:49 INFO - Cleaning up... 18:13:49 INFO - Return code: 0 18:13:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:13: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')]} 18:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13: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')]} 18:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc090>, '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 0x18dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d6f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', '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 18:13: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', 'jsonschema'] in /builds/slave/test/build 18:13: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 jsonschema 18:13:49 INFO - Using env: {'DISPLAY': ':0', 18:13:49 INFO - 'HOME': '/home/cltbld', 18:13:49 INFO - 'LANG': 'en_US.UTF-8', 18:13:49 INFO - 'LANGUAGE': 'en_US:en', 18:13:49 INFO - 'LOGNAME': 'cltbld', 18:13:49 INFO - 'MAIL': '/var/mail/cltbld', 18:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:49 INFO - 'MOZ_NO_REMOTE': '1', 18:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:49 INFO - 'NO_EM_RESTART': '1', 18:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:49 INFO - 'PWD': '/builds/slave/test', 18:13:49 INFO - 'SHELL': '/bin/bash', 18:13:49 INFO - 'SHLVL': '1', 18:13:49 INFO - 'TERM': 'linux', 18:13:49 INFO - 'TMOUT': '86400', 18:13:49 INFO - 'USER': 'cltbld', 18:13:49 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', 18:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:49 INFO - '_': '/tools/buildbot/bin/python'} 18:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:13:50 INFO - Cleaning up... 18:13:50 INFO - Return code: 0 18:13:50 INFO - Running post-action listener: _resource_record_post_action 18:13:50 INFO - Running post-action listener: _start_resource_monitoring 18:13:50 INFO - Starting resource monitoring. 18:13:50 INFO - [mozharness: 2017-10-13 01:13:50.235745Z] Finished create-virtualenv step (success) 18:13:50 INFO - [mozharness: 2017-10-13 01:13:50.236694Z] Running install step. 18:13:50 INFO - Running pre-action listener: _resource_record_pre_action 18:13:50 INFO - Running main action method: install 18:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:13:50 INFO - Reading from file tmpfile_stdout 18:13:50 INFO - Detecting whether we're running mozinstall >=1.0... 18:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:13:50 INFO - Reading from file tmpfile_stdout 18:13:50 INFO - Output received: 18:13:50 INFO - Usage: mozinstall [options] installer 18:13:50 INFO - Options: 18:13:50 INFO - -h, --help show this help message and exit 18:13:50 INFO - -d DEST, --destination=DEST 18:13:50 INFO - Directory to install application into. [default: 18:13:50 INFO - "/builds/slave/test"] 18:13:50 INFO - --app=APP Application being installed. [default: firefox] 18:13:50 INFO - mkdir: /builds/slave/test/build/application 18:13:50 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'] 18:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:14:05 INFO - Reading from file tmpfile_stdout 18:14:05 INFO - Output received: 18:14:05 INFO - /builds/slave/test/build/application/firefox/firefox 18:14:05 INFO - Running post-action listener: _resource_record_post_action 18:14:05 INFO - [mozharness: 2017-10-13 01:14:05.210645Z] Finished install step (success) 18:14:05 INFO - [mozharness: 2017-10-13 01:14:05.210789Z] Running setup-mitmproxy step. 18:14:05 INFO - Running pre-action listener: _resource_record_pre_action 18:14:05 INFO - Running main action method: setup_mitmproxy 18:14:05 INFO - Skipping: mitmproxy is not required 18:14:05 INFO - Running post-action listener: _resource_record_post_action 18:14:05 INFO - [mozharness: 2017-10-13 01:14:05.212265Z] Finished setup-mitmproxy step (success) 18:14:05 INFO - [mozharness: 2017-10-13 01:14:05.212575Z] Running run-tests step. 18:14:05 INFO - Running pre-action listener: _resource_record_pre_action 18:14:05 INFO - Running pre-action listener: _set_gcov_prefix 18:14:05 INFO - Running main action method: run_tests 18:14:05 WARNING - Try message not found. 18:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:14:05 INFO - Python 2.7.3 18:14:05 INFO - Return code: 0 18:14:05 INFO - grabbing minidump binary from tooltool 18:14: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')]} 18:14:05 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 0x18dc090>, '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 0x18dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d6f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:14:05 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 18:14:05 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 18:14:05 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 18:14:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:14:05 INFO - Return code: 0 18:14:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:14:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:14:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:14:05 INFO - ENV: RUST_BACKTRACE is now full 18:14:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:14:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:14:05 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/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 18:14:05 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/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 18:14:05 INFO - Using env: {'DISPLAY': ':0', 18:14:05 INFO - 'HOME': '/home/cltbld', 18:14:05 INFO - 'LANG': 'en_US.UTF-8', 18:14:05 INFO - 'LANGUAGE': 'en_US:en', 18:14:05 INFO - 'LOGNAME': 'cltbld', 18:14:05 INFO - 'MAIL': '/var/mail/cltbld', 18:14:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:14:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:05 INFO - 'MOZ_NO_REMOTE': '1', 18:14:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:05 INFO - 'NO_EM_RESTART': '1', 18:14:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:05 INFO - 'PWD': '/builds/slave/test', 18:14:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:14:05 INFO - 'RUST_BACKTRACE': 'full', 18:14:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:14:05 INFO - 'SHELL': '/bin/bash', 18:14:05 INFO - 'SHLVL': '1', 18:14:05 INFO - 'TERM': 'linux', 18:14:05 INFO - 'TMOUT': '86400', 18:14:05 INFO - 'USER': 'cltbld', 18:14:05 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', 18:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:05 INFO - '_': '/tools/buildbot/bin/python'} 18:14:05 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/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 18:14:05 INFO - mozversion application_buildid: 20171012235916 18:14:05 INFO - mozversion application_changeset: c50a31492fe7fe38a75c8b4722f24685ba7dac03 18:14:05 INFO - mozversion application_display_name: Firefox 18:14:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:14:05 INFO - mozversion application_name: Firefox 18:14:05 INFO - mozversion application_remotingname: firefox 18:14:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:14:05 INFO - mozversion application_vendor: Mozilla 18:14:05 INFO - mozversion application_version: 57.0 18:14:05 INFO - mozversion platform_buildid: 20171012235916 18:14:05 INFO - mozversion platform_changeset: c50a31492fe7fe38a75c8b4722f24685ba7dac03 18:14:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:14:05 INFO - mozversion platform_version: 57.0 18:14:05 INFO - using testdate: 1507857245 18:14:05 INFO - actual date: 1507857245 18:14:05 INFO - starting webserver on 'localhost:52793' 18:14:05 INFO - SUITE-START | Running 2 tests 18:14:05 INFO - TEST-START | dromaeo_css 18:14:05 INFO - Initialising browser for dromaeo_css test... 18:14:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52793/getInfo.html -profile /tmp/tmpPDFNpU/profile 18:14:05 INFO - TEST-INFO | started process 3679 (/builds/slave/test/build/application/firefox/firefox http://localhost:52793/getInfo.html) 18:14:15 INFO - TEST-INFO | 3679: exit 0 18:14:15 INFO - Browser initialized. 18:14:15 INFO - Running cycle 1/1 for dromaeo_css test... 18:14:15 INFO - Using env: {'DISPLAY': ':0', 18:14:15 INFO - 'HOME': '/home/cltbld', 18:14:15 INFO - 'JSGC_DISABLE_POISONING': '1', 18:14:15 INFO - 'LANG': 'en_US.UTF-8', 18:14:15 INFO - 'LANGUAGE': 'en_US:en', 18:14:15 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:14:15 INFO - 'LOGNAME': 'cltbld', 18:14:15 INFO - 'MAIL': '/var/mail/cltbld', 18:14:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:14:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:14:15 INFO - 'MOZ_CRASHREPORTER': '1', 18:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:15 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:14:15 INFO - 'MOZ_NO_REMOTE': '1', 18:14:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:15 INFO - 'NO_EM_RESTART': '1', 18:14:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:15 INFO - 'PWD': '/builds/slave/test', 18:14:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:14:15 INFO - 'RUST_BACKTRACE': 'full', 18:14:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:14:15 INFO - 'SHELL': '/bin/bash', 18:14:15 INFO - 'SHLVL': '1', 18:14:15 INFO - 'TERM': 'linux', 18:14:15 INFO - 'TMOUT': '86400', 18:14:15 INFO - 'USER': 'cltbld', 18:14:15 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', 18:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:15 INFO - '_': '/tools/buildbot/bin/python'} 18:14:15 INFO - TEST-INFO | started process 3914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPDFNpU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:14:16 INFO - PID 3914 | 18:14:16 INFO - PID 3914 | (/builds/slave/test/build/application/firefox/firefox:3963): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:14:16 INFO - PID 3914 | 18:14:26 INFO - PID 3914 | RSS: Main: 141500416 18:14:26 INFO - PID 3914 | 18:17:24 INFO - PID 3914 | Cycle 1(1): loaded http://localhost:52793/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52793/tests/dromaeo/cssquery-ext.html) 18:17:24 INFO - PID 3914 | RSS: Main: 145104896 18:17:24 INFO - PID 3914 | 18:20:26 INFO - PID 3914 | Cycle 1(1): loaded http://localhost:52793/tests/dromaeo/cssquery-ext.html (next: http://localhost:52793/tests/dromaeo/cssquery-jquery.html) 18:20:27 INFO - PID 3914 | RSS: Main: 142426112 18:20:27 INFO - PID 3914 | 18:23:28 INFO - PID 3914 | Cycle 1(1): loaded http://localhost:52793/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52793/tests/dromaeo/cssquery-mootools.html) 18:23:29 INFO - PID 3914 | RSS: Main: 145158144 18:23:29 INFO - PID 3914 | 18:26:30 INFO - PID 3914 | Cycle 1(1): loaded http://localhost:52793/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52793/tests/dromaeo/cssquery-prototype.html) 18:26:31 INFO - PID 3914 | RSS: Main: 144687104 18:26:31 INFO - PID 3914 | 18:29:34 INFO - PID 3914 | Cycle 1(1): loaded http://localhost:52793/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52793/tests/dromaeo/cssquery-yui.html) 18:29:34 INFO - PID 3914 | RSS: Main: 146014208 18:29:34 INFO - PID 3914 | 18:32:36 INFO - PID 3914 | Cycle 1(1): loaded http://localhost:52793/tests/dromaeo/cssquery-yui.html (next: http://localhost:52793/tests/dromaeo/cssquery-dojo.html) 18:32:36 INFO - PID 3914 | RSS: Main: 149078016 18:32:36 INFO - PID 3914 | 18:32:36 INFO - PID 3914 | __start_tp_report 18:32:36 INFO - PID 3914 | _x_x_mozilla_page_load 18:32:36 INFO - PID 3914 | _x_x_mozilla_page_load_details 18:32:36 INFO - PID 3914 | |i|pagename|runs| 18:32:36 INFO - PID 3914 | |0;dojo.html;3966.345552983758;4010.9398359024617;4050.432939388484;4053.1083161704432;4063.83744650214;6372.1079048933125;6443.130177426057;6478.773242936498;6560.179977502812;6561.77033803817;6377.42603165715;6394.136791533142;6478.676066196695;6481.31946145655;6503.4472069874;5778.393268706778;5791.942080579182;5852.590318677694;5876.70616469177;5944.227250457435;5769.913451298234;5813.825585232428;5831.766729330843;5831.854203644922;5851.444112809277;5828.737706803204;5881.529477641779;5905.320888097859;5923.17075609415;5930.703464826763;5779.624324418899;5834.5915785895;5854.174040048064;5952.821415357546;5961.195238642771;5692.487676109128;5785.942140578582;5823.708814559297;5825.621334613236;5849.649021058707;6407.231132264112;6415.326390728999;6458.870822583569;6463.321351258144;6468.3855033771715;7003.544769590011;7024.824379390505;7046.7181312747425;7114.964425177841;7144.857102857914;6963.79108626737;7034.8944765828555;7044.15470143586;7055.823604409879;7139.643017849139;6430.196225471816;6449.838754031187;6501.414872661483;6526.151600292027;6545.181852268466;7214.206437291894;7215.927840721631;7279.563226206445;7308.488405811649;7324.230955749569;6936.722531098801;6986.056882320821;7006.054182685272;7058;7101.360877521048;6941;7056.329648683367;7056.858862822714;7059.329363710439;7065.470089743187;6838.21360543534;6912;6929.099217101744;6978.546394484342;7011.123609548807;6959.686814093277;6960.825979350557;7037.683304251321;7049.577025378494;7056.894146587805;5094.821681241213;5104.132297509433;5129.153689641167;5172.069027575073;5177.792888284426;4667.696599721007;4691.882702932454;4701.553352431513;4736.786844591933;4753.191957367187;6568.244651865001;6579.901301480481;6590.209174899042;6654.633995130314;6660.300668429842;6990.196127445307;7020.613866237406;7022.12223472066;7108.609026503488;7111.6799744010605;6538.280789113193;6551.508636852255;6576.86846263072;6602.042703808017;6679.532432729759;5823.5341172706085;5890.3815099414805;5901.734421951022;5908.14331921869;5917.082852157922;7287.3441390274065;7310.853782924418;7338.4496162788;7384.96610474534;7450.403967682572;6886.10480637514;6924.4114250287275;6939.895901561582;6941.409980151744;6944.027836102849;7234.16807067173;7267.7819665410125;7429.925700742923;7441.55350678961;7445;6850.691718872563;6931.826704332432;7018.719251230098;7023.262557431396;7031.437485001085;6996.055532503047;7010.439164866696;7061.576305421691;7079.433645308466;7104.893426598708;6598.175228096488;6667.599944003376;6689.1972963244725;6829.385355318045;6831.077804496329;6780.016897549926;6781.11845460087;6792.592444453348;6879.484038697017;6885.9671049343;6682.565633233824;6702.899456508058;6705.631190284386;6762.932370676231;6791.083203767428;6744;6834.179898412222;6880.552764070319;6894.069300644349;6928.44572434194;6621.867562648624;6649.567778094409;6665.633390163587;6685;6703.625756719958 18:32:36 INFO - PID 3914 | |1;ext.html;879.815238799852;895.8790563273958;915.4919019943933;916.5921165081537;919.3840127114837;43815.12369752603;44649;44684;44788.77605611968;44907.77546112273;42017;45546;45816.770916145455;45927.31109033359;45941;8633.26617237534;8708.521031343274;8797.604107815163;8809.911900880974;8831.55842207887;8631.482111073356;8690.217880390763;8767.956160219223;8788.209061184492;8814.559272036404;8819.162179592928;8838.86741698875;8862.423942443753;8874.733757987271;8887.600057997406;8725.127487251288;8750.606222719929;8765;8791;8832.8675069874;8475.364347673949;8530.530820804854;8551.315894728406;8552.657893684245;8558.572071396406;41792.37311440331;42038.159236815096;42076;42188.3671744921;42207.788961055;3870.632289932452;3891.649751522348;3901.843926242947;3917.3536366499493;3918.1380096378753;34442.483362749575;34616.134596635035;34641.653583464344;34670.653293466996;34682.306353873035;5261.263423120766;5320.388155362144;5355.250264962909;5393.352797664266;5395.028894798935;247374;250136;250532.74733626397;255055;255565;52918.73540632349;53962.19056714152;54021.45978540243;54060.72969635126;54124.72937635365;57180.71409642925;57661.42338576561;57842.7107864458;57859.421405785404;57947.710261448425;18449.354272600664;18604.534886627942;18614.16236269371;18619.44141675752;18870.90564547196;15612.843871561367;15685.686286274211;15690.921545392428;15693.607659808367;15705.921470392575;14566.854331456761;14601.196934168724;14636.268186590627;14790.186539740418;14867.628309292355;5487.5609951203805;5513.5037846594;5535.25274087993;5600.775968961278;5626.606137570413;1097.2977294531506;1122.259308856151;1126.419893754717;1130.9547618095185;1137.7383201863618;26337;26356.60465093025;26361.868190658923;26478;26563;1229.4836168809122;1232.2729589542214;1240.7394447166196;1244.8692887246889;1252.1610520950985;13516.189028658311;13655.931720341334;13829.377678004514;13969.650758731113;14075.085119467201;302336;307505;310076;310505;316467;65142.674286628266;65509;65562.67218663971;65841.34158658353;65972.6805463888;1539.353471541955;1560.2354846125318;1565.1391734546182;1566.0368873142936;1566.1151449431036;31003.379932401676;31166.844165779024;31280.843595781877;31297.843510783212;31399.529007064455;43388.96277260561;43530.78234608807;43705.344419834364;44264.77867610641;44385.33421998737;257287;257323;258216;260376;261122;36216.275674485834;37328;37504.81247593745;37549;38216.235675286895;48698.51301487081;50249.49750502448;50561.24158137704;50893.74553127211;51026.48973510217;35683;35907.64092359043;36038.4594231092;36052.27895442024;36329.45505817468;35355;35974.28051439009;36033.459498107026;36375.45436818397;36868.26263474769;41530.37704434496;42592;42617.36073958831;42999.355009675506;43008.139837202456;34006.65993340134;34563.481547776304;34912.47631285583;35426.291474169855;36014.639853601126;26082.217533474028;26276.737232628195;26469.60295595529;26734.331641708333;26978.595321069806 18:32:36 INFO - PID 3914 | |2;jquery.html;637.6845354220653;642.376303451917;642.5844002382836;643.2439830293076;649.2417290747813;23574;24268.27195184143;24273;24295;24313.270601881948;26032.47935041298;26061.47877042458;26464.338391540223;26553.203403897915;26627.600585991226;6453.9354606454035;6767.323267673242;6818.6931588078405;6865.862682746342;6870.244273129952;6732.259451460335;6827.897581536281;6833.214180369247;6833.7949861503985;6840.247572767016;6702.865942681144;6742;6784.2876497967745;6986.650667466632;6997.440204783605;6989.545679530815;7017.193022802392;7026.754063607749;7044.260352662999;7050.153981522225;6520.7717729879705;6557.24591671959;6557.606543607351;6576.046473261398;6597.63712995785;29908.700912991026;30395.69604303973;30722.846385768153;30825;30930.072097836877;2361.244401791427;2403.375122468171;2414.4929564791414;2419.34677637037;2424.1273141668985;19624.41126766199;20301;20320.898395508077;20417.5916481671;20419.2853250137;2522.495500899809;2615.5161295160456;2631.355317947115;2640.155150351888;2690.313969937673;143684;148034;158282;162250.1887490567;163836;16097.034177949361;16724.080175590218;16882;16933.6453083753;17076.829231707772;26703.06539271155;26705.33236669099;26745.197644070708;26919.115661903477;26947.73052269452;10874.510647020903;10904.672859814218;11091.389973551371;11114.333140011626;11279.097672186206;9937.602495900082;9996.850047249298;10033;10041;10048.69853904384;9887.824678570703;9993;10141.2394070445;10188.388696678076;10322.741931451774;2978.1065680295824;3034.757219422441;3043.2087657209286;3046.284123231039;3104.4412005839167;1075.3386667199616;1094.3324572011068;1101.498818037791;1112.2603468693228;1112.8720197177267;21607.351779446642;21637.891810540845;21761.891190543945;21851.672224916638;21991.230306939182;1144.5765066925292;1148.1561052626314;1151.4357964597286;1152.1358980764426;1157.9015783658483;11708.297502149899;11856.525738970344;11986.64040078799;12022.398880055962;12116.273023618434;612869;613305;615851;622900;637544;127947;132943;133540;133754;134673;1139.9487023083982;1190.7499425120648;1261.3314943080181;1282.2562913510142;1318.723068155698;21836.23573174931;22411.767352795752;22618.190544756708;22683.432914177276;22795.31614051581;62596.374036259054;62784.68607656933;63059;63477.68261158665;64072.67963660152;81313;82153.58923205346;84777.57611211904;84806;85815.570922145;15839.841601583837;16116.838831612004;16176.110313932377;16215.189240538162;16233.67532649364;24066.87966560156;24424.87787561051;24427.38931526726;24488.387790305384;24722.876385617958;19093.522661933563;19376.515587110436;19482.220711171394;19497.220111195395;19504.31734889272;17463.30146794114;17607.559811004827;17633.294668213126;17719.911400442914;18081.728774068135;19879.602407951472;19958.700619490428;20277.391678249674;20409.183632654527;20644.17423303051;15708.057516549045;15889.52331430059;15913.68172636564;15949.681006379575;15974.201289935689;18962.0518974048;18971.525711857314;18976.71534927005;19238.711419329;19631.411057668294 18:32:36 INFO - PID 3914 | |3;mootools.html;1492.3806620252597;1524.961875953101;1543.6526781474176;1552.945646902358;1561.3910574875797;17595.38416155435;18340.541486462844;18352.08239588022;18365.816341836577;18367.357142499983;17746.733798992995;17832.55418614532;17946.55133621657;17954.730679039825;17975.550611234725;2869.34005178809;2934.1637633274413;2934.7212014858605;2944.0726171255988;2957.5859379686863;3084.8149111053294;3131.671174526676;3145.7011583899493;3160.194150491633;3163.746900247986;3041.817490950539;3158.0841555948746;3167.287360343927;3176.7935084219566;3176.8411579421054;2899.6955319691447;3109;3167.9841600791847;3175.3490534440616;3179.8728050878053;3009.292816188194;3077.4614442472703;3084.306031142975;3091.4744493435946;3094;17245.396411125676;17254.3960961367;17400;17401.47795566135;17437.912810435995;8672.13278672134;8885.733427997171;9109.362344635878;9148.725538233864;9227.769305767342;5583.441655834384;5714.085746280575;5838.941610583882;5906.438888305604;5933.703314834241;2096.9056392462376;2102.55846272283;2102.6635738281802;2150.0969592771075;2150.526884085514;31828.840855795803;31908.361832763447;32047.51928721071;32065.198370040704;32103;7462.403007759366;7593.240675932473;7605.543667379975;7736.845263094707;7769.067711874612;20575.38273851787;20759.68860467094;20760.48098797512;20768.169273229203;20785.58428831415;8888.911110888808;9002.639894404281;9042;9062.773430664154;9083.45499270046;8032.598370081472;8241;8267.586620668942;8320.167983201753;8359.164083591591;6111.266648002179;6129.80468808578;6155.630662160284;6166.445019948226;6189.81430557084;1614.6932082904211;1623.6590316033764;1760.084755926911;1765.3644687912342;1795.3877108806917;960.6253561111172;975.4439969217478;980.764616492051;1007.4459047523833;1008.0725732326277;8713.869291960626;8754.25588824957;8776.385653004356;8979.955100224457;9054.320925930582;1069.5080263079071;1077.7090185649831;1086.8206745886998;1094.9890501095047;1110.7389763405592;5197.714125723046;5244.842654720364;5352.223927530486;5356.544693701079;5488.780448782084;26604.201873943424;27300.453990920072;27622.171334859988;27701.30746731348;27742.72257277442;26033.349166270615;26721.86639066792;27386.589201161998;27452.450950980867;27503.17490475289;12800.103992720606;13006.869931300755;13096.083274170907;13181.209127452383;13349.46602135923;10458.563178654931;10482.437748357728;10546.894531054591;10633.149348052291;10650.414227217578;22320.906743127587;22725.772742273028;22745.317640470814;23062.884685576464;23321.883390582938;23669;23692.644610330513;23713.288601341297;23780.16769413062;24147.758522415254;13097.148685335424;13098.083134180515;13106.2136271824;13185.40665670028;13248.20510769357;16114.597135071717;16125.193740313172;16502.504924852274;16549.420770272984;16637.251323690703;13483.662908426975;13540.255285958972;13647.181169129884;13815.861841381458;13869.861301386856;12859;12902.419391127234;12942.482300707867;12952;12985.740285194432;11926.880731192925;11937.820932685843;12032.458539365574;12074.39628018613;12094.092943029133;8833.514156721441;8892.51091189965;8945.284377249935;8980.371374003757;9029.41308814925;8766.649334026568;8987.19115279628;8989.730308090768;9002.954985225031;9070.591823367833 18:32:36 INFO - PID 3914 | |4;prototype.html;579.8666306749449;581.7411251992864;596.9373215812337;607.9726412311445;615.4491729901736;6149.969250153748;6218.813435596933;6281.120643109957;6281.780137695182;6292.433680968712;6175.985609353922;6190.628562286255;6201.193844800169;6205.968970155143;6240.563160578761;5163.915577728672;5189.740512974355;5192.948070519285;5197.454267301936;5199.4800519948085;4906.9263961040615;5029;5148.304978827867;5156.381234251876;5186.870328241786;4979.825706100287;5032.220005899073;5052.115879721053;5054;5060.13977623803;4966.577840883548;4976.7013979161;4996.7008577769675;5024.171011783052;5037.848864534069;4513.210188217049;4607;4627.490975992638;4627.884302892421;4635.675502714811;6111.563782511106;6138.785142519991;6186.628802271833;6201.751929922798;6205.875882482325;5874.882502349972;5896.174535565025;5950.434708702666;5976.432238937294;5978.133170690269;6509.869802603968;6643.302453242388;6648.534602577822;6656.434203092743;6669.1330127083165;4830.758462076882;5108.131617625013;5130.9230361544605;5135.974320128413;5149.30484384607;6708.597484150918;6835.829104272383;6922.619255940921;6939.826504337381;6956.965215173892;5220.128929088986;5258.474152584788;5274.3670759509105;5289.418164001957;5291.417944026154;5278.709670968134;5301.54936830366;5302.655327403783;5332.9466705333225;5380.973095134499;5903.76384944606;5909.23179986599;5923.881522369615;5931.466168044896;5956.791512297135;6594.77996570636;6641.435477984329;6643.202815662152;6647.933520664828;6730.596164230162;1819.1353862290994;1832.9643751280485;1841.686913224755;1842.85257179428;1851.3705340184401;1264.3804535777588;1309.260267948606;1323.7749582570987;1335.7128217433299;1348.9055766096278;6120.265568131853;6145.298846382521;6265.780697675559;6277.5605707600025;6307.369263073748;6642.501812364092;6695.531312808154;6721.294264102199;6730.9326906731285;6774.27414921791;6302.684865756693;6303.495720342362;6318.988961766096;6353.491720662336;6358.713857876314;3543.8050907199836;3560.4481305397703;3568.4468907319406;3581.158427769472;3584.462330650423;7001.50989430735;7032.226455089936;7037.753678621224;7061.046758687511;7093.006979022941;6806.4554835613035;6869.007987683615;6892.345227203407;6918.827029324307;6944.791656250321;6934.826629334307;6947.40947019509;7026.43788496919;7026.891932420355;7059.788206353817;6518.967405162944;6639.800805975829;6671.933280667131;6688.3646053624825;6700.430463410665;6590.90113648286;6615;6644.966775166094;6645.534812563074;6648.135742353463;6917.757878474229;6921.342472465108;6937.930620693728;6951.304869513008;7009.441553832916;5146.9742651288;5148.845534633967;5170.7156106413;5194.610404219774;5205.323307969939;6498.512611554247;6568.653426047745;6653.866922661617;6738.831529211809;6744.460443164437;6416.454601358937;6444.838879027874;6558.409743123142;6631.469482441489;6633.402993730588;6425.228972523327;6445.843325339803;6540;6575.901361479678;6592.604443733391;6261.78083767066;6401.743930242738;6465.22417309907;6467.676616169267;6535.150430444012;6595.142631458071;6621.238557565942;6643.269240383457;6647;6666;6405.967970160119;6440.842317823394;6455.61266324022;6477.838054048687;6505.512086593619 18:32:36 INFO - PID 3914 | |5;yui.html;990.5839547390095;997.7156510394534;1022.7034160093573;1029.6447725534688;1029.7528593137645;23676.76323236767;24158.033678652853;24287.14994975176;24291.149809756662;24306.027758889646;22383.55232895341;22809.657855132187;23451.648225276633;23576.64635030476;23601.76398236017;1050.495762034224;1060.4379678770265;1061.883192848786;1062.3201151263197;1064.0902028765372;1043.2644985285394;1066.0565399621314;1075.714935542082;1076.8438576406415;1076.983845242322;1129.9378534180616;1135.5798354608764;1142.0749193153572;1142.3602782441817;1143.8684551276626;1131.7453572946063;1137.3687603380122;1144.34200334807;1144.6966553863233;1145.959891403801;844.6114787197896;845.3617518773349;846.3652260804397;846.5174850335311;851.3359579527978;20771.58456830855;21407.14371425141;21523.569528609496;21577;21643.134274628996;20469.8976505118;20807.375778726662;20951.895240523852;20983.685244721342;21022.894885525628;18946.810531894644;19025.33411330597;19067.427977160707;19095.427137185907;19118.426447206606;3842.8078596070086;3847.6729477994404;3923.097687531884;3933.744306620089;3944.704147188944;165405;166351;166437;168043.15978420153;168167.1591642046;17673.911630441766;18182.63634727298;18189.090545472674;18273.3604323848;18274.725879111826;28437.57343639847;29125.126246212647;33355.666443335744;34943.12642183966;35519.467207991904;9738.659146929824;10045.045720656526;10072.798544029078;10082.798344033079;10152.137068349126;4867.440244371872;4901.215805471179;4967.925481117786;4975.950240497621;4977.1538838397555;6108.480779133734;6239.844003899939;6243.906341404882;6252.718627661675;6274.403931626488;1240.1443004326986;1284.5760898903338;1290.4451086033096;1305.5691621764795;1309.4369421148806;746.9327760501473;763.4541302968404;764.5183534373309;767.0526899279386;778.2878666020528;12355.876441235652;12677.429515671816;12868.77746614089;12921.806172907414;12998.480060797652;733.1861633586715;734.9265073492608;744;761.4251240313528;765.6478020110811;6334.841628959339;6392.137061496732;6394.264659564116;6436.452901503331;6557.213134423804;145827;146373;146686.2665686686;147086;150226;129929;130008.3499582496;132549;136294;141466;115664;116717;117056.41471792587;117439.41280293715;119630;12214.938925305316;12230.388480576114;12245.693857653274;12536.091917401722;12561.246325220516;59791;59906.70046649739;60229.096563552455;60434.39565604288;61092;75905.24094758982;76355.61822191076;77860.22139778757;79429;79562.602186991;16685.49943501697;16708.74936875972;16796.160191990108;16853.915730421268;17001.319947201973;18458.26166953307;18498.352557660957;18661.253549857855;18676.43970680882;18690.439286821416;16277.348906043626;16593.585160370603;16622.833771662128;16733.079680617684;17239.482815515556;18173;18207.634427418263;18238.088095594903;18271.634567308844;18454.723179152592;17321.826781732023;17417.651646966737;17447;17453.912730436266;17480.30078796885;11589.826152607886;11747.353895535827;11996.160268781101;12275.140740148105;12299.69250768738;12200.81698774537;12459.93770031144;12519.31143787064;12604.810927835906;12682.682932926751 18:32:36 INFO - PID 3914 | __end_tp_report 18:32:36 INFO - PID 3914 | __start_cc_report 18:32:36 INFO - PID 3914 | _x_x_mozilla_cycle_collect,261 18:32:36 INFO - PID 3914 | __end_cc_report 18:32:36 INFO - PID 3914 | __startTimestamp1507858356440__endTimestamp 18:32:36 INFO - PID 3914 | 18:32:36 INFO - PID 3914 | ------- Summary: start ------- 18:32:36 INFO - PID 3914 | Number of tests: 6 18:32:36 INFO - PID 3914 | 18:32:36 INFO - PID 3914 | [#0] dojo.html Cycles:165 Average:6483.61 Median:6689.20 stddev:758.28 (11.3%) stddev-sans-first:734.44 18:32:36 INFO - PID 3914 | Values: 3966.3 4010.9 4050.4 4053.1 4063.8 6372.1 6443.1 6478.8 6560.2 6561.8 6377.4 6394.1 6478.7 6481.3 6503.4 5778.4 5791.9 5852.6 5876.7 5944.2 5769.9 5813.8 5831.8 5831.9 5851.4 5828.7 5881.5 5905.3 5923.2 5930.7 5779.6 5834.6 5854.2 5952.8 5961.2 5692.5 5785.9 5823.7 5825.6 5849.6 6407.2 6415.3 6458.9 6463.3 6468.4 7003.5 7024.8 7046.7 7115.0 7144.9 6963.8 7034.9 7044.2 7055.8 7139.6 6430.2 6449.8 6501.4 6526.2 6545.2 7214.2 7215.9 7279.6 7308.5 7324.2 6936.7 6986.1 7006.1 7058.0 7101.4 6941.0 7056.3 7056.9 7059.3 7065.5 6838.2 6912.0 6929.1 6978.5 7011.1 6959.7 6960.8 7037.7 7049.6 7056.9 5094.8 5104.1 5129.2 5172.1 5177.8 4667.7 4691.9 4701.6 4736.8 4753.2 6568.2 6579.9 6590.2 6654.6 6660.3 6990.2 7020.6 7022.1 7108.6 7111.7 6538.3 6551.5 6576.9 6602.0 6679.5 5823.5 5890.4 5901.7 5908.1 5917.1 7287.3 7310.9 7338.4 7385.0 7450.4 6886.1 6924.4 6939.9 6941.4 6944.0 7234.2 7267.8 7429.9 7441.6 7445.0 6850.7 6931.8 7018.7 7023.3 7031.4 6996.1 7010.4 7061.6 7079.4 7104.9 6598.2 6667.6 6689.2 6829.4 6831.1 6780.0 6781.1 6792.6 6879.5 6886.0 6682.6 6702.9 6705.6 6762.9 6791.1 6744.0 6834.2 6880.6 6894.1 6928.4 6621.9 6649.6 6665.6 6685.0 6703.6 18:32:36 INFO - PID 3914 | 18:32:36 INFO - PID 3914 | [#1] ext.html Cycles:180 Average:45966.65 Median:3881.14 stddev:71477.03 (1841.6%) stddev-sans-first:71597.37 18:32:36 INFO - PID 3914 | Values: 879.8 895.9 915.5 916.6 919.4 43815.1 44649.0 44684.0 44788.8 44907.8 42017.0 45546.0 45816.8 45927.3 45941.0 8633.3 8708.5 8797.6 8809.9 8831.6 8631.5 8690.2 8768.0 8788.2 8814.6 8819.2 8838.9 8862.4 8874.7 8887.6 8725.1 8750.6 8765.0 8791.0 8832.9 8475.4 8530.5 8551.3 8552.7 8558.6 41792.4 42038.2 42076.0 42188.4 42207.8 3870.6 3891.6 3901.8 3917.4 3918.1 34442.5 34616.1 34641.7 34670.7 34682.3 5261.3 5320.4 5355.3 5393.4 5395.0 247374.0 250136.0 250532.7 255055.0 255565.0 52918.7 53962.2 54021.5 54060.7 54124.7 57180.7 57661.4 57842.7 57859.4 57947.7 18449.4 18604.5 18614.2 18619.4 18870.9 15612.8 15685.7 15690.9 15693.6 15705.9 14566.9 14601.2 14636.3 14790.2 14867.6 5487.6 5513.5 5535.3 5600.8 5626.6 1097.3 1122.3 1126.4 1131.0 1137.7 26337.0 26356.6 26361.9 26478.0 26563.0 1229.5 1232.3 1240.7 1244.9 1252.2 13516.2 13655.9 13829.4 13969.7 14075.1 302336.0 307505.0 310076.0 310505.0 316467.0 65142.7 65509.0 65562.7 65841.3 65972.7 1539.4 1560.2 1565.1 1566.0 1566.1 31003.4 31166.8 31280.8 31297.8 31399.5 43389.0 43530.8 43705.3 44264.8 44385.3 257287.0 257323.0 258216.0 260376.0 261122.0 36216.3 37328.0 37504.8 37549.0 38216.2 48698.5 50249.5 50561.2 50893.7 51026.5 35683.0 35907.6 36038.5 36052.3 36329.5 35355.0 35974.3 36033.5 36375.5 36868.3 41530.4 42592.0 42617.4 42999.4 43008.1 34006.7 34563.5 34912.5 35426.3 36014.6 26082.2 26276.7 26469.6 26734.3 26978.6 18:32:36 INFO - PID 3914 | 18:32:36 INFO - PID 3914 | [#2] jquery.html Cycles:180 Average:40736.71 Median:23184.66 stddev:103837.84 (447.9%) stddev-sans-first:104085.48 18:32:36 INFO - PID 3914 | Values: 637.7 642.4 642.6 643.2 649.2 23574.0 24268.3 24273.0 24295.0 24313.3 26032.5 26061.5 26464.3 26553.2 26627.6 6453.9 6767.3 6818.7 6865.9 6870.2 6732.3 6827.9 6833.2 6833.8 6840.2 6702.9 6742.0 6784.3 6986.7 6997.4 6989.5 7017.2 7026.8 7044.3 7050.2 6520.8 6557.2 6557.6 6576.0 6597.6 29908.7 30395.7 30722.8 30825.0 30930.1 2361.2 2403.4 2414.5 2419.3 2424.1 19624.4 20301.0 20320.9 20417.6 20419.3 2522.5 2615.5 2631.4 2640.2 2690.3 143684.0 148034.0 158282.0 162250.2 163836.0 16097.0 16724.1 16882.0 16933.6 17076.8 26703.1 26705.3 26745.2 26919.1 26947.7 10874.5 10904.7 11091.4 11114.3 11279.1 9937.6 9996.9 10033.0 10041.0 10048.7 9887.8 9993.0 10141.2 10188.4 10322.7 2978.1 3034.8 3043.2 3046.3 3104.4 1075.3 1094.3 1101.5 1112.3 1112.9 21607.4 21637.9 21761.9 21851.7 21991.2 1144.6 1148.2 1151.4 1152.1 1157.9 11708.3 11856.5 11986.6 12022.4 12116.3 612869.0 613305.0 615851.0 622900.0 637544.0 127947.0 132943.0 133540.0 133754.0 134673.0 1139.9 1190.7 1261.3 1282.3 1318.7 21836.2 22411.8 22618.2 22683.4 22795.3 62596.4 62784.7 63059.0 63477.7 64072.7 81313.0 82153.6 84777.6 84806.0 85815.6 15839.8 16116.8 16176.1 16215.2 16233.7 24066.9 24424.9 24427.4 24488.4 24722.9 19093.5 19376.5 19482.2 19497.2 19504.3 17463.3 17607.6 17633.3 17719.9 18081.7 19879.6 19958.7 20277.4 20409.2 20644.2 15708.1 15889.5 15913.7 15949.7 15974.2 18962.1 18971.5 18976.7 19238.7 19631.4 18:32:36 INFO - PID 3914 | 18:32:36 INFO - PID 3914 | [#3] mootools.html Cycles:180 Average:11104.46 Median:27343.52 stddev:8263.62 (30.2%) stddev-sans-first:8255.25 18:32:36 INFO - PID 3914 | Values: 1492.4 1525.0 1543.7 1552.9 1561.4 17595.4 18340.5 18352.1 18365.8 18367.4 17746.7 17832.6 17946.6 17954.7 17975.6 2869.3 2934.2 2934.7 2944.1 2957.6 3084.8 3131.7 3145.7 3160.2 3163.7 3041.8 3158.1 3167.3 3176.8 3176.8 2899.7 3109.0 3168.0 3175.3 3179.9 3009.3 3077.5 3084.3 3091.5 3094.0 17245.4 17254.4 17400.0 17401.5 17437.9 8672.1 8885.7 9109.4 9148.7 9227.8 5583.4 5714.1 5838.9 5906.4 5933.7 2096.9 2102.6 2102.7 2150.1 2150.5 31828.8 31908.4 32047.5 32065.2 32103.0 7462.4 7593.2 7605.5 7736.8 7769.1 20575.4 20759.7 20760.5 20768.2 20785.6 8888.9 9002.6 9042.0 9062.8 9083.5 8032.6 8241.0 8267.6 8320.2 8359.2 6111.3 6129.8 6155.6 6166.4 6189.8 1614.7 1623.7 1760.1 1765.4 1795.4 960.6 975.4 980.8 1007.4 1008.1 8713.9 8754.3 8776.4 8980.0 9054.3 1069.5 1077.7 1086.8 1095.0 1110.7 5197.7 5244.8 5352.2 5356.5 5488.8 26604.2 27300.5 27622.2 27701.3 27742.7 26033.3 26721.9 27386.6 27452.5 27503.2 12800.1 13006.9 13096.1 13181.2 13349.5 10458.6 10482.4 10546.9 10633.1 10650.4 22320.9 22725.8 22745.3 23062.9 23321.9 23669.0 23692.6 23713.3 23780.2 24147.8 13097.1 13098.1 13106.2 13185.4 13248.2 16114.6 16125.2 16502.5 16549.4 16637.3 13483.7 13540.3 13647.2 13815.9 13869.9 12859.0 12902.4 12942.5 12952.0 12985.7 11926.9 11937.8 12032.5 12074.4 12094.1 8833.5 8892.5 8945.3 8980.4 9029.4 8766.6 8987.2 8989.7 9003.0 9070.6 18:32:36 INFO - PID 3914 | 18:32:36 INFO - PID 3914 | [#4] prototype.html Cycles:180 Average:5647.61 Median:6271.67 stddev:1555.87 (24.8%) stddev-sans-first:1513.02 18:32:36 INFO - PID 3914 | Values: 579.9 581.7 596.9 608.0 615.4 6150.0 6218.8 6281.1 6281.8 6292.4 6176.0 6190.6 6201.2 6206.0 6240.6 5163.9 5189.7 5192.9 5197.5 5199.5 4906.9 5029.0 5148.3 5156.4 5186.9 4979.8 5032.2 5052.1 5054.0 5060.1 4966.6 4976.7 4996.7 5024.2 5037.8 4513.2 4607.0 4627.5 4627.9 4635.7 6111.6 6138.8 6186.6 6201.8 6205.9 5874.9 5896.2 5950.4 5976.4 5978.1 6509.9 6643.3 6648.5 6656.4 6669.1 4830.8 5108.1 5130.9 5136.0 5149.3 6708.6 6835.8 6922.6 6939.8 6957.0 5220.1 5258.5 5274.4 5289.4 5291.4 5278.7 5301.5 5302.7 5332.9 5381.0 5903.8 5909.2 5923.9 5931.5 5956.8 6594.8 6641.4 6643.2 6647.9 6730.6 1819.1 1833.0 1841.7 1842.9 1851.4 1264.4 1309.3 1323.8 1335.7 1348.9 6120.3 6145.3 6265.8 6277.6 6307.4 6642.5 6695.5 6721.3 6730.9 6774.3 6302.7 6303.5 6319.0 6353.5 6358.7 3543.8 3560.4 3568.4 3581.2 3584.5 7001.5 7032.2 7037.8 7061.0 7093.0 6806.5 6869.0 6892.3 6918.8 6944.8 6934.8 6947.4 7026.4 7026.9 7059.8 6519.0 6639.8 6671.9 6688.4 6700.4 6590.9 6615.0 6645.0 6645.5 6648.1 6917.8 6921.3 6937.9 6951.3 7009.4 5147.0 5148.8 5170.7 5194.6 5205.3 6498.5 6568.7 6653.9 6738.8 6744.5 6416.5 6444.8 6558.4 6631.5 6633.4 6425.2 6445.8 6540.0 6575.9 6592.6 6261.8 6401.7 6465.2 6467.7 6535.2 6595.1 6621.2 6643.3 6647.0 6666.0 6406.0 6440.8 6455.6 6477.8 6505.5 18:32:36 INFO - PID 3914 | 18:32:36 INFO - PID 3914 | [#5] yui.html Cycles:180 Average:28903.53 Median:18198.36 stddev:43275.05 (237.8%) stddev-sans-first:43345.69 18:32:36 INFO - PID 3914 | Values: 990.6 997.7 1022.7 1029.6 1029.8 23676.8 24158.0 24287.1 24291.1 24306.0 22383.6 22809.7 23451.6 23576.6 23601.8 1050.5 1060.4 1061.9 1062.3 1064.1 1043.3 1066.1 1075.7 1076.8 1077.0 1129.9 1135.6 1142.1 1142.4 1143.9 1131.7 1137.4 1144.3 1144.7 1146.0 844.6 845.4 846.4 846.5 851.3 20771.6 21407.1 21523.6 21577.0 21643.1 20469.9 20807.4 20951.9 20983.7 21022.9 18946.8 19025.3 19067.4 19095.4 19118.4 3842.8 3847.7 3923.1 3933.7 3944.7 165405.0 166351.0 166437.0 168043.2 168167.2 17673.9 18182.6 18189.1 18273.4 18274.7 28437.6 29125.1 33355.7 34943.1 35519.5 9738.7 10045.0 10072.8 10082.8 10152.1 4867.4 4901.2 4967.9 4976.0 4977.2 6108.5 6239.8 6243.9 6252.7 6274.4 1240.1 1284.6 1290.4 1305.6 1309.4 746.9 763.5 764.5 767.1 778.3 12355.9 12677.4 12868.8 12921.8 12998.5 733.2 734.9 744.0 761.4 765.6 6334.8 6392.1 6394.3 6436.5 6557.2 145827.0 146373.0 146686.3 147086.0 150226.0 129929.0 130008.3 132549.0 136294.0 141466.0 115664.0 116717.0 117056.4 117439.4 119630.0 12214.9 12230.4 12245.7 12536.1 12561.2 59791.0 59906.7 60229.1 60434.4 61092.0 75905.2 76355.6 77860.2 79429.0 79562.6 16685.5 16708.7 16796.2 16853.9 17001.3 18458.3 18498.4 18661.3 18676.4 18690.4 16277.3 16593.6 16622.8 16733.1 17239.5 18173.0 18207.6 18238.1 18271.6 18454.7 17321.8 17417.7 17447.0 17453.9 17480.3 11589.8 11747.4 11996.2 12275.1 12299.7 12200.8 12459.9 12519.3 12604.8 12682.7 18:32:36 INFO - PID 3914 | -------- Summary: end -------- 18:32:36 INFO - PID 3914 | 18:32:37 INFO - TEST-INFO | 3914: exit 0 18:32:37 INFO - TEST-OK | dromaeo_css | took 1111368ms 18:32:37 INFO - TEST-START | kraken 18:32:37 INFO - Initialising browser for kraken test... 18:32:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52793/getInfo.html -profile /tmp/tmpVdbnCG/profile 18:32:37 INFO - TEST-INFO | started process 4299 (/builds/slave/test/build/application/firefox/firefox http://localhost:52793/getInfo.html) 18:32:42 INFO - TEST-INFO | 4299: exit 0 18:32:42 INFO - Browser initialized. 18:32:42 INFO - Running cycle 1/1 for kraken test... 18:32:42 INFO - Using env: {'DISPLAY': ':0', 18:32:42 INFO - 'HOME': '/home/cltbld', 18:32:42 INFO - 'JSGC_DISABLE_POISONING': '1', 18:32:42 INFO - 'LANG': 'en_US.UTF-8', 18:32:42 INFO - 'LANGUAGE': 'en_US:en', 18:32:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:32:42 INFO - 'LOGNAME': 'cltbld', 18:32:42 INFO - 'MAIL': '/var/mail/cltbld', 18:32:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:32:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:32:42 INFO - 'MOZ_CRASHREPORTER': '1', 18:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:32:42 INFO - 'MOZ_NO_REMOTE': '1', 18:32:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:42 INFO - 'NO_EM_RESTART': '1', 18:32:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:42 INFO - 'PWD': '/builds/slave/test', 18:32:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:32:42 INFO - 'RUST_BACKTRACE': 'full', 18:32:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:32:42 INFO - 'SHELL': '/bin/bash', 18:32:42 INFO - 'SHLVL': '1', 18:32:42 INFO - 'TERM': 'linux', 18:32:42 INFO - 'TMOUT': '86400', 18:32:42 INFO - 'USER': 'cltbld', 18:32:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213', 18:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:42 INFO - '_': '/tools/buildbot/bin/python'} 18:32:42 INFO - TEST-INFO | started process 4539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVdbnCG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:43 INFO - PID 4539 | 18:32:43 INFO - PID 4539 | (/builds/slave/test/build/application/firefox/firefox:4587): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:32:43 INFO - PID 4539 | 18:32:53 INFO - PID 4539 | RSS: Main: 142192640 18:32:53 INFO - PID 4539 | 18:32:56 INFO - PID 4539 | Cycle 1(1): loaded http://localhost:52793/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52793/tests/kraken/driver.html?testName=audio-beat-detection) 18:32:57 INFO - PID 4539 | RSS: Main: 147714048 18:32:57 INFO - PID 4539 | 18:32:59 INFO - PID 4539 | Cycle 1(1): loaded http://localhost:52793/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52793/tests/kraken/driver.html?testName=audio-dft) 18:33:00 INFO - PID 4539 | RSS: Main: 148152320 18:33:00 INFO - PID 4539 | 18:33:03 INFO - PID 4539 | Cycle 1(1): loaded http://localhost:52793/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52793/tests/kraken/driver.html?testName=audio-fft) 18:33:03 INFO - PID 4539 | RSS: Main: 149471232 18:33:03 INFO - PID 4539 | 18:33:05 INFO - PID 4539 | Cycle 1(1): loaded http://localhost:52793/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52793/tests/kraken/driver.html?testName=audio-oscillator) 18:33:06 INFO - PID 4539 | RSS: Main: 149323776 18:33:06 INFO - PID 4539 | 18:33:08 INFO - PID 4539 | Cycle 1(1): loaded http://localhost:52793/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52793/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:33:08 INFO - PID 4539 | RSS: Main: 149340160 18:33:08 INFO - PID 4539 | 18:33:12 INFO - PID 4539 | Cycle 1(1): loaded http://localhost:52793/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52793/tests/kraken/driver.html?testName=imaging-darkroom) 18:33:12 INFO - PID 4539 | RSS: Main: 148860928 18:33:12 INFO - PID 4539 | 18:33:16 INFO - PID 4539 | Cycle 1(1): loaded http://localhost:52793/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52793/tests/kraken/driver.html?testName=imaging-desaturate) 18:33:16 INFO - PID 4539 | RSS: Main: 152154112 18:33:16 INFO - PID 4539 | 18:33:19 INFO - PID 4539 | Cycle 1(1): loaded http://localhost:52793/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52793/tests/kraken/driver.html?testName=json-parse-financial) 18:33:20 INFO - PID 4539 | RSS: Main: 152211456 18:33:20 INFO - PID 4539 | 18:33:21 INFO - PID 4539 | Cycle 1(1): loaded http://localhost:52793/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52793/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:33:22 INFO - PID 4539 | RSS: Main: 152711168 18:33:22 INFO - PID 4539 | 18:33:23 INFO - PID 4539 | Cycle 1(1): loaded http://localhost:52793/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52793/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:33:24 INFO - PID 4539 | RSS: Main: 152547328 18:33:24 INFO - PID 4539 | 18:33:26 INFO - PID 4539 | Cycle 1(1): loaded http://localhost:52793/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52793/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:33:26 INFO - PID 4539 | RSS: Main: 149684224 18:33:26 INFO - PID 4539 | 18:33:29 INFO - PID 4539 | Cycle 1(1): loaded http://localhost:52793/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:33:30 INFO - PID 4539 | RSS: Main: 149356544 18:33:30 INFO - PID 4539 | 18:33:32 INFO - PID 4539 | Cycle 1(1): loaded http://localhost:52793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:33:33 INFO - PID 4539 | RSS: Main: 149680128 18:33:33 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | Cycle 1(1): loaded http://localhost:52793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52793/tests/kraken/driver.html?testName=ai-astar) 18:33:35 INFO - PID 4539 | RSS: Main: 150847488 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | __start_tp_report 18:33:35 INFO - PID 4539 | _x_x_mozilla_page_load 18:33:35 INFO - PID 4539 | _x_x_mozilla_page_load_details 18:33:35 INFO - PID 4539 | |i|pagename|runs| 18:33:35 INFO - PID 4539 | |0;ai-astar;106;105;106;106;106;111;107;106;105;106 18:33:35 INFO - PID 4539 | |1;audio-beat-detection;113;114;118;111;113;111;110;112;115;138 18:33:35 INFO - PID 4539 | |2;audio-dft;162;163;162;163;161;162;160;161;163;162 18:33:35 INFO - PID 4539 | |3;audio-fft;72;71;73;73;75;73;73;73;74;72 18:33:35 INFO - PID 4539 | |4;audio-oscillator;78;80;79;77;77;78;78;77;77;78 18:33:35 INFO - PID 4539 | |5;imaging-gaussian-blur;113;114;113;113;114;110;114;110;114;111 18:33:35 INFO - PID 4539 | |6;imaging-darkroom;148;148;149;150;148;150;149;151;148;148 18:33:35 INFO - PID 4539 | |7;imaging-desaturate;95;95;94;94;94;94;94;98;98;94 18:33:35 INFO - PID 4539 | |8;json-parse-financial;44;42;43;49;43;45;44;43;46;43 18:33:35 INFO - PID 4539 | |9;json-stringify-tinderbox;37;38;37;37;38;39;38;38;38;38 18:33:35 INFO - PID 4539 | |10;stanford-crypto-aes;71;72;71;71;75;73;70;73;72;70 18:33:35 INFO - PID 4539 | |11;stanford-crypto-ccm;107;105;102;107;105;107;105;103;99;107 18:33:35 INFO - PID 4539 | |12;stanford-crypto-pbkdf2;149;157;147;151;147;146;150;158;150;146 18:33:35 INFO - PID 4539 | |13;stanford-crypto-sha256-iterative;59;58;59;61;62;59;58;64;64;62 18:33:35 INFO - PID 4539 | __end_tp_report 18:33:35 INFO - PID 4539 | __start_cc_report 18:33:35 INFO - PID 4539 | _x_x_mozilla_cycle_collect,700 18:33:35 INFO - PID 4539 | __end_cc_report 18:33:35 INFO - PID 4539 | __startTimestamp1507858415284__endTimestamp 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | ------- Summary: start ------- 18:33:35 INFO - PID 4539 | Number of tests: 14 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | [#0] ai-astar Cycles:10 Average:106.40 Median:106.00 stddev:1.71 (1.6%) stddev-sans-first:1.81 18:33:35 INFO - PID 4539 | Values: 106.0 105.0 106.0 106.0 106.0 111.0 107.0 106.0 105.0 106.0 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | [#1] audio-beat-detection Cycles:10 Average:115.50 Median:113.50 stddev:8.24 (7.3%) stddev-sans-first:8.69 18:33:35 INFO - PID 4539 | Values: 113.0 114.0 118.0 111.0 113.0 111.0 110.0 112.0 115.0 138.0 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 18:33:35 INFO - PID 4539 | Values: 162.0 163.0 162.0 163.0 161.0 162.0 160.0 161.0 163.0 162.0 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | [#3] audio-fft Cycles:10 Average:72.90 Median:73.00 stddev:1.10 (1.5%) stddev-sans-first:1.12 18:33:35 INFO - PID 4539 | Values: 72.0 71.0 73.0 73.0 75.0 73.0 73.0 73.0 74.0 72.0 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:78.00 stddev:0.99 (1.3%) stddev-sans-first:1.05 18:33:35 INFO - PID 4539 | Values: 78.0 80.0 79.0 77.0 77.0 78.0 78.0 77.0 77.0 78.0 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | [#5] imaging-gaussian-blur Cycles:10 Average:112.60 Median:113.50 stddev:1.65 (1.5%) stddev-sans-first:1.74 18:33:35 INFO - PID 4539 | Values: 113.0 114.0 113.0 113.0 114.0 110.0 114.0 110.0 114.0 111.0 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 18:33:35 INFO - PID 4539 | Values: 148.0 148.0 149.0 150.0 148.0 150.0 149.0 151.0 148.0 148.0 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.50 stddev:1.63 (1.7%) stddev-sans-first:1.73 18:33:35 INFO - PID 4539 | Values: 95.0 95.0 94.0 94.0 94.0 94.0 94.0 98.0 98.0 94.0 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | [#8] json-parse-financial Cycles:10 Average:44.20 Median:44.00 stddev:2.04 (4.6%) stddev-sans-first:2.17 18:33:35 INFO - PID 4539 | Values: 44.0 42.0 43.0 49.0 43.0 45.0 44.0 43.0 46.0 43.0 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:0.63 (1.7%) stddev-sans-first:0.60 18:33:35 INFO - PID 4539 | Values: 37.0 38.0 37.0 37.0 38.0 39.0 38.0 38.0 38.0 38.0 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | [#10] stanford-crypto-aes Cycles:10 Average:71.80 Median:72.00 stddev:1.55 (2.2%) stddev-sans-first:1.62 18:33:35 INFO - PID 4539 | Values: 71.0 72.0 71.0 71.0 75.0 73.0 70.0 73.0 72.0 70.0 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | [#11] stanford-crypto-ccm Cycles:10 Average:104.70 Median:107.00 stddev:2.67 (2.5%) stddev-sans-first:2.70 18:33:35 INFO - PID 4539 | Values: 107.0 105.0 102.0 107.0 105.0 107.0 105.0 103.0 99.0 107.0 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.10 Median:150.00 stddev:4.28 (2.9%) stddev-sans-first:4.52 18:33:35 INFO - PID 4539 | Values: 149.0 157.0 147.0 151.0 147.0 146.0 150.0 158.0 150.0 146.0 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:61.50 stddev:2.32 (3.8%) stddev-sans-first:2.39 18:33:35 INFO - PID 4539 | Values: 59.0 58.0 59.0 61.0 62.0 59.0 58.0 64.0 64.0 62.0 18:33:35 INFO - PID 4539 | -------- Summary: end -------- 18:33:35 INFO - PID 4539 | 18:33:35 INFO - PID 4539 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:33:35 INFO - TEST-INFO | 4539: exit 0 18:33:35 INFO - TEST-OK | kraken | took 58847ms 18:33:35 INFO - SUITE-END | took 1170s 18:33:35 INFO - Completed test suite (00:19:30) 18:33:35 INFO - javascript benchmark 18:33:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9361.57473283776, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3966.345552983758, 4010.9398359024617, 4050.432939388484, 4053.1083161704432, 4063.83744650214, 6372.1079048933125, 6443.130177426057, 6478.773242936498, 6560.179977502812, 6561.77033803817, 6377.42603165715, 6394.136791533142, 6478.676066196695, 6481.31946145655, 6503.4472069874, 5778.393268706778, 5791.942080579182, 5852.590318677694, 5876.70616469177, 5944.227250457435, 5769.913451298234, 5813.825585232428, 5831.766729330843, 5831.854203644922, 5851.444112809277, 5828.737706803204, 5881.529477641779, 5905.320888097859, 5923.17075609415, 5930.703464826763, 5779.624324418899, 5834.5915785895, 5854.174040048064, 5952.821415357546, 5961.195238642771, 5692.487676109128, 5785.942140578582, 5823.708814559297, 5825.621334613236, 5849.649021058707, 6407.231132264112, 6415.326390728999, 6458.870822583569, 6463.321351258144, 6468.3855033771715, 7003.544769590011, 7024.824379390505, 7046.7181312747425, 7114.964425177841, 7144.857102857914, 6963.79108626737, 7034.8944765828555, 7044.15470143586, 7055.823604409879, 7139.643017849139, 6430.196225471816, 6449.838754031187, 6501.414872661483, 6526.151600292027, 6545.181852268466, 7214.206437291894, 7215.927840721631, 7279.563226206445, 7308.488405811649, 7324.230955749569, 6936.722531098801, 6986.056882320821, 7006.054182685272, 7058.0, 7101.360877521048, 6941.0, 7056.329648683367, 7056.858862822714, 7059.329363710439, 7065.470089743187, 6838.21360543534, 6912.0, 6929.099217101744, 6978.546394484342, 7011.123609548807, 6959.686814093277, 6960.825979350557, 7037.683304251321, 7049.577025378494, 7056.894146587805, 5094.821681241213, 5104.132297509433, 5129.153689641167, 5172.069027575073, 5177.792888284426, 4667.696599721007, 4691.882702932454, 4701.553352431513, 4736.786844591933, 4753.191957367187, 6568.244651865001, 6579.901301480481, 6590.209174899042, 6654.633995130314, 6660.300668429842, 6990.196127445307, 7020.613866237406, 7022.12223472066, 7108.609026503488, 7111.6799744010605, 6538.280789113193, 6551.508636852255, 6576.86846263072, 6602.042703808017, 6679.532432729759, 5823.5341172706085, 5890.3815099414805, 5901.734421951022, 5908.14331921869, 5917.082852157922, 7287.3441390274065, 7310.853782924418, 7338.4496162788, 7384.96610474534, 7450.403967682572, 6886.10480637514, 6924.4114250287275, 6939.895901561582, 6941.409980151744, 6944.027836102849, 7234.16807067173, 7267.7819665410125, 7429.925700742923, 7441.55350678961, 7445.0, 6850.691718872563, 6931.826704332432, 7018.719251230098, 7023.262557431396, 7031.437485001085, 6996.055532503047, 7010.439164866696, 7061.576305421691, 7079.433645308466, 7104.893426598708, 6598.175228096488, 6667.599944003376, 6689.1972963244725, 6829.385355318045, 6831.077804496329, 6780.016897549926, 6781.11845460087, 6792.592444453348, 6879.484038697017, 6885.9671049343, 6682.565633233824, 6702.899456508058, 6705.631190284386, 6762.932370676231, 6791.083203767428, 6744.0, 6834.179898412222, 6880.552764070319, 6894.069300644349, 6928.44572434194, 6621.867562648624, 6649.567778094409, 6665.633390163587, 6685.0, 6703.625756719958], "value": 6432.932418250608, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [879.815238799852, 895.8790563273958, 915.4919019943933, 916.5921165081537, 919.3840127114837, 43815.12369752603, 44649.0, 44684.0, 44788.77605611968, 44907.77546112273, 42017.0, 45546.0, 45816.770916145455, 45927.31109033359, 45941.0, 8633.26617237534, 8708.521031343274, 8797.604107815163, 8809.911900880974, 8831.55842207887, 8631.482111073356, 8690.217880390763, 8767.956160219223, 8788.209061184492, 8814.559272036404, 8819.162179592928, 8838.86741698875, 8862.423942443753, 8874.733757987271, 8887.600057997406, 8725.127487251288, 8750.606222719929, 8765.0, 8791.0, 8832.8675069874, 8475.364347673949, 8530.530820804854, 8551.315894728406, 8552.657893684245, 8558.572071396406, 41792.37311440331, 42038.159236815096, 42076.0, 42188.3671744921, 42207.788961055, 3870.632289932452, 3891.649751522348, 3901.843926242947, 3917.3536366499493, 3918.1380096378753, 34442.483362749575, 34616.134596635035, 34641.653583464344, 34670.653293466996, 34682.306353873035, 5261.263423120766, 5320.388155362144, 5355.250264962909, 5393.352797664266, 5395.028894798935, 247374.0, 250136.0, 250532.74733626397, 255055.0, 255565.0, 52918.73540632349, 53962.19056714152, 54021.45978540243, 54060.72969635126, 54124.72937635365, 57180.71409642925, 57661.42338576561, 57842.7107864458, 57859.421405785404, 57947.710261448425, 18449.354272600664, 18604.534886627942, 18614.16236269371, 18619.44141675752, 18870.90564547196, 15612.843871561367, 15685.686286274211, 15690.921545392428, 15693.607659808367, 15705.921470392575, 14566.854331456761, 14601.196934168724, 14636.268186590627, 14790.186539740418, 14867.628309292355, 5487.5609951203805, 5513.5037846594, 5535.25274087993, 5600.775968961278, 5626.606137570413, 1097.2977294531506, 1122.259308856151, 1126.419893754717, 1130.9547618095185, 1137.7383201863618, 26337.0, 26356.60465093025, 26361.868190658923, 26478.0, 26563.0, 1229.4836168809122, 1232.2729589542214, 1240.7394447166196, 1244.8692887246889, 1252.1610520950985, 13516.189028658311, 13655.931720341334, 13829.377678004514, 13969.650758731113, 14075.085119467201, 302336.0, 307505.0, 310076.0, 310505.0, 316467.0, 65142.674286628266, 65509.0, 65562.67218663971, 65841.34158658353, 65972.6805463888, 1539.353471541955, 1560.2354846125318, 1565.1391734546182, 1566.0368873142936, 1566.1151449431036, 31003.379932401676, 31166.844165779024, 31280.843595781877, 31297.843510783212, 31399.529007064455, 43388.96277260561, 43530.78234608807, 43705.344419834364, 44264.77867610641, 44385.33421998737, 257287.0, 257323.0, 258216.0, 260376.0, 261122.0, 36216.275674485834, 37328.0, 37504.81247593745, 37549.0, 38216.235675286895, 48698.51301487081, 50249.49750502448, 50561.24158137704, 50893.74553127211, 51026.48973510217, 35683.0, 35907.64092359043, 36038.4594231092, 36052.27895442024, 36329.45505817468, 35355.0, 35974.28051439009, 36033.459498107026, 36375.45436818397, 36868.26263474769, 41530.37704434496, 42592.0, 42617.36073958831, 42999.355009675506, 43008.139837202456, 34006.65993340134, 34563.481547776304, 34912.47631285583, 35426.291474169855, 36014.639853601126, 26082.217533474028, 26276.737232628195, 26469.60295595529, 26734.331641708333, 26978.595321069806], "value": 19521.730962167814, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.6845354220653, 642.376303451917, 642.5844002382836, 643.2439830293076, 649.2417290747813, 23574.0, 24268.27195184143, 24273.0, 24295.0, 24313.270601881948, 26032.47935041298, 26061.47877042458, 26464.338391540223, 26553.203403897915, 26627.600585991226, 6453.9354606454035, 6767.323267673242, 6818.6931588078405, 6865.862682746342, 6870.244273129952, 6732.259451460335, 6827.897581536281, 6833.214180369247, 6833.7949861503985, 6840.247572767016, 6702.865942681144, 6742.0, 6784.2876497967745, 6986.650667466632, 6997.440204783605, 6989.545679530815, 7017.193022802392, 7026.754063607749, 7044.260352662999, 7050.153981522225, 6520.7717729879705, 6557.24591671959, 6557.606543607351, 6576.046473261398, 6597.63712995785, 29908.700912991026, 30395.69604303973, 30722.846385768153, 30825.0, 30930.072097836877, 2361.244401791427, 2403.375122468171, 2414.4929564791414, 2419.34677637037, 2424.1273141668985, 19624.41126766199, 20301.0, 20320.898395508077, 20417.5916481671, 20419.2853250137, 2522.495500899809, 2615.5161295160456, 2631.355317947115, 2640.155150351888, 2690.313969937673, 143684.0, 148034.0, 158282.0, 162250.1887490567, 163836.0, 16097.034177949361, 16724.080175590218, 16882.0, 16933.6453083753, 17076.829231707772, 26703.06539271155, 26705.33236669099, 26745.197644070708, 26919.115661903477, 26947.73052269452, 10874.510647020903, 10904.672859814218, 11091.389973551371, 11114.333140011626, 11279.097672186206, 9937.602495900082, 9996.850047249298, 10033.0, 10041.0, 10048.69853904384, 9887.824678570703, 9993.0, 10141.2394070445, 10188.388696678076, 10322.741931451774, 2978.1065680295824, 3034.757219422441, 3043.2087657209286, 3046.284123231039, 3104.4412005839167, 1075.3386667199616, 1094.3324572011068, 1101.498818037791, 1112.2603468693228, 1112.8720197177267, 21607.351779446642, 21637.891810540845, 21761.891190543945, 21851.672224916638, 21991.230306939182, 1144.5765066925292, 1148.1561052626314, 1151.4357964597286, 1152.1358980764426, 1157.9015783658483, 11708.297502149899, 11856.525738970344, 11986.64040078799, 12022.398880055962, 12116.273023618434, 612869.0, 613305.0, 615851.0, 622900.0, 637544.0, 127947.0, 132943.0, 133540.0, 133754.0, 134673.0, 1139.9487023083982, 1190.7499425120648, 1261.3314943080181, 1282.2562913510142, 1318.723068155698, 21836.23573174931, 22411.767352795752, 22618.190544756708, 22683.432914177276, 22795.31614051581, 62596.374036259054, 62784.68607656933, 63059.0, 63477.68261158665, 64072.67963660152, 81313.0, 82153.58923205346, 84777.57611211904, 84806.0, 85815.570922145, 15839.841601583837, 16116.838831612004, 16176.110313932377, 16215.189240538162, 16233.67532649364, 24066.87966560156, 24424.87787561051, 24427.38931526726, 24488.387790305384, 24722.876385617958, 19093.522661933563, 19376.515587110436, 19482.220711171394, 19497.220111195395, 19504.31734889272, 17463.30146794114, 17607.559811004827, 17633.294668213126, 17719.911400442914, 18081.728774068135, 19879.602407951472, 19958.700619490428, 20277.391678249674, 20409.183632654527, 20644.17423303051, 15708.057516549045, 15889.52331430059, 15913.68172636564, 15949.681006379575, 15974.201289935689, 18962.0518974048, 18971.525711857314, 18976.71534927005, 19238.711419329, 19631.411057668294], "value": 13132.877290804374, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.3806620252597, 1524.961875953101, 1543.6526781474176, 1552.945646902358, 1561.3910574875797, 17595.38416155435, 18340.541486462844, 18352.08239588022, 18365.816341836577, 18367.357142499983, 17746.733798992995, 17832.55418614532, 17946.55133621657, 17954.730679039825, 17975.550611234725, 2869.34005178809, 2934.1637633274413, 2934.7212014858605, 2944.0726171255988, 2957.5859379686863, 3084.8149111053294, 3131.671174526676, 3145.7011583899493, 3160.194150491633, 3163.746900247986, 3041.817490950539, 3158.0841555948746, 3167.287360343927, 3176.7935084219566, 3176.8411579421054, 2899.6955319691447, 3109.0, 3167.9841600791847, 3175.3490534440616, 3179.8728050878053, 3009.292816188194, 3077.4614442472703, 3084.306031142975, 3091.4744493435946, 3094.0, 17245.396411125676, 17254.3960961367, 17400.0, 17401.47795566135, 17437.912810435995, 8672.13278672134, 8885.733427997171, 9109.362344635878, 9148.725538233864, 9227.769305767342, 5583.441655834384, 5714.085746280575, 5838.941610583882, 5906.438888305604, 5933.703314834241, 2096.9056392462376, 2102.55846272283, 2102.6635738281802, 2150.0969592771075, 2150.526884085514, 31828.840855795803, 31908.361832763447, 32047.51928721071, 32065.198370040704, 32103.0, 7462.403007759366, 7593.240675932473, 7605.543667379975, 7736.845263094707, 7769.067711874612, 20575.38273851787, 20759.68860467094, 20760.48098797512, 20768.169273229203, 20785.58428831415, 8888.911110888808, 9002.639894404281, 9042.0, 9062.773430664154, 9083.45499270046, 8032.598370081472, 8241.0, 8267.586620668942, 8320.167983201753, 8359.164083591591, 6111.266648002179, 6129.80468808578, 6155.630662160284, 6166.445019948226, 6189.81430557084, 1614.6932082904211, 1623.6590316033764, 1760.084755926911, 1765.3644687912342, 1795.3877108806917, 960.6253561111172, 975.4439969217478, 980.764616492051, 1007.4459047523833, 1008.0725732326277, 8713.869291960626, 8754.25588824957, 8776.385653004356, 8979.955100224457, 9054.320925930582, 1069.5080263079071, 1077.7090185649831, 1086.8206745886998, 1094.9890501095047, 1110.7389763405592, 5197.714125723046, 5244.842654720364, 5352.223927530486, 5356.544693701079, 5488.780448782084, 26604.201873943424, 27300.453990920072, 27622.171334859988, 27701.30746731348, 27742.72257277442, 26033.349166270615, 26721.86639066792, 27386.589201161998, 27452.450950980867, 27503.17490475289, 12800.103992720606, 13006.869931300755, 13096.083274170907, 13181.209127452383, 13349.46602135923, 10458.563178654931, 10482.437748357728, 10546.894531054591, 10633.149348052291, 10650.414227217578, 22320.906743127587, 22725.772742273028, 22745.317640470814, 23062.884685576464, 23321.883390582938, 23669.0, 23692.644610330513, 23713.288601341297, 23780.16769413062, 24147.758522415254, 13097.148685335424, 13098.083134180515, 13106.2136271824, 13185.40665670028, 13248.20510769357, 16114.597135071717, 16125.193740313172, 16502.504924852274, 16549.420770272984, 16637.251323690703, 13483.662908426975, 13540.255285958972, 13647.181169129884, 13815.861841381458, 13869.861301386856, 12859.0, 12902.419391127234, 12942.482300707867, 12952.0, 12985.740285194432, 11926.880731192925, 11937.820932685843, 12032.458539365574, 12074.39628018613, 12094.092943029133, 8833.514156721441, 8892.51091189965, 8945.284377249935, 8980.371374003757, 9029.41308814925, 8766.649334026568, 8987.19115279628, 8989.730308090768, 9002.954985225031, 9070.591823367833], "value": 7759.947947132394, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.8666306749449, 581.7411251992864, 596.9373215812337, 607.9726412311445, 615.4491729901736, 6149.969250153748, 6218.813435596933, 6281.120643109957, 6281.780137695182, 6292.433680968712, 6175.985609353922, 6190.628562286255, 6201.193844800169, 6205.968970155143, 6240.563160578761, 5163.915577728672, 5189.740512974355, 5192.948070519285, 5197.454267301936, 5199.4800519948085, 4906.9263961040615, 5029.0, 5148.304978827867, 5156.381234251876, 5186.870328241786, 4979.825706100287, 5032.220005899073, 5052.115879721053, 5054.0, 5060.13977623803, 4966.577840883548, 4976.7013979161, 4996.7008577769675, 5024.171011783052, 5037.848864534069, 4513.210188217049, 4607.0, 4627.490975992638, 4627.884302892421, 4635.675502714811, 6111.563782511106, 6138.785142519991, 6186.628802271833, 6201.751929922798, 6205.875882482325, 5874.882502349972, 5896.174535565025, 5950.434708702666, 5976.432238937294, 5978.133170690269, 6509.869802603968, 6643.302453242388, 6648.534602577822, 6656.434203092743, 6669.1330127083165, 4830.758462076882, 5108.131617625013, 5130.9230361544605, 5135.974320128413, 5149.30484384607, 6708.597484150918, 6835.829104272383, 6922.619255940921, 6939.826504337381, 6956.965215173892, 5220.128929088986, 5258.474152584788, 5274.3670759509105, 5289.418164001957, 5291.417944026154, 5278.709670968134, 5301.54936830366, 5302.655327403783, 5332.9466705333225, 5380.973095134499, 5903.76384944606, 5909.23179986599, 5923.881522369615, 5931.466168044896, 5956.791512297135, 6594.77996570636, 6641.435477984329, 6643.202815662152, 6647.933520664828, 6730.596164230162, 1819.1353862290994, 1832.9643751280485, 1841.686913224755, 1842.85257179428, 1851.3705340184401, 1264.3804535777588, 1309.260267948606, 1323.7749582570987, 1335.7128217433299, 1348.9055766096278, 6120.265568131853, 6145.298846382521, 6265.780697675559, 6277.5605707600025, 6307.369263073748, 6642.501812364092, 6695.531312808154, 6721.294264102199, 6730.9326906731285, 6774.27414921791, 6302.684865756693, 6303.495720342362, 6318.988961766096, 6353.491720662336, 6358.713857876314, 3543.8050907199836, 3560.4481305397703, 3568.4468907319406, 3581.158427769472, 3584.462330650423, 7001.50989430735, 7032.226455089936, 7037.753678621224, 7061.046758687511, 7093.006979022941, 6806.4554835613035, 6869.007987683615, 6892.345227203407, 6918.827029324307, 6944.791656250321, 6934.826629334307, 6947.40947019509, 7026.43788496919, 7026.891932420355, 7059.788206353817, 6518.967405162944, 6639.800805975829, 6671.933280667131, 6688.3646053624825, 6700.430463410665, 6590.90113648286, 6615.0, 6644.966775166094, 6645.534812563074, 6648.135742353463, 6917.757878474229, 6921.342472465108, 6937.930620693728, 6951.304869513008, 7009.441553832916, 5146.9742651288, 5148.845534633967, 5170.7156106413, 5194.610404219774, 5205.323307969939, 6498.512611554247, 6568.653426047745, 6653.866922661617, 6738.831529211809, 6744.460443164437, 6416.454601358937, 6444.838879027874, 6558.409743123142, 6631.469482441489, 6633.402993730588, 6425.228972523327, 6445.843325339803, 6540.0, 6575.901361479678, 6592.604443733391, 6261.78083767066, 6401.743930242738, 6465.22417309907, 6467.676616169267, 6535.150430444012, 6595.142631458071, 6621.238557565942, 6643.269240383457, 6647.0, 6666.0, 6405.967970160119, 6440.842317823394, 6455.61266324022, 6477.838054048687, 6505.512086593619], "value": 5207.895338775448, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [990.5839547390095, 997.7156510394534, 1022.7034160093573, 1029.6447725534688, 1029.7528593137645, 23676.76323236767, 24158.033678652853, 24287.14994975176, 24291.149809756662, 24306.027758889646, 22383.55232895341, 22809.657855132187, 23451.648225276633, 23576.64635030476, 23601.76398236017, 1050.495762034224, 1060.4379678770265, 1061.883192848786, 1062.3201151263197, 1064.0902028765372, 1043.2644985285394, 1066.0565399621314, 1075.714935542082, 1076.8438576406415, 1076.983845242322, 1129.9378534180616, 1135.5798354608764, 1142.0749193153572, 1142.3602782441817, 1143.8684551276626, 1131.7453572946063, 1137.3687603380122, 1144.34200334807, 1144.6966553863233, 1145.959891403801, 844.6114787197896, 845.3617518773349, 846.3652260804397, 846.5174850335311, 851.3359579527978, 20771.58456830855, 21407.14371425141, 21523.569528609496, 21577.0, 21643.134274628996, 20469.8976505118, 20807.375778726662, 20951.895240523852, 20983.685244721342, 21022.894885525628, 18946.810531894644, 19025.33411330597, 19067.427977160707, 19095.427137185907, 19118.426447206606, 3842.8078596070086, 3847.6729477994404, 3923.097687531884, 3933.744306620089, 3944.704147188944, 165405.0, 166351.0, 166437.0, 168043.15978420153, 168167.1591642046, 17673.911630441766, 18182.63634727298, 18189.090545472674, 18273.3604323848, 18274.725879111826, 28437.57343639847, 29125.126246212647, 33355.666443335744, 34943.12642183966, 35519.467207991904, 9738.659146929824, 10045.045720656526, 10072.798544029078, 10082.798344033079, 10152.137068349126, 4867.440244371872, 4901.215805471179, 4967.925481117786, 4975.950240497621, 4977.1538838397555, 6108.480779133734, 6239.844003899939, 6243.906341404882, 6252.718627661675, 6274.403931626488, 1240.1443004326986, 1284.5760898903338, 1290.4451086033096, 1305.5691621764795, 1309.4369421148806, 746.9327760501473, 763.4541302968404, 764.5183534373309, 767.0526899279386, 778.2878666020528, 12355.876441235652, 12677.429515671816, 12868.77746614089, 12921.806172907414, 12998.480060797652, 733.1861633586715, 734.9265073492608, 744.0, 761.4251240313528, 765.6478020110811, 6334.841628959339, 6392.137061496732, 6394.264659564116, 6436.452901503331, 6557.213134423804, 145827.0, 146373.0, 146686.2665686686, 147086.0, 150226.0, 129929.0, 130008.3499582496, 132549.0, 136294.0, 141466.0, 115664.0, 116717.0, 117056.41471792587, 117439.41280293715, 119630.0, 12214.938925305316, 12230.388480576114, 12245.693857653274, 12536.091917401722, 12561.246325220516, 59791.0, 59906.70046649739, 60229.096563552455, 60434.39565604288, 61092.0, 75905.24094758982, 76355.61822191076, 77860.22139778757, 79429.0, 79562.602186991, 16685.49943501697, 16708.74936875972, 16796.160191990108, 16853.915730421268, 17001.319947201973, 18458.26166953307, 18498.352557660957, 18661.253549857855, 18676.43970680882, 18690.439286821416, 16277.348906043626, 16593.585160370603, 16622.833771662128, 16733.079680617684, 17239.482815515556, 18173.0, 18207.634427418263, 18238.088095594903, 18271.634567308844, 18454.723179152592, 17321.826781732023, 17417.651646966737, 17447.0, 17453.912730436266, 17480.30078796885, 11589.826152607886, 11747.353895535827, 11996.160268781101, 12275.140740148105, 12299.69250768738, 12200.81698774537, 12459.93770031144, 12519.31143787064, 12604.810927835906, 12682.682932926751], "value": 10098.534643369461, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1360.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 106.0, 106.0, 106.0, 111.0, 107.0, 106.0, 105.0, 106.0], "value": 106.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 118.0, 111.0, 113.0, 111.0, 110.0, 112.0, 115.0, 138.0], "value": 115.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 161.0, 162.0, 160.0, 161.0, 163.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 73.0, 73.0, 75.0, 73.0, 73.0, 73.0, 74.0, 72.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 79.0, 77.0, 77.0, 78.0, 78.0, 77.0, 77.0, 78.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 114.0, 110.0, 114.0, 110.0, 114.0, 111.0], "value": 112.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 150.0, 148.0, 150.0, 149.0, 151.0, 148.0, 148.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 98.0, 98.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 42.0, 43.0, 49.0, 43.0, 45.0, 44.0, 43.0, 46.0, 43.0], "value": 44.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 37.0, 38.0, 39.0, 38.0, 38.0, 38.0, 38.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 71.0, 71.0, 75.0, 73.0, 70.0, 73.0, 72.0, 70.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 102.0, 107.0, 105.0, 107.0, 105.0, 103.0, 99.0, 107.0], "value": 104.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 157.0, 147.0, 151.0, 147.0, 146.0, 150.0, 158.0, 150.0, 146.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 61.0, 62.0, 59.0, 58.0, 64.0, 64.0, 62.0], "value": 60.6, "unit": "score"}]}]} 18:33:35 INFO - Return code: 0 18:33:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:33:36 INFO - # TBPL SUCCESS # 18:33:36 INFO - Running post-action listener: _package_coverage_data 18:33:36 INFO - Running post-action listener: _resource_record_post_action 18:33:36 INFO - [mozharness: 2017-10-13 01:33:36.058056Z] Finished run-tests step (success) 18:33:36 INFO - Running post-run listener: _resource_record_post_run 18:33:36 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 11063296; Write bytes: 419389440; Read time: 4812; Write time: 357496 18:33:36 INFO - TinderboxPrint: CPU usage
13.1% 18:33:36 INFO - TinderboxPrint: I/O read bytes / time
11,063,296 / 4,812 18:33:36 INFO - TinderboxPrint: I/O write bytes / time
419,389,440 / 357,496 18:33:36 INFO - TinderboxPrint: CPU idle
8,211.8 (86.9%) 18:33:36 INFO - TinderboxPrint: CPU user
1,179.2 (12.5%) 18:33:36 INFO - TinderboxPrint: Swap in / out
0 / 0 18:33:36 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 12607488; Read time: 0; Write time: 3436 18:33:36 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:33:36 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 11063296; Write bytes: 406781952; Read time: 4812; Write time: 354060 18:33:36 INFO - Running post-run listener: _upload_blobber_files 18:33:36 INFO - Blob upload gear active. 18:33:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:33:36 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 18:33:36 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'] 18:33:36 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 18:33:37 INFO - (blobuploader) - INFO - Open directory for files ... 18:33:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:33:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:33:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:33:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:33:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:33:38 INFO - (blobuploader) - INFO - Done attempting. 18:33:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:33:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:33:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:33:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:33:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:33:39 INFO - (blobuploader) - INFO - Done attempting. 18:33:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:33:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:33:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:33:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:33:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:33:45 INFO - (blobuploader) - INFO - Done attempting. 18:33:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:33:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:33:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:33:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:33:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:33:46 INFO - (blobuploader) - INFO - Done attempting. 18:33:46 INFO - (blobuploader) - INFO - Iteration through files over. 18:33:46 INFO - Return code: 0 18:33:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:33:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:33:46 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/02212b94800823db39c48e28a519c07532274ae11063154b3c3b8465ea7c6a6386a8afad8cc2c0a878cc58ac6fbf1e7b24d342a5bcc435c7b5c6804236b21151", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2bc86facf44c08bf33706d2213148f09a3a752ca582a72e2979f7dabd3202bc9cc145da38aff3a0f77255bb905f8c19782adc09cd8d074082b36090c6e9bbbf7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/eb494ddb34dea730236fd993ed885c43fce775564af05556e2366fb10ebf6ca09705c6b39e81a3d446c69ac91c80af9e6df7fd0368cdc98310d82ebf05f672c3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f336b4b2c633774dba751b67735d2a8c38aad53e50be24cee937aa9ea9d8c8652c67a2aa5abae8304c35d02e8bc9335c19ef6d932c961a386d2f49966545c06d"} 18:33:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:33:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:33:46 INFO - Contents: 18:33:46 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/02212b94800823db39c48e28a519c07532274ae11063154b3c3b8465ea7c6a6386a8afad8cc2c0a878cc58ac6fbf1e7b24d342a5bcc435c7b5c6804236b21151", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2bc86facf44c08bf33706d2213148f09a3a752ca582a72e2979f7dabd3202bc9cc145da38aff3a0f77255bb905f8c19782adc09cd8d074082b36090c6e9bbbf7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/eb494ddb34dea730236fd993ed885c43fce775564af05556e2366fb10ebf6ca09705c6b39e81a3d446c69ac91c80af9e6df7fd0368cdc98310d82ebf05f672c3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f336b4b2c633774dba751b67735d2a8c38aad53e50be24cee937aa9ea9d8c8652c67a2aa5abae8304c35d02e8bc9335c19ef6d932c961a386d2f49966545c06d"} 18:33:46 INFO - Running post-run listener: copy_logs_to_upload_dir 18:33:46 INFO - Copying logs to upload dir... 18:33:46 INFO - mkdir: /builds/slave/test/build/upload/logs 18:33:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.026836 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-10-12 18:33:46.945603) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-12 18:33:46.949436) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/02212b94800823db39c48e28a519c07532274ae11063154b3c3b8465ea7c6a6386a8afad8cc2c0a878cc58ac6fbf1e7b24d342a5bcc435c7b5c6804236b21151", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2bc86facf44c08bf33706d2213148f09a3a752ca582a72e2979f7dabd3202bc9cc145da38aff3a0f77255bb905f8c19782adc09cd8d074082b36090c6e9bbbf7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/eb494ddb34dea730236fd993ed885c43fce775564af05556e2366fb10ebf6ca09705c6b39e81a3d446c69ac91c80af9e6df7fd0368cdc98310d82ebf05f672c3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f336b4b2c633774dba751b67735d2a8c38aad53e50be24cee937aa9ea9d8c8652c67a2aa5abae8304c35d02e8bc9335c19ef6d932c961a386d2f49966545c06d"} build_url:https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/S9AoryBmT7Kb5uUhBT01vw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/02212b94800823db39c48e28a519c07532274ae11063154b3c3b8465ea7c6a6386a8afad8cc2c0a878cc58ac6fbf1e7b24d342a5bcc435c7b5c6804236b21151", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2bc86facf44c08bf33706d2213148f09a3a752ca582a72e2979f7dabd3202bc9cc145da38aff3a0f77255bb905f8c19782adc09cd8d074082b36090c6e9bbbf7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/eb494ddb34dea730236fd993ed885c43fce775564af05556e2366fb10ebf6ca09705c6b39e81a3d446c69ac91c80af9e6df7fd0368cdc98310d82ebf05f672c3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f336b4b2c633774dba751b67735d2a8c38aad53e50be24cee937aa9ea9d8c8652c67a2aa5abae8304c35d02e8bc9335c19ef6d932c961a386d2f49966545c06d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-12 18:33:46.979314) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 18:33:46.979695) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1507853859.291432-2031895213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 18:33:47.062278) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-12 18:33:47.062599) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-12 18:33:47.062904) ========= ========= Total master_lag: 0.19 =========