builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1507942594.11 results: success (0) revision: 60546645c39020a15adea8341a27f5b525b34e2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-13 17:56:34.106375) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-13 17:56:34.106832) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-13 17:56:34.107116) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-13 17:56:34.123623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-13 17:56:34.123963) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-13 17:56:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 116M=0s 2017-10-13 17:56:34 (116 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083405 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-13 17:56:34.227841) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-13 17:56:34.228586) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019521 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-13 17:56:34.283442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-13 17:56:34.284146) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 60546645c39020a15adea8341a27f5b525b34e2c --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 60546645c39020a15adea8341a27f5b525b34e2c --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=2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-13 17:56:34,332 truncating revision to first 12 chars 2017-10-13 17:56:34,332 Setting DEBUG logging. 2017-10-13 17:56:34,332 attempt 1/10 2017-10-13 17:56:34,332 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/60546645c390?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-13 17:56:34,734 unpacking tar archive at: mozilla-beta-60546645c390/testing/mozharness/ program finished with exit code 0 elapsedTime=0.691156 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-13 17:56:34.998035) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-13 17:56:34.998840) ========= script_repo_revision: 60546645c39020a15adea8341a27f5b525b34e2c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-13 17:56:34.999777) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-13 17:56:35.000491) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-13 17:56:35.017179) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-10-13 17:56:35.017897) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:56:35 INFO - MultiFileLogger online at 20171013 17:56:35 in /builds/slave/test 17:56:35 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 17:56:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:56:35 INFO - {'append_to_log': False, 17:56:35 INFO - 'base_work_dir': '/builds/slave/test', 17:56:35 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 17:56:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:56:35 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 17:56:35 INFO - 'buildbot_json_path': 'buildprops.json', 17:56:35 INFO - 'code_coverage': False, 17:56:35 INFO - 'config_files': ('talos/linux_config.py',), 17:56:35 INFO - 'default_actions': ('clobber', 17:56:35 INFO - 'read-buildbot-config', 17:56:35 INFO - 'download-and-extract', 17:56:35 INFO - 'populate-webroot', 17:56:35 INFO - 'create-virtualenv', 17:56:35 INFO - 'install', 17:56:35 INFO - 'setup-mitmproxy', 17:56:35 INFO - 'run-tests'), 17:56:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:56:35 INFO - 'disable_ccov_upload': False, 17:56:35 INFO - 'disable_stylo': False, 17:56:35 INFO - 'download_minidump_stackwalk': True, 17:56:35 INFO - 'download_symbols': 'ondemand', 17:56:35 INFO - 'enable_stylo': False, 17:56:35 INFO - 'enable_webrender': False, 17:56:35 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:56:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:56:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:56:35 INFO - 'gecko_profile': False, 17:56:35 INFO - 'gecko_profile_interval': 0, 17:56:35 INFO - 'installer_path': 'installer.exe', 17:56:35 INFO - 'log_level': 'info', 17:56:35 INFO - 'log_name': 'talos', 17:56:35 INFO - 'log_to_console': True, 17:56:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:56:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:56:35 INFO - 'opt_config_files': (), 17:56:35 INFO - 'pip_index': False, 17:56:35 INFO - 'suite': 'dromaeojs-e10s', 17:56:35 INFO - 'system_bits': '32', 17:56:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:56:35 INFO - 'title': 'talos-linux64-ix-012', 17:56:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:56:35 INFO - 'use_talos_json': True, 17:56:35 INFO - 'verify': 'False', 17:56:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:56:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:56:35 INFO - 'work_dir': 'build'} 17:56:35 INFO - [mozharness: 2017-10-14 00:56:35.208024Z] Running clobber step. 17:56:35 INFO - Running pre-action listener: _resource_record_pre_action 17:56:35 INFO - Running main action method: clobber 17:56:35 INFO - rmtree: /builds/slave/test/build 17:56:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:56:36 INFO - Running post-action listener: _resource_record_post_action 17:56:36 INFO - [mozharness: 2017-10-14 00:56:36.347959Z] Finished clobber step (success) 17:56:36 INFO - [mozharness: 2017-10-14 00:56:36.348057Z] Running read-buildbot-config step. 17:56:36 INFO - Running pre-action listener: _resource_record_pre_action 17:56:36 INFO - Running main action method: read_buildbot_config 17:56:36 INFO - Using buildbot properties: 17:56:36 INFO - { 17:56:36 INFO - "project": "", 17:56:36 INFO - "product": "firefox", 17:56:36 INFO - "who": "jryans@gmail.com", 17:56:36 INFO - "installer_path": "public/build/target.tar.bz2", 17:56:36 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 17:56:36 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 17:56:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 17:56:36 INFO - "stage_platform": "linux64", 17:56:36 INFO - "basedir": "/builds/slave/test", 17:56:36 INFO - "buildnumber": 142, 17:56:36 INFO - "platform": "ubuntu64_hw", 17:56:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:56:36 INFO - "slavebuilddir": "test", 17:56:36 INFO - "taskId": "EHYX1wLeSGeQ_9UO6l7Wwg", 17:56:36 INFO - "branch": "mozilla-beta", 17:56:36 INFO - "script_repo_revision": "production", 17:56:36 INFO - "revision": "60546645c39020a15adea8341a27f5b525b34e2c", 17:56:36 INFO - "slavename": "talos-linux64-ix-012", 17:56:36 INFO - "repo_path": "releases/mozilla-beta" 17:56:36 INFO - } 17:56:36 INFO - Finding installer, test and symbols from parent task. 17:56:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EHYX1wLeSGeQ_9UO6l7Wwg'}, attempt #1 17:56:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EHYX1wLeSGeQ_9UO6l7Wwg'}, attempt #1 17:56:37 INFO - Task dependencies: fHoNZRvxSmSCwNrakW95Dw 17:56:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw'}, attempt #1 17:56:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.tar.bz2 17:56:37 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.test_packages.json 17:56:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.crashreporter-symbols.zip 17:56:37 INFO - Running post-action listener: _resource_record_post_action 17:56:37 INFO - [mozharness: 2017-10-14 00:56:37.675122Z] Finished read-buildbot-config step (success) 17:56:37 INFO - [mozharness: 2017-10-14 00:56:37.675342Z] Running download-and-extract step. 17:56:37 INFO - Running pre-action listener: _resource_record_pre_action 17:56:37 INFO - Running main action method: download_and_extract 17:56:37 INFO - mkdir: /builds/slave/test/build/tests 17:56:37 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')]} 17:56:37 INFO - trying https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.test_packages.json 17:56:37 INFO - Downloading https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:56:38 INFO - Downloaded 989 bytes. 17:56:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:56:38 INFO - Using the following test package requirements: 17:56:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:56:38 INFO - u'common': [u'target.common.tests.zip'], 17:56:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:56:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:56:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:56:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:56:38 INFO - u'mozbase': [u'target.common.tests.zip'], 17:56:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:56:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:56:38 INFO - u'web-platform': [u'target.common.tests.zip', 17:56:38 INFO - u'target.web-platform.tests.tar.gz'], 17:56:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:56:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:56:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.common.tests.zip 17:56:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:56:38 INFO - Fetch https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.common.tests.zip into memory 17:56:40 INFO - Content-Length response header: 55178564 17:56:40 INFO - Bytes received: 55178564 17:56:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.talos.tests.zip 17:56:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:56:50 INFO - Fetch https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.talos.tests.zip into memory 17:56:51 INFO - Content-Length response header: 14509251 17:56:51 INFO - Bytes received: 14509251 17:56:52 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')]} 17:56:52 INFO - trying https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.tar.bz2 17:56:52 INFO - Downloading https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:56:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:56:54 INFO - Downloaded 53605185 bytes. 17:56:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.tar.bz2 17:56:54 INFO - mkdir: /builds/slave/test/properties 17:56:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:56:54 INFO - Writing to file /builds/slave/test/properties/build_url 17:56:54 INFO - Contents: 17:56:54 INFO - build_url:https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.tar.bz2 17:56:54 INFO - Running post-action listener: _resource_record_post_action 17:56:54 INFO - Running post-action listener: find_tests_for_verification 17:56:54 INFO - Running post-action listener: set_extra_try_arguments 17:56:54 INFO - [mozharness: 2017-10-14 00:56:54.076436Z] Finished download-and-extract step (success) 17:56:54 INFO - [mozharness: 2017-10-14 00:56:54.076662Z] Running populate-webroot step. 17:56:54 INFO - Running pre-action listener: _resource_record_pre_action 17:56:54 INFO - Running main action method: populate_webroot 17:56:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:56:54 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:56:54 INFO - 'tests': ['tresize', 17:56:54 INFO - 'tcanvasmark']}, 17:56:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:56:54 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:56:54 INFO - 'tests': ['dromaeo_css', 17:56:54 INFO - 'kraken']}, 17:56:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:56:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:54 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:56:54 INFO - 'talos_options': ['--disable-stylo'], 17:56:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:56:54 INFO - 'tests': ['damp', 'tps']}, 17:56:54 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:56:54 INFO - 'talos_options': ['--disable-stylo'], 17:56:54 INFO - 'tests': ['damp', 'tps']}, 17:56:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:56:54 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:56:54 INFO - 'tests': ['dromaeo_dom']}, 17:56:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:56:54 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:56:54 INFO - 'tests': ['basic_compositor_video', 17:56:54 INFO - 'glvideo']}, 17:56:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:56:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:56:54 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:56:54 INFO - 'talos_options': ['--disable-stylo'], 17:56:54 INFO - 'tests': ['ts_paint_webext', 17:56:54 INFO - 'tp5o_webext']}, 17:56:54 INFO - 'other-e10s': {'tests': ['a11yr', 17:56:54 INFO - 'ts_paint', 17:56:54 INFO - 'tpaint', 17:56:54 INFO - 'sessionrestore', 17:56:54 INFO - 'sessionrestore_many_windows', 17:56:54 INFO - 'sessionrestore_no_auto_restore', 17:56:54 INFO - 'tabpaint']}, 17:56:54 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:56:54 INFO - 'tests': ['a11yr', 17:56:54 INFO - 'ts_paint', 17:56:54 INFO - 'tpaint', 17:56:54 INFO - 'sessionrestore', 17:56:54 INFO - 'sessionrestore_many_windows', 17:56:54 INFO - 'sessionrestore_no_auto_restore', 17:56:54 INFO - 'tabpaint']}, 17:56:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:56:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:56:54 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:56:54 INFO - 'tests': ['perf_reftest_singletons']}, 17:56:54 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:56:54 INFO - 'tests': ['bloom_basic']}, 17:56:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:56:54 INFO - 'tsvgr_opacity', 17:56:54 INFO - 'tart', 17:56:54 INFO - 'tscrollx', 17:56:54 INFO - 'tsvg_static']}, 17:56:54 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:56:54 INFO - 'tests': ['tsvgx', 17:56:54 INFO - 'tsvgr_opacity', 17:56:54 INFO - 'tart', 17:56:54 INFO - 'tscrollx', 17:56:54 INFO - 'tsvg_static']}, 17:56:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:56:54 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:56:54 INFO - 'talos_options': ['--disable-stylo'], 17:56:54 INFO - 'tests': ['tp5o']}, 17:56:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:56:54 INFO - 'talos_options': ['--mitmproxy', 17:56:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:56:54 INFO - '--firstNonBlankPaint'], 17:56:54 INFO - 'tests': ['tp6_google', 17:56:54 INFO - 'tp6_youtube', 17:56:54 INFO - 'tp6_amazon', 17:56:54 INFO - 'tp6_facebook']}, 17:56:54 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:56:54 INFO - 'talos_options': ['--disable-stylo', 17:56:54 INFO - '--mitmproxy', 17:56:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:56:54 INFO - '--firstNonBlankPaint'], 17:56:54 INFO - 'tests': ['tp6_google', 17:56:54 INFO - 'tp6_youtube', 17:56:54 INFO - 'tp6_amazon', 17:56:54 INFO - 'tp6_facebook']}, 17:56:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:56:54 INFO - 'talos_options': ['--stylo-threads=1', 17:56:54 INFO - '--mitmproxy', 17:56:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:56:54 INFO - '--firstNonBlankPaint'], 17:56:54 INFO - 'tests': ['tp6_google', 17:56:54 INFO - 'tp6_youtube', 17:56:54 INFO - 'tp6_amazon', 17:56:54 INFO - 'tp6_facebook']}, 17:56:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:56:54 INFO - 'talos_options': ['--xperf_path', 17:56:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:54 INFO - 'tests': ['tp5n']}, 17:56:54 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:56:54 INFO - 'talos_options': ['--disable-stylo', 17:56:54 INFO - '--xperf_path', 17:56:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:54 INFO - 'tests': ['tp5n']}}} 17:56:54 INFO - Running post-action listener: _resource_record_post_action 17:56:54 INFO - [mozharness: 2017-10-14 00:56:54.097961Z] Finished populate-webroot step (success) 17:56:54 INFO - [mozharness: 2017-10-14 00:56:54.098051Z] Running create-virtualenv step. 17:56:54 INFO - Running pre-action listener: _resource_record_pre_action 17:56:54 INFO - Running main action method: create_virtualenv 17:56:54 INFO - Creating virtualenv /builds/slave/test/build/venv 17:56:54 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:56:54 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:56:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:56:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:56:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:56:54 INFO - Installing distribute.............................................................................................................................................................................................done. 17:56:55 INFO - Installing pip...............done. 17:56:55 INFO - Return code: 0 17:56:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:56:55 INFO - Reading from file tmpfile_stdout 17:56:55 INFO - Output received: 17:56:55 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:56:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dc090>, '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 0x16dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', '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 17:56:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:56:55 INFO - Using env: {'DISPLAY': ':0', 17:56:55 INFO - 'HOME': '/home/cltbld', 17:56:55 INFO - 'LANG': 'en_US.UTF-8', 17:56:55 INFO - 'LANGUAGE': 'en_US:en', 17:56:55 INFO - 'LOGNAME': 'cltbld', 17:56:55 INFO - 'MAIL': '/var/mail/cltbld', 17:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:55 INFO - 'MOZ_NO_REMOTE': '1', 17:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:55 INFO - 'NO_EM_RESTART': '1', 17:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:55 INFO - 'PWD': '/builds/slave/test', 17:56:55 INFO - 'SHELL': '/bin/bash', 17:56:55 INFO - 'SHLVL': '1', 17:56:55 INFO - 'TERM': 'linux', 17:56:55 INFO - 'TMOUT': '86400', 17:56:55 INFO - 'USER': 'cltbld', 17:56:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', 17:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:55 INFO - '_': '/tools/buildbot/bin/python'} 17:56:56 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:56:56 INFO - Downloading/unpacking pip>=1.5 17:56:56 INFO - Running setup.py egg_info for package pip 17:56:56 INFO - warning: no files found matching 'pip/cacert.pem' 17:56:56 INFO - warning: no files found matching '*.html' under directory 'docs' 17:56:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:56:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:56:56 INFO - Installing collected packages: pip 17:56:56 INFO - Found existing installation: pip 1.1 17:56:56 INFO - Uninstalling pip: 17:56:56 INFO - Successfully uninstalled pip 17:56:56 INFO - Running setup.py install for pip 17:56:56 INFO - warning: no files found matching 'pip/cacert.pem' 17:56:56 INFO - warning: no files found matching '*.html' under directory 'docs' 17:56:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:56:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:56:56 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:56:56 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:56:56 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:56:56 INFO - Successfully installed pip 17:56:56 INFO - Cleaning up... 17:56:56 INFO - Return code: 0 17:56:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:56 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 0x136d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dc090>, '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 0x16dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', '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 17:56:56 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 17:56:56 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 17:56:56 INFO - Using env: {'DISPLAY': ':0', 17:56:56 INFO - 'HOME': '/home/cltbld', 17:56:56 INFO - 'LANG': 'en_US.UTF-8', 17:56:56 INFO - 'LANGUAGE': 'en_US:en', 17:56:56 INFO - 'LOGNAME': 'cltbld', 17:56:56 INFO - 'MAIL': '/var/mail/cltbld', 17:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:56 INFO - 'MOZ_NO_REMOTE': '1', 17:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:56 INFO - 'NO_EM_RESTART': '1', 17:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:56 INFO - 'PWD': '/builds/slave/test', 17:56:56 INFO - 'SHELL': '/bin/bash', 17:56:56 INFO - 'SHLVL': '1', 17:56:56 INFO - 'TERM': 'linux', 17:56:56 INFO - 'TMOUT': '86400', 17:56:56 INFO - 'USER': 'cltbld', 17:56:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', 17:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:56 INFO - '_': '/tools/buildbot/bin/python'} 17:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:56 INFO - Downloading/unpacking psutil>=3.1.1 17:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:56:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:58 INFO - Installing collected packages: psutil 17:56:58 INFO - Running setup.py install for psutil 17:56:58 INFO - building 'psutil._psutil_linux' extension 17:56:58 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 17:56:58 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 17:56:58 INFO - building 'psutil._psutil_posix' extension 17:56:58 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 17:56:58 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 17:56:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:58 INFO - Successfully installed psutil 17:56:58 INFO - Cleaning up... 17:56:58 INFO - Return code: 0 17:56:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:56:58 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')]} 17:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:58 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')]} 17:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:58 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 0x136d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dc090>, '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 0x16dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', '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 17:56:58 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 17:56:58 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 17:56:58 INFO - Using env: {'DISPLAY': ':0', 17:56:58 INFO - 'HOME': '/home/cltbld', 17:56:58 INFO - 'LANG': 'en_US.UTF-8', 17:56:58 INFO - 'LANGUAGE': 'en_US:en', 17:56:58 INFO - 'LOGNAME': 'cltbld', 17:56:58 INFO - 'MAIL': '/var/mail/cltbld', 17:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:58 INFO - 'MOZ_NO_REMOTE': '1', 17:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:58 INFO - 'NO_EM_RESTART': '1', 17:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:58 INFO - 'PWD': '/builds/slave/test', 17:56:58 INFO - 'SHELL': '/bin/bash', 17:56:58 INFO - 'SHLVL': '1', 17:56:58 INFO - 'TERM': 'linux', 17:56:58 INFO - 'TMOUT': '86400', 17:56:58 INFO - 'USER': 'cltbld', 17:56:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', 17:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:58 INFO - '_': '/tools/buildbot/bin/python'} 17:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:56:59 INFO - Installing collected packages: mozsystemmonitor 17:56:59 INFO - Running setup.py install for mozsystemmonitor 17:57:00 INFO - Successfully installed mozsystemmonitor 17:57:00 INFO - Cleaning up... 17:57:00 INFO - Return code: 0 17:57:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:00 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 0x136d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dc090>, '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 0x16dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', '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 17:57:00 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 17:57:00 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 17:57:00 INFO - Using env: {'DISPLAY': ':0', 17:57:00 INFO - 'HOME': '/home/cltbld', 17:57:00 INFO - 'LANG': 'en_US.UTF-8', 17:57:00 INFO - 'LANGUAGE': 'en_US:en', 17:57:00 INFO - 'LOGNAME': 'cltbld', 17:57:00 INFO - 'MAIL': '/var/mail/cltbld', 17:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:00 INFO - 'MOZ_NO_REMOTE': '1', 17:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:00 INFO - 'NO_EM_RESTART': '1', 17:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:00 INFO - 'PWD': '/builds/slave/test', 17:57:00 INFO - 'SHELL': '/bin/bash', 17:57:00 INFO - 'SHLVL': '1', 17:57:00 INFO - 'TERM': 'linux', 17:57:00 INFO - 'TMOUT': '86400', 17:57:00 INFO - 'USER': 'cltbld', 17:57:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', 17:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:00 INFO - '_': '/tools/buildbot/bin/python'} 17:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:01 INFO - Downloading/unpacking jsonschema==2.5.1 17:57:01 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 17:57:01 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 17:57:01 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 17:57:01 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 17:57:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:57:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:57:02 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 17:57:02 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 17:57:02 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 17:57:02 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 17:57:02 INFO - Downloading functools32-3.2.3-2.tar.gz 17:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:57:02 INFO - warning: no files found matching '*.txt' 17:57:02 INFO - no previously-included directories found matching 'build' 17:57:02 INFO - no previously-included directories found matching 'dist' 17:57:02 INFO - no previously-included directories found matching '.git*' 17:57:02 INFO - Installing collected packages: jsonschema, functools32 17:57:02 INFO - Running setup.py install for functools32 17:57:02 INFO - warning: no files found matching '*.txt' 17:57:02 INFO - no previously-included directories found matching 'build' 17:57:02 INFO - no previously-included directories found matching 'dist' 17:57:02 INFO - no previously-included directories found matching '.git*' 17:57:02 INFO - Successfully installed jsonschema functools32 17:57:02 INFO - Cleaning up... 17:57:02 INFO - Return code: 0 17:57:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x136d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dc090>, '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 0x16dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', '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 17:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:57:02 INFO - Using env: {'DISPLAY': ':0', 17:57:02 INFO - 'HOME': '/home/cltbld', 17:57:02 INFO - 'LANG': 'en_US.UTF-8', 17:57:02 INFO - 'LANGUAGE': 'en_US:en', 17:57:02 INFO - 'LOGNAME': 'cltbld', 17:57:02 INFO - 'MAIL': '/var/mail/cltbld', 17:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:02 INFO - 'MOZ_NO_REMOTE': '1', 17:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:02 INFO - 'NO_EM_RESTART': '1', 17:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:02 INFO - 'PWD': '/builds/slave/test', 17:57:02 INFO - 'SHELL': '/bin/bash', 17:57:02 INFO - 'SHLVL': '1', 17:57:02 INFO - 'TERM': 'linux', 17:57:02 INFO - 'TMOUT': '86400', 17:57:02 INFO - 'USER': 'cltbld', 17:57:02 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', 17:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:02 INFO - '_': '/tools/buildbot/bin/python'} 17:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:57:03 INFO - Cleaning up... 17:57:03 INFO - Return code: 0 17:57:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:57:03 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')]} 17:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:03 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')]} 17:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:03 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 0x136d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dc090>, '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 0x16dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', '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 17:57:03 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 17:57:03 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 17:57:03 INFO - Using env: {'DISPLAY': ':0', 17:57:03 INFO - 'HOME': '/home/cltbld', 17:57:03 INFO - 'LANG': 'en_US.UTF-8', 17:57:03 INFO - 'LANGUAGE': 'en_US:en', 17:57:03 INFO - 'LOGNAME': 'cltbld', 17:57:03 INFO - 'MAIL': '/var/mail/cltbld', 17:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:03 INFO - 'MOZ_NO_REMOTE': '1', 17:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:03 INFO - 'NO_EM_RESTART': '1', 17:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:03 INFO - 'PWD': '/builds/slave/test', 17:57:03 INFO - 'SHELL': '/bin/bash', 17:57:03 INFO - 'SHLVL': '1', 17:57:03 INFO - 'TERM': 'linux', 17:57:03 INFO - 'TMOUT': '86400', 17:57:03 INFO - 'USER': 'cltbld', 17:57:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', 17:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:03 INFO - '_': '/tools/buildbot/bin/python'} 17:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:03 INFO - Downloading/unpacking blobuploader==1.2.4 17:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:04 INFO - Downloading blobuploader-1.2.4.tar.gz 17:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:57:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:57:04 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 17:57:04 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 17:57:04 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 17:57:04 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 17:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:57:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:57:04 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 17:57:04 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 17:57:04 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 17:57:04 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 17:57:04 INFO - Downloading docopt-0.6.1.tar.gz 17:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:57:05 INFO - Installing collected packages: blobuploader, requests, docopt 17:57:05 INFO - Running setup.py install for blobuploader 17:57:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:57:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:57:05 INFO - Running setup.py install for requests 17:57:05 INFO - Running setup.py install for docopt 17:57:05 INFO - Successfully installed blobuploader requests docopt 17:57:05 INFO - Cleaning up... 17:57:05 INFO - Return code: 0 17:57:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57: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')]} 17:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57: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')]} 17:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:05 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 0x136d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dc090>, '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 0x16dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', '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 17:57:05 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 17:57:05 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 17:57:05 INFO - Using env: {'DISPLAY': ':0', 17:57:05 INFO - 'HOME': '/home/cltbld', 17:57:05 INFO - 'LANG': 'en_US.UTF-8', 17:57:05 INFO - 'LANGUAGE': 'en_US:en', 17:57:05 INFO - 'LOGNAME': 'cltbld', 17:57:05 INFO - 'MAIL': '/var/mail/cltbld', 17:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:05 INFO - 'MOZ_NO_REMOTE': '1', 17:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:05 INFO - 'NO_EM_RESTART': '1', 17:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:05 INFO - 'PWD': '/builds/slave/test', 17:57:05 INFO - 'SHELL': '/bin/bash', 17:57:05 INFO - 'SHLVL': '1', 17:57:05 INFO - 'TERM': 'linux', 17:57:05 INFO - 'TMOUT': '86400', 17:57:05 INFO - 'USER': 'cltbld', 17:57:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', 17:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:05 INFO - '_': '/tools/buildbot/bin/python'} 17:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:57:05 INFO - Running setup.py (path:/tmp/pip-RMC12i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:57:05 INFO - Running setup.py (path:/tmp/pip-cyzVo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:57:05 INFO - Running setup.py (path:/tmp/pip-v3VXAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:57:06 INFO - Running setup.py (path:/tmp/pip-CblIif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:57:06 INFO - Running setup.py (path:/tmp/pip-ouXImw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:57:06 INFO - Running setup.py (path:/tmp/pip-OkYkRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:57:06 INFO - Running setup.py (path:/tmp/pip-R_5d4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:57:06 INFO - Running setup.py (path:/tmp/pip-7PpS4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:57:06 INFO - Running setup.py (path:/tmp/pip-zH8rHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:57:06 INFO - Running setup.py (path:/tmp/pip-dAinMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:57:06 INFO - Running setup.py (path:/tmp/pip-igDWu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:57:06 INFO - Running setup.py (path:/tmp/pip-xGy0er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:57:06 INFO - Running setup.py (path:/tmp/pip-t2xTFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:57:06 INFO - Running setup.py (path:/tmp/pip-W7FtSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:06 INFO - Running setup.py (path:/tmp/pip-2OfHHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:57:06 INFO - Running setup.py (path:/tmp/pip-AQW_Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:57:06 INFO - Running setup.py (path:/tmp/pip-ncn2Fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:57:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:57:07 INFO - Running setup.py install for manifestparser 17:57:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:57:07 INFO - Running setup.py install for mozcrash 17:57:07 INFO - Running setup.py install for mozdebug 17:57:07 INFO - Running setup.py install for mozdevice 17:57:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:57:07 INFO - Running setup.py install for mozfile 17:57:07 INFO - Running setup.py install for mozhttpd 17:57:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:57:07 INFO - Running setup.py install for mozinfo 17:57:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:57:07 INFO - Running setup.py install for mozInstall 17:57:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:57:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:57:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:57:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:57:07 INFO - Running setup.py install for mozleak 17:57:07 INFO - Running setup.py install for mozlog 17:57:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:57:08 INFO - Running setup.py install for moznetwork 17:57:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:57:08 INFO - Running setup.py install for mozprocess 17:57:08 INFO - Running setup.py install for mozprofile 17:57:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:57:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:57:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:57:08 INFO - Running setup.py install for mozrunner 17:57:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:57:08 INFO - Running setup.py install for mozscreenshot 17:57:08 INFO - Running setup.py install for moztest 17:57:08 INFO - Running setup.py install for mozversion 17:57:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:57:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:57:08 INFO - Cleaning up... 17:57:08 INFO - Return code: 0 17:57:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:08 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 0x136d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dc090>, '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 0x16dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', '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 17:57:08 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 17:57:08 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 17:57:08 INFO - Using env: {'DISPLAY': ':0', 17:57:08 INFO - 'HOME': '/home/cltbld', 17:57:08 INFO - 'LANG': 'en_US.UTF-8', 17:57:08 INFO - 'LANGUAGE': 'en_US:en', 17:57:08 INFO - 'LOGNAME': 'cltbld', 17:57:08 INFO - 'MAIL': '/var/mail/cltbld', 17:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:08 INFO - 'MOZ_NO_REMOTE': '1', 17:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:08 INFO - 'NO_EM_RESTART': '1', 17:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:08 INFO - 'PWD': '/builds/slave/test', 17:57:08 INFO - 'SHELL': '/bin/bash', 17:57:08 INFO - 'SHLVL': '1', 17:57:08 INFO - 'TERM': 'linux', 17:57:08 INFO - 'TMOUT': '86400', 17:57:08 INFO - 'USER': 'cltbld', 17:57:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', 17:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:08 INFO - '_': '/tools/buildbot/bin/python'} 17:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:57:09 INFO - Running setup.py (path:/tmp/pip-97J9Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:57:09 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)) 17:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:57:09 INFO - Running setup.py (path:/tmp/pip-BhIN2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:57:09 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)) 17:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:57:09 INFO - Running setup.py (path:/tmp/pip-R6HuVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:57:09 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)) 17:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:57:09 INFO - Running setup.py (path:/tmp/pip-Trz1pI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:57:09 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)) 17:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:57:09 INFO - Running setup.py (path:/tmp/pip-psoJSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:57:09 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)) 17:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:57:09 INFO - Running setup.py (path:/tmp/pip-JJGns_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:57:09 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)) 17:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:57:09 INFO - Running setup.py (path:/tmp/pip-UTNBbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:57:09 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)) 17:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:57:09 INFO - Running setup.py (path:/tmp/pip-DsHxj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:57:09 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)) 17:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:57:09 INFO - Running setup.py (path:/tmp/pip-lf1Eoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:57:09 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)) 17:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:57:09 INFO - Running setup.py (path:/tmp/pip-U2KKAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:57:09 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)) 17:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:57:09 INFO - Running setup.py (path:/tmp/pip-vBHFEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:57:09 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)) 17:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:57:09 INFO - Running setup.py (path:/tmp/pip-X9P6L0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:57:09 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)) 17:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:57:09 INFO - Running setup.py (path:/tmp/pip-T8EWWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:57:09 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)) 17:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:57:09 INFO - Running setup.py (path:/tmp/pip-cxzFQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:57:09 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)) 17:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:09 INFO - Running setup.py (path:/tmp/pip-us_oXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:10 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)) 17:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:57:10 INFO - Running setup.py (path:/tmp/pip-VA4naq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:57:10 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)) 17:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:57:10 INFO - Running setup.py (path:/tmp/pip-cr19dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:57:10 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)) 17:57:10 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)) 17:57:10 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)) 17:57:10 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)) 17:57:10 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)) 17:57:10 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)) 17:57:10 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)) 17:57:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:57:10 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 17:57:10 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 17:57:10 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 17:57:10 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 17:57:11 INFO - Downloading blessings-1.6.tar.gz 17:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:57:11 INFO - Installing collected packages: blessings 17:57:11 INFO - Running setup.py install for blessings 17:57:11 INFO - Successfully installed blessings 17:57:11 INFO - Cleaning up... 17:57:11 INFO - Return code: 0 17:57:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:57:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:57:11 INFO - Reading from file tmpfile_stdout 17:57:11 INFO - Current package versions: 17:57:11 INFO - argparse == 1.2.1 17:57:11 INFO - blessings == 1.6 17:57:11 INFO - blobuploader == 1.2.4 17:57:11 INFO - docopt == 0.6.1 17:57:11 INFO - functools32 == 3.2.3-2 17:57:11 INFO - jsonschema == 2.5.1 17:57:11 INFO - manifestparser == 1.1 17:57:11 INFO - mozInstall == 1.13 17:57:11 INFO - mozcrash == 1.0 17:57:11 INFO - mozdebug == 0.1 17:57:11 INFO - mozdevice == 0.51 17:57:11 INFO - mozfile == 1.2 17:57:11 INFO - mozhttpd == 0.7 17:57:11 INFO - mozinfo == 0.10 17:57:11 INFO - mozleak == 0.1 17:57:11 INFO - mozlog == 3.5 17:57:11 INFO - moznetwork == 0.27 17:57:11 INFO - mozprocess == 0.25 17:57:11 INFO - mozprofile == 0.28 17:57:11 INFO - mozrunner == 6.13 17:57:11 INFO - mozscreenshot == 0.1 17:57:11 INFO - mozsystemmonitor == 0.3 17:57:11 INFO - moztest == 0.8 17:57:11 INFO - mozversion == 1.4 17:57:11 INFO - psutil == 3.1.1 17:57:11 INFO - requests == 1.2.3 17:57:11 INFO - wsgiref == 0.1.2 17:57:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:11 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 0x136d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dc090>, '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 0x16dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', '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 17:57:11 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 17:57:11 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 17:57:11 INFO - Using env: {'DISPLAY': ':0', 17:57:11 INFO - 'HOME': '/home/cltbld', 17:57:11 INFO - 'LANG': 'en_US.UTF-8', 17:57:11 INFO - 'LANGUAGE': 'en_US:en', 17:57:11 INFO - 'LOGNAME': 'cltbld', 17:57:11 INFO - 'MAIL': '/var/mail/cltbld', 17:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:11 INFO - 'MOZ_NO_REMOTE': '1', 17:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:11 INFO - 'NO_EM_RESTART': '1', 17:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:11 INFO - 'PWD': '/builds/slave/test', 17:57:11 INFO - 'SHELL': '/bin/bash', 17:57:11 INFO - 'SHLVL': '1', 17:57:11 INFO - 'TERM': 'linux', 17:57:11 INFO - 'TMOUT': '86400', 17:57:11 INFO - 'USER': 'cltbld', 17:57:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', 17:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:11 INFO - '_': '/tools/buildbot/bin/python'} 17:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:11 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)) 17:57:11 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)) 17:57:11 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)) 17:57:11 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)) 17:57:11 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)) 17:57:11 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)) 17:57:11 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)) 17:57:11 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)) 17:57:11 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)) 17:57:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:57:13 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)) 17:57:13 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)) 17:57:13 INFO - Installing collected packages: simplejson 17:57:13 INFO - Running setup.py install for simplejson 17:57:13 INFO - building 'simplejson._speedups' extension 17:57:13 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 17:57:14 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 17:57:14 INFO - Successfully installed simplejson 17:57:14 INFO - Cleaning up... 17:57:14 INFO - Return code: 0 17:57:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dc090>, '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 0x16dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', '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 17:57:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:57:14 INFO - Using env: {'DISPLAY': ':0', 17:57:14 INFO - 'HOME': '/home/cltbld', 17:57:14 INFO - 'LANG': 'en_US.UTF-8', 17:57:14 INFO - 'LANGUAGE': 'en_US:en', 17:57:14 INFO - 'LOGNAME': 'cltbld', 17:57:14 INFO - 'MAIL': '/var/mail/cltbld', 17:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:14 INFO - 'MOZ_NO_REMOTE': '1', 17:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:14 INFO - 'NO_EM_RESTART': '1', 17:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:14 INFO - 'PWD': '/builds/slave/test', 17:57:14 INFO - 'SHELL': '/bin/bash', 17:57:14 INFO - 'SHLVL': '1', 17:57:14 INFO - 'TERM': 'linux', 17:57:14 INFO - 'TMOUT': '86400', 17:57:14 INFO - 'USER': 'cltbld', 17:57:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', 17:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:14 INFO - '_': '/tools/buildbot/bin/python'} 17:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:57:14 INFO - Cleaning up... 17:57:14 INFO - Return code: 0 17:57:14 INFO - Running post-action listener: _resource_record_post_action 17:57:14 INFO - Running post-action listener: _start_resource_monitoring 17:57:14 INFO - Starting resource monitoring. 17:57:14 INFO - [mozharness: 2017-10-14 00:57:14.476073Z] Finished create-virtualenv step (success) 17:57:14 INFO - [mozharness: 2017-10-14 00:57:14.476591Z] Running install step. 17:57:14 INFO - Running pre-action listener: _resource_record_pre_action 17:57:14 INFO - Running main action method: install 17:57:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:57:14 INFO - Reading from file tmpfile_stdout 17:57:14 INFO - Detecting whether we're running mozinstall >=1.0... 17:57:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:57:14 INFO - Reading from file tmpfile_stdout 17:57:14 INFO - Output received: 17:57:14 INFO - Usage: mozinstall [options] installer 17:57:14 INFO - Options: 17:57:14 INFO - -h, --help show this help message and exit 17:57:14 INFO - -d DEST, --destination=DEST 17:57:14 INFO - Directory to install application into. [default: 17:57:14 INFO - "/builds/slave/test"] 17:57:14 INFO - --app=APP Application being installed. [default: firefox] 17:57:14 INFO - mkdir: /builds/slave/test/build/application 17:57:14 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'] 17:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:57:29 INFO - Reading from file tmpfile_stdout 17:57:29 INFO - Output received: 17:57:29 INFO - /builds/slave/test/build/application/firefox/firefox 17:57:29 INFO - Running post-action listener: _resource_record_post_action 17:57:29 INFO - [mozharness: 2017-10-14 00:57:29.449889Z] Finished install step (success) 17:57:29 INFO - [mozharness: 2017-10-14 00:57:29.450035Z] Running setup-mitmproxy step. 17:57:29 INFO - Running pre-action listener: _resource_record_pre_action 17:57:29 INFO - Running main action method: setup_mitmproxy 17:57:29 INFO - Skipping: mitmproxy is not required 17:57:29 INFO - Running post-action listener: _resource_record_post_action 17:57:29 INFO - [mozharness: 2017-10-14 00:57:29.450572Z] Finished setup-mitmproxy step (success) 17:57:29 INFO - [mozharness: 2017-10-14 00:57:29.450674Z] Running run-tests step. 17:57:29 INFO - Running pre-action listener: _resource_record_pre_action 17:57:29 INFO - Running pre-action listener: _set_gcov_prefix 17:57:29 INFO - Running main action method: run_tests 17:57:29 WARNING - Try message not found. 17:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:57:29 INFO - Python 2.7.3 17:57:29 INFO - Return code: 0 17:57:29 INFO - grabbing minidump binary from tooltool 17:57: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')]} 17:57:29 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 0x16dc090>, '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 0x16dcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:57:29 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 17:57:29 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 17:57:29 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 17:57:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:57:29 INFO - Return code: 0 17:57:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:57:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:57:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:57:29 INFO - ENV: RUST_BACKTRACE is now full 17:57:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:57:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:57:29 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/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 17:57:29 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/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 17:57:29 INFO - Using env: {'DISPLAY': ':0', 17:57:29 INFO - 'HOME': '/home/cltbld', 17:57:29 INFO - 'LANG': 'en_US.UTF-8', 17:57:29 INFO - 'LANGUAGE': 'en_US:en', 17:57:29 INFO - 'LOGNAME': 'cltbld', 17:57:29 INFO - 'MAIL': '/var/mail/cltbld', 17:57:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:57:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:29 INFO - 'MOZ_NO_REMOTE': '1', 17:57:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:29 INFO - 'NO_EM_RESTART': '1', 17:57:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:29 INFO - 'PWD': '/builds/slave/test', 17:57:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:57:29 INFO - 'RUST_BACKTRACE': 'full', 17:57:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:57:29 INFO - 'SHELL': '/bin/bash', 17:57:29 INFO - 'SHLVL': '1', 17:57:29 INFO - 'TERM': 'linux', 17:57:29 INFO - 'TMOUT': '86400', 17:57:29 INFO - 'USER': 'cltbld', 17:57:29 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', 17:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:29 INFO - '_': '/tools/buildbot/bin/python'} 17:57:29 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/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 17:57:29 INFO - mozversion application_buildid: 20171013233710 17:57:29 INFO - mozversion application_changeset: 60546645c39020a15adea8341a27f5b525b34e2c 17:57:29 INFO - mozversion application_display_name: Firefox 17:57:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:57:29 INFO - mozversion application_name: Firefox 17:57:29 INFO - mozversion application_remotingname: firefox 17:57:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:57:29 INFO - mozversion application_vendor: Mozilla 17:57:29 INFO - mozversion application_version: 57.0 17:57:29 INFO - mozversion platform_buildid: 20171013233710 17:57:29 INFO - mozversion platform_changeset: 60546645c39020a15adea8341a27f5b525b34e2c 17:57:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:57:29 INFO - mozversion platform_version: 57.0 17:57:29 INFO - using testdate: 1507942649 17:57:29 INFO - actual date: 1507942649 17:57:29 INFO - starting webserver on 'localhost:42602' 17:57:29 INFO - SUITE-START | Running 2 tests 17:57:29 INFO - TEST-START | dromaeo_css 17:57:29 INFO - Initialising browser for dromaeo_css test... 17:57:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42602/getInfo.html -profile /tmp/tmp8W_pG_/profile 17:57:29 INFO - TEST-INFO | started process 29490 (/builds/slave/test/build/application/firefox/firefox http://localhost:42602/getInfo.html) 17:57:34 INFO - TEST-INFO | 29490: exit 0 17:57:34 INFO - Browser initialized. 17:57:34 INFO - Running cycle 1/1 for dromaeo_css test... 17:57:34 INFO - Using env: {'DISPLAY': ':0', 17:57:34 INFO - 'HOME': '/home/cltbld', 17:57:34 INFO - 'JSGC_DISABLE_POISONING': '1', 17:57:34 INFO - 'LANG': 'en_US.UTF-8', 17:57:34 INFO - 'LANGUAGE': 'en_US:en', 17:57:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:57:34 INFO - 'LOGNAME': 'cltbld', 17:57:34 INFO - 'MAIL': '/var/mail/cltbld', 17:57:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:57:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:57:34 INFO - 'MOZ_CRASHREPORTER': '1', 17:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:57:34 INFO - 'MOZ_NO_REMOTE': '1', 17:57:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:57:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:34 INFO - 'NO_EM_RESTART': '1', 17:57:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:34 INFO - 'PWD': '/builds/slave/test', 17:57:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:57:34 INFO - 'RUST_BACKTRACE': 'full', 17:57:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:57:34 INFO - 'SHELL': '/bin/bash', 17:57:34 INFO - 'SHLVL': '1', 17:57:34 INFO - 'TERM': 'linux', 17:57:34 INFO - 'TMOUT': '86400', 17:57:34 INFO - 'USER': 'cltbld', 17:57:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', 17:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:34 INFO - '_': '/tools/buildbot/bin/python'} 17:57:34 INFO - TEST-INFO | started process 29722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8W_pG_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:57:34 INFO - PID 29722 | 17:57:34 INFO - PID 29722 | (/builds/slave/test/build/application/firefox/firefox:29771): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:57:34 INFO - PID 29722 | 17:57:45 INFO - PID 29722 | RSS: Main: 143560704 17:57:45 INFO - PID 29722 | 18:00:42 INFO - PID 29722 | Cycle 1(1): loaded http://localhost:42602/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42602/tests/dromaeo/cssquery-ext.html) 18:00:43 INFO - PID 29722 | RSS: Main: 146477056 18:00:43 INFO - PID 29722 | 18:03:45 INFO - PID 29722 | Cycle 1(1): loaded http://localhost:42602/tests/dromaeo/cssquery-ext.html (next: http://localhost:42602/tests/dromaeo/cssquery-jquery.html) 18:03:45 INFO - PID 29722 | RSS: Main: 145055744 18:03:45 INFO - PID 29722 | 18:06:47 INFO - PID 29722 | Cycle 1(1): loaded http://localhost:42602/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42602/tests/dromaeo/cssquery-mootools.html) 18:06:48 INFO - PID 29722 | RSS: Main: 144666624 18:06:48 INFO - PID 29722 | 18:09:49 INFO - PID 29722 | Cycle 1(1): loaded http://localhost:42602/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42602/tests/dromaeo/cssquery-prototype.html) 18:09:50 INFO - PID 29722 | RSS: Main: 146333696 18:09:50 INFO - PID 29722 | 18:12:53 INFO - PID 29722 | Cycle 1(1): loaded http://localhost:42602/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42602/tests/dromaeo/cssquery-yui.html) 18:12:53 INFO - PID 29722 | RSS: Main: 147349504 18:12:53 INFO - PID 29722 | 18:15:55 INFO - PID 29722 | Cycle 1(1): loaded http://localhost:42602/tests/dromaeo/cssquery-yui.html (next: http://localhost:42602/tests/dromaeo/cssquery-dojo.html) 18:15:55 INFO - PID 29722 | RSS: Main: 150315008 18:15:55 INFO - PID 29722 | 18:15:55 INFO - PID 29722 | __start_tp_report 18:15:55 INFO - PID 29722 | _x_x_mozilla_page_load 18:15:55 INFO - PID 29722 | _x_x_mozilla_page_load_details 18:15:55 INFO - PID 29722 | |i|pagename|runs| 18:15:55 INFO - PID 29722 | |0;dojo.html;4039.8990025249373;4045.3931910213473;4051.331530297501;4063.593640635935;4077.1234184650293;6480.449161821245;6567.376099270574;6574.572652777566;6661.16735408074;6693.765718199864;6548.508861835369;6575.967120164404;6661.067450556926;6692.29730878258;6713.899291510631;5874.412558744113;5974.88050238996;5982.970085149568;5995.220621319222;6020.698965051752;5912.083627037816;5925.822225333247;5929.140274660172;5954.434328738763;6049.153118563405;5942.851428714273;5987.610805297663;6010.27876654802;6028.849278768044;6045.455908968192;5953.58324917256;5962.821115366546;5982.282126144891;6003.399660033983;6020.96989515054;5874.441928016831;5917.733701983421;5947.10793380992;6049.939500604982;6099.878002439927;6478.611283323015;6576.408123268929;6583.341665833426;6601.471882249457;6606.8017959461295;7168.283171682842;7175.103112110986;7230.2046774854725;7232.1683006454405;7263.527870688388;7108.075950126502;7186.353228209487;7246;7312.049433573655;7321.670524826395;6620.503462240303;6665.900011499832;6702.095217145672;6733.528652994243;6745.224299205556;7288.018901100999;7330.8900366494545;7364.3372096511575;7381.88927166093;7418.332350088518;7017.614031228331;7044.823879403056;7089.964550177217;7105;7121.35907768293;7037;7154.141503019567;7192.100987376578;7237.167725711611;7246.021787058785;7142.071530700976;7146.92853071473;7221.747238846615;7234;7236.312550307713;7150.284971502808;7157.498975071695;7236.565806051653;7238.963805180941;7255.347018768336;5212.635115541876;5326.813561525328;5330.973345133327;5335.893282134336;5369.006733754268;4822.903541929142;4882.389701287339;4908.680935739166;4944.456109827916;4979.153543897546;6707.3963343298365;6719.428848547928;6782.626955517494;6806.149231346082;6810.557313774589;7042.753503627348;7120.857582848314;7134.750283740044;7180.676869540883;7232.783016509513;6577.736890524326;6638.17022872141;6665.466762659073;6683;6687.431568316651;6057.697115144225;6065.059915713072;6144.477719393813;6157.876842463125;6169.167162433014;7284.016657751242;7330.706771729071;7377.741779037815;7465.440091993014;7512.436567257478;7089.078419805599;7112.644367781693;7170.211276759553;7175.641217939186;7187.712491500281;7359.705611775683;7370.373518251009;7462.44031697614;7507.587082710284;7508.399328053852;6835.316468353125;6949.652517374212;6983.266756990646;7061.364477197077;7089.255628158969;7154.964225178841;7249.166345870292;7249.456290778318;7258.600776957318;7275.781726548212;6897.448204143757;6911.550749201286;6913.41235994926;6998.790036298919;7002.264762199896;6745.628990405378;6793.490488213305;6902.551334163263;6928.099347084847;6939.306069393222;6858.074159988537;6906.792796216121;6924.515283930076;6939.653017349011;6952.826179345557;6932.168139823253;6965.373116419547;6998.825029374307;7023.367896889305;7085.787426377217;6624.470042396693;6624.9337506624315;6691.197056353269;6695.196576410862;6745.628990405575 18:15:55 INFO - PID 29722 | |1;ext.html;970.3838062830105;987.1806400687431;1001.664442411792;1030.2839526529065;1038.3250886923502;46246.768766156165;47056.52943470573;47075;47103.52896471034;47147.76426117869;43104;43398.349024764655;43453.34819977695;43468.782656086674;43528;7954.880676789839;8064.395170362217;8094.109647938722;8099.716509922154;8101.230383113595;8007.479513831582;8066.878996815052;8098.392620553453;8112.148224436438;8142.877856832122;8750.781230469258;8942.821143577125;8943.865842012376;8948.8657670135;8952.910470895273;8783.868241976408;8805.911940880573;8822.735317940407;8846.5134417607;8867;8695;8713;8737.868931966026;8775.736727898173;8796;42128.78935605333;42999.78500107479;43067.35398969018;43091;43159;3811.790351530665;3816.4466152407745;3824.063104539378;3830.69354451646;3847.557530883956;33863;33909.83045084783;34042.14894627654;34101.82949085264;34105.6589434105;5621.128725047583;5675.347335056439;5678.375378708339;5708.828735137952;5806.954748145332;231521;231676.84161579254;231797;232747;233418;52895.47104528982;53156.734216329445;53192.20211696828;53330;57647.71176144092;60241.69879150664;60884;60905.69547152236;61022.38977610256;61261.38738612646;17051.829481705023;17100;17138.657226855394;17148.82851171497;17167.570810729583;13617.046806723434;13759.587212383445;13760.518381856788;13774.793378099337;13809.447622095204;16363.181840907908;16516;16522.339106435847;16573;16640.583985400463;6158.445739883432;6258;6336.556441049082;6420.454261387835;6499.8700025999215;1121.9958137466922;1124.2074337591978;1127.4869934179928;1128.249713940237;1135.3017893995134;25848.353791155372;25853.74146258551;25959.480810384066;26430.6035409469;26452.470950580882;1218.5734992752466;1229.2685851918095;1231.975360492785;1241.4413513918773;1244.813278008306;13601.931990340183;13913.721725565432;14028.719425611635;14195.219262940638;14197.929010354883;305145;311476;313829;321683;323704;67228.66385668138;67369;67943.3205667937;67962;67995.32004679988;1529.4799768078906;1541.3372249932413;1545.3741234799925;1552.4566401759519;1587.745960646291;31690.366192675556;31725.841370792998;31746.682533175295;32483.512747309283;32588;43639.781801090794;43838.90402739957;43882;43930.780346099345;43937.34093988657;259263;259368;259489;260061;260599;38022;39223.41164882586;39410.80294598509;39512.2097558053;39614.207715846096;46811.76594117007;48177.277340840614;48765.5123448761;48907.04371825087;49200;34842;35395.46906796349;35620.109497262776;35946.28107437889;36143;34961.82519087388;35694.82152589221;36200;36353.81823090868;36504;42790.786046069574;42816.78591607022;42881;43328.78335608302;43450.34824477572;34340.65659343375;34347.65652343544;34657.13357166091;35005.64994350126;35257.647423525435;25496.617550737126;25770.330527283968;25914.740852591985;25952.610710838973;26673.199804005133 18:15:55 INFO - PID 29722 | |2;jquery.html;634.5991561181435;635.4996366537953;642.0812423343614;643.1968250709912;655.9996006090711;23729.644055339184;24515.632265516007;24521.63217551736;24554.631680524762;24629.876850615765;25017.62473562898;25166.874165629193;25370.873145634247;25400.11099611514;25427.36431589211;6387.776427825027;6599.406053455188;6625.0393692914495;6645.235797883232;6700.430463410604;6601.042848786923;6693.096431981693;6697.5981441113445;6709.228438729536;6713.462922966175;6510.576812507195;6671.232808227068;6691.832704182386;6692.230393504737;6745.3591908768585;6743.49423793215;6809.387155156035;6809.387155156035;6809.965950170217;6812.352826481526;6335.904961425582;6375.4262116409745;6379.904301435482;6382.744690212386;6397.456216221627;29368.41263174746;30354.84822575873;30834.38331233385;30836.691633083607;30850.38299234025;2327.5344931013865;2365.503244318695;2368.609179485383;2369.194473878872;2369.3721163891582;20480.69278960817;20933.79066209349;20950.895245523676;21035.368938931704;21046.473838154016;2515.73584773598;2573.8713064346894;2634.209737078869;2644.6694163229595;2647.139679604117;153083.2345838275;159796;167284;176830;178532;16396.918015409847;16924.568663907638;16941.070625281052;17003.489895303162;17012.574685632957;27175.456490870467;27184.320391990357;27201.45597088047;27253.727462725514;27261.86369068142;10763.24657273999;10842.644669416322;10876.782464350827;10988.725281867857;11084.889151108548;9789.386517145416;9893;9894.208463322917;9903.900960990299;9957.302988790716;9741.061647246375;9769.364991275545;10077.647282345082;10148.695539133838;10201.795964080677;2850.743433091032;2917.9562306565417;2927.487689654302;3020.2449387653087;3031.681673424303;1023.5291765787672;1043.087298613713;1043.6295115234134;1056.6513050693252;1059.5073290919606;21417.46456338573;21496.032678529504;21710.565788684136;21968;22341.329760107223;1118.245184500459;1119.3116233516491;1127.2503784983057;1129.3619105205532;1144.5993902134187;11587.942060289644;11786.705332366759;11811.114166437379;11924.224925379822;11958.760824783629;641389;656460;656635;670217;672242;134327;134457.3277133608;135117;138462;138535;1134.4214450630072;1175.8471398718284;1199.6401079676236;1245.4644502863675;1257.43415463042;21488.005885218285;22126.336209913727;22149.44626384289;22166.335009949726;22218.44453888666;63597;64941.35058649542;66524.66737666281;67298.3270167292;67343.66328168327;82701.58649206716;85255;86393.56803215944;87327;88751.55624221837;16045.919770401073;16110.67778644444;16169.514914552583;16347;16368.754468683217;24308;24473.755262447146;24475.877620611784;24689.25932222036;24699.62950555779;19733.1120099593;19807.801921981172;19835.20659173617;19835.504112396728;19914.60170796605;16911.746323804906;17322.653546929243;17564.648707026045;17914.552136196176;18212.998285094447;19732.30936917201;20287.69568456445;20679.58640827205;20816.167353306304;20835.583288334452;15614.687706246039;15746.448874289345;15945.760813587573;15991.840081599035;16009.519714408587;19561.706574401112;19573.608527829078;19925.202991880164;19971;20170.697439538126 18:15:55 INFO - PID 29722 | |3;mootools.html;1377.2149874571494;1421.9857801421983;1431.8281806183259;1438.6834896322805;1456.0317388936357;17604.91197544012;18284.26862925483;18291.451256462293;18304.17631206597;18308.450746477592;17939.192736326862;18096.366627168052;18213.81786182138;18255.452336429895;18262.269509219615;2790.7627851632583;2833.6457942757156;2840.3041254892582;2847.103162503815;2847.857607119646;2671.345520347518;2763.3782398960275;2763.6407267055256;2764.834109953399;2765.7234276572385;2610.9608355874584;2730.494858451183;2738.7124351943057;2837.8581070946475;2840.7017263187377;2670.519306524825;2695.487857307125;2716.307341627892;2721.319670082479;2730.1127133681634;2697.8516181610003;2717.714639962815;2733.8906443742226;2734.0567504211017;2757.379589592346;17066.658666826595;17245.913770431194;17439.128043597768;17576.560585985324;17608.471745847644;8528;8800.031996480382;8838.072002439716;8842.602082906285;8859;5859.1504231886565;6036.667983260919;6099.878002439971;6151.87696246077;6169.259688837324;2066.865653732503;2100.422383844455;2101.170037835062;2111.5430353056495;2193.1775584155944;32177.356452870812;32291.51562726561;32322.838385808154;32388.190295242573;32472.350552988806;7473.663685134182;7533.773986780406;7555.395568354628;7632;7702.460827742004;20651;20709.378718638465;20710.96445177765;20775.168993240102;20839.166433342496;8609;8755.474671519729;8783.824323513494;8791.868121978176;8805.955970220108;7633;7775.92224077752;7809.843803123906;7816.687332506636;7878;6102.542309326729;6204.565680402418;6244.968775156095;6281.3404592518045;6300.117983482316;1590.2207918120268;1607.8311777263452;1823.854091672663;1859.2562974809914;1859.3678149429259;982.4350998176077;1005.1657124586576;1007.7430255284855;1008.7125169326854;1011.3527342500805;9567.569459374345;9760.023997600183;9838.36050656705;9858.95070524657;9948.303618746762;822.7696245051395;827.2058823529479;828.8963879515061;845.8054647431002;887.8845750052452;5518.420565840609;5764.798232061858;5900.852478687982;5931.228940237742;5986.551008674367;25634.743652563608;26297.474050518882;26461.073862414723;26946.461070778474;27071.323216919736;25644;26045.869770651025;26527.734722652913;26705.19884403471;26790.330241743723;12974.675633109247;13102.410391532214;13201.47194112244;13306.268155251553;13311.733765324832;9455.763605909908;9503.239740820856;9555.04449555039;9573.425594464354;9596.568154433207;22038.99999999936;22158.667619986034;22249.555008900054;22549.43626409353;22853.657195141754;22738;22847.543049139258;22958.311250662508;23003.65494517617;23487.29538113791;12428.689282767642;12561.120721549403;12761.680957976125;12765.48938042505;12767.361631918553;15809.446669366516;15940.68118637644;16122.435714749927;16140.757888631446;16271.105089220207;11900.642980710592;12120.515179392725;12286;12350.62948111558;12453.937730311653;11736;11861.525538978343;12047.33739644328;12169.634910952685;12312.507499699912;11415.657530274106;11642.41787910618;11688.88311116912;11700;11701.180917335705;8488.074255670792;8634.654613815377;8660.870086948575;8673.91326086731;8676.132386761274;8775.561221939006;8959.596818143069;9042.18620324174;9050;9065.728028159167 18:15:55 INFO - PID 29722 | |4;prototype.html;530.2708775433779;560.0845109724743;566.8979583674936;569.4135040907864;603.3393434189562;6296.212973378328;6311.147995020671;6332.3351048139975;6378.330275321094;6407;6262;6313.7474501020015;6316.494680425566;6359.6184228946295;6376.362363763621;5196.350456192976;5221.556167725729;5236.528712415882;5260.685767966176;5267.710275934832;5028;5133.768980395891;5195.324607801;5209.843704688866;5241.528262456378;5103.974480127594;5145.125328694112;5148.275327765203;5161.896762064756;5177.30106435632;5117.641765076446;5143.305653736735;5177.275181474615;5177.637565370425;5223.764930578114;4672.532746725335;4689.554492323224;4702.625174286997;4703.858884233478;4723.07899959508;6320.810375688737;6332.4934005279465;6355.332690067523;6374.458171055466;6388.936110638881;5997.790077347272;6013.188219590387;6103.42017508336;6160.383961603849;6163.198784158076;6753.223379311393;6776.6611669416825;6793.966030169818;6811.386975172259;6826.761063362758;5022;5224.242484839715;5233.325335892516;5256.553192978601;5274.208868669731;6922.480813938974;6929.461202912101;7014;7057.082579264663;7077.221505634325;5366.651167674088;5368.516833485005;5392.110301800238;5415.729213539386;5419.268398766195;5417.918731219035;5445.537129343971;5459.843361872117;5475.589330800206;5490.533304669068;5976.342602313742;6065.484433823174;6067.605605635619;6069.36271691466;6105.450509454082;6879.140107486564;6888.517803753789;6932.757353492704;6937.653117344113;6939.340762627542;1849.7906132859746;1877.596316791869;1885.849132069431;1887.3960332693407;1896.061449582438;1303.5958852755487;1345.7173993461483;1352.648311439033;1358.809766632672;1359.1709057474932;6389.520785941073;6405.583637063576;6438.742450301936;6439.710213040425;6444.806655800334;6901.896471552931;6945.201301850251;6968.1638203414905;6995.125609298838;7006.754763583352;6382.904256436157;6414.294427612959;6425.490009847682;6482.870342593216;6505.7397704092255;3628.729944519397;3654.7258955577904;3669.3028324618235;3677.9080522986606;3700.481932529448;7166.491727895299;7197.964010179916;7199.784006479814;7210.978832674776;7227.638618069181;7115.146182458035;7196.136463624399;7203.711851525985;7228.168760592494;7234.24040475753;7022.367986881205;7084.43324534036;7121.608311542915;7149.857002859913;7155.069840920647;6799.388055075067;6856.931430685829;6867.828304292432;6871.5189936703955;6901.206361268318;6830;6852.246252912076;6876.828079297858;6899.517033807585;6944.861102777815;7032.542884712478;7116.679749411185;7124.254557633206;7150.785476435715;7160.069191005136;5317.787288508416;5321.164198351563;5328.866778330573;5385.353757548963;5394.730263486731;6612.603243805387;6647.767328143492;6820;6839.316068393121;6928.965355173192;6596.439302659328;6611.933880661132;6641.074088514277;6648.83377915556;6742.42689371409;6585.3085426029575;6612.636305003271;6614.10709554204;6694.096296999843;6734.831629209309;6559.967200163968;6600.504962127956;6635.8009259722285;6641.575824824001;6659.633720145439;6740.136081609032;6743.696533656095;6789.524733268821;6805.149356330458;6824.692888820115;6547.214334279917;6567.474602031922;6579.243387010555;6583.275839657538;6622.337766223532 18:15:55 INFO - PID 29722 | |5;yui.html;1008.8385858262675;1013.1236480444416;1031;1038.2317085356838;1047.3611097230687;18848.90575547122;19337.903310483463;19347.516312092204;19362.419127426165;19366.612667746653;18857.33999310021;18902.716459253123;18973.905130474363;19103.808961910378;19211.32760353388;1050.931689440186;1080.8000519903803;1087.325857968061;1092.9945350273238;1093.5899037860802;1095.775366049958;1099.6096385783053;1099.6920862158609;1099.8900109988977;1101.262154356583;1100.372787511119;1118.0943435816973;1118.6028959719304;1121.4785124916912;1121.938293393863;1115.6485707002269;1115.648570700231;1115.7880002799482;1117.4133579870552;1117.4245263689206;833.2750507058897;833.3041910005153;835.9665613375457;839.290799274612;839.315957494646;17723.822761772346;20718.896405518026;20910;21054;21203.68194477084;21324.786752132437;21863.344099677037;22064.88967555168;22132;22214.444638883997;17797.822021779746;18244.726329105073;18276;18288.81711182898;18340.54148646281;4160.167966406731;4172;4195.748255104673;4199.538050814408;4210.536840947493;162683;165938.3406165935;166547.99999999878;169401;170366;17469.91265043692;17522.649547008987;17605.911970440324;17622.502087322464;17635.470935871945;33293.66706332954;33370.49944250838;33388;33427.331453371284;33494;9367.578458969227;9615.663451779154;9668.951655241679;9676.371035882645;9679.032096790264;4794.95205047952;4923.507649235048;4940.209566469348;4940.654154209171;4948.851534453972;5916.852078698067;5961.225040744762;5977.910331345033;5988.880222395528;5991.610545314541;1112.232559533919;1112.8108221602347;1116.7654792493668;1120.1095129372168;1121.5233525751523;767.3362541401648;770.0836005153849;788.2354116507094;790.4032455496178;794.0035255753992;11632.592859249886;12354.691132721753;12582.370881456074;13339.733205336033;13490;759.164918589547;766.306492624176;766.5975362934392;773.9883901741479;780.9062912450429;5726.627769194989;5740.626859254218;5796.478316951495;5856.59003869725;5909.143174239797;154038;155921;157136.21431892767;157314.21342893213;157385;137890.31054844862;138897;140139;140285;143656.28171859073;118648.8135118655;119016;119663.803361967;121416.39291803485;122822.38588806998;10711.517981690999;10906.61826836057;10921.945390273315;11078.113750899747;11238.775224495628;56251.71874140603;56692.71653641705;57352.42647573471;57918.710406447695;58895.41104589071;70751;72394;72923;73575.63212183905;75055.24944750701;15080.622984425478;15126.470573529874;15494.302756376215;15603.765943511084;15628.140452275235;17914.46256612304;18385.17266722974;18487.445376638723;18513.90743046276;18587.34944276944;17030.40393586268;17285.74071388905;17311;17434.21546030457;17507.82492175062;14367.425302988182;14585.708285834437;14597.051191672508;14597.197154156624;14658.486952956595;16159.515214543113;16490.83509164941;16807.495775126765;16870.240839162023;16898.32406703718;12470.625881223577;12825.743485130432;12868.292243926673;12870.292133932724;12892.871071289166;12347.19743216688;12398.752024959631;12476.500939962663;12727.2999984998;12771.106022578702 18:15:55 INFO - PID 29722 | __end_tp_report 18:15:55 INFO - PID 29722 | __start_cc_report 18:15:55 INFO - PID 29722 | _x_x_mozilla_cycle_collect,227 18:15:55 INFO - PID 29722 | __end_cc_report 18:15:55 INFO - PID 29722 | __startTimestamp1507943755424__endTimestamp 18:15:55 INFO - PID 29722 | 18:15:55 INFO - PID 29722 | ------- Summary: start ------- 18:15:55 INFO - PID 29722 | Number of tests: 6 18:15:55 INFO - PID 29722 | 18:15:55 INFO - PID 29722 | [#0] dojo.html Cycles:165 Average:6618.29 Median:6835.32 stddev:758.33 (11.1%) stddev-sans-first:733.19 18:15:55 INFO - PID 29722 | Values: 4039.9 4045.4 4051.3 4063.6 4077.1 6480.4 6567.4 6574.6 6661.2 6693.8 6548.5 6576.0 6661.1 6692.3 6713.9 5874.4 5974.9 5983.0 5995.2 6020.7 5912.1 5925.8 5929.1 5954.4 6049.2 5942.9 5987.6 6010.3 6028.8 6045.5 5953.6 5962.8 5982.3 6003.4 6021.0 5874.4 5917.7 5947.1 6049.9 6099.9 6478.6 6576.4 6583.3 6601.5 6606.8 7168.3 7175.1 7230.2 7232.2 7263.5 7108.1 7186.4 7246.0 7312.0 7321.7 6620.5 6665.9 6702.1 6733.5 6745.2 7288.0 7330.9 7364.3 7381.9 7418.3 7017.6 7044.8 7090.0 7105.0 7121.4 7037.0 7154.1 7192.1 7237.2 7246.0 7142.1 7146.9 7221.7 7234.0 7236.3 7150.3 7157.5 7236.6 7239.0 7255.3 5212.6 5326.8 5331.0 5335.9 5369.0 4822.9 4882.4 4908.7 4944.5 4979.2 6707.4 6719.4 6782.6 6806.1 6810.6 7042.8 7120.9 7134.8 7180.7 7232.8 6577.7 6638.2 6665.5 6683.0 6687.4 6057.7 6065.1 6144.5 6157.9 6169.2 7284.0 7330.7 7377.7 7465.4 7512.4 7089.1 7112.6 7170.2 7175.6 7187.7 7359.7 7370.4 7462.4 7507.6 7508.4 6835.3 6949.7 6983.3 7061.4 7089.3 7155.0 7249.2 7249.5 7258.6 7275.8 6897.4 6911.6 6913.4 6998.8 7002.3 6745.6 6793.5 6902.6 6928.1 6939.3 6858.1 6906.8 6924.5 6939.7 6952.8 6932.2 6965.4 6998.8 7023.4 7085.8 6624.5 6624.9 6691.2 6695.2 6745.6 18:15:55 INFO - PID 29722 | 18:15:55 INFO - PID 29722 | [#1] ext.html Cycles:180 Average:45737.49 Median:3820.25 stddev:70705.24 (1850.8%) stddev-sans-first:70823.69 18:15:55 INFO - PID 29722 | Values: 970.4 987.2 1001.7 1030.3 1038.3 46246.8 47056.5 47075.0 47103.5 47147.8 43104.0 43398.3 43453.3 43468.8 43528.0 7954.9 8064.4 8094.1 8099.7 8101.2 8007.5 8066.9 8098.4 8112.1 8142.9 8750.8 8942.8 8943.9 8948.9 8952.9 8783.9 8805.9 8822.7 8846.5 8867.0 8695.0 8713.0 8737.9 8775.7 8796.0 42128.8 42999.8 43067.4 43091.0 43159.0 3811.8 3816.4 3824.1 3830.7 3847.6 33863.0 33909.8 34042.1 34101.8 34105.7 5621.1 5675.3 5678.4 5708.8 5807.0 231521.0 231676.8 231797.0 232747.0 233418.0 52895.5 53156.7 53192.2 53330.0 57647.7 60241.7 60884.0 60905.7 61022.4 61261.4 17051.8 17100.0 17138.7 17148.8 17167.6 13617.0 13759.6 13760.5 13774.8 13809.4 16363.2 16516.0 16522.3 16573.0 16640.6 6158.4 6258.0 6336.6 6420.5 6499.9 1122.0 1124.2 1127.5 1128.2 1135.3 25848.4 25853.7 25959.5 26430.6 26452.5 1218.6 1229.3 1232.0 1241.4 1244.8 13601.9 13913.7 14028.7 14195.2 14197.9 305145.0 311476.0 313829.0 321683.0 323704.0 67228.7 67369.0 67943.3 67962.0 67995.3 1529.5 1541.3 1545.4 1552.5 1587.7 31690.4 31725.8 31746.7 32483.5 32588.0 43639.8 43838.9 43882.0 43930.8 43937.3 259263.0 259368.0 259489.0 260061.0 260599.0 38022.0 39223.4 39410.8 39512.2 39614.2 46811.8 48177.3 48765.5 48907.0 49200.0 34842.0 35395.5 35620.1 35946.3 36143.0 34961.8 35694.8 36200.0 36353.8 36504.0 42790.8 42816.8 42881.0 43328.8 43450.3 34340.7 34347.7 34657.1 35005.6 35257.6 25496.6 25770.3 25914.7 25952.6 26673.2 18:15:55 INFO - PID 29722 | 18:15:55 INFO - PID 29722 | [#2] jquery.html Cycles:180 Average:42376.45 Median:2368.90 stddev:110423.06 (4661.4%) stddev-sans-first:110688.35 18:15:55 INFO - PID 29722 | Values: 634.6 635.5 642.1 643.2 656.0 23729.6 24515.6 24521.6 24554.6 24629.9 25017.6 25166.9 25370.9 25400.1 25427.4 6387.8 6599.4 6625.0 6645.2 6700.4 6601.0 6693.1 6697.6 6709.2 6713.5 6510.6 6671.2 6691.8 6692.2 6745.4 6743.5 6809.4 6809.4 6810.0 6812.4 6335.9 6375.4 6379.9 6382.7 6397.5 29368.4 30354.8 30834.4 30836.7 30850.4 2327.5 2365.5 2368.6 2369.2 2369.4 20480.7 20933.8 20950.9 21035.4 21046.5 2515.7 2573.9 2634.2 2644.7 2647.1 153083.2 159796.0 167284.0 176830.0 178532.0 16396.9 16924.6 16941.1 17003.5 17012.6 27175.5 27184.3 27201.5 27253.7 27261.9 10763.2 10842.6 10876.8 10988.7 11084.9 9789.4 9893.0 9894.2 9903.9 9957.3 9741.1 9769.4 10077.6 10148.7 10201.8 2850.7 2918.0 2927.5 3020.2 3031.7 1023.5 1043.1 1043.6 1056.7 1059.5 21417.5 21496.0 21710.6 21968.0 22341.3 1118.2 1119.3 1127.3 1129.4 1144.6 11587.9 11786.7 11811.1 11924.2 11958.8 641389.0 656460.0 656635.0 670217.0 672242.0 134327.0 134457.3 135117.0 138462.0 138535.0 1134.4 1175.8 1199.6 1245.5 1257.4 21488.0 22126.3 22149.4 22166.3 22218.4 63597.0 64941.4 66524.7 67298.3 67343.7 82701.6 85255.0 86393.6 87327.0 88751.6 16045.9 16110.7 16169.5 16347.0 16368.8 24308.0 24473.8 24475.9 24689.3 24699.6 19733.1 19807.8 19835.2 19835.5 19914.6 16911.7 17322.7 17564.6 17914.6 18213.0 19732.3 20287.7 20679.6 20816.2 20835.6 15614.7 15746.4 15945.8 15991.8 16009.5 19561.7 19573.6 19925.2 19971.0 20170.7 18:15:55 INFO - PID 29722 | 18:15:55 INFO - PID 29722 | [#3] mootools.html Cycles:180 Average:10876.93 Median:14820.97 stddev:8182.39 (55.2%) stddev-sans-first:8174.21 18:15:55 INFO - PID 29722 | Values: 1377.2 1422.0 1431.8 1438.7 1456.0 17604.9 18284.3 18291.5 18304.2 18308.5 17939.2 18096.4 18213.8 18255.5 18262.3 2790.8 2833.6 2840.3 2847.1 2847.9 2671.3 2763.4 2763.6 2764.8 2765.7 2611.0 2730.5 2738.7 2837.9 2840.7 2670.5 2695.5 2716.3 2721.3 2730.1 2697.9 2717.7 2733.9 2734.1 2757.4 17066.7 17245.9 17439.1 17576.6 17608.5 8528.0 8800.0 8838.1 8842.6 8859.0 5859.2 6036.7 6099.9 6151.9 6169.3 2066.9 2100.4 2101.2 2111.5 2193.2 32177.4 32291.5 32322.8 32388.2 32472.4 7473.7 7533.8 7555.4 7632.0 7702.5 20651.0 20709.4 20711.0 20775.2 20839.2 8609.0 8755.5 8783.8 8791.9 8806.0 7633.0 7775.9 7809.8 7816.7 7878.0 6102.5 6204.6 6245.0 6281.3 6300.1 1590.2 1607.8 1823.9 1859.3 1859.4 982.4 1005.2 1007.7 1008.7 1011.4 9567.6 9760.0 9838.4 9859.0 9948.3 822.8 827.2 828.9 845.8 887.9 5518.4 5764.8 5900.9 5931.2 5986.6 25634.7 26297.5 26461.1 26946.5 27071.3 25644.0 26045.9 26527.7 26705.2 26790.3 12974.7 13102.4 13201.5 13306.3 13311.7 9455.8 9503.2 9555.0 9573.4 9596.6 22039.0 22158.7 22249.6 22549.4 22853.7 22738.0 22847.5 22958.3 23003.7 23487.3 12428.7 12561.1 12761.7 12765.5 12767.4 15809.4 15940.7 16122.4 16140.8 16271.1 11900.6 12120.5 12286.0 12350.6 12453.9 11736.0 11861.5 12047.3 12169.6 12312.5 11415.7 11642.4 11688.9 11700.0 11701.2 8488.1 8634.7 8660.9 8673.9 8676.1 8775.6 8959.6 9042.2 9050.0 9065.7 18:15:55 INFO - PID 29722 | 18:15:55 INFO - PID 29722 | [#4] prototype.html Cycles:180 Average:5788.39 Median:6397.55 stddev:1602.78 (25.1%) stddev-sans-first:1557.93 18:15:55 INFO - PID 29722 | Values: 530.3 560.1 566.9 569.4 603.3 6296.2 6311.1 6332.3 6378.3 6407.0 6262.0 6313.7 6316.5 6359.6 6376.4 5196.4 5221.6 5236.5 5260.7 5267.7 5028.0 5133.8 5195.3 5209.8 5241.5 5104.0 5145.1 5148.3 5161.9 5177.3 5117.6 5143.3 5177.3 5177.6 5223.8 4672.5 4689.6 4702.6 4703.9 4723.1 6320.8 6332.5 6355.3 6374.5 6388.9 5997.8 6013.2 6103.4 6160.4 6163.2 6753.2 6776.7 6794.0 6811.4 6826.8 5022.0 5224.2 5233.3 5256.6 5274.2 6922.5 6929.5 7014.0 7057.1 7077.2 5366.7 5368.5 5392.1 5415.7 5419.3 5417.9 5445.5 5459.8 5475.6 5490.5 5976.3 6065.5 6067.6 6069.4 6105.5 6879.1 6888.5 6932.8 6937.7 6939.3 1849.8 1877.6 1885.8 1887.4 1896.1 1303.6 1345.7 1352.6 1358.8 1359.2 6389.5 6405.6 6438.7 6439.7 6444.8 6901.9 6945.2 6968.2 6995.1 7006.8 6382.9 6414.3 6425.5 6482.9 6505.7 3628.7 3654.7 3669.3 3677.9 3700.5 7166.5 7198.0 7199.8 7211.0 7227.6 7115.1 7196.1 7203.7 7228.2 7234.2 7022.4 7084.4 7121.6 7149.9 7155.1 6799.4 6856.9 6867.8 6871.5 6901.2 6830.0 6852.2 6876.8 6899.5 6944.9 7032.5 7116.7 7124.3 7150.8 7160.1 5317.8 5321.2 5328.9 5385.4 5394.7 6612.6 6647.8 6820.0 6839.3 6929.0 6596.4 6611.9 6641.1 6648.8 6742.4 6585.3 6612.6 6614.1 6694.1 6734.8 6560.0 6600.5 6635.8 6641.6 6659.6 6740.1 6743.7 6789.5 6805.1 6824.7 6547.2 6567.5 6579.2 6583.3 6622.3 18:15:55 INFO - PID 29722 | 18:15:55 INFO - PID 29722 | [#5] yui.html Cycles:180 Average:28737.16 Median:17515.24 stddev:44509.56 (254.1%) stddev-sans-first:44585.73 18:15:55 INFO - PID 29722 | Values: 1008.8 1013.1 1031.0 1038.2 1047.4 18848.9 19337.9 19347.5 19362.4 19366.6 18857.3 18902.7 18973.9 19103.8 19211.3 1050.9 1080.8 1087.3 1093.0 1093.6 1095.8 1099.6 1099.7 1099.9 1101.3 1100.4 1118.1 1118.6 1121.5 1121.9 1115.6 1115.6 1115.8 1117.4 1117.4 833.3 833.3 836.0 839.3 839.3 17723.8 20718.9 20910.0 21054.0 21203.7 21324.8 21863.3 22064.9 22132.0 22214.4 17797.8 18244.7 18276.0 18288.8 18340.5 4160.2 4172.0 4195.7 4199.5 4210.5 162683.0 165938.3 166548.0 169401.0 170366.0 17469.9 17522.6 17605.9 17622.5 17635.5 33293.7 33370.5 33388.0 33427.3 33494.0 9367.6 9615.7 9669.0 9676.4 9679.0 4795.0 4923.5 4940.2 4940.7 4948.9 5916.9 5961.2 5977.9 5988.9 5991.6 1112.2 1112.8 1116.8 1120.1 1121.5 767.3 770.1 788.2 790.4 794.0 11632.6 12354.7 12582.4 13339.7 13490.0 759.2 766.3 766.6 774.0 780.9 5726.6 5740.6 5796.5 5856.6 5909.1 154038.0 155921.0 157136.2 157314.2 157385.0 137890.3 138897.0 140139.0 140285.0 143656.3 118648.8 119016.0 119663.8 121416.4 122822.4 10711.5 10906.6 10921.9 11078.1 11238.8 56251.7 56692.7 57352.4 57918.7 58895.4 70751.0 72394.0 72923.0 73575.6 75055.2 15080.6 15126.5 15494.3 15603.8 15628.1 17914.5 18385.2 18487.4 18513.9 18587.3 17030.4 17285.7 17311.0 17434.2 17507.8 14367.4 14585.7 14597.1 14597.2 14658.5 16159.5 16490.8 16807.5 16870.2 16898.3 12470.6 12825.7 12868.3 12870.3 12892.9 12347.2 12398.8 12476.5 12727.3 12771.1 18:15:55 INFO - PID 29722 | -------- Summary: end -------- 18:15:55 INFO - PID 29722 | 18:15:55 INFO - TEST-INFO | 29722: exit 0 18:15:56 INFO - TEST-OK | dromaeo_css | took 1106190ms 18:15:56 INFO - TEST-START | kraken 18:15:56 INFO - Initialising browser for kraken test... 18:15:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42602/getInfo.html -profile /tmp/tmpggdrKR/profile 18:15:56 INFO - TEST-INFO | started process 30082 (/builds/slave/test/build/application/firefox/firefox http://localhost:42602/getInfo.html) 18:16:00 INFO - TEST-INFO | 30082: exit 0 18:16:00 INFO - Browser initialized. 18:16:00 INFO - Running cycle 1/1 for kraken test... 18:16:00 INFO - Using env: {'DISPLAY': ':0', 18:16:00 INFO - 'HOME': '/home/cltbld', 18:16:00 INFO - 'JSGC_DISABLE_POISONING': '1', 18:16:00 INFO - 'LANG': 'en_US.UTF-8', 18:16:00 INFO - 'LANGUAGE': 'en_US:en', 18:16:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:16:00 INFO - 'LOGNAME': 'cltbld', 18:16:00 INFO - 'MAIL': '/var/mail/cltbld', 18:16:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:16:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:16:00 INFO - 'MOZ_CRASHREPORTER': '1', 18:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:16:00 INFO - 'MOZ_NO_REMOTE': '1', 18:16:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:00 INFO - 'NO_EM_RESTART': '1', 18:16:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:00 INFO - 'PWD': '/builds/slave/test', 18:16:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:16:00 INFO - 'RUST_BACKTRACE': 'full', 18:16:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:16:00 INFO - 'SHELL': '/bin/bash', 18:16:00 INFO - 'SHLVL': '1', 18:16:00 INFO - 'TERM': 'linux', 18:16:00 INFO - 'TMOUT': '86400', 18:16:00 INFO - 'USER': 'cltbld', 18:16:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381', 18:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:00 INFO - '_': '/tools/buildbot/bin/python'} 18:16:00 INFO - TEST-INFO | started process 30316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpggdrKR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:16:01 INFO - PID 30316 | 18:16:01 INFO - PID 30316 | (/builds/slave/test/build/application/firefox/firefox:30364): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:16:01 INFO - PID 30316 | 18:16:11 INFO - PID 30316 | RSS: Main: 143749120 18:16:11 INFO - PID 30316 | 18:16:13 INFO - PID 30316 | Cycle 1(1): loaded http://localhost:42602/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42602/tests/kraken/driver.html?testName=audio-beat-detection) 18:16:14 INFO - PID 30316 | RSS: Main: 150753280 18:16:14 INFO - PID 30316 | 18:16:17 INFO - PID 30316 | Cycle 1(1): loaded http://localhost:42602/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42602/tests/kraken/driver.html?testName=audio-dft) 18:16:17 INFO - PID 30316 | RSS: Main: 150900736 18:16:17 INFO - PID 30316 | 18:16:20 INFO - PID 30316 | Cycle 1(1): loaded http://localhost:42602/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42602/tests/kraken/driver.html?testName=audio-fft) 18:16:21 INFO - PID 30316 | RSS: Main: 152690688 18:16:21 INFO - PID 30316 | 18:16:23 INFO - PID 30316 | Cycle 1(1): loaded http://localhost:42602/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42602/tests/kraken/driver.html?testName=audio-oscillator) 18:16:23 INFO - PID 30316 | RSS: Main: 152592384 18:16:23 INFO - PID 30316 | 18:16:26 INFO - PID 30316 | Cycle 1(1): loaded http://localhost:42602/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42602/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:16:26 INFO - PID 30316 | RSS: Main: 152215552 18:16:26 INFO - PID 30316 | 18:16:29 INFO - PID 30316 | Cycle 1(1): loaded http://localhost:42602/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42602/tests/kraken/driver.html?testName=imaging-darkroom) 18:16:30 INFO - PID 30316 | RSS: Main: 152272896 18:16:30 INFO - PID 30316 | 18:16:33 INFO - PID 30316 | Cycle 1(1): loaded http://localhost:42602/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42602/tests/kraken/driver.html?testName=imaging-desaturate) 18:16:34 INFO - PID 30316 | RSS: Main: 154525696 18:16:34 INFO - PID 30316 | 18:16:37 INFO - PID 30316 | Cycle 1(1): loaded http://localhost:42602/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42602/tests/kraken/driver.html?testName=json-parse-financial) 18:16:37 INFO - PID 30316 | RSS: Main: 155738112 18:16:37 INFO - PID 30316 | 18:16:39 INFO - PID 30316 | Cycle 1(1): loaded http://localhost:42602/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42602/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:16:39 INFO - PID 30316 | RSS: Main: 155160576 18:16:39 INFO - PID 30316 | 18:16:41 INFO - PID 30316 | Cycle 1(1): loaded http://localhost:42602/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42602/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:16:42 INFO - PID 30316 | RSS: Main: 154800128 18:16:42 INFO - PID 30316 | 18:16:44 INFO - PID 30316 | Cycle 1(1): loaded http://localhost:42602/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42602/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:16:44 INFO - PID 30316 | RSS: Main: 151793664 18:16:44 INFO - PID 30316 | 18:16:47 INFO - PID 30316 | Cycle 1(1): loaded http://localhost:42602/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42602/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:16:47 INFO - PID 30316 | RSS: Main: 151789568 18:16:47 INFO - PID 30316 | 18:16:50 INFO - PID 30316 | Cycle 1(1): loaded http://localhost:42602/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42602/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:16:50 INFO - PID 30316 | RSS: Main: 152055808 18:16:50 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | Cycle 1(1): loaded http://localhost:42602/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42602/tests/kraken/driver.html?testName=ai-astar) 18:16:52 INFO - PID 30316 | RSS: Main: 153907200 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | __start_tp_report 18:16:52 INFO - PID 30316 | _x_x_mozilla_page_load 18:16:52 INFO - PID 30316 | _x_x_mozilla_page_load_details 18:16:52 INFO - PID 30316 | |i|pagename|runs| 18:16:52 INFO - PID 30316 | |0;ai-astar;104;106;107;109;105;106;106;106;107;105 18:16:52 INFO - PID 30316 | |1;audio-beat-detection;113;120;111;116;122;113;115;144;114;111 18:16:52 INFO - PID 30316 | |2;audio-dft;163;163;162;161;161;161;161;162;162;161 18:16:52 INFO - PID 30316 | |3;audio-fft;74;72;75;73;74;73;74;74;72;74 18:16:52 INFO - PID 30316 | |4;audio-oscillator;78;82;84;79;77;86;76;77;77;79 18:16:52 INFO - PID 30316 | |5;imaging-gaussian-blur;110;114;114;111;114;115;114;114;113;114 18:16:52 INFO - PID 30316 | |6;imaging-darkroom;151;149;147;153;150;148;149;149;149;147 18:16:52 INFO - PID 30316 | |7;imaging-desaturate;93;94;94;94;94;94;93;94;94;94 18:16:52 INFO - PID 30316 | |8;json-parse-financial;45;43;43;48;43;43;43;43;43;43 18:16:52 INFO - PID 30316 | |9;json-stringify-tinderbox;46;47;46;46;46;45;46;46;49;46 18:16:52 INFO - PID 30316 | |10;stanford-crypto-aes;79;80;68;69;69;70;70;72;73;72 18:16:52 INFO - PID 30316 | |11;stanford-crypto-ccm;108;100;102;108;109;104;110;102;111;102 18:16:52 INFO - PID 30316 | |12;stanford-crypto-pbkdf2;158;146;158;146;151;148;150;158;151;149 18:16:52 INFO - PID 30316 | |13;stanford-crypto-sha256-iterative;60;61;60;58;59;61;59;57;61;60 18:16:52 INFO - PID 30316 | __end_tp_report 18:16:52 INFO - PID 30316 | __start_cc_report 18:16:52 INFO - PID 30316 | _x_x_mozilla_cycle_collect,663 18:16:52 INFO - PID 30316 | __end_cc_report 18:16:52 INFO - PID 30316 | __startTimestamp1507943812875__endTimestamp 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | ------- Summary: start ------- 18:16:52 INFO - PID 30316 | Number of tests: 14 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | [#0] ai-astar Cycles:10 Average:106.10 Median:106.00 stddev:1.37 (1.3%) stddev-sans-first:1.22 18:16:52 INFO - PID 30316 | Values: 104.0 106.0 107.0 109.0 105.0 106.0 106.0 106.0 107.0 105.0 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | [#1] audio-beat-detection Cycles:10 Average:117.90 Median:115.50 stddev:9.85 (8.5%) stddev-sans-first:10.28 18:16:52 INFO - PID 30316 | Values: 113.0 120.0 111.0 116.0 122.0 113.0 115.0 144.0 114.0 111.0 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.73 18:16:52 INFO - PID 30316 | Values: 163.0 163.0 162.0 161.0 161.0 161.0 161.0 162.0 162.0 161.0 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | [#3] audio-fft Cycles:10 Average:73.50 Median:74.00 stddev:0.97 (1.3%) stddev-sans-first:1.01 18:16:52 INFO - PID 30316 | Values: 74.0 72.0 75.0 73.0 74.0 73.0 74.0 74.0 72.0 74.0 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:79.00 stddev:3.37 (4.3%) stddev-sans-first:3.54 18:16:52 INFO - PID 30316 | Values: 78.0 82.0 84.0 79.0 77.0 86.0 76.0 77.0 77.0 79.0 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:1.57 (1.4%) stddev-sans-first:1.12 18:16:52 INFO - PID 30316 | Values: 110.0 114.0 114.0 111.0 114.0 115.0 114.0 114.0 113.0 114.0 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:1.81 (1.2%) stddev-sans-first:1.80 18:16:52 INFO - PID 30316 | Values: 151.0 149.0 147.0 153.0 150.0 148.0 149.0 149.0 149.0 147.0 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 18:16:52 INFO - PID 30316 | Values: 93.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | [#8] json-parse-financial Cycles:10 Average:43.70 Median:43.00 stddev:1.64 (3.8%) stddev-sans-first:1.67 18:16:52 INFO - PID 30316 | Values: 45.0 43.0 43.0 48.0 43.0 43.0 43.0 43.0 43.0 43.0 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | [#9] json-stringify-tinderbox Cycles:10 Average:46.30 Median:46.00 stddev:1.06 (2.3%) stddev-sans-first:1.12 18:16:52 INFO - PID 30316 | Values: 46.0 47.0 46.0 46.0 46.0 45.0 46.0 46.0 49.0 46.0 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | [#10] stanford-crypto-aes Cycles:10 Average:72.20 Median:72.00 stddev:4.16 (5.8%) stddev-sans-first:3.61 18:16:52 INFO - PID 30316 | Values: 79.0 80.0 68.0 69.0 69.0 70.0 70.0 72.0 73.0 72.0 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | [#11] stanford-crypto-ccm Cycles:10 Average:105.60 Median:108.00 stddev:4.01 (3.7%) stddev-sans-first:4.15 18:16:52 INFO - PID 30316 | Values: 108.0 100.0 102.0 108.0 109.0 104.0 110.0 102.0 111.0 102.0 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.50 Median:151.00 stddev:4.81 (3.2%) stddev-sans-first:4.49 18:16:52 INFO - PID 30316 | Values: 158.0 146.0 158.0 146.0 151.0 148.0 150.0 158.0 151.0 149.0 18:16:52 INFO - PID 30316 | 18:16:52 INFO - PID 30316 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:60.00 stddev:1.35 (2.2%) stddev-sans-first:1.42 18:16:52 INFO - PID 30316 | Values: 60.0 61.0 60.0 58.0 59.0 61.0 59.0 57.0 61.0 60.0 18:16:52 INFO - PID 30316 | -------- Summary: end -------- 18:16:52 INFO - PID 30316 | 18:16:53 INFO - PID 30316 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:16:53 INFO - TEST-INFO | 30316: exit 0 18:16:53 INFO - TEST-OK | kraken | took 57490ms 18:16:53 INFO - SUITE-END | took 1163s 18:16:53 INFO - Completed test suite (00:19:23) 18:16:53 INFO - javascript benchmark 18:16:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9333.910046766523, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4039.8990025249373, 4045.3931910213473, 4051.331530297501, 4063.593640635935, 4077.1234184650293, 6480.449161821245, 6567.376099270574, 6574.572652777566, 6661.16735408074, 6693.765718199864, 6548.508861835369, 6575.967120164404, 6661.067450556926, 6692.29730878258, 6713.899291510631, 5874.412558744113, 5974.88050238996, 5982.970085149568, 5995.220621319222, 6020.698965051752, 5912.083627037816, 5925.822225333247, 5929.140274660172, 5954.434328738763, 6049.153118563405, 5942.851428714273, 5987.610805297663, 6010.27876654802, 6028.849278768044, 6045.455908968192, 5953.58324917256, 5962.821115366546, 5982.282126144891, 6003.399660033983, 6020.96989515054, 5874.441928016831, 5917.733701983421, 5947.10793380992, 6049.939500604982, 6099.878002439927, 6478.611283323015, 6576.408123268929, 6583.341665833426, 6601.471882249457, 6606.8017959461295, 7168.283171682842, 7175.103112110986, 7230.2046774854725, 7232.1683006454405, 7263.527870688388, 7108.075950126502, 7186.353228209487, 7246.0, 7312.049433573655, 7321.670524826395, 6620.503462240303, 6665.900011499832, 6702.095217145672, 6733.528652994243, 6745.224299205556, 7288.018901100999, 7330.8900366494545, 7364.3372096511575, 7381.88927166093, 7418.332350088518, 7017.614031228331, 7044.823879403056, 7089.964550177217, 7105.0, 7121.35907768293, 7037.0, 7154.141503019567, 7192.100987376578, 7237.167725711611, 7246.021787058785, 7142.071530700976, 7146.92853071473, 7221.747238846615, 7234.0, 7236.312550307713, 7150.284971502808, 7157.498975071695, 7236.565806051653, 7238.963805180941, 7255.347018768336, 5212.635115541876, 5326.813561525328, 5330.973345133327, 5335.893282134336, 5369.006733754268, 4822.903541929142, 4882.389701287339, 4908.680935739166, 4944.456109827916, 4979.153543897546, 6707.3963343298365, 6719.428848547928, 6782.626955517494, 6806.149231346082, 6810.557313774589, 7042.753503627348, 7120.857582848314, 7134.750283740044, 7180.676869540883, 7232.783016509513, 6577.736890524326, 6638.17022872141, 6665.466762659073, 6683.0, 6687.431568316651, 6057.697115144225, 6065.059915713072, 6144.477719393813, 6157.876842463125, 6169.167162433014, 7284.016657751242, 7330.706771729071, 7377.741779037815, 7465.440091993014, 7512.436567257478, 7089.078419805599, 7112.644367781693, 7170.211276759553, 7175.641217939186, 7187.712491500281, 7359.705611775683, 7370.373518251009, 7462.44031697614, 7507.587082710284, 7508.399328053852, 6835.316468353125, 6949.652517374212, 6983.266756990646, 7061.364477197077, 7089.255628158969, 7154.964225178841, 7249.166345870292, 7249.456290778318, 7258.600776957318, 7275.781726548212, 6897.448204143757, 6911.550749201286, 6913.41235994926, 6998.790036298919, 7002.264762199896, 6745.628990405378, 6793.490488213305, 6902.551334163263, 6928.099347084847, 6939.306069393222, 6858.074159988537, 6906.792796216121, 6924.515283930076, 6939.653017349011, 6952.826179345557, 6932.168139823253, 6965.373116419547, 6998.825029374307, 7023.367896889305, 7085.787426377217, 6624.470042396693, 6624.9337506624315, 6691.197056353269, 6695.196576410862, 6745.628990405575], "value": 6568.310973488498, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [970.3838062830105, 987.1806400687431, 1001.664442411792, 1030.2839526529065, 1038.3250886923502, 46246.768766156165, 47056.52943470573, 47075.0, 47103.52896471034, 47147.76426117869, 43104.0, 43398.349024764655, 43453.34819977695, 43468.782656086674, 43528.0, 7954.880676789839, 8064.395170362217, 8094.109647938722, 8099.716509922154, 8101.230383113595, 8007.479513831582, 8066.878996815052, 8098.392620553453, 8112.148224436438, 8142.877856832122, 8750.781230469258, 8942.821143577125, 8943.865842012376, 8948.8657670135, 8952.910470895273, 8783.868241976408, 8805.911940880573, 8822.735317940407, 8846.5134417607, 8867.0, 8695.0, 8713.0, 8737.868931966026, 8775.736727898173, 8796.0, 42128.78935605333, 42999.78500107479, 43067.35398969018, 43091.0, 43159.0, 3811.790351530665, 3816.4466152407745, 3824.063104539378, 3830.69354451646, 3847.557530883956, 33863.0, 33909.83045084783, 34042.14894627654, 34101.82949085264, 34105.6589434105, 5621.128725047583, 5675.347335056439, 5678.375378708339, 5708.828735137952, 5806.954748145332, 231521.0, 231676.84161579254, 231797.0, 232747.0, 233418.0, 52895.47104528982, 53156.734216329445, 53192.20211696828, 53330.0, 57647.71176144092, 60241.69879150664, 60884.0, 60905.69547152236, 61022.38977610256, 61261.38738612646, 17051.829481705023, 17100.0, 17138.657226855394, 17148.82851171497, 17167.570810729583, 13617.046806723434, 13759.587212383445, 13760.518381856788, 13774.793378099337, 13809.447622095204, 16363.181840907908, 16516.0, 16522.339106435847, 16573.0, 16640.583985400463, 6158.445739883432, 6258.0, 6336.556441049082, 6420.454261387835, 6499.8700025999215, 1121.9958137466922, 1124.2074337591978, 1127.4869934179928, 1128.249713940237, 1135.3017893995134, 25848.353791155372, 25853.74146258551, 25959.480810384066, 26430.6035409469, 26452.470950580882, 1218.5734992752466, 1229.2685851918095, 1231.975360492785, 1241.4413513918773, 1244.813278008306, 13601.931990340183, 13913.721725565432, 14028.719425611635, 14195.219262940638, 14197.929010354883, 305145.0, 311476.0, 313829.0, 321683.0, 323704.0, 67228.66385668138, 67369.0, 67943.3205667937, 67962.0, 67995.32004679988, 1529.4799768078906, 1541.3372249932413, 1545.3741234799925, 1552.4566401759519, 1587.745960646291, 31690.366192675556, 31725.841370792998, 31746.682533175295, 32483.512747309283, 32588.0, 43639.781801090794, 43838.90402739957, 43882.0, 43930.780346099345, 43937.34093988657, 259263.0, 259368.0, 259489.0, 260061.0, 260599.0, 38022.0, 39223.41164882586, 39410.80294598509, 39512.2097558053, 39614.207715846096, 46811.76594117007, 48177.277340840614, 48765.5123448761, 48907.04371825087, 49200.0, 34842.0, 35395.46906796349, 35620.109497262776, 35946.28107437889, 36143.0, 34961.82519087388, 35694.82152589221, 36200.0, 36353.81823090868, 36504.0, 42790.786046069574, 42816.78591607022, 42881.0, 43328.78335608302, 43450.34824477572, 34340.65659343375, 34347.65652343544, 34657.13357166091, 35005.64994350126, 35257.647423525435, 25496.617550737126, 25770.330527283968, 25914.740852591985, 25952.610710838973, 26673.199804005133], "value": 19575.89926793121, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.5991561181435, 635.4996366537953, 642.0812423343614, 643.1968250709912, 655.9996006090711, 23729.644055339184, 24515.632265516007, 24521.63217551736, 24554.631680524762, 24629.876850615765, 25017.62473562898, 25166.874165629193, 25370.873145634247, 25400.11099611514, 25427.36431589211, 6387.776427825027, 6599.406053455188, 6625.0393692914495, 6645.235797883232, 6700.430463410604, 6601.042848786923, 6693.096431981693, 6697.5981441113445, 6709.228438729536, 6713.462922966175, 6510.576812507195, 6671.232808227068, 6691.832704182386, 6692.230393504737, 6745.3591908768585, 6743.49423793215, 6809.387155156035, 6809.387155156035, 6809.965950170217, 6812.352826481526, 6335.904961425582, 6375.4262116409745, 6379.904301435482, 6382.744690212386, 6397.456216221627, 29368.41263174746, 30354.84822575873, 30834.38331233385, 30836.691633083607, 30850.38299234025, 2327.5344931013865, 2365.503244318695, 2368.609179485383, 2369.194473878872, 2369.3721163891582, 20480.69278960817, 20933.79066209349, 20950.895245523676, 21035.368938931704, 21046.473838154016, 2515.73584773598, 2573.8713064346894, 2634.209737078869, 2644.6694163229595, 2647.139679604117, 153083.2345838275, 159796.0, 167284.0, 176830.0, 178532.0, 16396.918015409847, 16924.568663907638, 16941.070625281052, 17003.489895303162, 17012.574685632957, 27175.456490870467, 27184.320391990357, 27201.45597088047, 27253.727462725514, 27261.86369068142, 10763.24657273999, 10842.644669416322, 10876.782464350827, 10988.725281867857, 11084.889151108548, 9789.386517145416, 9893.0, 9894.208463322917, 9903.900960990299, 9957.302988790716, 9741.061647246375, 9769.364991275545, 10077.647282345082, 10148.695539133838, 10201.795964080677, 2850.743433091032, 2917.9562306565417, 2927.487689654302, 3020.2449387653087, 3031.681673424303, 1023.5291765787672, 1043.087298613713, 1043.6295115234134, 1056.6513050693252, 1059.5073290919606, 21417.46456338573, 21496.032678529504, 21710.565788684136, 21968.0, 22341.329760107223, 1118.245184500459, 1119.3116233516491, 1127.2503784983057, 1129.3619105205532, 1144.5993902134187, 11587.942060289644, 11786.705332366759, 11811.114166437379, 11924.224925379822, 11958.760824783629, 641389.0, 656460.0, 656635.0, 670217.0, 672242.0, 134327.0, 134457.3277133608, 135117.0, 138462.0, 138535.0, 1134.4214450630072, 1175.8471398718284, 1199.6401079676236, 1245.4644502863675, 1257.43415463042, 21488.005885218285, 22126.336209913727, 22149.44626384289, 22166.335009949726, 22218.44453888666, 63597.0, 64941.35058649542, 66524.66737666281, 67298.3270167292, 67343.66328168327, 82701.58649206716, 85255.0, 86393.56803215944, 87327.0, 88751.55624221837, 16045.919770401073, 16110.67778644444, 16169.514914552583, 16347.0, 16368.754468683217, 24308.0, 24473.755262447146, 24475.877620611784, 24689.25932222036, 24699.62950555779, 19733.1120099593, 19807.801921981172, 19835.20659173617, 19835.504112396728, 19914.60170796605, 16911.746323804906, 17322.653546929243, 17564.648707026045, 17914.552136196176, 18212.998285094447, 19732.30936917201, 20287.69568456445, 20679.58640827205, 20816.167353306304, 20835.583288334452, 15614.687706246039, 15746.448874289345, 15945.760813587573, 15991.840081599035, 16009.519714408587, 19561.706574401112, 19573.608527829078, 19925.202991880164, 19971.0, 20170.697439538126], "value": 13120.23777113514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.2149874571494, 1421.9857801421983, 1431.8281806183259, 1438.6834896322805, 1456.0317388936357, 17604.91197544012, 18284.26862925483, 18291.451256462293, 18304.17631206597, 18308.450746477592, 17939.192736326862, 18096.366627168052, 18213.81786182138, 18255.452336429895, 18262.269509219615, 2790.7627851632583, 2833.6457942757156, 2840.3041254892582, 2847.103162503815, 2847.857607119646, 2671.345520347518, 2763.3782398960275, 2763.6407267055256, 2764.834109953399, 2765.7234276572385, 2610.9608355874584, 2730.494858451183, 2738.7124351943057, 2837.8581070946475, 2840.7017263187377, 2670.519306524825, 2695.487857307125, 2716.307341627892, 2721.319670082479, 2730.1127133681634, 2697.8516181610003, 2717.714639962815, 2733.8906443742226, 2734.0567504211017, 2757.379589592346, 17066.658666826595, 17245.913770431194, 17439.128043597768, 17576.560585985324, 17608.471745847644, 8528.0, 8800.031996480382, 8838.072002439716, 8842.602082906285, 8859.0, 5859.1504231886565, 6036.667983260919, 6099.878002439971, 6151.87696246077, 6169.259688837324, 2066.865653732503, 2100.422383844455, 2101.170037835062, 2111.5430353056495, 2193.1775584155944, 32177.356452870812, 32291.51562726561, 32322.838385808154, 32388.190295242573, 32472.350552988806, 7473.663685134182, 7533.773986780406, 7555.395568354628, 7632.0, 7702.460827742004, 20651.0, 20709.378718638465, 20710.96445177765, 20775.168993240102, 20839.166433342496, 8609.0, 8755.474671519729, 8783.824323513494, 8791.868121978176, 8805.955970220108, 7633.0, 7775.92224077752, 7809.843803123906, 7816.687332506636, 7878.0, 6102.542309326729, 6204.565680402418, 6244.968775156095, 6281.3404592518045, 6300.117983482316, 1590.2207918120268, 1607.8311777263452, 1823.854091672663, 1859.2562974809914, 1859.3678149429259, 982.4350998176077, 1005.1657124586576, 1007.7430255284855, 1008.7125169326854, 1011.3527342500805, 9567.569459374345, 9760.023997600183, 9838.36050656705, 9858.95070524657, 9948.303618746762, 822.7696245051395, 827.2058823529479, 828.8963879515061, 845.8054647431002, 887.8845750052452, 5518.420565840609, 5764.798232061858, 5900.852478687982, 5931.228940237742, 5986.551008674367, 25634.743652563608, 26297.474050518882, 26461.073862414723, 26946.461070778474, 27071.323216919736, 25644.0, 26045.869770651025, 26527.734722652913, 26705.19884403471, 26790.330241743723, 12974.675633109247, 13102.410391532214, 13201.47194112244, 13306.268155251553, 13311.733765324832, 9455.763605909908, 9503.239740820856, 9555.04449555039, 9573.425594464354, 9596.568154433207, 22038.99999999936, 22158.667619986034, 22249.555008900054, 22549.43626409353, 22853.657195141754, 22738.0, 22847.543049139258, 22958.311250662508, 23003.65494517617, 23487.29538113791, 12428.689282767642, 12561.120721549403, 12761.680957976125, 12765.48938042505, 12767.361631918553, 15809.446669366516, 15940.68118637644, 16122.435714749927, 16140.757888631446, 16271.105089220207, 11900.642980710592, 12120.515179392725, 12286.0, 12350.62948111558, 12453.937730311653, 11736.0, 11861.525538978343, 12047.33739644328, 12169.634910952685, 12312.507499699912, 11415.657530274106, 11642.41787910618, 11688.88311116912, 11700.0, 11701.180917335705, 8488.074255670792, 8634.654613815377, 8660.870086948575, 8673.91326086731, 8676.132386761274, 8775.561221939006, 8959.596818143069, 9042.18620324174, 9050.0, 9065.728028159167], "value": 7502.02344155198, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.2708775433779, 560.0845109724743, 566.8979583674936, 569.4135040907864, 603.3393434189562, 6296.212973378328, 6311.147995020671, 6332.3351048139975, 6378.330275321094, 6407.0, 6262.0, 6313.7474501020015, 6316.494680425566, 6359.6184228946295, 6376.362363763621, 5196.350456192976, 5221.556167725729, 5236.528712415882, 5260.685767966176, 5267.710275934832, 5028.0, 5133.768980395891, 5195.324607801, 5209.843704688866, 5241.528262456378, 5103.974480127594, 5145.125328694112, 5148.275327765203, 5161.896762064756, 5177.30106435632, 5117.641765076446, 5143.305653736735, 5177.275181474615, 5177.637565370425, 5223.764930578114, 4672.532746725335, 4689.554492323224, 4702.625174286997, 4703.858884233478, 4723.07899959508, 6320.810375688737, 6332.4934005279465, 6355.332690067523, 6374.458171055466, 6388.936110638881, 5997.790077347272, 6013.188219590387, 6103.42017508336, 6160.383961603849, 6163.198784158076, 6753.223379311393, 6776.6611669416825, 6793.966030169818, 6811.386975172259, 6826.761063362758, 5022.0, 5224.242484839715, 5233.325335892516, 5256.553192978601, 5274.208868669731, 6922.480813938974, 6929.461202912101, 7014.0, 7057.082579264663, 7077.221505634325, 5366.651167674088, 5368.516833485005, 5392.110301800238, 5415.729213539386, 5419.268398766195, 5417.918731219035, 5445.537129343971, 5459.843361872117, 5475.589330800206, 5490.533304669068, 5976.342602313742, 6065.484433823174, 6067.605605635619, 6069.36271691466, 6105.450509454082, 6879.140107486564, 6888.517803753789, 6932.757353492704, 6937.653117344113, 6939.340762627542, 1849.7906132859746, 1877.596316791869, 1885.849132069431, 1887.3960332693407, 1896.061449582438, 1303.5958852755487, 1345.7173993461483, 1352.648311439033, 1358.809766632672, 1359.1709057474932, 6389.520785941073, 6405.583637063576, 6438.742450301936, 6439.710213040425, 6444.806655800334, 6901.896471552931, 6945.201301850251, 6968.1638203414905, 6995.125609298838, 7006.754763583352, 6382.904256436157, 6414.294427612959, 6425.490009847682, 6482.870342593216, 6505.7397704092255, 3628.729944519397, 3654.7258955577904, 3669.3028324618235, 3677.9080522986606, 3700.481932529448, 7166.491727895299, 7197.964010179916, 7199.784006479814, 7210.978832674776, 7227.638618069181, 7115.146182458035, 7196.136463624399, 7203.711851525985, 7228.168760592494, 7234.24040475753, 7022.367986881205, 7084.43324534036, 7121.608311542915, 7149.857002859913, 7155.069840920647, 6799.388055075067, 6856.931430685829, 6867.828304292432, 6871.5189936703955, 6901.206361268318, 6830.0, 6852.246252912076, 6876.828079297858, 6899.517033807585, 6944.861102777815, 7032.542884712478, 7116.679749411185, 7124.254557633206, 7150.785476435715, 7160.069191005136, 5317.787288508416, 5321.164198351563, 5328.866778330573, 5385.353757548963, 5394.730263486731, 6612.603243805387, 6647.767328143492, 6820.0, 6839.316068393121, 6928.965355173192, 6596.439302659328, 6611.933880661132, 6641.074088514277, 6648.83377915556, 6742.42689371409, 6585.3085426029575, 6612.636305003271, 6614.10709554204, 6694.096296999843, 6734.831629209309, 6559.967200163968, 6600.504962127956, 6635.8009259722285, 6641.575824824001, 6659.633720145439, 6740.136081609032, 6743.696533656095, 6789.524733268821, 6805.149356330458, 6824.692888820115, 6547.214334279917, 6567.474602031922, 6579.243387010555, 6583.275839657538, 6622.337766223532], "value": 5326.074008425043, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1008.8385858262675, 1013.1236480444416, 1031.0, 1038.2317085356838, 1047.3611097230687, 18848.90575547122, 19337.903310483463, 19347.516312092204, 19362.419127426165, 19366.612667746653, 18857.33999310021, 18902.716459253123, 18973.905130474363, 19103.808961910378, 19211.32760353388, 1050.931689440186, 1080.8000519903803, 1087.325857968061, 1092.9945350273238, 1093.5899037860802, 1095.775366049958, 1099.6096385783053, 1099.6920862158609, 1099.8900109988977, 1101.262154356583, 1100.372787511119, 1118.0943435816973, 1118.6028959719304, 1121.4785124916912, 1121.938293393863, 1115.6485707002269, 1115.648570700231, 1115.7880002799482, 1117.4133579870552, 1117.4245263689206, 833.2750507058897, 833.3041910005153, 835.9665613375457, 839.290799274612, 839.315957494646, 17723.822761772346, 20718.896405518026, 20910.0, 21054.0, 21203.68194477084, 21324.786752132437, 21863.344099677037, 22064.88967555168, 22132.0, 22214.444638883997, 17797.822021779746, 18244.726329105073, 18276.0, 18288.81711182898, 18340.54148646281, 4160.167966406731, 4172.0, 4195.748255104673, 4199.538050814408, 4210.536840947493, 162683.0, 165938.3406165935, 166547.99999999878, 169401.0, 170366.0, 17469.91265043692, 17522.649547008987, 17605.911970440324, 17622.502087322464, 17635.470935871945, 33293.66706332954, 33370.49944250838, 33388.0, 33427.331453371284, 33494.0, 9367.578458969227, 9615.663451779154, 9668.951655241679, 9676.371035882645, 9679.032096790264, 4794.95205047952, 4923.507649235048, 4940.209566469348, 4940.654154209171, 4948.851534453972, 5916.852078698067, 5961.225040744762, 5977.910331345033, 5988.880222395528, 5991.610545314541, 1112.232559533919, 1112.8108221602347, 1116.7654792493668, 1120.1095129372168, 1121.5233525751523, 767.3362541401648, 770.0836005153849, 788.2354116507094, 790.4032455496178, 794.0035255753992, 11632.592859249886, 12354.691132721753, 12582.370881456074, 13339.733205336033, 13490.0, 759.164918589547, 766.306492624176, 766.5975362934392, 773.9883901741479, 780.9062912450429, 5726.627769194989, 5740.626859254218, 5796.478316951495, 5856.59003869725, 5909.143174239797, 154038.0, 155921.0, 157136.21431892767, 157314.21342893213, 157385.0, 137890.31054844862, 138897.0, 140139.0, 140285.0, 143656.28171859073, 118648.8135118655, 119016.0, 119663.803361967, 121416.39291803485, 122822.38588806998, 10711.517981690999, 10906.61826836057, 10921.945390273315, 11078.113750899747, 11238.775224495628, 56251.71874140603, 56692.71653641705, 57352.42647573471, 57918.710406447695, 58895.41104589071, 70751.0, 72394.0, 72923.0, 73575.63212183905, 75055.24944750701, 15080.622984425478, 15126.470573529874, 15494.302756376215, 15603.765943511084, 15628.140452275235, 17914.46256612304, 18385.17266722974, 18487.445376638723, 18513.90743046276, 18587.34944276944, 17030.40393586268, 17285.74071388905, 17311.0, 17434.21546030457, 17507.82492175062, 14367.425302988182, 14585.708285834437, 14597.051191672508, 14597.197154156624, 14658.486952956595, 16159.515214543113, 16490.83509164941, 16807.495775126765, 16870.240839162023, 16898.32406703718, 12470.625881223577, 12825.743485130432, 12868.292243926673, 12870.292133932724, 12892.871071289166, 12347.19743216688, 12398.752024959631, 12476.500939962663, 12727.2999984998, 12771.106022578702], "value": 9809.638156538826, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1373.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 106.0, 107.0, 109.0, 105.0, 106.0, 106.0, 106.0, 107.0, 105.0], "value": 106.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 120.0, 111.0, 116.0, 122.0, 113.0, 115.0, 144.0, 114.0, 111.0], "value": 117.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 75.0, 73.0, 74.0, 73.0, 74.0, 74.0, 72.0, 74.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 84.0, 79.0, 77.0, 86.0, 76.0, 77.0, 77.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 114.0, 111.0, 114.0, 115.0, 114.0, 114.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 147.0, 153.0, 150.0, 148.0, 149.0, 149.0, 149.0, 147.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 43.0, 43.0, 48.0, 43.0, 43.0, 43.0, 43.0, 43.0, 43.0], "value": 43.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 47.0, 46.0, 46.0, 46.0, 45.0, 46.0, 46.0, 49.0, 46.0], "value": 46.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 68.0, 69.0, 69.0, 70.0, 70.0, 72.0, 73.0, 72.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 100.0, 102.0, 108.0, 109.0, 104.0, 110.0, 102.0, 111.0, 102.0], "value": 105.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 146.0, 158.0, 146.0, 151.0, 148.0, 150.0, 158.0, 151.0, 149.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 58.0, 59.0, 61.0, 59.0, 57.0, 61.0, 60.0], "value": 59.6, "unit": "score"}]}]} 18:16:53 INFO - Return code: 0 18:16:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:16:53 INFO - # TBPL SUCCESS # 18:16:53 INFO - Running post-action listener: _package_coverage_data 18:16:53 INFO - Running post-action listener: _resource_record_post_action 18:16:53 INFO - [mozharness: 2017-10-14 01:16:53.687672Z] Finished run-tests step (success) 18:16:53 INFO - Running post-run listener: _resource_record_post_run 18:16:53 INFO - Total resource usage - Wall time: 1179s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289357824; Read time: 196; Write time: 152776 18:16:53 INFO - TinderboxPrint: CPU usage
13.0% 18:16:53 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 196 18:16:53 INFO - TinderboxPrint: I/O write bytes / time
289,357,824 / 152,776 18:16:53 INFO - TinderboxPrint: CPU idle
8,173.3 (86.9%) 18:16:53 INFO - TinderboxPrint: CPU user
1,179.0 (12.5%) 18:16:53 INFO - TinderboxPrint: Swap in / out
0 / 0 18:16:53 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 8192000; Read time: 0; Write time: 1192 18:16:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:16:53 INFO - run-tests - Wall time: 1164s; CPU: 13.0%; Read bytes: 8192; Write bytes: 281165824; Read time: 196; Write time: 151584 18:16:54 INFO - Running post-run listener: _upload_blobber_files 18:16:54 INFO - Blob upload gear active. 18:16:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:16:54 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:16:54 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:16:54 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:16:54 INFO - (blobuploader) - INFO - Open directory for files ... 18:16:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:16:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:16:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:55 INFO - (blobuploader) - INFO - Done attempting. 18:16:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:16:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:17:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:17:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:17:02 INFO - (blobuploader) - INFO - Done attempting. 18:17:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:17:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:17:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:17:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:17:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:17:04 INFO - (blobuploader) - INFO - Done attempting. 18:17:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:17:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:17:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:17:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:17:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:17:05 INFO - (blobuploader) - INFO - Done attempting. 18:17:05 INFO - (blobuploader) - INFO - Iteration through files over. 18:17:05 INFO - Return code: 0 18:17:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:17:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:17:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/93e2db26c94323fb3e9dff609f39368bb4a22a73f2f4a6a34d2c2d7778e56175b2d0dbc30f4be6b36829d038d820f8fee018bb35f524f2fd1d39dcb2040264a1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/17f730c9546bce9c41df3b4c8d484a6e30171a262678e07c6f9576976f534097ce40596fad7955aaad8c3272902be87b002d2d28f1aea36b8728f849c4cf39c6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d7143e8d9b8a2f84b9da78e99ede05a4d32875405e1b949a3c1b4f89a6fcc06820dc9aaeaa911f1e91d8ea9f4d9a68b4e7bf710410a207d60874cf03f55c62d1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e0d5f55a87e83711b47050e9946f0f5188227f36f9909ca650f2faeb2c2442085192b909d1cfde46b0bc72ded27f2d82c58d56352ab3f133c6753a37a6b0e913"} 18:17:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:17:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:17:05 INFO - Contents: 18:17:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/93e2db26c94323fb3e9dff609f39368bb4a22a73f2f4a6a34d2c2d7778e56175b2d0dbc30f4be6b36829d038d820f8fee018bb35f524f2fd1d39dcb2040264a1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/17f730c9546bce9c41df3b4c8d484a6e30171a262678e07c6f9576976f534097ce40596fad7955aaad8c3272902be87b002d2d28f1aea36b8728f849c4cf39c6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d7143e8d9b8a2f84b9da78e99ede05a4d32875405e1b949a3c1b4f89a6fcc06820dc9aaeaa911f1e91d8ea9f4d9a68b4e7bf710410a207d60874cf03f55c62d1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e0d5f55a87e83711b47050e9946f0f5188227f36f9909ca650f2faeb2c2442085192b909d1cfde46b0bc72ded27f2d82c58d56352ab3f133c6753a37a6b0e913"} 18:17:05 INFO - Running post-run listener: copy_logs_to_upload_dir 18:17:05 INFO - Copying logs to upload dir... 18:17:05 INFO - mkdir: /builds/slave/test/build/upload/logs 18:17:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.399262 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-10-13 18:17:05.447979) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-13 18:17:05.453643) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/93e2db26c94323fb3e9dff609f39368bb4a22a73f2f4a6a34d2c2d7778e56175b2d0dbc30f4be6b36829d038d820f8fee018bb35f524f2fd1d39dcb2040264a1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/17f730c9546bce9c41df3b4c8d484a6e30171a262678e07c6f9576976f534097ce40596fad7955aaad8c3272902be87b002d2d28f1aea36b8728f849c4cf39c6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d7143e8d9b8a2f84b9da78e99ede05a4d32875405e1b949a3c1b4f89a6fcc06820dc9aaeaa911f1e91d8ea9f4d9a68b4e7bf710410a207d60874cf03f55c62d1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e0d5f55a87e83711b47050e9946f0f5188227f36f9909ca650f2faeb2c2442085192b909d1cfde46b0bc72ded27f2d82c58d56352ab3f133c6753a37a6b0e913"} build_url:https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011424 build_url: 'https://queue.taskcluster.net/v1/task/fHoNZRvxSmSCwNrakW95Dw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/93e2db26c94323fb3e9dff609f39368bb4a22a73f2f4a6a34d2c2d7778e56175b2d0dbc30f4be6b36829d038d820f8fee018bb35f524f2fd1d39dcb2040264a1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/17f730c9546bce9c41df3b4c8d484a6e30171a262678e07c6f9576976f534097ce40596fad7955aaad8c3272902be87b002d2d28f1aea36b8728f849c4cf39c6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d7143e8d9b8a2f84b9da78e99ede05a4d32875405e1b949a3c1b4f89a6fcc06820dc9aaeaa911f1e91d8ea9f4d9a68b4e7bf710410a207d60874cf03f55c62d1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e0d5f55a87e83711b47050e9946f0f5188227f36f9909ca650f2faeb2c2442085192b909d1cfde46b0bc72ded27f2d82c58d56352ab3f133c6753a37a6b0e913"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-13 18:17:05.486462) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-13 18:17:05.486969) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1507942593.194193-19434381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-13 18:17:05.571155) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-13 18:17:05.571492) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-13 18:17:05.571852) ========= ========= Total master_lag: 0.21 =========