builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-051 starttime: 1506817584.84 results: success (0) revision: 179dccc17c7f261347436b4b1c33029c8272960b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-30 17:26:24.841119) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-30 17:26:24.841591) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-30 17:26:24.843745) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-30 17:26:24.891095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 17:26:24.891609) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-30 17:26:24-- 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% 41.8M=0s 2017-09-30 17:26:25 (41.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.166747 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 17:26:25.091791) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 17:26:25.095148) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018978 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 17:26:25.148015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-30 17:26:25.148387) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 179dccc17c7f261347436b4b1c33029c8272960b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 179dccc17c7f261347436b4b1c33029c8272960b --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=5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-30 17:26:25,205 truncating revision to first 12 chars 2017-09-30 17:26:25,205 Setting DEBUG logging. 2017-09-30 17:26:25,205 attempt 1/10 2017-09-30 17:26:25,205 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/179dccc17c7f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-30 17:26:26,449 unpacking tar archive at: mozilla-central-179dccc17c7f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.548073 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-30 17:26:26.725390) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-30 17:26:26.725713) ========= script_repo_revision: 179dccc17c7f261347436b4b1c33029c8272960b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-30 17:26:26.726101) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-30 17:26:26.726372) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-30 17:26:26.742296) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-30 17:26:26.742563) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:26:27 INFO - MultiFileLogger online at 20170930 17:26:27 in /builds/slave/test 17:26:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:26:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:26:27 INFO - {'append_to_log': False, 17:26:27 INFO - 'base_work_dir': '/builds/slave/test', 17:26:27 INFO - 'blob_upload_branch': 'Firefox', 17:26:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:26:27 INFO - 'branch': 'Firefox', 17:26:27 INFO - 'buildbot_json_path': 'buildprops.json', 17:26:27 INFO - 'code_coverage': False, 17:26:27 INFO - 'config_files': ('talos/linux_config.py',), 17:26:27 INFO - 'default_actions': ('clobber', 17:26:27 INFO - 'read-buildbot-config', 17:26:27 INFO - 'download-and-extract', 17:26:27 INFO - 'populate-webroot', 17:26:27 INFO - 'create-virtualenv', 17:26:27 INFO - 'install', 17:26:27 INFO - 'setup-mitmproxy', 17:26:27 INFO - 'run-tests'), 17:26:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:26:27 INFO - 'disable_ccov_upload': False, 17:26:27 INFO - 'disable_stylo': False, 17:26:27 INFO - 'download_minidump_stackwalk': True, 17:26:27 INFO - 'download_symbols': 'ondemand', 17:26:27 INFO - 'enable_stylo': False, 17:26:27 INFO - 'enable_webrender': False, 17:26:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:26:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:26:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:26:27 INFO - 'gecko_profile': False, 17:26:27 INFO - 'gecko_profile_interval': 0, 17:26:27 INFO - 'installer_path': 'installer.exe', 17:26:27 INFO - 'log_level': 'info', 17:26:27 INFO - 'log_name': 'talos', 17:26:27 INFO - 'log_to_console': True, 17:26:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:26:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:26:27 INFO - 'opt_config_files': (), 17:26:27 INFO - 'pip_index': False, 17:26:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 17:26:27 INFO - 'system_bits': '32', 17:26:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:26:27 INFO - 'title': 'talos-linux64-ix-051', 17:26:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:26:27 INFO - 'use_talos_json': True, 17:26:27 INFO - 'verify': 'False', 17:26:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:26:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:26:27 INFO - 'work_dir': 'build'} 17:26:27 INFO - [mozharness: 2017-10-01 00:26:27.030439Z] Running clobber step. 17:26:27 INFO - Running pre-action listener: _resource_record_pre_action 17:26:27 INFO - Running main action method: clobber 17:26:27 INFO - rmtree: /builds/slave/test/build 17:26:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:26:27 INFO - Running post-action listener: _resource_record_post_action 17:26:27 INFO - [mozharness: 2017-10-01 00:26:27.982055Z] Finished clobber step (success) 17:26:27 INFO - [mozharness: 2017-10-01 00:26:27.982150Z] Running read-buildbot-config step. 17:26:27 INFO - Running pre-action listener: _resource_record_pre_action 17:26:27 INFO - Running main action method: read_buildbot_config 17:26:27 INFO - Using buildbot properties: 17:26:27 INFO - { 17:26:27 INFO - "project": "", 17:26:27 INFO - "product": "firefox", 17:26:27 INFO - "who": "archaeopteryx@coole-files.de", 17:26:27 INFO - "installer_path": "public/build/target.tar.bz2", 17:26:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 17:26:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:26:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 17:26:27 INFO - "stage_platform": "linux64-pgo", 17:26:27 INFO - "basedir": "/builds/slave/test", 17:26:27 INFO - "buildnumber": 79, 17:26:27 INFO - "platform": "ubuntu64_hw", 17:26:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:26:27 INFO - "slavebuilddir": "test", 17:26:27 INFO - "taskId": "O_ARNL-FQf2PZL_QscS3ag", 17:26:27 INFO - "branch": "mozilla-central", 17:26:27 INFO - "script_repo_revision": "production", 17:26:27 INFO - "revision": "179dccc17c7f261347436b4b1c33029c8272960b", 17:26:27 INFO - "slavename": "talos-linux64-ix-051", 17:26:27 INFO - "repo_path": "mozilla-central" 17:26:27 INFO - } 17:26:27 INFO - Finding installer, test and symbols from parent task. 17:26:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O_ARNL-FQf2PZL_QscS3ag'}, attempt #1 17:26:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O_ARNL-FQf2PZL_QscS3ag'}, attempt #1 17:26:28 INFO - Task dependencies: N6FqeYAdQrOnZuU68arTCg 17:26:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg'}, attempt #1 17:26:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.tar.bz2 17:26:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.test_packages.json 17:26:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.crashreporter-symbols.zip 17:26:29 INFO - Running post-action listener: _resource_record_post_action 17:26:29 INFO - [mozharness: 2017-10-01 00:26:29.449624Z] Finished read-buildbot-config step (success) 17:26:29 INFO - [mozharness: 2017-10-01 00:26:29.449843Z] Running download-and-extract step. 17:26:29 INFO - Running pre-action listener: _resource_record_pre_action 17:26:29 INFO - Running main action method: download_and_extract 17:26:29 INFO - mkdir: /builds/slave/test/build/tests 17:26: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:26:29 INFO - trying https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.test_packages.json 17:26:29 INFO - Downloading https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:26:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:26:30 INFO - Downloaded 989 bytes. 17:26:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:26:30 INFO - Using the following test package requirements: 17:26:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:26:30 INFO - u'common': [u'target.common.tests.zip'], 17:26:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:26:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:26:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:26:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:26:30 INFO - u'mozbase': [u'target.common.tests.zip'], 17:26:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:26:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:26:30 INFO - u'web-platform': [u'target.common.tests.zip', 17:26:30 INFO - u'target.web-platform.tests.tar.gz'], 17:26:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:26:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:26:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.common.tests.zip 17:26:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:26:30 INFO - Fetch https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.common.tests.zip into memory 17:26:31 INFO - Content-Length response header: 55917009 17:26:31 INFO - Bytes received: 55917009 17:26:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.talos.tests.zip 17:26:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:26:43 INFO - Fetch https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.talos.tests.zip into memory 17:26:44 INFO - Content-Length response header: 14522385 17:26:44 INFO - Bytes received: 14522385 17:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:44 INFO - trying https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.tar.bz2 17:26:44 INFO - Downloading https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:26:47 INFO - Downloaded 62377863 bytes. 17:26:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.tar.bz2 17:26:47 INFO - mkdir: /builds/slave/test/properties 17:26:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:26:47 INFO - Writing to file /builds/slave/test/properties/build_url 17:26:47 INFO - Contents: 17:26:47 INFO - build_url:https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.tar.bz2 17:26:47 INFO - Running post-action listener: _resource_record_post_action 17:26:47 INFO - Running post-action listener: find_tests_for_verification 17:26:47 INFO - Running post-action listener: set_extra_try_arguments 17:26:47 INFO - [mozharness: 2017-10-01 00:26:47.921907Z] Finished download-and-extract step (success) 17:26:47 INFO - [mozharness: 2017-10-01 00:26:47.922004Z] Running populate-webroot step. 17:26:47 INFO - Running pre-action listener: _resource_record_pre_action 17:26:47 INFO - Running main action method: populate_webroot 17:26:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:26:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:47 INFO - 'tests': ['tresize', 17:26:47 INFO - 'tcanvasmark']}, 17:26:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:26:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:47 INFO - 'tests': ['dromaeo_css', 17:26:47 INFO - 'kraken']}, 17:26:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:26:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:26:47 INFO - 'talos_options': ['--disable-stylo'], 17:26:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:26:47 INFO - 'tests': ['damp', 'tps']}, 17:26:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:26:47 INFO - 'talos_options': ['--disable-stylo'], 17:26:47 INFO - 'tests': ['damp', 'tps']}, 17:26:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:26:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:47 INFO - 'tests': ['dromaeo_dom']}, 17:26:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:26:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:47 INFO - 'tests': ['basic_compositor_video', 17:26:47 INFO - 'glvideo']}, 17:26:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:26:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:26:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:26:47 INFO - 'talos_options': ['--disable-stylo'], 17:26:47 INFO - 'tests': ['ts_paint_webext', 17:26:47 INFO - 'tp5o_webext']}, 17:26:47 INFO - 'other-e10s': {'tests': ['a11yr', 17:26:47 INFO - 'ts_paint', 17:26:47 INFO - 'tpaint', 17:26:47 INFO - 'sessionrestore', 17:26:47 INFO - 'sessionrestore_many_windows', 17:26:47 INFO - 'sessionrestore_no_auto_restore', 17:26:47 INFO - 'tabpaint', 17:26:47 INFO - 'cpstartup']}, 17:26:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:47 INFO - 'tests': ['a11yr', 17:26:47 INFO - 'ts_paint', 17:26:47 INFO - 'tpaint', 17:26:47 INFO - 'sessionrestore', 17:26:47 INFO - 'sessionrestore_many_windows', 17:26:47 INFO - 'sessionrestore_no_auto_restore', 17:26:47 INFO - 'tabpaint', 17:26:47 INFO - 'cpstartup']}, 17:26:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:26:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:26:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:47 INFO - 'tests': ['perf_reftest_singletons']}, 17:26:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:47 INFO - 'tests': ['perf_reftest']}, 17:26:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:26:47 INFO - 'tsvgr_opacity', 17:26:47 INFO - 'tart', 17:26:47 INFO - 'tscrollx', 17:26:47 INFO - 'tsvg_static']}, 17:26:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:47 INFO - 'tests': ['tsvgx', 17:26:47 INFO - 'tsvgr_opacity', 17:26:47 INFO - 'tart', 17:26:47 INFO - 'tscrollx', 17:26:47 INFO - 'tsvg_static']}, 17:26:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:26:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:26:47 INFO - 'talos_options': ['--disable-stylo'], 17:26:47 INFO - 'tests': ['tp5o']}, 17:26:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:26:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:26:47 INFO - 'talos_options': ['--mitmproxy', 17:26:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:26:47 INFO - '--firstNonBlankPaint'], 17:26:47 INFO - 'tests': ['tp6_google', 17:26:47 INFO - 'tp6_youtube', 17:26:47 INFO - 'tp6_amazon', 17:26:47 INFO - 'tp6_facebook']}, 17:26:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:26:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:26:47 INFO - 'talos_options': ['--disable-stylo', 17:26:47 INFO - '--mitmproxy', 17:26:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:26:47 INFO - '--firstNonBlankPaint'], 17:26:47 INFO - 'tests': ['tp6_google', 17:26:47 INFO - 'tp6_youtube', 17:26:47 INFO - 'tp6_amazon', 17:26:47 INFO - 'tp6_facebook']}, 17:26:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:26:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:26:47 INFO - 'talos_options': ['--stylo-threads=1', 17:26:47 INFO - '--mitmproxy', 17:26:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:26:47 INFO - '--firstNonBlankPaint'], 17:26:47 INFO - 'tests': ['tp6_google', 17:26:47 INFO - 'tp6_youtube', 17:26:47 INFO - 'tp6_amazon', 17:26:47 INFO - 'tp6_facebook']}, 17:26:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:26:47 INFO - 'talos_options': ['--xperf_path', 17:26:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:47 INFO - 'tests': ['tp5n']}, 17:26:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:26:47 INFO - 'talos_options': ['--disable-stylo', 17:26:47 INFO - '--xperf_path', 17:26:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:47 INFO - 'tests': ['tp5n']}}} 17:26:47 INFO - Running post-action listener: _resource_record_post_action 17:26:47 INFO - [mozharness: 2017-10-01 00:26:47.937462Z] Finished populate-webroot step (success) 17:26:47 INFO - [mozharness: 2017-10-01 00:26:47.937551Z] Running create-virtualenv step. 17:26:47 INFO - Running pre-action listener: _resource_record_pre_action 17:26:47 INFO - Running main action method: create_virtualenv 17:26:47 INFO - Creating virtualenv /builds/slave/test/build/venv 17:26:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:26:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:26:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:26:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:26:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:26:48 INFO - Installing distribute.............................................................................................................................................................................................done. 17:26:49 INFO - Installing pip...............done. 17:26:49 INFO - Return code: 0 17:26:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:26:49 INFO - Reading from file tmpfile_stdout 17:26:49 INFO - Output received: 17:26:49 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:26:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xca71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10149c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d60>, '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 0x1012a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012ef0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', '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:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:26:49 INFO - Using env: {'DISPLAY': ':0', 17:26:49 INFO - 'HOME': '/home/cltbld', 17:26:49 INFO - 'LANG': 'en_US.UTF-8', 17:26:49 INFO - 'LANGUAGE': 'en_US:en', 17:26:49 INFO - 'LOGNAME': 'cltbld', 17:26:49 INFO - 'MAIL': '/var/mail/cltbld', 17:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:49 INFO - 'MOZ_NO_REMOTE': '1', 17:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:49 INFO - 'NO_EM_RESTART': '1', 17:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:49 INFO - 'PWD': '/builds/slave/test', 17:26:49 INFO - 'SHELL': '/bin/bash', 17:26:49 INFO - 'SHLVL': '1', 17:26:49 INFO - 'TERM': 'linux', 17:26:49 INFO - 'TMOUT': '86400', 17:26:49 INFO - 'USER': 'cltbld', 17:26:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', 17:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:49 INFO - '_': '/tools/buildbot/bin/python'} 17:26:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:26:50 INFO - Downloading/unpacking pip>=1.5 17:26:50 INFO - Running setup.py egg_info for package pip 17:26:50 INFO - warning: no files found matching 'pip/cacert.pem' 17:26:50 INFO - warning: no files found matching '*.html' under directory 'docs' 17:26:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:26:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:26:50 INFO - Installing collected packages: pip 17:26:50 INFO - Found existing installation: pip 1.1 17:26:50 INFO - Uninstalling pip: 17:26:50 INFO - Successfully uninstalled pip 17:26:50 INFO - Running setup.py install for pip 17:26:50 INFO - warning: no files found matching 'pip/cacert.pem' 17:26:50 INFO - warning: no files found matching '*.html' under directory 'docs' 17:26:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:26:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:26:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:26:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:26:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:26:50 INFO - Successfully installed pip 17:26:50 INFO - Cleaning up... 17:26:50 INFO - Return code: 0 17:26:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xca71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10149c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d60>, '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 0x1012a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012ef0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', '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:26:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:26:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:26:50 INFO - Using env: {'DISPLAY': ':0', 17:26:50 INFO - 'HOME': '/home/cltbld', 17:26:50 INFO - 'LANG': 'en_US.UTF-8', 17:26:50 INFO - 'LANGUAGE': 'en_US:en', 17:26:50 INFO - 'LOGNAME': 'cltbld', 17:26:50 INFO - 'MAIL': '/var/mail/cltbld', 17:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:50 INFO - 'MOZ_NO_REMOTE': '1', 17:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:50 INFO - 'NO_EM_RESTART': '1', 17:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:50 INFO - 'PWD': '/builds/slave/test', 17:26:50 INFO - 'SHELL': '/bin/bash', 17:26:50 INFO - 'SHLVL': '1', 17:26:50 INFO - 'TERM': 'linux', 17:26:50 INFO - 'TMOUT': '86400', 17:26:50 INFO - 'USER': 'cltbld', 17:26:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', 17:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:50 INFO - '_': '/tools/buildbot/bin/python'} 17:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:50 INFO - Downloading/unpacking psutil>=3.1.1 17:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:51 INFO - Installing collected packages: psutil 17:26:51 INFO - Running setup.py install for psutil 17:26:51 INFO - building 'psutil._psutil_linux' extension 17:26:52 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:26:53 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:26:53 INFO - building 'psutil._psutil_posix' extension 17:26:53 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:26:53 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:26:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:53 INFO - Successfully installed psutil 17:26:53 INFO - Cleaning up... 17:26:53 INFO - Return code: 0 17:26:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xca71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10149c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d60>, '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 0x1012a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012ef0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', '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:26:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:26:53 INFO - Using env: {'DISPLAY': ':0', 17:26:53 INFO - 'HOME': '/home/cltbld', 17:26:53 INFO - 'LANG': 'en_US.UTF-8', 17:26:53 INFO - 'LANGUAGE': 'en_US:en', 17:26:53 INFO - 'LOGNAME': 'cltbld', 17:26:53 INFO - 'MAIL': '/var/mail/cltbld', 17:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:53 INFO - 'MOZ_NO_REMOTE': '1', 17:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:53 INFO - 'NO_EM_RESTART': '1', 17:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:53 INFO - 'PWD': '/builds/slave/test', 17:26:53 INFO - 'SHELL': '/bin/bash', 17:26:53 INFO - 'SHLVL': '1', 17:26:53 INFO - 'TERM': 'linux', 17:26:53 INFO - 'TMOUT': '86400', 17:26:53 INFO - 'USER': 'cltbld', 17:26:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', 17:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:53 INFO - '_': '/tools/buildbot/bin/python'} 17:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:26:55 INFO - Installing collected packages: mozsystemmonitor 17:26:55 INFO - Running setup.py install for mozsystemmonitor 17:26:55 INFO - Successfully installed mozsystemmonitor 17:26:55 INFO - Cleaning up... 17:26:55 INFO - Return code: 0 17:26:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:26: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:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26: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:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26: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', '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 0xca71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10149c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d60>, '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 0x1012a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012ef0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', '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:26: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:26: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 jsonschema==2.5.1 17:26:55 INFO - Using env: {'DISPLAY': ':0', 17:26:55 INFO - 'HOME': '/home/cltbld', 17:26:55 INFO - 'LANG': 'en_US.UTF-8', 17:26:55 INFO - 'LANGUAGE': 'en_US:en', 17:26:55 INFO - 'LOGNAME': 'cltbld', 17:26:55 INFO - 'MAIL': '/var/mail/cltbld', 17:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:55 INFO - 'MOZ_NO_REMOTE': '1', 17:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:55 INFO - 'NO_EM_RESTART': '1', 17:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:55 INFO - 'PWD': '/builds/slave/test', 17:26:55 INFO - 'SHELL': '/bin/bash', 17:26:55 INFO - 'SHLVL': '1', 17:26:55 INFO - 'TERM': 'linux', 17:26:55 INFO - 'TMOUT': '86400', 17:26:55 INFO - 'USER': 'cltbld', 17:26:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', 17:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:55 INFO - '_': '/tools/buildbot/bin/python'} 17:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:55 INFO - Downloading/unpacking jsonschema==2.5.1 17:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:26:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:26: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:26: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:26: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:26: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:26:56 INFO - Downloading functools32-3.2.3-2.tar.gz 17:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:26:56 INFO - warning: no files found matching '*.txt' 17:26:56 INFO - no previously-included directories found matching 'build' 17:26:56 INFO - no previously-included directories found matching 'dist' 17:26:56 INFO - no previously-included directories found matching '.git*' 17:26:56 INFO - Installing collected packages: jsonschema, functools32 17:26:56 INFO - Running setup.py install for functools32 17:26:56 INFO - warning: no files found matching '*.txt' 17:26:56 INFO - no previously-included directories found matching 'build' 17:26:56 INFO - no previously-included directories found matching 'dist' 17:26:56 INFO - no previously-included directories found matching '.git*' 17:26:56 INFO - Successfully installed jsonschema functools32 17:26:56 INFO - Cleaning up... 17:26:56 INFO - Return code: 0 17:26:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:26: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:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26: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:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26: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', '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 0xca71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10149c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d60>, '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 0x1012a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012ef0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', '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:26: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:26: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 functools32==3.2.3-2 17:26:56 INFO - Using env: {'DISPLAY': ':0', 17:26:56 INFO - 'HOME': '/home/cltbld', 17:26:56 INFO - 'LANG': 'en_US.UTF-8', 17:26:56 INFO - 'LANGUAGE': 'en_US:en', 17:26:56 INFO - 'LOGNAME': 'cltbld', 17:26:56 INFO - 'MAIL': '/var/mail/cltbld', 17:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:56 INFO - 'MOZ_NO_REMOTE': '1', 17:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:56 INFO - 'NO_EM_RESTART': '1', 17:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:56 INFO - 'PWD': '/builds/slave/test', 17:26:56 INFO - 'SHELL': '/bin/bash', 17:26:56 INFO - 'SHLVL': '1', 17:26:56 INFO - 'TERM': 'linux', 17:26:56 INFO - 'TMOUT': '86400', 17:26:56 INFO - 'USER': 'cltbld', 17:26:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', 17:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:56 INFO - '_': '/tools/buildbot/bin/python'} 17:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:26:57 INFO - Cleaning up... 17:26:57 INFO - Return code: 0 17:26:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:26:57 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:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:57 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:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:57 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 0xca71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10149c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d60>, '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 0x1012a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012ef0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', '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:26:57 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:26:57 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:26:57 INFO - Using env: {'DISPLAY': ':0', 17:26:57 INFO - 'HOME': '/home/cltbld', 17:26:57 INFO - 'LANG': 'en_US.UTF-8', 17:26:57 INFO - 'LANGUAGE': 'en_US:en', 17:26:57 INFO - 'LOGNAME': 'cltbld', 17:26:57 INFO - 'MAIL': '/var/mail/cltbld', 17:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:57 INFO - 'MOZ_NO_REMOTE': '1', 17:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:57 INFO - 'NO_EM_RESTART': '1', 17:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:57 INFO - 'PWD': '/builds/slave/test', 17:26:57 INFO - 'SHELL': '/bin/bash', 17:26:57 INFO - 'SHLVL': '1', 17:26:57 INFO - 'TERM': 'linux', 17:26:57 INFO - 'TMOUT': '86400', 17:26:57 INFO - 'USER': 'cltbld', 17:26:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', 17:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:57 INFO - '_': '/tools/buildbot/bin/python'} 17:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:57 INFO - Downloading/unpacking blobuploader==1.2.4 17:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:58 INFO - Downloading blobuploader-1.2.4.tar.gz 17:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:26:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:26: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:26: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:26: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:26: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:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:26:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:26: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:26: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:26: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:26: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:26:58 INFO - Downloading docopt-0.6.1.tar.gz 17:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:26:59 INFO - Installing collected packages: blobuploader, requests, docopt 17:26:59 INFO - Running setup.py install for blobuploader 17:26:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:26:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:26:59 INFO - Running setup.py install for requests 17:26:59 INFO - Running setup.py install for docopt 17:26:59 INFO - Successfully installed blobuploader requests docopt 17:26:59 INFO - Cleaning up... 17:26:59 INFO - Return code: 0 17:26:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xca71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10149c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d60>, '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 0x1012a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012ef0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', '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:26:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:26:59 INFO - Using env: {'DISPLAY': ':0', 17:26:59 INFO - 'HOME': '/home/cltbld', 17:26:59 INFO - 'LANG': 'en_US.UTF-8', 17:26:59 INFO - 'LANGUAGE': 'en_US:en', 17:26:59 INFO - 'LOGNAME': 'cltbld', 17:26:59 INFO - 'MAIL': '/var/mail/cltbld', 17:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:59 INFO - 'MOZ_NO_REMOTE': '1', 17:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:59 INFO - 'NO_EM_RESTART': '1', 17:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:59 INFO - 'PWD': '/builds/slave/test', 17:26:59 INFO - 'SHELL': '/bin/bash', 17:26:59 INFO - 'SHLVL': '1', 17:26:59 INFO - 'TERM': 'linux', 17:26:59 INFO - 'TMOUT': '86400', 17:26:59 INFO - 'USER': 'cltbld', 17:26:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', 17:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:59 INFO - '_': '/tools/buildbot/bin/python'} 17:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:26:59 INFO - Running setup.py (path:/tmp/pip-XmCiQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:26:59 INFO - Running setup.py (path:/tmp/pip-6BOHOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:26:59 INFO - Running setup.py (path:/tmp/pip-cQyyWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:27:00 INFO - Running setup.py (path:/tmp/pip-76oSVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:27:00 INFO - Running setup.py (path:/tmp/pip-ipXg3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:27:00 INFO - Running setup.py (path:/tmp/pip-uDwXBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:27:00 INFO - Running setup.py (path:/tmp/pip-IDZnh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:27:00 INFO - Running setup.py (path:/tmp/pip-XlJjhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:27:00 INFO - Running setup.py (path:/tmp/pip-B_7x6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:27:00 INFO - Running setup.py (path:/tmp/pip-rc2ish-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:27:00 INFO - Running setup.py (path:/tmp/pip-INVjwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:27:00 INFO - Running setup.py (path:/tmp/pip-jTkts7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:27:00 INFO - Running setup.py (path:/tmp/pip-gDU6KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:27:00 INFO - Running setup.py (path:/tmp/pip-b3fZCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:00 INFO - Running setup.py (path:/tmp/pip-TMGTN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:27:00 INFO - Running setup.py (path:/tmp/pip-vijuTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:27:00 INFO - Running setup.py (path:/tmp/pip-D9DNjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:27:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:27:01 INFO - Running setup.py install for manifestparser 17:27:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Running setup.py install for mozcrash 17:27:01 INFO - Running setup.py install for mozdebug 17:27:01 INFO - Running setup.py install for mozdevice 17:27:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Running setup.py install for mozfile 17:27:01 INFO - Running setup.py install for mozhttpd 17:27:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Running setup.py install for mozinfo 17:27:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Running setup.py install for mozInstall 17:27:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Running setup.py install for mozleak 17:27:01 INFO - Running setup.py install for mozlog 17:27:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:27:02 INFO - Running setup.py install for moznetwork 17:27:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:27:02 INFO - Running setup.py install for mozprocess 17:27:02 INFO - Running setup.py install for mozprofile 17:27:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:27:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:27:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:27:02 INFO - Running setup.py install for mozrunner 17:27:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:27:02 INFO - Running setup.py install for mozscreenshot 17:27:02 INFO - Running setup.py install for moztest 17:27:02 INFO - Running setup.py install for mozversion 17:27:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:27:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:27:02 INFO - Cleaning up... 17:27:02 INFO - Return code: 0 17:27:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27: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:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27: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:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xca71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10149c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d60>, '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 0x1012a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012ef0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', '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:27:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:27:02 INFO - Using env: {'DISPLAY': ':0', 17:27:02 INFO - 'HOME': '/home/cltbld', 17:27:02 INFO - 'LANG': 'en_US.UTF-8', 17:27:02 INFO - 'LANGUAGE': 'en_US:en', 17:27:02 INFO - 'LOGNAME': 'cltbld', 17:27:02 INFO - 'MAIL': '/var/mail/cltbld', 17:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:02 INFO - 'MOZ_NO_REMOTE': '1', 17:27:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:02 INFO - 'NO_EM_RESTART': '1', 17:27:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:02 INFO - 'PWD': '/builds/slave/test', 17:27:02 INFO - 'SHELL': '/bin/bash', 17:27:02 INFO - 'SHLVL': '1', 17:27:02 INFO - 'TERM': 'linux', 17:27:02 INFO - 'TMOUT': '86400', 17:27:02 INFO - 'USER': 'cltbld', 17:27:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', 17:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:02 INFO - '_': '/tools/buildbot/bin/python'} 17:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:27:03 INFO - Running setup.py (path:/tmp/pip-KPeXBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:27:03 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:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:27:03 INFO - Running setup.py (path:/tmp/pip-XU_X6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:27:03 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:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:27:03 INFO - Running setup.py (path:/tmp/pip-9K1Ycy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:27:03 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:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:27:03 INFO - Running setup.py (path:/tmp/pip-xKNXRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:27:03 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:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:27:03 INFO - Running setup.py (path:/tmp/pip-wIkM3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:27:03 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:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:27:03 INFO - Running setup.py (path:/tmp/pip-MArb0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:27:03 INFO - Running setup.py (path:/tmp/pip-FPRUsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:27:03 INFO - Running setup.py (path:/tmp/pip-LXamxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:27:03 INFO - Running setup.py (path:/tmp/pip-eNPjNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:27:03 INFO - Running setup.py (path:/tmp/pip-TGOKth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:27:03 INFO - Running setup.py (path:/tmp/pip-0g8YxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:27:03 INFO - Running setup.py (path:/tmp/pip-MytNKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:27:03 INFO - Running setup.py (path:/tmp/pip-ikRpW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:27:03 INFO - Running setup.py (path:/tmp/pip-bdWkjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:27:04 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:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:04 INFO - Running setup.py (path:/tmp/pip-Hetyf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:04 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:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:27:04 INFO - Running setup.py (path:/tmp/pip-4f2wEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:27:04 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:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:27:04 INFO - Running setup.py (path:/tmp/pip-YP83sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:27:04 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:27:04 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:27:04 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:27:04 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:27:04 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:27:04 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:27:04 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:27:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:27: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:27: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:27: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:27: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:27:05 INFO - Downloading blessings-1.6.tar.gz 17:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:27:05 INFO - Installing collected packages: blessings 17:27:05 INFO - Running setup.py install for blessings 17:27:05 INFO - Successfully installed blessings 17:27:05 INFO - Cleaning up... 17:27:05 INFO - Return code: 0 17:27:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:05 INFO - Reading from file tmpfile_stdout 17:27:05 INFO - Current package versions: 17:27:05 INFO - argparse == 1.2.1 17:27:05 INFO - blessings == 1.6 17:27:05 INFO - blobuploader == 1.2.4 17:27:05 INFO - docopt == 0.6.1 17:27:05 INFO - functools32 == 3.2.3-2 17:27:05 INFO - jsonschema == 2.5.1 17:27:05 INFO - manifestparser == 1.1 17:27:05 INFO - mozInstall == 1.13 17:27:05 INFO - mozcrash == 1.0 17:27:05 INFO - mozdebug == 0.1 17:27:05 INFO - mozdevice == 0.51 17:27:05 INFO - mozfile == 1.2 17:27:05 INFO - mozhttpd == 0.7 17:27:05 INFO - mozinfo == 0.10 17:27:05 INFO - mozleak == 0.1 17:27:05 INFO - mozlog == 3.5 17:27:05 INFO - moznetwork == 0.27 17:27:05 INFO - mozprocess == 0.25 17:27:05 INFO - mozprofile == 0.28 17:27:05 INFO - mozrunner == 6.13 17:27:05 INFO - mozscreenshot == 0.1 17:27:05 INFO - mozsystemmonitor == 0.3 17:27:05 INFO - moztest == 0.8 17:27:05 INFO - mozversion == 1.4 17:27:05 INFO - psutil == 3.1.1 17:27:05 INFO - requests == 1.2.3 17:27:05 INFO - wsgiref == 0.1.2 17:27:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27: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:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27: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:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xca71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10149c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d60>, '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 0x1012a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012ef0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', '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:27:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:27:05 INFO - Using env: {'DISPLAY': ':0', 17:27:05 INFO - 'HOME': '/home/cltbld', 17:27:05 INFO - 'LANG': 'en_US.UTF-8', 17:27:05 INFO - 'LANGUAGE': 'en_US:en', 17:27:05 INFO - 'LOGNAME': 'cltbld', 17:27:05 INFO - 'MAIL': '/var/mail/cltbld', 17:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:05 INFO - 'MOZ_NO_REMOTE': '1', 17:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:05 INFO - 'NO_EM_RESTART': '1', 17:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:05 INFO - 'PWD': '/builds/slave/test', 17:27:05 INFO - 'SHELL': '/bin/bash', 17:27:05 INFO - 'SHLVL': '1', 17:27:05 INFO - 'TERM': 'linux', 17:27:05 INFO - 'TMOUT': '86400', 17:27:05 INFO - 'USER': 'cltbld', 17:27:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', 17:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:05 INFO - '_': '/tools/buildbot/bin/python'} 17:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:06 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:27:06 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:27:06 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:27:06 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:27:06 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:27:06 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:27:06 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:27:06 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:27:06 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:27:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:27:06 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:27:06 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:27:06 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:27:06 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:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:27:07 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:27:07 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:27:07 INFO - Installing collected packages: simplejson 17:27:07 INFO - Running setup.py install for simplejson 17:27:07 INFO - building 'simplejson._speedups' extension 17:27:07 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:27:08 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:27:08 INFO - Successfully installed simplejson 17:27:08 INFO - Cleaning up... 17:27:08 INFO - Return code: 0 17:27:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:27: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:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27: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:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:08 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 0xca71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10149c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d60>, '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 0x1012a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012ef0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', '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:27:08 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:27:08 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:27:08 INFO - Using env: {'DISPLAY': ':0', 17:27:08 INFO - 'HOME': '/home/cltbld', 17:27:08 INFO - 'LANG': 'en_US.UTF-8', 17:27:08 INFO - 'LANGUAGE': 'en_US:en', 17:27:08 INFO - 'LOGNAME': 'cltbld', 17:27:08 INFO - 'MAIL': '/var/mail/cltbld', 17:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:08 INFO - 'MOZ_NO_REMOTE': '1', 17:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:08 INFO - 'NO_EM_RESTART': '1', 17:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:08 INFO - 'PWD': '/builds/slave/test', 17:27:08 INFO - 'SHELL': '/bin/bash', 17:27:08 INFO - 'SHLVL': '1', 17:27:08 INFO - 'TERM': 'linux', 17:27:08 INFO - 'TMOUT': '86400', 17:27:08 INFO - 'USER': 'cltbld', 17:27:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', 17:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:08 INFO - '_': '/tools/buildbot/bin/python'} 17:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:27:08 INFO - Cleaning up... 17:27:08 INFO - Return code: 0 17:27:08 INFO - Running post-action listener: _resource_record_post_action 17:27:08 INFO - Running post-action listener: _start_resource_monitoring 17:27:08 INFO - Starting resource monitoring. 17:27:08 INFO - [mozharness: 2017-10-01 00:27:08.558299Z] Finished create-virtualenv step (success) 17:27:08 INFO - [mozharness: 2017-10-01 00:27:08.559301Z] Running install step. 17:27:08 INFO - Running pre-action listener: _resource_record_pre_action 17:27:08 INFO - Running main action method: install 17:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:08 INFO - Reading from file tmpfile_stdout 17:27:08 INFO - Detecting whether we're running mozinstall >=1.0... 17:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:27:08 INFO - Reading from file tmpfile_stdout 17:27:08 INFO - Output received: 17:27:08 INFO - Usage: mozinstall [options] installer 17:27:08 INFO - Options: 17:27:08 INFO - -h, --help show this help message and exit 17:27:08 INFO - -d DEST, --destination=DEST 17:27:08 INFO - Directory to install application into. [default: 17:27:08 INFO - "/builds/slave/test"] 17:27:08 INFO - --app=APP Application being installed. [default: firefox] 17:27:08 INFO - mkdir: /builds/slave/test/build/application 17:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:27:26 INFO - Reading from file tmpfile_stdout 17:27:26 INFO - Output received: 17:27:26 INFO - /builds/slave/test/build/application/firefox/firefox 17:27:26 INFO - Running post-action listener: _resource_record_post_action 17:27:26 INFO - [mozharness: 2017-10-01 00:27:26.522324Z] Finished install step (success) 17:27:26 INFO - [mozharness: 2017-10-01 00:27:26.522573Z] Running setup-mitmproxy step. 17:27:26 INFO - Running pre-action listener: _resource_record_pre_action 17:27:26 INFO - Running main action method: setup_mitmproxy 17:27:26 INFO - Skipping: mitmproxy is not required 17:27:26 INFO - Running post-action listener: _resource_record_post_action 17:27:26 INFO - [mozharness: 2017-10-01 00:27:26.523710Z] Finished setup-mitmproxy step (success) 17:27:26 INFO - [mozharness: 2017-10-01 00:27:26.523928Z] Running run-tests step. 17:27:26 INFO - Running pre-action listener: _resource_record_pre_action 17:27:26 INFO - Running pre-action listener: _set_gcov_prefix 17:27:26 INFO - Running main action method: run_tests 17:27:26 WARNING - Try message not found. 17:27:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:27:26 INFO - Python 2.7.3 17:27:26 INFO - Return code: 0 17:27:26 INFO - grabbing minidump binary from tooltool 17:27:26 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:27:26 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 0x1011d60>, '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 0x1012a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:27:26 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:27:26 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:27:26 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:27:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:27:26 INFO - Return code: 0 17:27:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:27:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:27:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:27:26 INFO - ENV: RUST_BACKTRACE is now full 17:27:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:27:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:27:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 17:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 17:27:26 INFO - Using env: {'DISPLAY': ':0', 17:27:26 INFO - 'HOME': '/home/cltbld', 17:27:26 INFO - 'LANG': 'en_US.UTF-8', 17:27:26 INFO - 'LANGUAGE': 'en_US:en', 17:27:26 INFO - 'LOGNAME': 'cltbld', 17:27:26 INFO - 'MAIL': '/var/mail/cltbld', 17:27:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:27:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:26 INFO - 'MOZ_NO_REMOTE': '1', 17:27:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:27:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:26 INFO - 'NO_EM_RESTART': '1', 17:27:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:26 INFO - 'PWD': '/builds/slave/test', 17:27:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:27:26 INFO - 'RUST_BACKTRACE': 'full', 17:27:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:27:26 INFO - 'SHELL': '/bin/bash', 17:27:26 INFO - 'SHLVL': '1', 17:27:26 INFO - 'TERM': 'linux', 17:27:26 INFO - 'TMOUT': '86400', 17:27:26 INFO - 'USER': 'cltbld', 17:27:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', 17:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:26 INFO - '_': '/tools/buildbot/bin/python'} 17:27:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 17:27:27 INFO - mozversion application_buildid: 20170930230214 17:27:27 INFO - mozversion application_changeset: 179dccc17c7f261347436b4b1c33029c8272960b 17:27:27 INFO - mozversion application_display_name: FirefoxNightly 17:27:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:27:27 INFO - mozversion application_name: Firefox 17:27:27 INFO - mozversion application_remotingname: firefox 17:27:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:27:27 INFO - mozversion application_vendor: Mozilla 17:27:27 INFO - mozversion application_version: 58.0a1 17:27:27 INFO - mozversion platform_buildid: 20170930230214 17:27:27 INFO - mozversion platform_changeset: 179dccc17c7f261347436b4b1c33029c8272960b 17:27:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:27:27 INFO - mozversion platform_version: 58.0a1 17:27:27 INFO - using testdate: 1506817647 17:27:27 INFO - actual date: 1506817647 17:27:27 INFO - starting webserver on 'localhost:49498' 17:27:27 INFO - SUITE-START | Running 2 tests 17:27:27 INFO - TEST-START | dromaeo_css 17:27:27 INFO - Initialising browser for dromaeo_css test... 17:27:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49498/getInfo.html -profile /tmp/tmpqkhZQ0/profile 17:27:27 INFO - TEST-INFO | started process 3662 (/builds/slave/test/build/application/firefox/firefox http://localhost:49498/getInfo.html) 17:27:34 INFO - TEST-INFO | 3662: exit 0 17:27:34 INFO - Browser initialized. 17:27:34 INFO - Running cycle 1/1 for dromaeo_css test... 17:27:34 INFO - Using env: {'DISPLAY': ':0', 17:27:34 INFO - 'HOME': '/home/cltbld', 17:27:34 INFO - 'JSGC_DISABLE_POISONING': '1', 17:27:34 INFO - 'LANG': 'en_US.UTF-8', 17:27:34 INFO - 'LANGUAGE': 'en_US:en', 17:27:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:27:34 INFO - 'LOGNAME': 'cltbld', 17:27:34 INFO - 'MAIL': '/var/mail/cltbld', 17:27:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:27:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:27:34 INFO - 'MOZ_CRASHREPORTER': '1', 17:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:27:34 INFO - 'MOZ_NO_REMOTE': '1', 17:27:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:34 INFO - 'NO_EM_RESTART': '1', 17:27:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:34 INFO - 'PWD': '/builds/slave/test', 17:27:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:27:34 INFO - 'RUST_BACKTRACE': 'full', 17:27:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:27:34 INFO - 'SHELL': '/bin/bash', 17:27:34 INFO - 'SHLVL': '1', 17:27:34 INFO - 'STYLO_FORCE_DISABLED': '1', 17:27:34 INFO - 'TERM': 'linux', 17:27:34 INFO - 'TMOUT': '86400', 17:27:34 INFO - 'USER': 'cltbld', 17:27:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', 17:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:34 INFO - '_': '/tools/buildbot/bin/python'} 17:27:34 INFO - TEST-INFO | started process 3905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqkhZQ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:35 INFO - PID 3905 | 17:27:35 INFO - PID 3905 | (/builds/slave/test/build/application/firefox/firefox:3954): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:27:35 INFO - PID 3905 | 17:27:45 INFO - PID 3905 | RSS: Main: 140918784 17:27:45 INFO - PID 3905 | 17:30:42 INFO - PID 3905 | Cycle 1(1): loaded http://localhost:49498/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49498/tests/dromaeo/cssquery-ext.html) 17:30:44 INFO - PID 3905 | RSS: Main: 142925824 17:30:44 INFO - PID 3905 | 17:33:46 INFO - PID 3905 | Cycle 1(1): loaded http://localhost:49498/tests/dromaeo/cssquery-ext.html (next: http://localhost:49498/tests/dromaeo/cssquery-jquery.html) 17:33:47 INFO - PID 3905 | RSS: Main: 144330752 17:33:47 INFO - PID 3905 | 17:36:48 INFO - PID 3905 | Cycle 1(1): loaded http://localhost:49498/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49498/tests/dromaeo/cssquery-mootools.html) 17:36:49 INFO - PID 3905 | RSS: Main: 144596992 17:36:49 INFO - PID 3905 | 17:39:50 INFO - PID 3905 | Cycle 1(1): loaded http://localhost:49498/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49498/tests/dromaeo/cssquery-prototype.html) 17:39:51 INFO - PID 3905 | RSS: Main: 144977920 17:39:51 INFO - PID 3905 | 17:42:54 INFO - PID 3905 | Cycle 1(1): loaded http://localhost:49498/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49498/tests/dromaeo/cssquery-yui.html) 17:42:54 INFO - PID 3905 | RSS: Main: 147730432 17:42:54 INFO - PID 3905 | 17:45:56 INFO - PID 3905 | Cycle 1(1): loaded http://localhost:49498/tests/dromaeo/cssquery-yui.html (next: http://localhost:49498/tests/dromaeo/cssquery-dojo.html) 17:45:56 INFO - PID 3905 | RSS: Main: 149237760 17:45:56 INFO - PID 3905 | 17:45:56 INFO - PID 3905 | __start_tp_report 17:45:56 INFO - PID 3905 | _x_x_mozilla_page_load 17:45:56 INFO - PID 3905 | _x_x_mozilla_page_load_details 17:45:56 INFO - PID 3905 | |i|pagename|runs| 17:45:56 INFO - PID 3905 | |0;dojo.html;3839.1553858151215;3866.8839934801968;3889.416587511873;3895.4741109950164;3897.7661340319564;6152.907706384408;6178.227721534809;6201.193844800176;6248.812535623927;6364.331745166754;6187.319394866572;6196.442320191182;6196.876062478747;6212.5961812482155;6215.62706237626;5579.38626751057;5590.972045139779;5604;5615.80344687936;5676.659400435987;5715.228444160027;5743.253377060976;5756.740946657411;5774.105013722879;5796.855078623026;5650.463205995424;5695.401982791809;5703.03048481757;5724.5992780505385;5729.169270455782;5154.690718556899;5444.972775136139;5584.4136365681425;5642.548596112301;5643.209950606918;5574.080276754331;5579.13523403873;5646.18130371098;5659.773609055633;5663.207150998864;6191.4118158774845;6217.378262173792;6291.8741625167695;6316.147320111772;6317.936820631827;6626.966865165691;6661.000849872509;6668.099806526106;6671.499637527157;6672.065910772496;6719.092922455455;6731.663416829139;6852.931470685279;6908.689108990107;6935.895961560581;6352.523560732871;6440.5491615586925;6458.967705161491;6463.192100987423;6466.773662921775;7050.083489146481;7064.540804847668;7136;7148.964255178691;7156.177039640508;6644.634545099969;6657.933420665829;6743.15710536183;6785.084013658192;6809.863802724017;6947.51367404287;6955.095837541087;6974.337437943387;6978.581285122909;6996.090508233897;6804.387605115465;6808.353206445379;6887.035814985906;6895.069165662671;6904.516683832184;6732.023856540774;6808.08090907731;6810.421114205249;6885.51801373899;6910.2053263874295;4934.703917764874;4936.160852655057;4950.059488697208;4950.133726597903;4951.356323677899;4536.79584418702;4564.1556312082375;4606.5854073132905;4619.214733495314;4636.466806317317;6239.78160764371;6260.46786023184;6279.874402511924;6341.017142342944;6341.302456729756;6617.735290588419;6784.287649796799;6802.897956530656;6885.208201056842;6910.585364878123;6262.15460912771;6292.05619157121;6307.747690092437;6318.241810982711;6322.747090116344;5546.55627549795;5579.804706835242;5592.748326325325;5625.46558076982;5629.4652008059165;7106.253843346374;7115.1106111736035;7130.465215108888;7195.172555156119;7215.819604509929;6831.351021652935;6840.555363901331;6908.965455172692;6927.064846245894;6931.757388491378;7002.019717239488;7070.257622949516;7072.292770723092;7074.327938845801;7110.7511237106455;6700.229473610597;6755;6755.054292399166;6779.457643388419;6781;6897.034415181979;6900;6928.549644273307;6939.722411103701;6968.581885086911;6615.5038372123245;6618.139641846529;6707.832304192434;6710.027046078389;6717.966410167918;6525.282218956006;6617.966910165418;6619.040239165198;6706.463482921452;6722.596644201363;6496.902546461902;6517;6523.543351965507;6524.869502610016;6525.673716314261;6659.766908158192;6664.400203981665;6667.466602671871;6696.096027036482;6704.99425086241;6409.967950160406;6465.1595292611655;6467.611943283418;6557.704903279268;6577.375149360803 17:45:56 INFO - PID 3905 | |1;ext.html;946.2099147212077;959.2565761534814;975.4439969217547;1004.2969921055263;1009.8586197932289;44814;45541.316880246784;45593.77203113988;45681;45715.31427028589;40688.59311406885;41026.38460423096;41227;41333.58666413335;41459;7440.144383395911;7506.1367942686475;7514.135874374462;7556.093268807724;7592.468527203098;7438.888416673754;7490.812729681747;7505.211952744965;7506.887396689054;7529.284717951813;8326.66693332266;8498.320134389234;8516;8532.061473237969;8552;8425.241728244488;8438.915610843906;8495.532745698983;8502.914970850274;8504.489730616182;8286.544240066794;8376.246137847624;8448.197421244971;8452.197041281068;8485;41264.38103428451;41680.374794378105;41691.583084169375;41829.16341673149;41848;3650.1604630935035;3667.1015601177614;3691.151035261878;3698.0939669780805;3701.5743189533277;34160;34217.48673769896;34395.484067739;34429.48355774665;34466.65533344659;5414.187871819219;5427.864303392407;5429.212764149176;5430.782768689248;5542.695151766651;240440;241151;241553;242629.99999999822;242642;54736;54911.72544137254;54985.725071375186;55002;55099;56441.435585643616;56625.15062274069;56648.716756416776;56685.71657141688;56744;17132.40036598713;17550.210240539207;17558.561035973948;17575.296988120586;17609.7358539622;14373.78439323411;14392.42430302797;14397.352119154662;14409;14431.35058922351;15027.398904043934;15228.543143705707;15244.618884527754;15246.923765381101;15318.387264509518;6044.365341639153;6080.270367555921;6127.2647282325515;6219.378062193744;6226.59527130735;1081.6646839479786;1083.7778255457613;1104.2325583719237;1108.1688733449912;1110.8611423572054;26215.082472113383;26310.736892631212;26316.8684156578;26430.339241519116;26498;1157.1494951210852;1194.790911590468;1197.874223206568;1215.8844909733562;1223.2354778263584;13550.661233469242;14031.368588413547;14108.012439129163;14236.857631423552;14270.429182832779;302151;303776;303882;304203;304550;59061.70469147713;61571.384286156564;62120;62318;64076.359236407974;1457.242234038294;1502.9924850375678;1507.0656193160312;1508.2911031815029;1523.5277064110162;30168.24579385533;30725.692743073178;30810.229744256572;30866.53700194544;31609;42580.574194257664;43279;43293.35059974166;43341.34987975246;43383.34924976065;172485;173258.13370933064;173936;174333;175529.12235438742;35089.824550877085;36296.27407451889;36425.085993121014;36476.63523364838;36479.817600911825;46533.302000469346;47144.528554714016;47150.52849471599;47347.28979065248;47367;34884;34892.82553587216;35748.821255893556;36238;36313;35209.295814084086;35375.29249415049;35474;35658.82170589131;35909.28181436304;39752.80123599363;40732.79633601813;41153.79423102865;41312;41415.171696566504;33763.493547597296;33962.320753585285;34050.489242661875;34130;34491.655083448844;24312;25407.872960635817;25807.870960645076;26086.86956565205;26566.7343326572 17:45:56 INFO - PID 3905 | |2;jquery.html;618.882412341655;625.121704005872;626.4362074133277;626.5175814622739;640.6220330005297;23564.293071207892;24114.638280425785;24961.375965600848;25039.499210015787;25049.872755726014;22840.885795570997;23555.528889422203;23564.528709425802;23568.410789730264;23621.17325893594;6454.483641308696;6582.440492558138;6598.406143447089;6602.66986650668;6636.502262330345;6489.837754056162;6745.258021617618;6751.594904305733;6753.15585551806;6762.864742705143;6642.036904648847;6679.231888332831;6708.49686273529;6734.090897728793;6736.225334086594;6635.5686880353105;6688.531802773808;6710.966445167767;6721;6727.327267273283;6281.371862813682;6286.402791734778;6293.181886354791;6293.213348331458;6294.590851594632;29828;30222.84888575565;30766.53850192249;30831.2292192697;31051.068467946;2283.7259528856644;2294.380517260347;2307.757685443038;2321.9883900580558;2323.581755284048;20496.282630107875;21404.571908561742;21433.249836255658;21496.570068598696;21520.246791362228;2603.2971097803675;2617.6073588961617;2645.061003343824;2665.733426657338;2674.4784766970447;140862;146263;153054.23472882566;159339.2033039839;159637;16271.51185464438;16306.266218020217;16326.346946122023;16754.916225418794;16886;26932.59601105985;26971.73028269692;26981.865090674422;26995.595066074024;27015.459690806074;10944.671659850217;11136;11150;11348.943255283672;11429.771404571862;10237.283390162765;10272.435016074038;10347.12049475803;10358.482075896174;10418.739531511774;9912.801743965081;9993.900060999442;10145.137663298703;10285.537150828231;10356.585736570452;2906.1717410537894;2907.3458471843664;2999.2951656360738;3019.5168772996217;3047.6647568767416;1025.8409946458312;1054.9736256593646;1060.3690803971624;1064.1752641702742;1065.9147268218524;21314.680279795815;21820.781792181875;21848.01683924227;21892.45268868291;21902.671459927795;1126.7859106769688;1127.2222166705112;1133.557912414159;1136.7840110379002;1138.9886101139048;11750.059995200363;11835.526578936919;11876.64370068882;11905;11919;615359;624739;631840;634979;643144;136697;137384;138577;138604.30697846648;140365;1212.5513559982862;1227.4292454008928;1256.9371531423392;1263.1031967303134;1269.504893091695;18787.15457804375;18827.811721882605;18834.623307534046;18968.051597420348;19114.522136946132;61844;62967.37032629615;64219.67890160519;64527.67736161477;65372.34627653663;83010;83525.16474835417;83581.58209208916;84012;84543.5772821132;15770.369185232463;15872.92063539675;16045.67908641844;16084.919575402047;16112.274947627151;24117.276481705576;24139.758602413753;24175.153869614478;24291.14980975728;24415.877920610284;19395.030248487237;19936.60126797485;20049.59900802005;20171.59656806885;20196.495087622927;17282.481525554253;17698.115094245495;17712.55718607045;17730.29078836884;17935.282588696828;19509.219631214593;19627.80372196317;19707.211711531378;19976.800231997495;19994.60010799805;15608.687826243638;15672.216389180723;15698.686026279638;15829.445969391016;15956.68086638284;18884.244630214638;19101.140448679565;19102.7134592984;19384.612307753483;19408.4177474676 17:45:56 INFO - PID 3905 | |3;mootools.html;1424.4587056918372;1459.2630721485648;1487.2043456750641;1507.0354972817395;1507.7587585986244;16232.51302460925;16980.660386792257;16987.575310617227;17002.319907203713;17038.659226815456;16624.58438539037;16651.250693718783;16654.50036498904;16783.32866685331;16798.244079016444;2790.7627851632583;2868.6127372804717;2869.1392582225353;2871.4974879396127;2872.7701783857347;2586.1853516142355;2650.6289119523185;2650.7349265073435;2652.681678198619;2653.24382550973;2693.6228927950006;2728.1269993602054;2729.344957210265;2729.945401091977;2730.9726902731018;2566.781823545001;2602.258356368435;2625.3961588834677;2625.553655878505;2626.4090579619624;2463.71667258264;2465.137201979293;2476.4799392127493;2483.3295010347288;2527.519771243458;16557.503274901774;16816;16831.66336673272;16832.915835420867;16843.83156168447;8332.66669333226;8420.157984201593;8649.135086491364;8723.432976856548;8732.956335218283;5599.440055994409;5805.303363596353;5857.004309267435;5865.325487568942;5867.237259156325;2150.397888591197;2177.9564408711735;2184.3678367567045;2187.1907394264067;2228.9777102229095;30487.847560762053;30716.2320941976;30757.69242307593;30826.691733082607;30914.690853091408;7538.680730872075;7589.8861517077285;7644.426667999922;7699.960505331821;7745.148033716287;20067.598648026957;20279.08744106519;20356.898215508827;20418.183272668928;20449.693254600894;8550.486970781772;8769.166929141722;8776.385653004356;8782.692605758768;8808.163224493663;7861.764147075597;7997.7600671979935;8027.719029833927;8027.919720802717;8145.429819912668;5909.852253693606;5909.940900590939;5918.46733793952;5996.640201587918;6005.519558435315;1765.2321240260271;1767.3195819609286;1769.672610567049;1774.1306759687918;1788.0702034942017;993.2699465892563;1016.9389836609827;1020.7090979071078;1023.0843395161438;1043.598214687351;8618.525981070976;8633.223009929137;8673.696420625374;8717.564121793885;8787.604557794915;813.5810057820228;821.9917800822035;822.5517093184229;838.2413915406567;838.8322335532918;5855.473007429352;5856.355800861902;6047.667378294236;6214.25428948529;6303.432691057827;24099.638505422434;24102;24820.131295404575;24833.13751468647;24936.625950610756;24722.876385618318;24883.62674559883;25002;25011;25021;11587.826182607268;11635.59275425373;11779.705507362212;11975.760484790255;12466.252024878537;9060.81878362416;9139.908600914172;9170.266378689555;9186.724398268063;9214.861777073484;20170;20323.288684895957;20717.171313147304;21624.243151489623;21747.56504869862;21843.67234491452;22027.779722202573;22129.114835406403;22309.665355019362;22451.550968980857;12719.491220351083;12768.233905965672;12812;12840.935795320964;12937.935310323388;15188.088714677155;15331.693366132391;15408.229588520753;15499;15534.300956457213;11520.596779112691;11750.647480575597;11787.11596630239;11826.881731182579;12005.699857503283;11013;11080.168987325822;11087.445627718744;11254.268472549258;11255.66233013011;10818.080463160719;10918;11074.889251107386;11088.279261847954;11100.888991109985;8149.266566009088;8261.17388261169;8348.071100986288;8454.535000575028;8486.70296539643;7979.241972012649;8074.111847696866;8084.029916410069;8099.311558517592;8351.1648835116 17:45:56 INFO - PID 3905 | |4;prototype.html;545.4599946053406;564.2636359550787;565.9745311460985;568.4202113843882;586.1969102329808;6203.565750397474;6236.472064344236;6239.6322574198075;6268.592541484801;6314.116023756677;6116.204893363868;6222.751089956397;6233.844153896155;6236.3763623637615;6263.404976527234;5084.567811736007;5138.383393992726;5151.845444636667;5174.861530463292;5176.352955880506;5167.612429067816;5195.558377537914;5213.218017297398;5220.3996540397775;5274.129768588197;5184.948150518503;5187.04039752647;5199.428062913076;5220.973895130519;5245.659032162897;5147.459516750725;5230.424653288154;5243.764030618612;5253.395859476171;5255.659806749292;4910;4948.430930443009;4956.950430495685;4969.211084009789;4973.950260497421;6188.195534580521;6253.7185826637915;6254.6247225166635;6292.244930608356;6352.237731472207;5990.9400905990815;6131.540134489886;6173.135760993465;6182.629042257479;6227.750889964396;6670.833229169261;6722.260551339349;6731.865362692768;6753.763618273337;6761.391474767294;5465.562754979592;5480.808171713971;5486.753096110685;5495.422980587021;5520.420355862657;6965.442764578822;6972.895406568906;7019.543729657556;7063.434925205971;7134.32223938725;5686.777342871303;5711.571632127607;5721.971390143106;5723.942760572424;5734.913976290359;5787.668836167705;5818.796342128006;5826.941730582725;5840.240768700041;5867.119932010232;6131.478824299985;6157.353477884847;6169.444749972524;6175.228096487939;6224.657643829542;6373.776917807947;6482.448991835652;6591.868162636816;6630.104935833697;6799.150106236721;1982.692682634194;1990.3431867483696;1992.521794769274;1993.960120797605;2010.3968809357427;1482.7775833625042;1492.835788063312;1503.7218114648824;1503.9097654140787;1529.8240702319154;6113.480354169857;6121.877562448726;6123.38766123393;6132.565763172548;6216.316205217422;6732.3743739941465;6732.798016059526;6747.865042699119;6751.657929325015;6752.696128674222;6192.628442293387;6259.749610015549;6271.717772700239;6271.78048768291;6273.12176295319;3558.5018097466377;3559.288142371536;3562.750607457453;3563.8396272167815;3569.321828852562;7032.8945065824055;7055.659424709289;7115.6086415247655;7117.288271172842;7133.678984445609;6875.828104297432;6911.5853048816225;6965.756198533027;6996.650167491605;7009.859802803915;6863.876935994111;6903.827404314932;6963.825904352431;7004.159500859828;7051.964740176471;6593.560312741911;6758;6793.354631310018;6814.829629259109;6853.623050732258;6691.397774200151;6699.43054840344;6710.496712746466;6725.697343619647;6739.66301684904;7012.719491220294;7049.189343225595;7056.13012551664;7063.39961103312;7080.858382832417;5215.6609820361555;5223.660462069954;5263.105272103828;5285.603579731459;5287.339082614673;6852.6916288768125;6894.448444124358;6895.241523432519;6895.724171033303;6940.340667636567;6500.537379089667;6556.2788093308745;6591.901121483277;6628.867422651617;6659.633720145439;6347.682615869096;6409.583377080475;6544.4764418845425;6556.770513032021;6616.735330586723;6375.139356187041;6394.26465956421;6450.323115906846;6488.286288508355;6496.317886622026;6220.600364917857;6403.7118329676205;6503.544751867324;6548.901766473411;6585.440237579668;6243.843903902439;6379.936200637934;6429.32492088324;6446.4520515756685;6504.447121994494 17:45:56 INFO - PID 3905 | |5;yui.html;955.0878910640339;983.2330781990048;1005.793812268485;1007.0936157458291;1018.9949050254747;19004;19522.90238548807;19568.21727130913;19608.70586941197;19635.41093767189;17289.74065389017;17353.39263125791;17610;19078.046097695093;19273.421797346065;1034.9793004139913;1061.3366645846345;1061.4745700878077;1062.2617280989716;1062.787442511497;1051.526812934179;1078.051314842941;1080.2438293194755;1082.7076689293885;1083.6748975307416;1145.5475087340496;1147.3230793831638;1148.5405837664916;1148.925319854211;1151.0158814213853;1063.1972860490357;1102.2174256278051;1104.276698762312;1142.959996400126;1143.9084873210122;808.2321794295384;820.0405525535139;820.913804050572;821.0065820357374;821.1993306526149;18509.537261568435;18526.814731852643;18539.72190417145;18566.071696415125;18610.906945465187;21859.890700546555;23711;23896.641550376757;23972.160974365812;23990.400239993964;17501.649967000714;18212.453626391096;18319.633607327913;18356.724649130272;18373.265069397206;3957.7823219722904;3988.062805240766;3988.481497405319;3990.1221731219084;3990.541087774885;163291;163947;164159.17920410322;164651;166574;17708.734368984475;17760.023198723935;17824.732629010574;17838.464846054638;18078.728819067725;34131;34506;34553.82723086419;34886.12784680403;35112;9245.537723113817;9345.953270233606;9375.390599611004;9394.718158455258;9399;4478.171538265431;4509.2559727644575;4554.931676024862;4555.840545580955;4578.9542104579195;6076.483498902643;6296.874062518724;6303.3066362700065;6324.936750632435;6327.4938004959495;1143.4282858570714;1172.9472173752201;1178.4107946026986;1192.6779769462196;1192.8807119288;692.304234244591;714.1465948191861;717.3113810741746;718.4575645387699;728.1626129950599;12342.81485777714;12352.505899763908;12931;13971.930140349234;13971.930140349234;711.6904146696204;715.1775458223085;716.2837162837163;720.200577359131;729.3873146556917;5819.73811178498;5952.7023648817385;5975;5975.880482390415;6122.20411346531;146101;148197.2590137064;148686;153884;154839;132120;133392;133672;134522;138308;109750.45124774166;110855;111806.44096779627;113113;114053.42973285081;11160.386178759922;11375.26060806045;11417.657470275904;11601.76796464049;11605.825912611486;57574;57821;57947.4205257942;58037.4196258032;58065;70869;71267.64366178136;71668;71936.64031679808;75279;15022.62443438879;15096;15160.09039457636;15193.240337983278;15226.162561058805;16504.25730842091;16539.586510336856;16544.172791360623;16676.416325428552;16684;14361.56915292501;14513.129212247299;14565.053271537316;14645;14652.413903443743;15759.448419305269;16064.277107529955;16132.596685082966;16205.108719020567;16270;14704.705905882036;14797.186154761592;14903.552893413214;15021.474248401253;15181.316840741973;10678;10832.458377080957;10993.395363255098;11010.559577616805;11016.449177540931;10769.138468922623;10841.241113122005;10961.780764384508;11003.449827508432;11230.606928757454 17:45:56 INFO - PID 3905 | __end_tp_report 17:45:56 INFO - PID 3905 | __start_cc_report 17:45:56 INFO - PID 3905 | _x_x_mozilla_cycle_collect,270 17:45:56 INFO - PID 3905 | __end_cc_report 17:45:56 INFO - PID 3905 | __startTimestamp1506818756662__endTimestamp 17:45:56 INFO - PID 3905 | 17:45:56 INFO - PID 3905 | ------- Summary: start ------- 17:45:56 INFO - PID 3905 | Number of tests: 6 17:45:56 INFO - PID 3905 | 17:45:56 INFO - PID 3905 | [#0] dojo.html Cycles:165 Average:6288.07 Median:6525.28 stddev:756.43 (11.6%) stddev-sans-first:733.94 17:45:56 INFO - PID 3905 | Values: 3839.2 3866.9 3889.4 3895.5 3897.8 6152.9 6178.2 6201.2 6248.8 6364.3 6187.3 6196.4 6196.9 6212.6 6215.6 5579.4 5591.0 5604.0 5615.8 5676.7 5715.2 5743.3 5756.7 5774.1 5796.9 5650.5 5695.4 5703.0 5724.6 5729.2 5154.7 5445.0 5584.4 5642.5 5643.2 5574.1 5579.1 5646.2 5659.8 5663.2 6191.4 6217.4 6291.9 6316.1 6317.9 6627.0 6661.0 6668.1 6671.5 6672.1 6719.1 6731.7 6852.9 6908.7 6935.9 6352.5 6440.5 6459.0 6463.2 6466.8 7050.1 7064.5 7136.0 7149.0 7156.2 6644.6 6657.9 6743.2 6785.1 6809.9 6947.5 6955.1 6974.3 6978.6 6996.1 6804.4 6808.4 6887.0 6895.1 6904.5 6732.0 6808.1 6810.4 6885.5 6910.2 4934.7 4936.2 4950.1 4950.1 4951.4 4536.8 4564.2 4606.6 4619.2 4636.5 6239.8 6260.5 6279.9 6341.0 6341.3 6617.7 6784.3 6802.9 6885.2 6910.6 6262.2 6292.1 6307.7 6318.2 6322.7 5546.6 5579.8 5592.7 5625.5 5629.5 7106.3 7115.1 7130.5 7195.2 7215.8 6831.4 6840.6 6909.0 6927.1 6931.8 7002.0 7070.3 7072.3 7074.3 7110.8 6700.2 6755.0 6755.1 6779.5 6781.0 6897.0 6900.0 6928.5 6939.7 6968.6 6615.5 6618.1 6707.8 6710.0 6718.0 6525.3 6618.0 6619.0 6706.5 6722.6 6496.9 6517.0 6523.5 6524.9 6525.7 6659.8 6664.4 6667.5 6696.1 6705.0 6410.0 6465.2 6467.6 6557.7 6577.4 17:45:56 INFO - PID 3905 | 17:45:56 INFO - PID 3905 | [#1] ext.html Cycles:180 Average:42562.40 Median:36478.23 stddev:64040.60 (175.6%) stddev-sans-first:64144.01 17:45:56 INFO - PID 3905 | Values: 946.2 959.3 975.4 1004.3 1009.9 44814.0 45541.3 45593.8 45681.0 45715.3 40688.6 41026.4 41227.0 41333.6 41459.0 7440.1 7506.1 7514.1 7556.1 7592.5 7438.9 7490.8 7505.2 7506.9 7529.3 8326.7 8498.3 8516.0 8532.1 8552.0 8425.2 8438.9 8495.5 8502.9 8504.5 8286.5 8376.2 8448.2 8452.2 8485.0 41264.4 41680.4 41691.6 41829.2 41848.0 3650.2 3667.1 3691.2 3698.1 3701.6 34160.0 34217.5 34395.5 34429.5 34466.7 5414.2 5427.9 5429.2 5430.8 5542.7 240440.0 241151.0 241553.0 242630.0 242642.0 54736.0 54911.7 54985.7 55002.0 55099.0 56441.4 56625.2 56648.7 56685.7 56744.0 17132.4 17550.2 17558.6 17575.3 17609.7 14373.8 14392.4 14397.4 14409.0 14431.4 15027.4 15228.5 15244.6 15246.9 15318.4 6044.4 6080.3 6127.3 6219.4 6226.6 1081.7 1083.8 1104.2 1108.2 1110.9 26215.1 26310.7 26316.9 26430.3 26498.0 1157.1 1194.8 1197.9 1215.9 1223.2 13550.7 14031.4 14108.0 14236.9 14270.4 302151.0 303776.0 303882.0 304203.0 304550.0 59061.7 61571.4 62120.0 62318.0 64076.4 1457.2 1503.0 1507.1 1508.3 1523.5 30168.2 30725.7 30810.2 30866.5 31609.0 42580.6 43279.0 43293.4 43341.3 43383.3 172485.0 173258.1 173936.0 174333.0 175529.1 35089.8 36296.3 36425.1 36476.6 36479.8 46533.3 47144.5 47150.5 47347.3 47367.0 34884.0 34892.8 35748.8 36238.0 36313.0 35209.3 35375.3 35474.0 35658.8 35909.3 39752.8 40732.8 41153.8 41312.0 41415.2 33763.5 33962.3 34050.5 34130.0 34491.7 24312.0 25407.9 25807.9 26086.9 26566.7 17:45:56 INFO - PID 3905 | 17:45:56 INFO - PID 3905 | [#2] jquery.html Cycles:180 Average:40906.00 Median:21870.23 stddev:105403.69 (482.0%) stddev-sans-first:105655.97 17:45:56 INFO - PID 3905 | Values: 618.9 625.1 626.4 626.5 640.6 23564.3 24114.6 24961.4 25039.5 25049.9 22840.9 23555.5 23564.5 23568.4 23621.2 6454.5 6582.4 6598.4 6602.7 6636.5 6489.8 6745.3 6751.6 6753.2 6762.9 6642.0 6679.2 6708.5 6734.1 6736.2 6635.6 6688.5 6711.0 6721.0 6727.3 6281.4 6286.4 6293.2 6293.2 6294.6 29828.0 30222.8 30766.5 30831.2 31051.1 2283.7 2294.4 2307.8 2322.0 2323.6 20496.3 21404.6 21433.2 21496.6 21520.2 2603.3 2617.6 2645.1 2665.7 2674.5 140862.0 146263.0 153054.2 159339.2 159637.0 16271.5 16306.3 16326.3 16754.9 16886.0 26932.6 26971.7 26981.9 26995.6 27015.5 10944.7 11136.0 11150.0 11348.9 11429.8 10237.3 10272.4 10347.1 10358.5 10418.7 9912.8 9993.9 10145.1 10285.5 10356.6 2906.2 2907.3 2999.3 3019.5 3047.7 1025.8 1055.0 1060.4 1064.2 1065.9 21314.7 21820.8 21848.0 21892.5 21902.7 1126.8 1127.2 1133.6 1136.8 1139.0 11750.1 11835.5 11876.6 11905.0 11919.0 615359.0 624739.0 631840.0 634979.0 643144.0 136697.0 137384.0 138577.0 138604.3 140365.0 1212.6 1227.4 1256.9 1263.1 1269.5 18787.2 18827.8 18834.6 18968.1 19114.5 61844.0 62967.4 64219.7 64527.7 65372.3 83010.0 83525.2 83581.6 84012.0 84543.6 15770.4 15872.9 16045.7 16084.9 16112.3 24117.3 24139.8 24175.2 24291.1 24415.9 19395.0 19936.6 20049.6 20171.6 20196.5 17282.5 17698.1 17712.6 17730.3 17935.3 19509.2 19627.8 19707.2 19976.8 19994.6 15608.7 15672.2 15698.7 15829.4 15956.7 18884.2 19101.1 19102.7 19384.6 19408.4 17:45:56 INFO - PID 3905 | 17:45:56 INFO - PID 3905 | [#3] mootools.html Cycles:180 Average:10377.96 Median:25006.50 stddev:7704.26 (30.8%) stddev-sans-first:7696.51 17:45:56 INFO - PID 3905 | Values: 1424.5 1459.3 1487.2 1507.0 1507.8 16232.5 16980.7 16987.6 17002.3 17038.7 16624.6 16651.3 16654.5 16783.3 16798.2 2790.8 2868.6 2869.1 2871.5 2872.8 2586.2 2650.6 2650.7 2652.7 2653.2 2693.6 2728.1 2729.3 2729.9 2731.0 2566.8 2602.3 2625.4 2625.6 2626.4 2463.7 2465.1 2476.5 2483.3 2527.5 16557.5 16816.0 16831.7 16832.9 16843.8 8332.7 8420.2 8649.1 8723.4 8733.0 5599.4 5805.3 5857.0 5865.3 5867.2 2150.4 2178.0 2184.4 2187.2 2229.0 30487.8 30716.2 30757.7 30826.7 30914.7 7538.7 7589.9 7644.4 7700.0 7745.1 20067.6 20279.1 20356.9 20418.2 20449.7 8550.5 8769.2 8776.4 8782.7 8808.2 7861.8 7997.8 8027.7 8027.9 8145.4 5909.9 5909.9 5918.5 5996.6 6005.5 1765.2 1767.3 1769.7 1774.1 1788.1 993.3 1016.9 1020.7 1023.1 1043.6 8618.5 8633.2 8673.7 8717.6 8787.6 813.6 822.0 822.6 838.2 838.8 5855.5 5856.4 6047.7 6214.3 6303.4 24099.6 24102.0 24820.1 24833.1 24936.6 24722.9 24883.6 25002.0 25011.0 25021.0 11587.8 11635.6 11779.7 11975.8 12466.3 9060.8 9139.9 9170.3 9186.7 9214.9 20170.0 20323.3 20717.2 21624.2 21747.6 21843.7 22027.8 22129.1 22309.7 22451.6 12719.5 12768.2 12812.0 12840.9 12937.9 15188.1 15331.7 15408.2 15499.0 15534.3 11520.6 11750.6 11787.1 11826.9 12005.7 11013.0 11080.2 11087.4 11254.3 11255.7 10818.1 10918.0 11074.9 11088.3 11100.9 8149.3 8261.2 8348.1 8454.5 8486.7 7979.2 8074.1 8084.0 8099.3 8351.2 17:45:56 INFO - PID 3905 | 17:45:56 INFO - PID 3905 | [#4] prototype.html Cycles:180 Average:5749.49 Median:6248.78 stddev:1533.13 (24.5%) stddev-sans-first:1486.85 17:45:56 INFO - PID 3905 | Values: 545.5 564.3 566.0 568.4 586.2 6203.6 6236.5 6239.6 6268.6 6314.1 6116.2 6222.8 6233.8 6236.4 6263.4 5084.6 5138.4 5151.8 5174.9 5176.4 5167.6 5195.6 5213.2 5220.4 5274.1 5184.9 5187.0 5199.4 5221.0 5245.7 5147.5 5230.4 5243.8 5253.4 5255.7 4910.0 4948.4 4957.0 4969.2 4974.0 6188.2 6253.7 6254.6 6292.2 6352.2 5990.9 6131.5 6173.1 6182.6 6227.8 6670.8 6722.3 6731.9 6753.8 6761.4 5465.6 5480.8 5486.8 5495.4 5520.4 6965.4 6972.9 7019.5 7063.4 7134.3 5686.8 5711.6 5722.0 5723.9 5734.9 5787.7 5818.8 5826.9 5840.2 5867.1 6131.5 6157.4 6169.4 6175.2 6224.7 6373.8 6482.4 6591.9 6630.1 6799.2 1982.7 1990.3 1992.5 1994.0 2010.4 1482.8 1492.8 1503.7 1503.9 1529.8 6113.5 6121.9 6123.4 6132.6 6216.3 6732.4 6732.8 6747.9 6751.7 6752.7 6192.6 6259.7 6271.7 6271.8 6273.1 3558.5 3559.3 3562.8 3563.8 3569.3 7032.9 7055.7 7115.6 7117.3 7133.7 6875.8 6911.6 6965.8 6996.7 7009.9 6863.9 6903.8 6963.8 7004.2 7052.0 6593.6 6758.0 6793.4 6814.8 6853.6 6691.4 6699.4 6710.5 6725.7 6739.7 7012.7 7049.2 7056.1 7063.4 7080.9 5215.7 5223.7 5263.1 5285.6 5287.3 6852.7 6894.4 6895.2 6895.7 6940.3 6500.5 6556.3 6591.9 6628.9 6659.6 6347.7 6409.6 6544.5 6556.8 6616.7 6375.1 6394.3 6450.3 6488.3 6496.3 6220.6 6403.7 6503.5 6548.9 6585.4 6243.8 6379.9 6429.3 6446.5 6504.4 17:45:56 INFO - PID 3905 | 17:45:56 INFO - PID 3905 | [#5] yui.html Cycles:180 Average:27893.10 Median:91625.21 stddev:43014.21 (46.9%) stddev-sans-first:43087.33 17:45:56 INFO - PID 3905 | Values: 955.1 983.2 1005.8 1007.1 1019.0 19004.0 19522.9 19568.2 19608.7 19635.4 17289.7 17353.4 17610.0 19078.0 19273.4 1035.0 1061.3 1061.5 1062.3 1062.8 1051.5 1078.1 1080.2 1082.7 1083.7 1145.5 1147.3 1148.5 1148.9 1151.0 1063.2 1102.2 1104.3 1143.0 1143.9 808.2 820.0 820.9 821.0 821.2 18509.5 18526.8 18539.7 18566.1 18610.9 21859.9 23711.0 23896.6 23972.2 23990.4 17501.6 18212.5 18319.6 18356.7 18373.3 3957.8 3988.1 3988.5 3990.1 3990.5 163291.0 163947.0 164159.2 164651.0 166574.0 17708.7 17760.0 17824.7 17838.5 18078.7 34131.0 34506.0 34553.8 34886.1 35112.0 9245.5 9346.0 9375.4 9394.7 9399.0 4478.2 4509.3 4554.9 4555.8 4579.0 6076.5 6296.9 6303.3 6324.9 6327.5 1143.4 1172.9 1178.4 1192.7 1192.9 692.3 714.1 717.3 718.5 728.2 12342.8 12352.5 12931.0 13971.9 13971.9 711.7 715.2 716.3 720.2 729.4 5819.7 5952.7 5975.0 5975.9 6122.2 146101.0 148197.3 148686.0 153884.0 154839.0 132120.0 133392.0 133672.0 134522.0 138308.0 109750.5 110855.0 111806.4 113113.0 114053.4 11160.4 11375.3 11417.7 11601.8 11605.8 57574.0 57821.0 57947.4 58037.4 58065.0 70869.0 71267.6 71668.0 71936.6 75279.0 15022.6 15096.0 15160.1 15193.2 15226.2 16504.3 16539.6 16544.2 16676.4 16684.0 14361.6 14513.1 14565.1 14645.0 14652.4 15759.4 16064.3 16132.6 16205.1 16270.0 14704.7 14797.2 14903.6 15021.5 15181.3 10678.0 10832.5 10993.4 11010.6 11016.4 10769.1 10841.2 10961.8 11003.4 11230.6 17:45:56 INFO - PID 3905 | -------- Summary: end -------- 17:45:56 INFO - PID 3905 | 17:45:57 INFO - TEST-INFO | 3905: exit 0 17:45:57 INFO - TEST-OK | dromaeo_css | took 1109933ms 17:45:57 INFO - TEST-START | kraken 17:45:57 INFO - Initialising browser for kraken test... 17:45:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49498/getInfo.html -profile /tmp/tmpKpDMYu/profile 17:45:57 INFO - TEST-INFO | started process 4290 (/builds/slave/test/build/application/firefox/firefox http://localhost:49498/getInfo.html) 17:46:02 INFO - TEST-INFO | 4290: exit 0 17:46:02 INFO - Browser initialized. 17:46:02 INFO - Running cycle 1/1 for kraken test... 17:46:02 INFO - Using env: {'DISPLAY': ':0', 17:46:02 INFO - 'HOME': '/home/cltbld', 17:46:02 INFO - 'JSGC_DISABLE_POISONING': '1', 17:46:02 INFO - 'LANG': 'en_US.UTF-8', 17:46:02 INFO - 'LANGUAGE': 'en_US:en', 17:46:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:46:02 INFO - 'LOGNAME': 'cltbld', 17:46:02 INFO - 'MAIL': '/var/mail/cltbld', 17:46:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:46:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:46:02 INFO - 'MOZ_CRASHREPORTER': '1', 17:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:46:02 INFO - 'MOZ_NO_REMOTE': '1', 17:46:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:02 INFO - 'NO_EM_RESTART': '1', 17:46:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:02 INFO - 'PWD': '/builds/slave/test', 17:46:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:46:02 INFO - 'RUST_BACKTRACE': 'full', 17:46:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:46:02 INFO - 'SHELL': '/bin/bash', 17:46:02 INFO - 'SHLVL': '1', 17:46:02 INFO - 'STYLO_FORCE_DISABLED': '1', 17:46:02 INFO - 'TERM': 'linux', 17:46:02 INFO - 'TMOUT': '86400', 17:46:02 INFO - 'USER': 'cltbld', 17:46:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822', 17:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:02 INFO - '_': '/tools/buildbot/bin/python'} 17:46:02 INFO - TEST-INFO | started process 4529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKpDMYu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:46:03 INFO - PID 4529 | 17:46:03 INFO - PID 4529 | (/builds/slave/test/build/application/firefox/firefox:4579): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:46:03 INFO - PID 4529 | 17:46:13 INFO - PID 4529 | RSS: Main: 145108992 17:46:13 INFO - PID 4529 | 17:46:16 INFO - PID 4529 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49498/tests/kraken/driver.html?testName=audio-beat-detection) 17:46:17 INFO - PID 4529 | RSS: Main: 151728128 17:46:17 INFO - PID 4529 | 17:46:19 INFO - PID 4529 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49498/tests/kraken/driver.html?testName=audio-dft) 17:46:20 INFO - PID 4529 | RSS: Main: 152461312 17:46:20 INFO - PID 4529 | 17:46:23 INFO - PID 4529 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49498/tests/kraken/driver.html?testName=audio-fft) 17:46:23 INFO - PID 4529 | RSS: Main: 148254720 17:46:23 INFO - PID 4529 | 17:46:25 INFO - PID 4529 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49498/tests/kraken/driver.html?testName=audio-oscillator) 17:46:26 INFO - PID 4529 | RSS: Main: 149016576 17:46:26 INFO - PID 4529 | 17:46:28 INFO - PID 4529 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49498/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:46:28 INFO - PID 4529 | RSS: Main: 149135360 17:46:28 INFO - PID 4529 | 17:46:31 INFO - PID 4529 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49498/tests/kraken/driver.html?testName=imaging-darkroom) 17:46:32 INFO - PID 4529 | RSS: Main: 149016576 17:46:32 INFO - PID 4529 | 17:46:36 INFO - PID 4529 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49498/tests/kraken/driver.html?testName=imaging-desaturate) 17:46:36 INFO - PID 4529 | RSS: Main: 149999616 17:46:36 INFO - PID 4529 | 17:46:39 INFO - PID 4529 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49498/tests/kraken/driver.html?testName=json-parse-financial) 17:46:40 INFO - PID 4529 | RSS: Main: 151822336 17:46:40 INFO - PID 4529 | 17:46:41 INFO - PID 4529 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49498/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:46:42 INFO - PID 4529 | RSS: Main: 151506944 17:46:42 INFO - PID 4529 | 17:46:43 INFO - PID 4529 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:46:44 INFO - PID 4529 | RSS: Main: 151408640 17:46:44 INFO - PID 4529 | 17:46:46 INFO - PID 4529 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:46:47 INFO - PID 4529 | RSS: Main: 148905984 17:46:47 INFO - PID 4529 | 17:46:49 INFO - PID 4529 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:46:50 INFO - PID 4529 | RSS: Main: 148451328 17:46:50 INFO - PID 4529 | 17:46:52 INFO - PID 4529 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:46:53 INFO - PID 4529 | RSS: Main: 149000192 17:46:53 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49498/tests/kraken/driver.html?testName=ai-astar) 17:46:55 INFO - PID 4529 | RSS: Main: 150577152 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | __start_tp_report 17:46:55 INFO - PID 4529 | _x_x_mozilla_page_load 17:46:55 INFO - PID 4529 | _x_x_mozilla_page_load_details 17:46:55 INFO - PID 4529 | |i|pagename|runs| 17:46:55 INFO - PID 4529 | |0;ai-astar;105;104;105;105;106;107;106;108;108;106 17:46:55 INFO - PID 4529 | |1;audio-beat-detection;114;112;120;122;116;117;114;114;112;123 17:46:55 INFO - PID 4529 | |2;audio-dft;163;161;161;162;162;163;163;163;161;170 17:46:55 INFO - PID 4529 | |3;audio-fft;74;73;72;74;74;74;72;74;74;73 17:46:55 INFO - PID 4529 | |4;audio-oscillator;80;79;78;78;78;77;77;78;78;78 17:46:55 INFO - PID 4529 | |5;imaging-gaussian-blur;112;112;111;117;112;112;117;113;114;112 17:46:55 INFO - PID 4529 | |6;imaging-darkroom;149;149;148;150;149;149;149;150;149;150 17:46:55 INFO - PID 4529 | |7;imaging-desaturate;94;94;99;94;94;95;94;96;99;95 17:46:55 INFO - PID 4529 | |8;json-parse-financial;45;43;44;46;42;44;44;43;42;43 17:46:55 INFO - PID 4529 | |9;json-stringify-tinderbox;36;36;36;36;36;36;36;36;36;37 17:46:55 INFO - PID 4529 | |10;stanford-crypto-aes;70;69;71;72;71;72;71;70;71;71 17:46:55 INFO - PID 4529 | |11;stanford-crypto-ccm;105;110;106;102;105;101;109;103;114;107 17:46:55 INFO - PID 4529 | |12;stanford-crypto-pbkdf2;147;147;150;144;153;147;149;152;151;150 17:46:55 INFO - PID 4529 | |13;stanford-crypto-sha256-iterative;59;59;59;57;61;60;61;62;57;60 17:46:55 INFO - PID 4529 | __end_tp_report 17:46:55 INFO - PID 4529 | __start_cc_report 17:46:55 INFO - PID 4529 | _x_x_mozilla_cycle_collect,701 17:46:55 INFO - PID 4529 | __end_cc_report 17:46:55 INFO - PID 4529 | __startTimestamp1506818815317__endTimestamp 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | ------- Summary: start ------- 17:46:55 INFO - PID 4529 | Number of tests: 14 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | [#0] ai-astar Cycles:10 Average:106.00 Median:106.00 stddev:1.33 (1.3%) stddev-sans-first:1.36 17:46:55 INFO - PID 4529 | Values: 105.0 104.0 105.0 105.0 106.0 107.0 106.0 108.0 108.0 106.0 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | [#1] audio-beat-detection Cycles:10 Average:116.40 Median:116.50 stddev:4.01 (3.4%) stddev-sans-first:4.15 17:46:55 INFO - PID 4529 | Values: 114.0 112.0 120.0 122.0 116.0 117.0 114.0 114.0 112.0 123.0 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:2.64 (1.6%) stddev-sans-first:2.80 17:46:55 INFO - PID 4529 | Values: 163.0 161.0 161.0 162.0 162.0 163.0 163.0 163.0 161.0 170.0 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | [#3] audio-fft Cycles:10 Average:73.40 Median:74.00 stddev:0.84 (1.1%) stddev-sans-first:0.87 17:46:55 INFO - PID 4529 | Values: 74.0 73.0 72.0 74.0 74.0 74.0 72.0 74.0 74.0 73.0 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:78.00 stddev:0.88 (1.1%) stddev-sans-first:0.60 17:46:55 INFO - PID 4529 | Values: 80.0 79.0 78.0 78.0 78.0 77.0 77.0 78.0 78.0 78.0 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:112.50 stddev:2.15 (1.9%) stddev-sans-first:2.24 17:46:55 INFO - PID 4529 | Values: 112.0 112.0 111.0 117.0 112.0 112.0 117.0 113.0 114.0 112.0 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 17:46:55 INFO - PID 4529 | Values: 149.0 149.0 148.0 150.0 149.0 149.0 149.0 150.0 149.0 150.0 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:2.01 (2.1%) stddev-sans-first:2.07 17:46:55 INFO - PID 4529 | Values: 94.0 94.0 99.0 94.0 94.0 95.0 94.0 96.0 99.0 95.0 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | [#8] json-parse-financial Cycles:10 Average:43.60 Median:44.00 stddev:1.26 (2.9%) stddev-sans-first:1.24 17:46:55 INFO - PID 4529 | Values: 45.0 43.0 44.0 46.0 42.0 44.0 44.0 43.0 42.0 43.0 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | [#9] json-stringify-tinderbox Cycles:10 Average:36.10 Median:36.00 stddev:0.32 (0.9%) stddev-sans-first:0.33 17:46:55 INFO - PID 4529 | Values: 36.0 36.0 36.0 36.0 36.0 36.0 36.0 36.0 36.0 37.0 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | [#10] stanford-crypto-aes Cycles:10 Average:70.80 Median:71.00 stddev:0.92 (1.3%) stddev-sans-first:0.93 17:46:55 INFO - PID 4529 | Values: 70.0 69.0 71.0 72.0 71.0 72.0 71.0 70.0 71.0 71.0 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | [#11] stanford-crypto-ccm Cycles:10 Average:106.20 Median:106.50 stddev:3.97 (3.7%) stddev-sans-first:4.18 17:46:55 INFO - PID 4529 | Values: 105.0 110.0 106.0 102.0 105.0 101.0 109.0 103.0 114.0 107.0 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:150.00 stddev:2.75 (1.8%) stddev-sans-first:2.82 17:46:55 INFO - PID 4529 | Values: 147.0 147.0 150.0 144.0 153.0 147.0 149.0 152.0 151.0 150.0 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.50 Median:60.00 stddev:1.65 (2.7%) stddev-sans-first:1.74 17:46:55 INFO - PID 4529 | Values: 59.0 59.0 59.0 57.0 61.0 60.0 61.0 62.0 57.0 60.0 17:46:55 INFO - PID 4529 | -------- Summary: end -------- 17:46:55 INFO - PID 4529 | 17:46:55 INFO - PID 4529 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:46:55 INFO - TEST-INFO | 4529: exit 0 17:46:55 INFO - TEST-OK | kraken | took 58773ms 17:46:55 INFO - SUITE-END | took 1168s 17:46:55 INFO - Completed test suite (00:19:28) 17:46:55 INFO - javascript benchmark 17:46:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9080.858631812887, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3839.1553858151215, 3866.8839934801968, 3889.416587511873, 3895.4741109950164, 3897.7661340319564, 6152.907706384408, 6178.227721534809, 6201.193844800176, 6248.812535623927, 6364.331745166754, 6187.319394866572, 6196.442320191182, 6196.876062478747, 6212.5961812482155, 6215.62706237626, 5579.38626751057, 5590.972045139779, 5604.0, 5615.80344687936, 5676.659400435987, 5715.228444160027, 5743.253377060976, 5756.740946657411, 5774.105013722879, 5796.855078623026, 5650.463205995424, 5695.401982791809, 5703.03048481757, 5724.5992780505385, 5729.169270455782, 5154.690718556899, 5444.972775136139, 5584.4136365681425, 5642.548596112301, 5643.209950606918, 5574.080276754331, 5579.13523403873, 5646.18130371098, 5659.773609055633, 5663.207150998864, 6191.4118158774845, 6217.378262173792, 6291.8741625167695, 6316.147320111772, 6317.936820631827, 6626.966865165691, 6661.000849872509, 6668.099806526106, 6671.499637527157, 6672.065910772496, 6719.092922455455, 6731.663416829139, 6852.931470685279, 6908.689108990107, 6935.895961560581, 6352.523560732871, 6440.5491615586925, 6458.967705161491, 6463.192100987423, 6466.773662921775, 7050.083489146481, 7064.540804847668, 7136.0, 7148.964255178691, 7156.177039640508, 6644.634545099969, 6657.933420665829, 6743.15710536183, 6785.084013658192, 6809.863802724017, 6947.51367404287, 6955.095837541087, 6974.337437943387, 6978.581285122909, 6996.090508233897, 6804.387605115465, 6808.353206445379, 6887.035814985906, 6895.069165662671, 6904.516683832184, 6732.023856540774, 6808.08090907731, 6810.421114205249, 6885.51801373899, 6910.2053263874295, 4934.703917764874, 4936.160852655057, 4950.059488697208, 4950.133726597903, 4951.356323677899, 4536.79584418702, 4564.1556312082375, 4606.5854073132905, 4619.214733495314, 4636.466806317317, 6239.78160764371, 6260.46786023184, 6279.874402511924, 6341.017142342944, 6341.302456729756, 6617.735290588419, 6784.287649796799, 6802.897956530656, 6885.208201056842, 6910.585364878123, 6262.15460912771, 6292.05619157121, 6307.747690092437, 6318.241810982711, 6322.747090116344, 5546.55627549795, 5579.804706835242, 5592.748326325325, 5625.46558076982, 5629.4652008059165, 7106.253843346374, 7115.1106111736035, 7130.465215108888, 7195.172555156119, 7215.819604509929, 6831.351021652935, 6840.555363901331, 6908.965455172692, 6927.064846245894, 6931.757388491378, 7002.019717239488, 7070.257622949516, 7072.292770723092, 7074.327938845801, 7110.7511237106455, 6700.229473610597, 6755.0, 6755.054292399166, 6779.457643388419, 6781.0, 6897.034415181979, 6900.0, 6928.549644273307, 6939.722411103701, 6968.581885086911, 6615.5038372123245, 6618.139641846529, 6707.832304192434, 6710.027046078389, 6717.966410167918, 6525.282218956006, 6617.966910165418, 6619.040239165198, 6706.463482921452, 6722.596644201363, 6496.902546461902, 6517.0, 6523.543351965507, 6524.869502610016, 6525.673716314261, 6659.766908158192, 6664.400203981665, 6667.466602671871, 6696.096027036482, 6704.99425086241, 6409.967950160406, 6465.1595292611655, 6467.611943283418, 6557.704903279268, 6577.375149360803], "value": 6236.277777682856, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [946.2099147212077, 959.2565761534814, 975.4439969217547, 1004.2969921055263, 1009.8586197932289, 44814.0, 45541.316880246784, 45593.77203113988, 45681.0, 45715.31427028589, 40688.59311406885, 41026.38460423096, 41227.0, 41333.58666413335, 41459.0, 7440.144383395911, 7506.1367942686475, 7514.135874374462, 7556.093268807724, 7592.468527203098, 7438.888416673754, 7490.812729681747, 7505.211952744965, 7506.887396689054, 7529.284717951813, 8326.66693332266, 8498.320134389234, 8516.0, 8532.061473237969, 8552.0, 8425.241728244488, 8438.915610843906, 8495.532745698983, 8502.914970850274, 8504.489730616182, 8286.544240066794, 8376.246137847624, 8448.197421244971, 8452.197041281068, 8485.0, 41264.38103428451, 41680.374794378105, 41691.583084169375, 41829.16341673149, 41848.0, 3650.1604630935035, 3667.1015601177614, 3691.151035261878, 3698.0939669780805, 3701.5743189533277, 34160.0, 34217.48673769896, 34395.484067739, 34429.48355774665, 34466.65533344659, 5414.187871819219, 5427.864303392407, 5429.212764149176, 5430.782768689248, 5542.695151766651, 240440.0, 241151.0, 241553.0, 242629.99999999822, 242642.0, 54736.0, 54911.72544137254, 54985.725071375186, 55002.0, 55099.0, 56441.435585643616, 56625.15062274069, 56648.716756416776, 56685.71657141688, 56744.0, 17132.40036598713, 17550.210240539207, 17558.561035973948, 17575.296988120586, 17609.7358539622, 14373.78439323411, 14392.42430302797, 14397.352119154662, 14409.0, 14431.35058922351, 15027.398904043934, 15228.543143705707, 15244.618884527754, 15246.923765381101, 15318.387264509518, 6044.365341639153, 6080.270367555921, 6127.2647282325515, 6219.378062193744, 6226.59527130735, 1081.6646839479786, 1083.7778255457613, 1104.2325583719237, 1108.1688733449912, 1110.8611423572054, 26215.082472113383, 26310.736892631212, 26316.8684156578, 26430.339241519116, 26498.0, 1157.1494951210852, 1194.790911590468, 1197.874223206568, 1215.8844909733562, 1223.2354778263584, 13550.661233469242, 14031.368588413547, 14108.012439129163, 14236.857631423552, 14270.429182832779, 302151.0, 303776.0, 303882.0, 304203.0, 304550.0, 59061.70469147713, 61571.384286156564, 62120.0, 62318.0, 64076.359236407974, 1457.242234038294, 1502.9924850375678, 1507.0656193160312, 1508.2911031815029, 1523.5277064110162, 30168.24579385533, 30725.692743073178, 30810.229744256572, 30866.53700194544, 31609.0, 42580.574194257664, 43279.0, 43293.35059974166, 43341.34987975246, 43383.34924976065, 172485.0, 173258.13370933064, 173936.0, 174333.0, 175529.12235438742, 35089.824550877085, 36296.27407451889, 36425.085993121014, 36476.63523364838, 36479.817600911825, 46533.302000469346, 47144.528554714016, 47150.52849471599, 47347.28979065248, 47367.0, 34884.0, 34892.82553587216, 35748.821255893556, 36238.0, 36313.0, 35209.295814084086, 35375.29249415049, 35474.0, 35658.82170589131, 35909.28181436304, 39752.80123599363, 40732.79633601813, 41153.79423102865, 41312.0, 41415.171696566504, 33763.493547597296, 33962.320753585285, 34050.489242661875, 34130.0, 34491.655083448844, 24312.0, 25407.872960635817, 25807.870960645076, 26086.86956565205, 26566.7343326572], "value": 18824.400995862838, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.882412341655, 625.121704005872, 626.4362074133277, 626.5175814622739, 640.6220330005297, 23564.293071207892, 24114.638280425785, 24961.375965600848, 25039.499210015787, 25049.872755726014, 22840.885795570997, 23555.528889422203, 23564.528709425802, 23568.410789730264, 23621.17325893594, 6454.483641308696, 6582.440492558138, 6598.406143447089, 6602.66986650668, 6636.502262330345, 6489.837754056162, 6745.258021617618, 6751.594904305733, 6753.15585551806, 6762.864742705143, 6642.036904648847, 6679.231888332831, 6708.49686273529, 6734.090897728793, 6736.225334086594, 6635.5686880353105, 6688.531802773808, 6710.966445167767, 6721.0, 6727.327267273283, 6281.371862813682, 6286.402791734778, 6293.181886354791, 6293.213348331458, 6294.590851594632, 29828.0, 30222.84888575565, 30766.53850192249, 30831.2292192697, 31051.068467946, 2283.7259528856644, 2294.380517260347, 2307.757685443038, 2321.9883900580558, 2323.581755284048, 20496.282630107875, 21404.571908561742, 21433.249836255658, 21496.570068598696, 21520.246791362228, 2603.2971097803675, 2617.6073588961617, 2645.061003343824, 2665.733426657338, 2674.4784766970447, 140862.0, 146263.0, 153054.23472882566, 159339.2033039839, 159637.0, 16271.51185464438, 16306.266218020217, 16326.346946122023, 16754.916225418794, 16886.0, 26932.59601105985, 26971.73028269692, 26981.865090674422, 26995.595066074024, 27015.459690806074, 10944.671659850217, 11136.0, 11150.0, 11348.943255283672, 11429.771404571862, 10237.283390162765, 10272.435016074038, 10347.12049475803, 10358.482075896174, 10418.739531511774, 9912.801743965081, 9993.900060999442, 10145.137663298703, 10285.537150828231, 10356.585736570452, 2906.1717410537894, 2907.3458471843664, 2999.2951656360738, 3019.5168772996217, 3047.6647568767416, 1025.8409946458312, 1054.9736256593646, 1060.3690803971624, 1064.1752641702742, 1065.9147268218524, 21314.680279795815, 21820.781792181875, 21848.01683924227, 21892.45268868291, 21902.671459927795, 1126.7859106769688, 1127.2222166705112, 1133.557912414159, 1136.7840110379002, 1138.9886101139048, 11750.059995200363, 11835.526578936919, 11876.64370068882, 11905.0, 11919.0, 615359.0, 624739.0, 631840.0, 634979.0, 643144.0, 136697.0, 137384.0, 138577.0, 138604.30697846648, 140365.0, 1212.5513559982862, 1227.4292454008928, 1256.9371531423392, 1263.1031967303134, 1269.504893091695, 18787.15457804375, 18827.811721882605, 18834.623307534046, 18968.051597420348, 19114.522136946132, 61844.0, 62967.37032629615, 64219.67890160519, 64527.67736161477, 65372.34627653663, 83010.0, 83525.16474835417, 83581.58209208916, 84012.0, 84543.5772821132, 15770.369185232463, 15872.92063539675, 16045.67908641844, 16084.919575402047, 16112.274947627151, 24117.276481705576, 24139.758602413753, 24175.153869614478, 24291.14980975728, 24415.877920610284, 19395.030248487237, 19936.60126797485, 20049.59900802005, 20171.59656806885, 20196.495087622927, 17282.481525554253, 17698.115094245495, 17712.55718607045, 17730.29078836884, 17935.282588696828, 19509.219631214593, 19627.80372196317, 19707.211711531378, 19976.800231997495, 19994.60010799805, 15608.687826243638, 15672.216389180723, 15698.686026279638, 15829.445969391016, 15956.68086638284, 18884.244630214638, 19101.140448679565, 19102.7134592984, 19384.612307753483, 19408.4177474676], "value": 12968.356249305007, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.4587056918372, 1459.2630721485648, 1487.2043456750641, 1507.0354972817395, 1507.7587585986244, 16232.51302460925, 16980.660386792257, 16987.575310617227, 17002.319907203713, 17038.659226815456, 16624.58438539037, 16651.250693718783, 16654.50036498904, 16783.32866685331, 16798.244079016444, 2790.7627851632583, 2868.6127372804717, 2869.1392582225353, 2871.4974879396127, 2872.7701783857347, 2586.1853516142355, 2650.6289119523185, 2650.7349265073435, 2652.681678198619, 2653.24382550973, 2693.6228927950006, 2728.1269993602054, 2729.344957210265, 2729.945401091977, 2730.9726902731018, 2566.781823545001, 2602.258356368435, 2625.3961588834677, 2625.553655878505, 2626.4090579619624, 2463.71667258264, 2465.137201979293, 2476.4799392127493, 2483.3295010347288, 2527.519771243458, 16557.503274901774, 16816.0, 16831.66336673272, 16832.915835420867, 16843.83156168447, 8332.66669333226, 8420.157984201593, 8649.135086491364, 8723.432976856548, 8732.956335218283, 5599.440055994409, 5805.303363596353, 5857.004309267435, 5865.325487568942, 5867.237259156325, 2150.397888591197, 2177.9564408711735, 2184.3678367567045, 2187.1907394264067, 2228.9777102229095, 30487.847560762053, 30716.2320941976, 30757.69242307593, 30826.691733082607, 30914.690853091408, 7538.680730872075, 7589.8861517077285, 7644.426667999922, 7699.960505331821, 7745.148033716287, 20067.598648026957, 20279.08744106519, 20356.898215508827, 20418.183272668928, 20449.693254600894, 8550.486970781772, 8769.166929141722, 8776.385653004356, 8782.692605758768, 8808.163224493663, 7861.764147075597, 7997.7600671979935, 8027.719029833927, 8027.919720802717, 8145.429819912668, 5909.852253693606, 5909.940900590939, 5918.46733793952, 5996.640201587918, 6005.519558435315, 1765.2321240260271, 1767.3195819609286, 1769.672610567049, 1774.1306759687918, 1788.0702034942017, 993.2699465892563, 1016.9389836609827, 1020.7090979071078, 1023.0843395161438, 1043.598214687351, 8618.525981070976, 8633.223009929137, 8673.696420625374, 8717.564121793885, 8787.604557794915, 813.5810057820228, 821.9917800822035, 822.5517093184229, 838.2413915406567, 838.8322335532918, 5855.473007429352, 5856.355800861902, 6047.667378294236, 6214.25428948529, 6303.432691057827, 24099.638505422434, 24102.0, 24820.131295404575, 24833.13751468647, 24936.625950610756, 24722.876385618318, 24883.62674559883, 25002.0, 25011.0, 25021.0, 11587.826182607268, 11635.59275425373, 11779.705507362212, 11975.760484790255, 12466.252024878537, 9060.81878362416, 9139.908600914172, 9170.266378689555, 9186.724398268063, 9214.861777073484, 20170.0, 20323.288684895957, 20717.171313147304, 21624.243151489623, 21747.56504869862, 21843.67234491452, 22027.779722202573, 22129.114835406403, 22309.665355019362, 22451.550968980857, 12719.491220351083, 12768.233905965672, 12812.0, 12840.935795320964, 12937.935310323388, 15188.088714677155, 15331.693366132391, 15408.229588520753, 15499.0, 15534.300956457213, 11520.596779112691, 11750.647480575597, 11787.11596630239, 11826.881731182579, 12005.699857503283, 11013.0, 11080.168987325822, 11087.445627718744, 11254.268472549258, 11255.66233013011, 10818.080463160719, 10918.0, 11074.889251107386, 11088.279261847954, 11100.888991109985, 8149.266566009088, 8261.17388261169, 8348.071100986288, 8454.535000575028, 8486.70296539643, 7979.241972012649, 8074.111847696866, 8084.029916410069, 8099.311558517592, 8351.1648835116], "value": 7250.230491279624, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.4599946053406, 564.2636359550787, 565.9745311460985, 568.4202113843882, 586.1969102329808, 6203.565750397474, 6236.472064344236, 6239.6322574198075, 6268.592541484801, 6314.116023756677, 6116.204893363868, 6222.751089956397, 6233.844153896155, 6236.3763623637615, 6263.404976527234, 5084.567811736007, 5138.383393992726, 5151.845444636667, 5174.861530463292, 5176.352955880506, 5167.612429067816, 5195.558377537914, 5213.218017297398, 5220.3996540397775, 5274.129768588197, 5184.948150518503, 5187.04039752647, 5199.428062913076, 5220.973895130519, 5245.659032162897, 5147.459516750725, 5230.424653288154, 5243.764030618612, 5253.395859476171, 5255.659806749292, 4910.0, 4948.430930443009, 4956.950430495685, 4969.211084009789, 4973.950260497421, 6188.195534580521, 6253.7185826637915, 6254.6247225166635, 6292.244930608356, 6352.237731472207, 5990.9400905990815, 6131.540134489886, 6173.135760993465, 6182.629042257479, 6227.750889964396, 6670.833229169261, 6722.260551339349, 6731.865362692768, 6753.763618273337, 6761.391474767294, 5465.562754979592, 5480.808171713971, 5486.753096110685, 5495.422980587021, 5520.420355862657, 6965.442764578822, 6972.895406568906, 7019.543729657556, 7063.434925205971, 7134.32223938725, 5686.777342871303, 5711.571632127607, 5721.971390143106, 5723.942760572424, 5734.913976290359, 5787.668836167705, 5818.796342128006, 5826.941730582725, 5840.240768700041, 5867.119932010232, 6131.478824299985, 6157.353477884847, 6169.444749972524, 6175.228096487939, 6224.657643829542, 6373.776917807947, 6482.448991835652, 6591.868162636816, 6630.104935833697, 6799.150106236721, 1982.692682634194, 1990.3431867483696, 1992.521794769274, 1993.960120797605, 2010.3968809357427, 1482.7775833625042, 1492.835788063312, 1503.7218114648824, 1503.9097654140787, 1529.8240702319154, 6113.480354169857, 6121.877562448726, 6123.38766123393, 6132.565763172548, 6216.316205217422, 6732.3743739941465, 6732.798016059526, 6747.865042699119, 6751.657929325015, 6752.696128674222, 6192.628442293387, 6259.749610015549, 6271.717772700239, 6271.78048768291, 6273.12176295319, 3558.5018097466377, 3559.288142371536, 3562.750607457453, 3563.8396272167815, 3569.321828852562, 7032.8945065824055, 7055.659424709289, 7115.6086415247655, 7117.288271172842, 7133.678984445609, 6875.828104297432, 6911.5853048816225, 6965.756198533027, 6996.650167491605, 7009.859802803915, 6863.876935994111, 6903.827404314932, 6963.825904352431, 7004.159500859828, 7051.964740176471, 6593.560312741911, 6758.0, 6793.354631310018, 6814.829629259109, 6853.623050732258, 6691.397774200151, 6699.43054840344, 6710.496712746466, 6725.697343619647, 6739.66301684904, 7012.719491220294, 7049.189343225595, 7056.13012551664, 7063.39961103312, 7080.858382832417, 5215.6609820361555, 5223.660462069954, 5263.105272103828, 5285.603579731459, 5287.339082614673, 6852.6916288768125, 6894.448444124358, 6895.241523432519, 6895.724171033303, 6940.340667636567, 6500.537379089667, 6556.2788093308745, 6591.901121483277, 6628.867422651617, 6659.633720145439, 6347.682615869096, 6409.583377080475, 6544.4764418845425, 6556.770513032021, 6616.735330586723, 6375.139356187041, 6394.26465956421, 6450.323115906846, 6488.286288508355, 6496.317886622026, 6220.600364917857, 6403.7118329676205, 6503.544751867324, 6548.901766473411, 6585.440237579668, 6243.843903902439, 6379.936200637934, 6429.32492088324, 6446.4520515756685, 6504.447121994494], "value": 5318.9336148029215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [955.0878910640339, 983.2330781990048, 1005.793812268485, 1007.0936157458291, 1018.9949050254747, 19004.0, 19522.90238548807, 19568.21727130913, 19608.70586941197, 19635.41093767189, 17289.74065389017, 17353.39263125791, 17610.0, 19078.046097695093, 19273.421797346065, 1034.9793004139913, 1061.3366645846345, 1061.4745700878077, 1062.2617280989716, 1062.787442511497, 1051.526812934179, 1078.051314842941, 1080.2438293194755, 1082.7076689293885, 1083.6748975307416, 1145.5475087340496, 1147.3230793831638, 1148.5405837664916, 1148.925319854211, 1151.0158814213853, 1063.1972860490357, 1102.2174256278051, 1104.276698762312, 1142.959996400126, 1143.9084873210122, 808.2321794295384, 820.0405525535139, 820.913804050572, 821.0065820357374, 821.1993306526149, 18509.537261568435, 18526.814731852643, 18539.72190417145, 18566.071696415125, 18610.906945465187, 21859.890700546555, 23711.0, 23896.641550376757, 23972.160974365812, 23990.400239993964, 17501.649967000714, 18212.453626391096, 18319.633607327913, 18356.724649130272, 18373.265069397206, 3957.7823219722904, 3988.062805240766, 3988.481497405319, 3990.1221731219084, 3990.541087774885, 163291.0, 163947.0, 164159.17920410322, 164651.0, 166574.0, 17708.734368984475, 17760.023198723935, 17824.732629010574, 17838.464846054638, 18078.728819067725, 34131.0, 34506.0, 34553.82723086419, 34886.12784680403, 35112.0, 9245.537723113817, 9345.953270233606, 9375.390599611004, 9394.718158455258, 9399.0, 4478.171538265431, 4509.2559727644575, 4554.931676024862, 4555.840545580955, 4578.9542104579195, 6076.483498902643, 6296.874062518724, 6303.3066362700065, 6324.936750632435, 6327.4938004959495, 1143.4282858570714, 1172.9472173752201, 1178.4107946026986, 1192.6779769462196, 1192.8807119288, 692.304234244591, 714.1465948191861, 717.3113810741746, 718.4575645387699, 728.1626129950599, 12342.81485777714, 12352.505899763908, 12931.0, 13971.930140349234, 13971.930140349234, 711.6904146696204, 715.1775458223085, 716.2837162837163, 720.200577359131, 729.3873146556917, 5819.73811178498, 5952.7023648817385, 5975.0, 5975.880482390415, 6122.20411346531, 146101.0, 148197.2590137064, 148686.0, 153884.0, 154839.0, 132120.0, 133392.0, 133672.0, 134522.0, 138308.0, 109750.45124774166, 110855.0, 111806.44096779627, 113113.0, 114053.42973285081, 11160.386178759922, 11375.26060806045, 11417.657470275904, 11601.76796464049, 11605.825912611486, 57574.0, 57821.0, 57947.4205257942, 58037.4196258032, 58065.0, 70869.0, 71267.64366178136, 71668.0, 71936.64031679808, 75279.0, 15022.62443438879, 15096.0, 15160.09039457636, 15193.240337983278, 15226.162561058805, 16504.25730842091, 16539.586510336856, 16544.172791360623, 16676.416325428552, 16684.0, 14361.56915292501, 14513.129212247299, 14565.053271537316, 14645.0, 14652.413903443743, 15759.448419305269, 16064.277107529955, 16132.596685082966, 16205.108719020567, 16270.0, 14704.705905882036, 14797.186154761592, 14903.552893413214, 15021.474248401253, 15181.316840741973, 10678.0, 10832.458377080957, 10993.395363255098, 11010.559577616805, 11016.449177540931, 10769.138468922623, 10841.241113122005, 10961.780764384508, 11003.449827508432, 11230.606928757454], "value": 9550.52594887143, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1359.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 104.0, 105.0, 105.0, 106.0, 107.0, 106.0, 108.0, 108.0, 106.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 120.0, 122.0, 116.0, 117.0, 114.0, 114.0, 112.0, 123.0], "value": 116.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 162.0, 162.0, 163.0, 163.0, 163.0, 161.0, 170.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 74.0, 74.0, 74.0, 72.0, 74.0, 74.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 78.0, 78.0, 77.0, 77.0, 78.0, 78.0, 78.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 111.0, 117.0, 112.0, 112.0, 117.0, 113.0, 114.0, 112.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 150.0, 149.0, 149.0, 149.0, 150.0, 149.0, 150.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 99.0, 94.0, 94.0, 95.0, 94.0, 96.0, 99.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 43.0, 44.0, 46.0, 42.0, 44.0, 44.0, 43.0, 42.0, 43.0], "value": 43.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 36.0, 36.0, 36.0, 36.0, 36.0, 36.0, 36.0, 37.0], "value": 36.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 71.0, 72.0, 71.0, 72.0, 71.0, 70.0, 71.0, 71.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 110.0, 106.0, 102.0, 105.0, 101.0, 109.0, 103.0, 114.0, 107.0], "value": 106.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 150.0, 144.0, 153.0, 147.0, 149.0, 152.0, 151.0, 150.0], "value": 149.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 57.0, 61.0, 60.0, 61.0, 62.0, 57.0, 60.0], "value": 59.5, "unit": "score"}]}]} 17:46:56 INFO - Return code: 0 17:46:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:46:56 INFO - # TBPL SUCCESS # 17:46:56 INFO - Running post-action listener: _package_coverage_data 17:46:56 INFO - Running post-action listener: _resource_record_post_action 17:46:56 INFO - [mozharness: 2017-10-01 00:46:56.089425Z] Finished run-tests step (success) 17:46:56 INFO - Running post-run listener: _resource_record_post_run 17:46:56 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 9256960; Write bytes: 519888896; Read time: 2528; Write time: 394984 17:46:56 INFO - TinderboxPrint: CPU usage
13.1% 17:46:56 INFO - TinderboxPrint: I/O read bytes / time
9,256,960 / 2,528 17:46:56 INFO - TinderboxPrint: I/O write bytes / time
519,888,896 / 394,984 17:46:56 INFO - TinderboxPrint: CPU idle
8,225.0 (86.9%) 17:46:56 INFO - TinderboxPrint: CPU user
1,187.4 (12.5%) 17:46:56 INFO - TinderboxPrint: Swap in / out
0 / 0 17:46:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 74760192; Read time: 184; Write time: 36544 17:46:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:46:56 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 9248768; Write bytes: 405123072; Read time: 2268; Write time: 348900 17:46:56 INFO - Running post-run listener: _upload_blobber_files 17:46:56 INFO - Blob upload gear active. 17:46:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:46:56 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 17:46:56 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:46:56 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:46:57 INFO - (blobuploader) - INFO - Open directory for files ... 17:46:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:46:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:46:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:46:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:46:58 INFO - (blobuploader) - INFO - Done attempting. 17:46:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 17:46:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:46:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 17:46:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:46:59 INFO - (blobuploader) - INFO - Done attempting. 17:46:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:46:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:47:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:05 INFO - (blobuploader) - INFO - Done attempting. 17:47:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 17:47:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 17:47:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:06 INFO - (blobuploader) - INFO - Done attempting. 17:47:06 INFO - (blobuploader) - INFO - Iteration through files over. 17:47:06 INFO - Return code: 0 17:47:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:47:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:47:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4b09a74aae093144d125fb3a7d406f6057ac1e3c68bf075c649c229141f2d5e7f96ca5e0fb034cc4c04a72b118c8ace7c335142c49013dec4599ea6efb2116c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c4034cd3b0d2be8ae2e3ff1049f948096a31cf6d43d3bb66c7cb49b46b6a0b3928fe47e1d555b1317c8dc2e5d3849e0be609337b58dfc249b83081b071cf7c6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/672da36cca151b22e327d25cbe56532e0ea538d790a6e9e6ee8ef8fabf57b77d0aa8d46787c396dccf53cc6a3d707ca7702956333d340ff167cc743fffa60393", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67f4dcf3812658cc77a33ace33b5495068b544ad89711a6d6d5aa6b94b0f8a2eb5439a7430e0271ad92cc76229151871084a522515438ed5a46fc1a631b290b7"} 17:47:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:47:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:47:06 INFO - Contents: 17:47:06 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4b09a74aae093144d125fb3a7d406f6057ac1e3c68bf075c649c229141f2d5e7f96ca5e0fb034cc4c04a72b118c8ace7c335142c49013dec4599ea6efb2116c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c4034cd3b0d2be8ae2e3ff1049f948096a31cf6d43d3bb66c7cb49b46b6a0b3928fe47e1d555b1317c8dc2e5d3849e0be609337b58dfc249b83081b071cf7c6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/672da36cca151b22e327d25cbe56532e0ea538d790a6e9e6ee8ef8fabf57b77d0aa8d46787c396dccf53cc6a3d707ca7702956333d340ff167cc743fffa60393", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67f4dcf3812658cc77a33ace33b5495068b544ad89711a6d6d5aa6b94b0f8a2eb5439a7430e0271ad92cc76229151871084a522515438ed5a46fc1a631b290b7"} 17:47:06 INFO - Running post-run listener: copy_logs_to_upload_dir 17:47:06 INFO - Copying logs to upload dir... 17:47:06 INFO - mkdir: /builds/slave/test/build/upload/logs 17:47:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.880335 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-30 17:47:06.692370) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-30 17:47:06.700294) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4b09a74aae093144d125fb3a7d406f6057ac1e3c68bf075c649c229141f2d5e7f96ca5e0fb034cc4c04a72b118c8ace7c335142c49013dec4599ea6efb2116c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c4034cd3b0d2be8ae2e3ff1049f948096a31cf6d43d3bb66c7cb49b46b6a0b3928fe47e1d555b1317c8dc2e5d3849e0be609337b58dfc249b83081b071cf7c6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/672da36cca151b22e327d25cbe56532e0ea538d790a6e9e6ee8ef8fabf57b77d0aa8d46787c396dccf53cc6a3d707ca7702956333d340ff167cc743fffa60393", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67f4dcf3812658cc77a33ace33b5495068b544ad89711a6d6d5aa6b94b0f8a2eb5439a7430e0271ad92cc76229151871084a522515438ed5a46fc1a631b290b7"} build_url:https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011139 build_url: 'https://queue.taskcluster.net/v1/task/N6FqeYAdQrOnZuU68arTCg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4b09a74aae093144d125fb3a7d406f6057ac1e3c68bf075c649c229141f2d5e7f96ca5e0fb034cc4c04a72b118c8ace7c335142c49013dec4599ea6efb2116c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c4034cd3b0d2be8ae2e3ff1049f948096a31cf6d43d3bb66c7cb49b46b6a0b3928fe47e1d555b1317c8dc2e5d3849e0be609337b58dfc249b83081b071cf7c6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/672da36cca151b22e327d25cbe56532e0ea538d790a6e9e6ee8ef8fabf57b77d0aa8d46787c396dccf53cc6a3d707ca7702956333d340ff167cc743fffa60393", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67f4dcf3812658cc77a33ace33b5495068b544ad89711a6d6d5aa6b94b0f8a2eb5439a7430e0271ad92cc76229151871084a522515438ed5a46fc1a631b290b7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-30 17:47:06.731375) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 17:47:06.731679) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506816756.788355-1326145822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 17:47:06.812895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-30 17:47:06.813205) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-30 17:47:06.813531) ========= ========= Total master_lag: 0.26 =========