builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-086 starttime: 1507142369.72 results: success (0) revision: ee1c41cf306df0043a8e68af042f133acf2ef94e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 11:39:29.718966) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 11:39:29.719484) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 11:39:29.719786) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 11:39:29.761338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 11:39:29.761739) ========= 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=438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-04 11:39:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 201M=0s 2017-10-04 11:39:29 (201 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151213 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 11:39:29.952224) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 11:39:29.952556) ========= 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=438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020550 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 11:39:30.002964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 11:39:30.003434) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ee1c41cf306df0043a8e68af042f133acf2ef94e --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 ee1c41cf306df0043a8e68af042f133acf2ef94e --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=438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-04 11:39:30,047 truncating revision to first 12 chars 2017-10-04 11:39:30,047 Setting DEBUG logging. 2017-10-04 11:39:30,047 attempt 1/10 2017-10-04 11:39:30,047 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ee1c41cf306d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-04 11:39:30,520 unpacking tar archive at: mozilla-central-ee1c41cf306d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.800197 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 11:39:30.828216) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 11:39:30.828609) ========= script_repo_revision: ee1c41cf306df0043a8e68af042f133acf2ef94e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 11:39:30.829056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 11:39:30.829315) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 11:39:30.858616) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-10-04 11:39:30.858885) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-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-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=438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:39:31 INFO - MultiFileLogger online at 20171004 11:39:31 in /builds/slave/test 11:39:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:39:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:39:31 INFO - {'append_to_log': False, 11:39:31 INFO - 'base_work_dir': '/builds/slave/test', 11:39:31 INFO - 'blob_upload_branch': 'Firefox', 11:39:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:39:31 INFO - 'branch': 'Firefox', 11:39:31 INFO - 'buildbot_json_path': 'buildprops.json', 11:39:31 INFO - 'code_coverage': False, 11:39:31 INFO - 'config_files': ('talos/linux_config.py',), 11:39:31 INFO - 'default_actions': ('clobber', 11:39:31 INFO - 'read-buildbot-config', 11:39:31 INFO - 'download-and-extract', 11:39:31 INFO - 'populate-webroot', 11:39:31 INFO - 'create-virtualenv', 11:39:31 INFO - 'install', 11:39:31 INFO - 'setup-mitmproxy', 11:39:31 INFO - 'run-tests'), 11:39:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:39:31 INFO - 'disable_ccov_upload': False, 11:39:31 INFO - 'disable_stylo': False, 11:39:31 INFO - 'download_minidump_stackwalk': True, 11:39:31 INFO - 'download_symbols': 'ondemand', 11:39:31 INFO - 'enable_stylo': False, 11:39:31 INFO - 'enable_webrender': False, 11:39:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:39:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:39:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:39:31 INFO - 'gecko_profile': False, 11:39:31 INFO - 'gecko_profile_interval': 0, 11:39:31 INFO - 'installer_path': 'installer.exe', 11:39:31 INFO - 'log_level': 'info', 11:39:31 INFO - 'log_name': 'talos', 11:39:31 INFO - 'log_to_console': True, 11:39:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:39:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:39:31 INFO - 'opt_config_files': (), 11:39:31 INFO - 'pip_index': False, 11:39:31 INFO - 'suite': 'dromaeojs-e10s', 11:39:31 INFO - 'system_bits': '32', 11:39:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:39:31 INFO - 'title': 'talos-linux64-ix-086', 11:39:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:39:31 INFO - 'use_talos_json': True, 11:39:31 INFO - 'verify': 'False', 11:39:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:39:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:39:31 INFO - 'work_dir': 'build'} 11:39:31 INFO - [mozharness: 2017-10-04 18:39:31.151464Z] Running clobber step. 11:39:31 INFO - Running pre-action listener: _resource_record_pre_action 11:39:31 INFO - Running main action method: clobber 11:39:31 INFO - rmtree: /builds/slave/test/build 11:39:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:39:32 INFO - Running post-action listener: _resource_record_post_action 11:39:32 INFO - [mozharness: 2017-10-04 18:39:32.120093Z] Finished clobber step (success) 11:39:32 INFO - [mozharness: 2017-10-04 18:39:32.120198Z] Running read-buildbot-config step. 11:39:32 INFO - Running pre-action listener: _resource_record_pre_action 11:39:32 INFO - Running main action method: read_buildbot_config 11:39:32 INFO - Using buildbot properties: 11:39:32 INFO - { 11:39:32 INFO - "project": "", 11:39:32 INFO - "product": "firefox", 11:39:32 INFO - "who": "ffxbld@noreply.mozilla.org", 11:39:32 INFO - "installer_path": "public/build/target.tar.bz2", 11:39:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:39:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:39:32 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:39:32 INFO - "stage_platform": "linux64-qr", 11:39:32 INFO - "basedir": "/builds/slave/test", 11:39:32 INFO - "buildnumber": 11, 11:39:32 INFO - "platform": "ubuntu64_hw_qr", 11:39:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:39:32 INFO - "slavebuilddir": "test", 11:39:32 INFO - "taskId": "LYxqSRy-QRGoTeCPzZWvPA", 11:39:32 INFO - "branch": "mozilla-central", 11:39:32 INFO - "script_repo_revision": "production", 11:39:32 INFO - "revision": "ee1c41cf306df0043a8e68af042f133acf2ef94e", 11:39:32 INFO - "slavename": "talos-linux64-ix-086", 11:39:32 INFO - "repo_path": "mozilla-central" 11:39:32 INFO - } 11:39:32 INFO - Finding installer, test and symbols from parent task. 11:39:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LYxqSRy-QRGoTeCPzZWvPA'}, attempt #1 11:39:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LYxqSRy-QRGoTeCPzZWvPA'}, attempt #1 11:39:33 INFO - Task dependencies: BavWyDaiT8KnVg76Xnu26Q 11:39:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q'}, attempt #1 11:39:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.tar.bz2 11:39:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.test_packages.json 11:39:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.crashreporter-symbols.zip 11:39:33 INFO - Running post-action listener: _resource_record_post_action 11:39:33 INFO - [mozharness: 2017-10-04 18:39:33.579916Z] Finished read-buildbot-config step (success) 11:39:33 INFO - [mozharness: 2017-10-04 18:39:33.580134Z] Running download-and-extract step. 11:39:33 INFO - Running pre-action listener: _resource_record_pre_action 11:39:33 INFO - Running main action method: download_and_extract 11:39:33 INFO - mkdir: /builds/slave/test/build/tests 11:39:33 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')]} 11:39:33 INFO - trying https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.test_packages.json 11:39:33 INFO - Downloading https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:39:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:39:34 INFO - Downloaded 989 bytes. 11:39:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:39:34 INFO - Using the following test package requirements: 11:39:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:39:34 INFO - u'common': [u'target.common.tests.zip'], 11:39:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:39:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:39:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:39:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:39:34 INFO - u'mozbase': [u'target.common.tests.zip'], 11:39:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:39:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:39:34 INFO - u'web-platform': [u'target.common.tests.zip', 11:39:34 INFO - u'target.web-platform.tests.tar.gz'], 11:39:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:39:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:39:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.common.tests.zip 11:39:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:39:34 INFO - Fetch https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.common.tests.zip into memory 11:39:37 INFO - Content-Length response header: 55310581 11:39:37 INFO - Bytes received: 55310581 11:39:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.talos.tests.zip 11:39:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:39:48 INFO - Fetch https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.talos.tests.zip into memory 11:39:49 INFO - Content-Length response header: 14533844 11:39:49 INFO - Bytes received: 14533844 11:39: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')]} 11:39:49 INFO - trying https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.tar.bz2 11:39:49 INFO - Downloading https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:39:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:39:52 INFO - Downloaded 63229471 bytes. 11:39:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.tar.bz2 11:39:52 INFO - mkdir: /builds/slave/test/properties 11:39:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:39:52 INFO - Writing to file /builds/slave/test/properties/build_url 11:39:52 INFO - Contents: 11:39:52 INFO - build_url:https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.tar.bz2 11:39:52 INFO - Running post-action listener: _resource_record_post_action 11:39:52 INFO - Running post-action listener: find_tests_for_verification 11:39:52 INFO - Running post-action listener: set_extra_try_arguments 11:39:52 INFO - [mozharness: 2017-10-04 18:39:52.257468Z] Finished download-and-extract step (success) 11:39:52 INFO - [mozharness: 2017-10-04 18:39:52.257566Z] Running populate-webroot step. 11:39:52 INFO - Running pre-action listener: _resource_record_pre_action 11:39:52 INFO - Running main action method: populate_webroot 11:39:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:39:52 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:39:52 INFO - 'tests': ['tresize', 11:39:52 INFO - 'tcanvasmark']}, 11:39:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:39:52 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:39:52 INFO - 'tests': ['dromaeo_css', 11:39:52 INFO - 'kraken']}, 11:39:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:39:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:52 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:39:52 INFO - 'talos_options': ['--disable-stylo'], 11:39:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:39:52 INFO - 'tests': ['damp', 'tps']}, 11:39:52 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:39:52 INFO - 'talos_options': ['--disable-stylo'], 11:39:52 INFO - 'tests': ['damp', 'tps']}, 11:39:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:39:52 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:39:52 INFO - 'tests': ['dromaeo_dom']}, 11:39:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:39:52 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:39:52 INFO - 'tests': ['basic_compositor_video', 11:39:52 INFO - 'glvideo']}, 11:39:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:39:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:39:52 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:39:52 INFO - 'talos_options': ['--disable-stylo'], 11:39:52 INFO - 'tests': ['ts_paint_webext', 11:39:52 INFO - 'tp5o_webext']}, 11:39:52 INFO - 'other-e10s': {'tests': ['a11yr', 11:39:52 INFO - 'ts_paint', 11:39:52 INFO - 'tpaint', 11:39:52 INFO - 'sessionrestore', 11:39:52 INFO - 'sessionrestore_many_windows', 11:39:52 INFO - 'sessionrestore_no_auto_restore', 11:39:52 INFO - 'tabpaint', 11:39:52 INFO - 'cpstartup']}, 11:39:52 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:39:52 INFO - 'tests': ['a11yr', 11:39:52 INFO - 'ts_paint', 11:39:52 INFO - 'tpaint', 11:39:52 INFO - 'sessionrestore', 11:39:52 INFO - 'sessionrestore_many_windows', 11:39:52 INFO - 'sessionrestore_no_auto_restore', 11:39:52 INFO - 'tabpaint', 11:39:52 INFO - 'cpstartup']}, 11:39:52 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:39:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:39:52 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:39:52 INFO - 'tests': ['perf_reftest_singletons']}, 11:39:52 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:39:52 INFO - 'tests': ['perf_reftest']}, 11:39:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:39:52 INFO - 'tsvgr_opacity', 11:39:52 INFO - 'tart', 11:39:52 INFO - 'tscrollx', 11:39:52 INFO - 'tsvg_static']}, 11:39:52 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:39:52 INFO - 'tests': ['tsvgx', 11:39:52 INFO - 'tsvgr_opacity', 11:39:52 INFO - 'tart', 11:39:52 INFO - 'tscrollx', 11:39:52 INFO - 'tsvg_static']}, 11:39:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:39:52 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:39:52 INFO - 'talos_options': ['--disable-stylo'], 11:39:52 INFO - 'tests': ['tp5o']}, 11:39:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:39:52 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:39:52 INFO - 'talos_options': ['--mitmproxy', 11:39:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:39:52 INFO - '--firstNonBlankPaint'], 11:39:52 INFO - 'tests': ['tp6_google', 11:39:52 INFO - 'tp6_youtube', 11:39:52 INFO - 'tp6_amazon', 11:39:52 INFO - 'tp6_facebook']}, 11:39:52 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:39:52 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:39:52 INFO - 'talos_options': ['--disable-stylo', 11:39:52 INFO - '--mitmproxy', 11:39:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:39:52 INFO - '--firstNonBlankPaint'], 11:39:52 INFO - 'tests': ['tp6_google', 11:39:52 INFO - 'tp6_youtube', 11:39:52 INFO - 'tp6_amazon', 11:39:52 INFO - 'tp6_facebook']}, 11:39:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:39:52 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:39:52 INFO - 'talos_options': ['--stylo-threads=1', 11:39:52 INFO - '--mitmproxy', 11:39:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:39:52 INFO - '--firstNonBlankPaint'], 11:39:52 INFO - 'tests': ['tp6_google', 11:39:52 INFO - 'tp6_youtube', 11:39:52 INFO - 'tp6_amazon', 11:39:52 INFO - 'tp6_facebook']}, 11:39:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:39:52 INFO - 'talos_options': ['--xperf_path', 11:39:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:52 INFO - 'tests': ['tp5n']}, 11:39:52 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:39:52 INFO - 'talos_options': ['--disable-stylo', 11:39:52 INFO - '--xperf_path', 11:39:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:52 INFO - 'tests': ['tp5n']}}} 11:39:52 INFO - Running post-action listener: _resource_record_post_action 11:39:52 INFO - [mozharness: 2017-10-04 18:39:52.273476Z] Finished populate-webroot step (success) 11:39:52 INFO - [mozharness: 2017-10-04 18:39:52.273574Z] Running create-virtualenv step. 11:39:52 INFO - Running pre-action listener: _resource_record_pre_action 11:39:52 INFO - Running main action method: create_virtualenv 11:39:52 INFO - Creating virtualenv /builds/slave/test/build/venv 11:39:52 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:39:52 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:39:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:39:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:39:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:39:53 INFO - Installing distribute.............................................................................................................................................................................................done. 11:39:53 INFO - Installing pip...............done. 11:39:53 INFO - Return code: 0 11:39:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:39:53 INFO - Reading from file tmpfile_stdout 11:39:53 INFO - Output received: 11:39:53 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:39:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39: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')]} 11:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d60>, '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 0x255aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255aef0>, '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': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', '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 11:39: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', 'pip>=1.5'] in /builds/slave/test/build 11:39: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 pip>=1.5 11:39:53 INFO - Using env: {'DISPLAY': ':0', 11:39:53 INFO - 'HOME': '/home/cltbld', 11:39:53 INFO - 'LANG': 'en_US.UTF-8', 11:39:53 INFO - 'LANGUAGE': 'en_US:en', 11:39:53 INFO - 'LOGNAME': 'cltbld', 11:39:53 INFO - 'MAIL': '/var/mail/cltbld', 11:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:53 INFO - 'MOZ_NO_REMOTE': '1', 11:39:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:53 INFO - 'NO_EM_RESTART': '1', 11:39:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:53 INFO - 'PWD': '/builds/slave/test', 11:39:53 INFO - 'SHELL': '/bin/bash', 11:39:53 INFO - 'SHLVL': '1', 11:39:53 INFO - 'TERM': 'linux', 11:39:53 INFO - 'TMOUT': '86400', 11:39:53 INFO - 'USER': 'cltbld', 11:39:53 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', 11:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:53 INFO - '_': '/tools/buildbot/bin/python'} 11:39:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:39:54 INFO - Downloading/unpacking pip>=1.5 11:39:54 INFO - Running setup.py egg_info for package pip 11:39:54 INFO - warning: no files found matching 'pip/cacert.pem' 11:39:54 INFO - warning: no files found matching '*.html' under directory 'docs' 11:39:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:39:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:39:54 INFO - Installing collected packages: pip 11:39:54 INFO - Found existing installation: pip 1.1 11:39:54 INFO - Uninstalling pip: 11:39:54 INFO - Successfully uninstalled pip 11:39:54 INFO - Running setup.py install for pip 11:39:54 INFO - warning: no files found matching 'pip/cacert.pem' 11:39:54 INFO - warning: no files found matching '*.html' under directory 'docs' 11:39:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:39:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:39:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:39:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:39:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:39:54 INFO - Successfully installed pip 11:39:54 INFO - Cleaning up... 11:39:54 INFO - Return code: 0 11:39:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:39:54 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')]} 11:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:54 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')]} 11:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:54 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 0x21ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d60>, '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 0x255aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255aef0>, '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': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', '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 11:39:54 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 11:39:54 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 11:39:54 INFO - Using env: {'DISPLAY': ':0', 11:39:54 INFO - 'HOME': '/home/cltbld', 11:39:54 INFO - 'LANG': 'en_US.UTF-8', 11:39:54 INFO - 'LANGUAGE': 'en_US:en', 11:39:54 INFO - 'LOGNAME': 'cltbld', 11:39:54 INFO - 'MAIL': '/var/mail/cltbld', 11:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:54 INFO - 'MOZ_NO_REMOTE': '1', 11:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:54 INFO - 'NO_EM_RESTART': '1', 11:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:54 INFO - 'PWD': '/builds/slave/test', 11:39:54 INFO - 'SHELL': '/bin/bash', 11:39:54 INFO - 'SHLVL': '1', 11:39:54 INFO - 'TERM': 'linux', 11:39:54 INFO - 'TMOUT': '86400', 11:39:54 INFO - 'USER': 'cltbld', 11:39:54 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', 11:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:54 INFO - '_': '/tools/buildbot/bin/python'} 11:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:55 INFO - Downloading/unpacking psutil>=3.1.1 11:39: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 11:39: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 11:39: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 11:39: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 11:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:39:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:56 INFO - Installing collected packages: psutil 11:39:56 INFO - Running setup.py install for psutil 11:39:56 INFO - building 'psutil._psutil_linux' extension 11:39:56 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 11:39:57 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 11:39:57 INFO - building 'psutil._psutil_posix' extension 11:39:57 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 11:39:57 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 11:39:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:57 INFO - Successfully installed psutil 11:39:57 INFO - Cleaning up... 11:39:57 INFO - Return code: 0 11:39:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39: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')]} 11:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d60>, '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 0x255aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255aef0>, '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': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', '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 11:39: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:39: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 mozsystemmonitor==0.3 11:39:57 INFO - Using env: {'DISPLAY': ':0', 11:39:57 INFO - 'HOME': '/home/cltbld', 11:39:57 INFO - 'LANG': 'en_US.UTF-8', 11:39:57 INFO - 'LANGUAGE': 'en_US:en', 11:39:57 INFO - 'LOGNAME': 'cltbld', 11:39:57 INFO - 'MAIL': '/var/mail/cltbld', 11:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:57 INFO - 'MOZ_NO_REMOTE': '1', 11:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:57 INFO - 'NO_EM_RESTART': '1', 11:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:57 INFO - 'PWD': '/builds/slave/test', 11:39:57 INFO - 'SHELL': '/bin/bash', 11:39:57 INFO - 'SHLVL': '1', 11:39:57 INFO - 'TERM': 'linux', 11:39:57 INFO - 'TMOUT': '86400', 11:39:57 INFO - 'USER': 'cltbld', 11:39:57 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', 11:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:57 INFO - '_': '/tools/buildbot/bin/python'} 11:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:39: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 11:39: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 11:39: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 11:39: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 11:39:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:39:59 INFO - Installing collected packages: mozsystemmonitor 11:39:59 INFO - Running setup.py install for mozsystemmonitor 11:39:59 INFO - Successfully installed mozsystemmonitor 11:39:59 INFO - Cleaning up... 11:39:59 INFO - Return code: 0 11:39:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39: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')]} 11:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:59 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 0x21ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d60>, '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 0x255aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255aef0>, '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': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', '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 11:39:59 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 11:39:59 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 11:39:59 INFO - Using env: {'DISPLAY': ':0', 11:39:59 INFO - 'HOME': '/home/cltbld', 11:39:59 INFO - 'LANG': 'en_US.UTF-8', 11:39:59 INFO - 'LANGUAGE': 'en_US:en', 11:39:59 INFO - 'LOGNAME': 'cltbld', 11:39:59 INFO - 'MAIL': '/var/mail/cltbld', 11:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:59 INFO - 'MOZ_NO_REMOTE': '1', 11:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:59 INFO - 'NO_EM_RESTART': '1', 11:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:59 INFO - 'PWD': '/builds/slave/test', 11:39:59 INFO - 'SHELL': '/bin/bash', 11:39:59 INFO - 'SHLVL': '1', 11:39:59 INFO - 'TERM': 'linux', 11:39:59 INFO - 'TMOUT': '86400', 11:39:59 INFO - 'USER': 'cltbld', 11:39:59 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', 11:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:59 INFO - '_': '/tools/buildbot/bin/python'} 11:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:59 INFO - Downloading/unpacking jsonschema==2.5.1 11:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:40:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:40:00 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 11:40:00 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 11:40:00 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 11:40:00 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 11:40:00 INFO - Downloading functools32-3.2.3-2.tar.gz 11:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:40:00 INFO - warning: no files found matching '*.txt' 11:40:00 INFO - no previously-included directories found matching 'build' 11:40:00 INFO - no previously-included directories found matching 'dist' 11:40:00 INFO - no previously-included directories found matching '.git*' 11:40:00 INFO - Installing collected packages: jsonschema, functools32 11:40:00 INFO - Running setup.py install for functools32 11:40:00 INFO - warning: no files found matching '*.txt' 11:40:00 INFO - no previously-included directories found matching 'build' 11:40:00 INFO - no previously-included directories found matching 'dist' 11:40:00 INFO - no previously-included directories found matching '.git*' 11:40:00 INFO - Successfully installed jsonschema functools32 11:40:00 INFO - Cleaning up... 11:40:00 INFO - Return code: 0 11:40:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d60>, '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 0x255aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255aef0>, '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': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', '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 11:40:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:40:00 INFO - Using env: {'DISPLAY': ':0', 11:40:00 INFO - 'HOME': '/home/cltbld', 11:40:00 INFO - 'LANG': 'en_US.UTF-8', 11:40:00 INFO - 'LANGUAGE': 'en_US:en', 11:40:00 INFO - 'LOGNAME': 'cltbld', 11:40:00 INFO - 'MAIL': '/var/mail/cltbld', 11:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:00 INFO - 'MOZ_NO_REMOTE': '1', 11:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:00 INFO - 'NO_EM_RESTART': '1', 11:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:00 INFO - 'PWD': '/builds/slave/test', 11:40:00 INFO - 'SHELL': '/bin/bash', 11:40:00 INFO - 'SHLVL': '1', 11:40:00 INFO - 'TERM': 'linux', 11:40:00 INFO - 'TMOUT': '86400', 11:40:00 INFO - 'USER': 'cltbld', 11:40:00 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', 11:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:00 INFO - '_': '/tools/buildbot/bin/python'} 11:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:40:01 INFO - Cleaning up... 11:40:01 INFO - Return code: 0 11:40:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:40:01 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')]} 11:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:01 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')]} 11:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:01 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 0x21ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d60>, '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 0x255aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255aef0>, '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': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', '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 11:40:01 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 11:40:01 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 11:40:01 INFO - Using env: {'DISPLAY': ':0', 11:40:01 INFO - 'HOME': '/home/cltbld', 11:40:01 INFO - 'LANG': 'en_US.UTF-8', 11:40:01 INFO - 'LANGUAGE': 'en_US:en', 11:40:01 INFO - 'LOGNAME': 'cltbld', 11:40:01 INFO - 'MAIL': '/var/mail/cltbld', 11:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:01 INFO - 'MOZ_NO_REMOTE': '1', 11:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:01 INFO - 'NO_EM_RESTART': '1', 11:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:01 INFO - 'PWD': '/builds/slave/test', 11:40:01 INFO - 'SHELL': '/bin/bash', 11:40:01 INFO - 'SHLVL': '1', 11:40:01 INFO - 'TERM': 'linux', 11:40:01 INFO - 'TMOUT': '86400', 11:40:01 INFO - 'USER': 'cltbld', 11:40:01 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', 11:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:01 INFO - '_': '/tools/buildbot/bin/python'} 11:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:01 INFO - Downloading/unpacking blobuploader==1.2.4 11:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:02 INFO - Downloading blobuploader-1.2.4.tar.gz 11:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:40:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:40:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:02 INFO - Downloading docopt-0.6.1.tar.gz 11:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:40:03 INFO - Installing collected packages: blobuploader, requests, docopt 11:40:03 INFO - Running setup.py install for blobuploader 11:40:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:40:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:40:03 INFO - Running setup.py install for requests 11:40:03 INFO - Running setup.py install for docopt 11:40:03 INFO - Successfully installed blobuploader requests docopt 11:40:03 INFO - Cleaning up... 11:40:03 INFO - Return code: 0 11:40:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:03 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 0x21ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d60>, '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 0x255aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255aef0>, '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': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', '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 11:40:03 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 11:40:03 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 11:40:03 INFO - Using env: {'DISPLAY': ':0', 11:40:03 INFO - 'HOME': '/home/cltbld', 11:40:03 INFO - 'LANG': 'en_US.UTF-8', 11:40:03 INFO - 'LANGUAGE': 'en_US:en', 11:40:03 INFO - 'LOGNAME': 'cltbld', 11:40:03 INFO - 'MAIL': '/var/mail/cltbld', 11:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:03 INFO - 'MOZ_NO_REMOTE': '1', 11:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:03 INFO - 'NO_EM_RESTART': '1', 11:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:03 INFO - 'PWD': '/builds/slave/test', 11:40:03 INFO - 'SHELL': '/bin/bash', 11:40:03 INFO - 'SHLVL': '1', 11:40:03 INFO - 'TERM': 'linux', 11:40:03 INFO - 'TMOUT': '86400', 11:40:03 INFO - 'USER': 'cltbld', 11:40:03 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', 11:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:03 INFO - '_': '/tools/buildbot/bin/python'} 11:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:03 INFO - Running setup.py (path:/tmp/pip-pKulAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:03 INFO - Running setup.py (path:/tmp/pip-H3uJQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:03 INFO - Running setup.py (path:/tmp/pip-qaMjM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:04 INFO - Running setup.py (path:/tmp/pip-JVIEdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:04 INFO - Running setup.py (path:/tmp/pip-tXwaUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:04 INFO - Running setup.py (path:/tmp/pip-jxmQcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:04 INFO - Running setup.py (path:/tmp/pip-AfW1ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:04 INFO - Running setup.py (path:/tmp/pip-GlW1JP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:04 INFO - Running setup.py (path:/tmp/pip-_Vozlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:04 INFO - Running setup.py (path:/tmp/pip-qinwNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:04 INFO - Running setup.py (path:/tmp/pip-KwPCua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:04 INFO - Running setup.py (path:/tmp/pip-PQyeJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:04 INFO - Running setup.py (path:/tmp/pip-PSgz7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:04 INFO - Running setup.py (path:/tmp/pip-mJbCsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:04 INFO - Running setup.py (path:/tmp/pip-ZAyHiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:04 INFO - Running setup.py (path:/tmp/pip-aGRnxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:04 INFO - Running setup.py (path:/tmp/pip-vV5Rhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:40:04 INFO - Running setup.py install for manifestparser 11:40:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:40:05 INFO - Running setup.py install for mozcrash 11:40:05 INFO - Running setup.py install for mozdebug 11:40:05 INFO - Running setup.py install for mozdevice 11:40:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:40:05 INFO - Running setup.py install for mozfile 11:40:05 INFO - Running setup.py install for mozhttpd 11:40:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:40:05 INFO - Running setup.py install for mozinfo 11:40:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:40:05 INFO - Running setup.py install for mozInstall 11:40:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:40:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:40:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:40:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:40:05 INFO - Running setup.py install for mozleak 11:40:05 INFO - Running setup.py install for mozlog 11:40:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:40:05 INFO - Running setup.py install for moznetwork 11:40:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:40:06 INFO - Running setup.py install for mozprocess 11:40:06 INFO - Running setup.py install for mozprofile 11:40:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:40:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:40:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:40:06 INFO - Running setup.py install for mozrunner 11:40:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:40:06 INFO - Running setup.py install for mozscreenshot 11:40:06 INFO - Running setup.py install for moztest 11:40:06 INFO - Running setup.py install for mozversion 11:40:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:40:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:40:06 INFO - Cleaning up... 11:40:06 INFO - Return code: 0 11:40:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:06 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')]} 11:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:06 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')]} 11:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:06 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 0x21ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d60>, '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 0x255aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255aef0>, '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': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', '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 11:40:06 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 11:40:06 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 11:40:06 INFO - Using env: {'DISPLAY': ':0', 11:40:06 INFO - 'HOME': '/home/cltbld', 11:40:06 INFO - 'LANG': 'en_US.UTF-8', 11:40:06 INFO - 'LANGUAGE': 'en_US:en', 11:40:06 INFO - 'LOGNAME': 'cltbld', 11:40:06 INFO - 'MAIL': '/var/mail/cltbld', 11:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:06 INFO - 'MOZ_NO_REMOTE': '1', 11:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:06 INFO - 'NO_EM_RESTART': '1', 11:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:06 INFO - 'PWD': '/builds/slave/test', 11:40:06 INFO - 'SHELL': '/bin/bash', 11:40:06 INFO - 'SHLVL': '1', 11:40:06 INFO - 'TERM': 'linux', 11:40:06 INFO - 'TMOUT': '86400', 11:40:06 INFO - 'USER': 'cltbld', 11:40:06 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', 11:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:06 INFO - '_': '/tools/buildbot/bin/python'} 11:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:06 INFO - Running setup.py (path:/tmp/pip-E3gJRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:07 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)) 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:07 INFO - Running setup.py (path:/tmp/pip-JDthLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40:07 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)) 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:07 INFO - Running setup.py (path:/tmp/pip-3PyXST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40:07 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)) 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:07 INFO - Running setup.py (path:/tmp/pip-_ZmvtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40:07 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)) 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:07 INFO - Running setup.py (path:/tmp/pip-bZ572Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40:07 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)) 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:07 INFO - Running setup.py (path:/tmp/pip-x_9R0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40:07 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)) 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:07 INFO - Running setup.py (path:/tmp/pip-01UgMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40:07 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)) 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:07 INFO - Running setup.py (path:/tmp/pip-3owTUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40:07 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)) 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:07 INFO - Running setup.py (path:/tmp/pip-3O3t56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40:07 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)) 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:07 INFO - Running setup.py (path:/tmp/pip-jq1irY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40:07 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)) 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:07 INFO - Running setup.py (path:/tmp/pip-6171rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40:07 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)) 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:07 INFO - Running setup.py (path:/tmp/pip-HiteJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40:07 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)) 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:07 INFO - Running setup.py (path:/tmp/pip-KaeZh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40:07 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)) 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:07 INFO - Running setup.py (path:/tmp/pip-AWNDyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:07 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)) 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:07 INFO - Running setup.py (path:/tmp/pip-hPG3Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:08 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)) 11:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:08 INFO - Running setup.py (path:/tmp/pip-uqPeWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40:08 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)) 11:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:08 INFO - Running setup.py (path:/tmp/pip-o0mrT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40:08 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)) 11:40:08 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)) 11:40:08 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)) 11:40:08 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)) 11:40:08 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)) 11:40:08 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)) 11:40:08 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)) 11:40:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:40:08 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 11:40:08 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 11:40:08 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 11:40:08 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 11:40:09 INFO - Downloading blessings-1.6.tar.gz 11:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:40:09 INFO - Installing collected packages: blessings 11:40:09 INFO - Running setup.py install for blessings 11:40:09 INFO - Successfully installed blessings 11:40:09 INFO - Cleaning up... 11:40:09 INFO - Return code: 0 11:40:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:40:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:40:09 INFO - Reading from file tmpfile_stdout 11:40:09 INFO - Current package versions: 11:40:09 INFO - argparse == 1.2.1 11:40:09 INFO - blessings == 1.6 11:40:09 INFO - blobuploader == 1.2.4 11:40:09 INFO - docopt == 0.6.1 11:40:09 INFO - functools32 == 3.2.3-2 11:40:09 INFO - jsonschema == 2.5.1 11:40:09 INFO - manifestparser == 1.1 11:40:09 INFO - mozInstall == 1.13 11:40:09 INFO - mozcrash == 1.0 11:40:09 INFO - mozdebug == 0.1 11:40:09 INFO - mozdevice == 0.51 11:40:09 INFO - mozfile == 1.2 11:40:09 INFO - mozhttpd == 0.7 11:40:09 INFO - mozinfo == 0.10 11:40:09 INFO - mozleak == 0.1 11:40:09 INFO - mozlog == 3.5 11:40:09 INFO - moznetwork == 0.27 11:40:09 INFO - mozprocess == 0.25 11:40:09 INFO - mozprofile == 0.28 11:40:09 INFO - mozrunner == 6.13 11:40:09 INFO - mozscreenshot == 0.1 11:40:09 INFO - mozsystemmonitor == 0.3 11:40:09 INFO - moztest == 0.8 11:40:09 INFO - mozversion == 1.4 11:40:09 INFO - psutil == 3.1.1 11:40:09 INFO - requests == 1.2.3 11:40:09 INFO - wsgiref == 0.1.2 11:40:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:09 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 0x21ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d60>, '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 0x255aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255aef0>, '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': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', '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 11:40:09 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 11:40:09 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 11:40:09 INFO - Using env: {'DISPLAY': ':0', 11:40:09 INFO - 'HOME': '/home/cltbld', 11:40:09 INFO - 'LANG': 'en_US.UTF-8', 11:40:09 INFO - 'LANGUAGE': 'en_US:en', 11:40:09 INFO - 'LOGNAME': 'cltbld', 11:40:09 INFO - 'MAIL': '/var/mail/cltbld', 11:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:09 INFO - 'MOZ_NO_REMOTE': '1', 11:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:09 INFO - 'NO_EM_RESTART': '1', 11:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:09 INFO - 'PWD': '/builds/slave/test', 11:40:09 INFO - 'SHELL': '/bin/bash', 11:40:09 INFO - 'SHLVL': '1', 11:40:09 INFO - 'TERM': 'linux', 11:40:09 INFO - 'TMOUT': '86400', 11:40:09 INFO - 'USER': 'cltbld', 11:40:09 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', 11:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:09 INFO - '_': '/tools/buildbot/bin/python'} 11:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:40:09 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 11:40:09 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 11:40:09 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 11:40:09 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 11:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:40:11 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)) 11:40:11 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)) 11:40:11 INFO - Installing collected packages: simplejson 11:40:11 INFO - Running setup.py install for simplejson 11:40:11 INFO - building 'simplejson._speedups' extension 11:40:11 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 11:40:12 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 11:40:12 INFO - Successfully installed simplejson 11:40:12 INFO - Cleaning up... 11:40:12 INFO - Return code: 0 11:40:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:40:12 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')]} 11:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:12 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')]} 11:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:12 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 0x21ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d60>, '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 0x255aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255aef0>, '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': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', '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 11:40:12 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 11:40:12 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 11:40:12 INFO - Using env: {'DISPLAY': ':0', 11:40:12 INFO - 'HOME': '/home/cltbld', 11:40:12 INFO - 'LANG': 'en_US.UTF-8', 11:40:12 INFO - 'LANGUAGE': 'en_US:en', 11:40:12 INFO - 'LOGNAME': 'cltbld', 11:40:12 INFO - 'MAIL': '/var/mail/cltbld', 11:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:12 INFO - 'MOZ_NO_REMOTE': '1', 11:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:12 INFO - 'NO_EM_RESTART': '1', 11:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:12 INFO - 'PWD': '/builds/slave/test', 11:40:12 INFO - 'SHELL': '/bin/bash', 11:40:12 INFO - 'SHLVL': '1', 11:40:12 INFO - 'TERM': 'linux', 11:40:12 INFO - 'TMOUT': '86400', 11:40:12 INFO - 'USER': 'cltbld', 11:40:12 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', 11:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:12 INFO - '_': '/tools/buildbot/bin/python'} 11:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:40:12 INFO - Cleaning up... 11:40:12 INFO - Return code: 0 11:40:12 INFO - Running post-action listener: _resource_record_post_action 11:40:12 INFO - Running post-action listener: _start_resource_monitoring 11:40:12 INFO - Starting resource monitoring. 11:40:12 INFO - [mozharness: 2017-10-04 18:40:12.683460Z] Finished create-virtualenv step (success) 11:40:12 INFO - [mozharness: 2017-10-04 18:40:12.684440Z] Running install step. 11:40:12 INFO - Running pre-action listener: _resource_record_pre_action 11:40:12 INFO - Running main action method: install 11:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:40:12 INFO - Reading from file tmpfile_stdout 11:40:12 INFO - Detecting whether we're running mozinstall >=1.0... 11:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:40:13 INFO - Reading from file tmpfile_stdout 11:40:13 INFO - Output received: 11:40:13 INFO - Usage: mozinstall [options] installer 11:40:13 INFO - Options: 11:40:13 INFO - -h, --help show this help message and exit 11:40:13 INFO - -d DEST, --destination=DEST 11:40:13 INFO - Directory to install application into. [default: 11:40:13 INFO - "/builds/slave/test"] 11:40:13 INFO - --app=APP Application being installed. [default: firefox] 11:40:13 INFO - mkdir: /builds/slave/test/build/application 11:40:13 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'] 11:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:40:31 INFO - Reading from file tmpfile_stdout 11:40:31 INFO - Output received: 11:40:31 INFO - /builds/slave/test/build/application/firefox/firefox 11:40:31 INFO - Running post-action listener: _resource_record_post_action 11:40:31 INFO - [mozharness: 2017-10-04 18:40:31.127414Z] Finished install step (success) 11:40:31 INFO - [mozharness: 2017-10-04 18:40:31.127560Z] Running setup-mitmproxy step. 11:40:31 INFO - Running pre-action listener: _resource_record_pre_action 11:40:31 INFO - Running main action method: setup_mitmproxy 11:40:31 INFO - Skipping: mitmproxy is not required 11:40:31 INFO - Running post-action listener: _resource_record_post_action 11:40:31 INFO - [mozharness: 2017-10-04 18:40:31.128091Z] Finished setup-mitmproxy step (success) 11:40:31 INFO - [mozharness: 2017-10-04 18:40:31.128221Z] Running run-tests step. 11:40:31 INFO - Running pre-action listener: _resource_record_pre_action 11:40:31 INFO - Running pre-action listener: _set_gcov_prefix 11:40:31 INFO - Running main action method: run_tests 11:40:31 WARNING - Try message not found. 11:40:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:40:31 INFO - Python 2.7.3 11:40:31 INFO - Return code: 0 11:40:31 INFO - grabbing minidump binary from tooltool 11:40:31 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')]} 11:40:31 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 0x2559d60>, '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 0x255aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255aef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:40:31 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 11:40:31 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 11:40:31 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 11:40:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:40:31 INFO - Return code: 0 11:40:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:40:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:40:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:40:31 INFO - ENV: RUST_BACKTRACE is now full 11:40:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:40:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:40:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-086 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:40:31 INFO - Using env: {'DISPLAY': ':0', 11:40:31 INFO - 'HOME': '/home/cltbld', 11:40:31 INFO - 'LANG': 'en_US.UTF-8', 11:40:31 INFO - 'LANGUAGE': 'en_US:en', 11:40:31 INFO - 'LOGNAME': 'cltbld', 11:40:31 INFO - 'MAIL': '/var/mail/cltbld', 11:40:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:40:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:40:31 INFO - 'MOZ_ACCELERATED': '1', 11:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:31 INFO - 'MOZ_NO_REMOTE': '1', 11:40:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:40:31 INFO - 'MOZ_WEBRENDER': '1', 11:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:31 INFO - 'NO_EM_RESTART': '1', 11:40:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:31 INFO - 'PWD': '/builds/slave/test', 11:40:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:40:31 INFO - 'RUST_BACKTRACE': 'full', 11:40:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:40:31 INFO - 'SHELL': '/bin/bash', 11:40:31 INFO - 'SHLVL': '1', 11:40:31 INFO - 'TERM': 'linux', 11:40:31 INFO - 'TMOUT': '86400', 11:40:31 INFO - 'USER': 'cltbld', 11:40:31 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', 11:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:31 INFO - '_': '/tools/buildbot/bin/python'} 11:40:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:40:31 INFO - mozversion application_buildid: 20171004174332 11:40:31 INFO - mozversion application_changeset: ee1c41cf306df0043a8e68af042f133acf2ef94e 11:40:31 INFO - mozversion application_display_name: Nightly 11:40:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:40:31 INFO - mozversion application_name: Firefox 11:40:31 INFO - mozversion application_remotingname: firefox 11:40:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:40:31 INFO - mozversion application_vendor: Mozilla 11:40:31 INFO - mozversion application_version: 58.0a1 11:40:31 INFO - mozversion platform_buildid: 20171004174332 11:40:31 INFO - mozversion platform_changeset: ee1c41cf306df0043a8e68af042f133acf2ef94e 11:40:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:40:31 INFO - mozversion platform_version: 58.0a1 11:40:31 INFO - using testdate: 1507142431 11:40:31 INFO - actual date: 1507142431 11:40:31 INFO - starting webserver on 'localhost:50765' 11:40:31 INFO - SUITE-START | Running 2 tests 11:40:31 INFO - TEST-START | dromaeo_css 11:40:31 INFO - Initialising browser for dromaeo_css test... 11:40:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50765/getInfo.html -profile /tmp/tmpaDDdTF/profile 11:40:31 INFO - TEST-INFO | started process 3723 (/builds/slave/test/build/application/firefox/firefox http://localhost:50765/getInfo.html) 11:40:40 INFO - TEST-INFO | 3723: exit 0 11:40:40 INFO - Browser initialized. 11:40:40 INFO - Running cycle 1/1 for dromaeo_css test... 11:40:40 INFO - Using env: {'DISPLAY': ':0', 11:40:40 INFO - 'HOME': '/home/cltbld', 11:40:40 INFO - 'JSGC_DISABLE_POISONING': '1', 11:40:40 INFO - 'LANG': 'en_US.UTF-8', 11:40:40 INFO - 'LANGUAGE': 'en_US:en', 11:40:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:40:40 INFO - 'LOGNAME': 'cltbld', 11:40:40 INFO - 'MAIL': '/var/mail/cltbld', 11:40:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:40:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:40:40 INFO - 'MOZ_ACCELERATED': '1', 11:40:40 INFO - 'MOZ_CRASHREPORTER': '1', 11:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:40:40 INFO - 'MOZ_NO_REMOTE': '1', 11:40:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:40:40 INFO - 'MOZ_WEBRENDER': '1', 11:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:40 INFO - 'NO_EM_RESTART': '1', 11:40:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:40 INFO - 'PWD': '/builds/slave/test', 11:40:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:40:40 INFO - 'RUST_BACKTRACE': 'full', 11:40:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:40:40 INFO - 'SHELL': '/bin/bash', 11:40:40 INFO - 'SHLVL': '1', 11:40:40 INFO - 'TERM': 'linux', 11:40:40 INFO - 'TMOUT': '86400', 11:40:40 INFO - 'USER': 'cltbld', 11:40:40 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', 11:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:40 INFO - '_': '/tools/buildbot/bin/python'} 11:40:40 INFO - TEST-INFO | started process 3973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaDDdTF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:41 INFO - PID 3973 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:40:41 INFO - PID 3973 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:40:42 INFO - PID 3973 | 11:40:42 INFO - PID 3973 | (/builds/slave/test/build/application/firefox/firefox:4033): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:40:42 INFO - PID 3973 | 11:40:52 INFO - PID 3973 | RSS: Main: 191639552 11:40:52 INFO - PID 3973 | 11:43:49 INFO - PID 3973 | Cycle 1(1): loaded http://localhost:50765/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50765/tests/dromaeo/cssquery-ext.html) 11:43:50 INFO - PID 3973 | RSS: Main: 187424768 11:43:50 INFO - PID 3973 | 11:46:52 INFO - PID 3973 | Cycle 1(1): loaded http://localhost:50765/tests/dromaeo/cssquery-ext.html (next: http://localhost:50765/tests/dromaeo/cssquery-jquery.html) 11:46:53 INFO - PID 3973 | RSS: Main: 186507264 11:46:53 INFO - PID 3973 | 11:49:55 INFO - PID 3973 | Cycle 1(1): loaded http://localhost:50765/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50765/tests/dromaeo/cssquery-mootools.html) 11:49:56 INFO - PID 3973 | RSS: Main: 187645952 11:49:56 INFO - PID 3973 | 11:52:58 INFO - PID 3973 | Cycle 1(1): loaded http://localhost:50765/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50765/tests/dromaeo/cssquery-prototype.html) 11:52:58 INFO - PID 3973 | RSS: Main: 187559936 11:52:58 INFO - PID 3973 | 11:56:02 INFO - PID 3973 | Cycle 1(1): loaded http://localhost:50765/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50765/tests/dromaeo/cssquery-yui.html) 11:56:03 INFO - PID 3973 | RSS: Main: 190222336 11:56:03 INFO - PID 3973 | 11:59:05 INFO - PID 3973 | Cycle 1(1): loaded http://localhost:50765/tests/dromaeo/cssquery-yui.html (next: http://localhost:50765/tests/dromaeo/cssquery-dojo.html) 11:59:05 INFO - PID 3973 | RSS: Main: 191283200 11:59:05 INFO - PID 3973 | 11:59:05 INFO - PID 3973 | __start_tp_report 11:59:05 INFO - PID 3973 | _x_x_mozilla_page_load 11:59:05 INFO - PID 3973 | _x_x_mozilla_page_load_details 11:59:05 INFO - PID 3973 | |i|pagename|runs| 11:59:05 INFO - PID 3973 | |0;dojo.html;3090.0420869530444;3128.85920133594;3135.858886350114;3139.419207446621;3154.6372167200752;6118.96940515298;6264.091706702526;6275.592086514379;6339.6830158492;6417.06952491889;6196.566240363177;6232.937670623292;6258.718357673904;6405.19935008124;6434.227892652888;5692.943070569283;5810.506106980912;5824.039033559478;5833.270841144857;5885.7939972100985;111.67809702773103;5356.625036247464;5637.379888212294;5841.824745257649;5843.328017278025;5637.577181711388;5698.715064246791;5706.28671416073;5718.285214348207;5800.7679692812235;5792.913106303409;5856.472917437409;5861.648301101947;5870.706464676792;5886.234789477383;5738.512226460714;5766.0197766379815;5851.824445266649;5855.677937713424;5855.853603659943;6220.066989951498;6226.190595222637;6243.750249989995;6244.281907580641;6367.904481432736;6702.296258892795;6715.764948226789;6793.796186114425;6804.65976701163;6813.897791533131;6749.831254218635;6783.694733736994;6881.243063263037;6920.411764999981;6939.444844412435;6281.560290779647;6298.307186209513;6303.684815759239;6373.649449280288;6380.7128679209545;6843.520953533304;6887.380135787703;6909.689063992132;6922.965385173042;7073.92926070743;6493.31820158886;6564.442022428051;6580.5722628029025;6593.208814942238;6606.504512161607;6642.169728783902;6694;6812.182538095461;6847.349501797321;6862.245153033163;6656.034874943203;6788.660566971632;6814.420774234147;6826.522143449911;6833;6731.932680673229;6781.491388145909;6816.591004539743;6826.385625293748;6909.619970901548;5218.608604354688;5219.765110570033;5275.393329767126;5311.176767601028;5318.335208098988;4617.538246175355;4625.676202665781;4644.605208557243;4695.530446955346;4749.691270067435;5811.215485909348;5862.677552734641;5890.057590785454;5893.911591326134;5895.587308888336;6739;6788.422984046312;6811.182658081062;6832.180138383326;6890.345417185359;5670.5180059695385;5756.625819321731;5777.537796976232;5840.8247752567495;5879.617824841372;5768.307803063659;5798.565107616945;5822.301323841081;5860.765569377178;5871.94128058714;6530.444912182517;6547.836304092436;6548.70530826114;6550.967245163839;6564.835879102965;6792.490563207681;6816.693248803816;6851.07510486088;6868.381845633917;6882.346177113166;6472.126262954441;6479.870402591828;6555.2789193187755;6559.245686746085;6583.078369028244;6503.739850405931;6560.9343906562235;6619.768308109193;6734.8653026940165;6785.93214067853;6680.5991640501725;6681.2650608434005;6758.86482270342;6763.154605674291;6774.661266936535;6497.31778163305;6524.543281970216;6556.8360790980605;6610.140681711539;6614.107095542233;6565.409113179837;6662.333766623299;6676.198856137295;6681.933180668131;6690.665466726741;6487.351264873475;6522.184726909137;6545.21457425112;6583.80248592543;6621.5364924454825;6438.130852334875;6595.8021259362295;6599.8020059398295;6615.966920165561;6732.764353247613;6177.135201071944;6202.038684003986;6242.438180563771;6248.156498872594;6260.373962603885 11:59:05 INFO - PID 3973 | |1;ext.html;866.1987661413199;869.5174178331026;879.6349514951296;884.5577211394303;891.140049851893;41720.58279417205;42480.57519424805;42511;42762.786186069025;42851.14297714044;38075.42886856692;38639.613603864025;38725.41911871317;38999;39074;7160.96419517903;7310.853782924339;7332.1934587195365;7337.523061001045;7339.229380915007;7152.570845749246;7199.784006479814;7203;7235.746748863791;7245.855082898365;7128.287171282856;7213.963930180368;7901.48640338379;8089.919100808976;8134.389920755967;7935.603219838985;8063;8152.510849349058;8152.714654987047;8153.143919888385;7980.321672657831;7981.3614910807;8067.596620168968;8090.635921383552;8093.109757926623;38066.619333806586;38545.421818672745;38843.61156388428;38884.611153888385;38902.22195556101;3571.8035508047046;3579.6957258633047;3582.22982058856;3596.62235465275;3647.854085836563;31621.367572648647;31993.52009719856;32022.35955280881;32028.839855800572;32122.839385802923;4993.475685053054;5136.897262054776;5153.458886816868;5164.509371609691;5194.844154675366;182161;182553.99999999866;182754;184192;184666;42250.36624450636;42808;48031.27953080706;50221.24668129981;51615.225771613455;53101;53153;53239.46760532345;53313;53436.46563534393;13994;14042.719145617235;14139.717205655828;14150.85849141516;16026.519204423887;11198.496067676973;11274.210805243718;11274.887251127384;11277.379744113989;11300.54797808095;13708;13809.240491772847;13811.861881381259;13857.584272471842;14003.439862405594;5521.503064724194;5661.490465858093;5708.942910570924;5745.454181852718;5789.218455508537;993.821112199811;1004.4324956399611;1020.739711373595;1035.9896401035894;1041.4948749856314;23811.523769524512;23991.040358385817;24110.276691699277;24146.154884578955;24317;1119.4179026905963;1134.4967917509334;1146.1232157399595;1148.0930065248526;1148.91427600918;12626.408552441462;12764.744705106032;12781.360931953364;12796.744065118646;12917;241219;242535;243362;245012;245177;53708;53723.19415208775;53851.46148538543;53921.460785391646;53954.19068713972;1401.4324198699544;1465.0843222985634;1475.2918599072505;1479.615300022002;1481.4222453243028;23347.766522334558;23400.531989360457;23493.53012939766;23726.288211353687;23811.523769524858;34299.82850085734;34419;38368.2326353477;38721.22557548777;38858;196105;196745;196789;197159;197294;34332.82833585916;34551.136221594665;34664.65335346614;34787.30425391529;34816.47775283322;41153.38269925894;43353;43869.78065109654;43926.12147757091;43988.78005609952;31258.843705781324;31551.684483154873;31748.523772143897;31759.84120079385;31799.841000794848;31142.532862006636;31279.53080703837;31820.68179318177;31834.36331273408;31956.52065218977;36079.63920360763;36202.27595448129;36230.27539449249;36472.27055458929;36506.45240321344;30746.846265768527;30956;31171.688283117786;31282.68717312889;31470.37059258848;23067.538649226586;23846.403839904142;24082.277531674077;24305.576349172996;24495.75504245006 11:59:05 INFO - PID 3973 | |2;jquery.html;582.2023827356522;584.9298084229893;590.7784580782206;602.3614968133777;628.8270725550473;21671.891640541795;22120.336389908287;22319.665205021898;22434.3269701909;22513;22851.885740571273;24178.395540111505;24280;24306.75693243067;24326;6490.383413575714;6603.042558828967;6636.170478690164;6648.335166483362;6648.867022659544;6502.2197336319705;6612.537122401433;6613.603183808963;6615.636140012298;6624.1719785026635;6176.351483094255;6495.610263384188;6513.446357059655;6514.739410423577;6516.771912983047;6445.742170313182;6514.77198298062;6521.510886683518;6530.869382612321;6533.314002029813;5910.940890591125;6022.8494287642725;6076.908846367308;6118.174046503754;6167.691615419211;27370.863145684343;28186.15441536757;28235.29411764702;28370.29074273139;28372.858135709397;2082.541840795023;2083.2396175396025;2119.6502577074766;2121.1727426303755;2122.7028216049766;18463.630727385378;19418.41744747646;19675.508112297164;19700.211991520322;19705.408837734893;2413.722421921484;2470.3700556358012;2502.7121880983736;2519.685039370079;2525.9242222733346;113950.43024784906;118777;141351;141510;145313.2734336332;18626.627467450577;21208.469788255417;21248.25631102904;21438.892805536183;21693.783062169492;42269.36595951063;42285;42331.576684233376;42361.15277694429;42594.935126621465;11705.414729263503;11757.353345565905;11783.823242651368;11863.940680296544;12026.4588093536;9858.80282394348;9944.552495137736;9989.100980911753;9998.850017249748;10114.898851011396;10988.175886808522;11026;11155.107591392669;11220.27068240578;11654.88345116555;3771.981140094282;4167.770772607475;4345.891352716208;4429.269170586882;4491.236489796743;951.4861974533675;972.0231167676582;979.7109852593502;980.9362391444533;986.4328011393477;18713.251469941322;18775.624487510173;18847.53602384479;19160.808391915903;19246.518837028907;1036.8600238967642;1037.4605205293205;1041.807265655856;1048.6382198141782;1053.2364036073939;10184.388936663823;10332.638357657595;10367.688969330931;10476.547467326509;10653.78692426147;458567;468980;479310;480158;482784;119184;119576;119663;119800.40099799445;119836;1011.1556850030307;1119.8824123467082;1157.4907040901976;1180.1620849196995;1186.6618013866007;19373;19511.21955121836;19708.113134908675;19913.701294480306;19975.101120449322;55928.88142237214;57746.133807992075;58622.41377586169;58633.82732345415;59534;73929.6303518479;74333.628331858;75123.62438187774;75813;76046.61976690081;18796.436106916815;19548.120334585263;19549.022548872214;19580.314688985818;19713.310034148737;21310.254141104986;21357.89321053447;21864.250859931486;21903.67144492802;21952;16561.751573726164;17455.214515346586;17568.56078598045;17619.647607048042;17636.20637071309;15316;15733.685326293638;15808.841911580737;15900.443484477988;16350.918245409173;17751.64496710033;17999.280028799225;18059.097045147428;18174.36389726353;18295.17671704803;18956.336528221447;18972.335968241045;18984.620307594047;19054.618907622047;19107.331243406414;17354.219060142575;17531.912340438215;17550.473485795446;17599;17676.558086047437 11:59:05 INFO - PID 3973 | |3;mootools.html;1364.6110858405352;1413.5264686330086;1413.9505117320896;1420.2898550724638;1431.756601377766;15305.693886122272;15888.126153061577;15904.125273109974;15971.361145554178;16016.439424620141;15721.528354149365;15856;15865.762013569776;15866.603334916634;15876.761848572281;2719.864006799662;2839.9006034788786;2840.61651677023;2841.076650088719;2847.288177955511;2805.6633204015443;2820.2667306500357;2830.4339132173545;2840.730130637586;2855.585940038693;2671.2921075914896;2761.765249953756;2761.8619069046567;2766.0180635874276;2768.958465623017;2686.194141757475;2696.5820297853766;2712.186344096773;2715.9049433269743;2717.021872126033;2667.8265912715806;2674.8261363011343;2685.78513718902;2693.299742067057;2701.1761412769097;14741.262936853114;14930.552083437515;15016.699666006618;15153.318100685385;15264.847351526454;7915.406344524184;8200.384971127189;8255;8261.463004904663;8268.338532917352;5138.306328645623;5330.92003619946;5487.341519017744;5600.803971861006;5603.103503439471;1896.4026331705468;1906.65680177568;1940.2142132436386;1982.3161009451717;1985.1662301833264;24373.63439548408;25216.747832521807;27157.185284441497;27955.72044279531;27976.160715178576;7193.529303564952;7205.531640443354;7230.891536626955;7356.080489938758;7421.591812450367;20061.49846253826;20061.498462538555;20075.899620501805;20123.390128789662;20204.29284975019;8263.297619702393;8279.751607451786;8333.374996875258;8338.332933365316;8338.583070846433;7207.387372073433;7302.963485182647;7656.425768067417;7666.808329791688;7687.730929417444;5566.276384070045;5832.62087964281;5873.119032145212;5874.618149820248;5946.70266486674;1775.4407361681028;1838.9150401263319;1841.6500864835639;1856.832885040353;1868.4394681595468;842.8988521377474;843.7721815110009;853.8164294676675;862.2369203255164;869.8999615044224;7650.273224043707;7766.145723970359;7858.803529911684;7952.443328966917;7960.522368657899;730.3718801830422;733.0946281342538;736.3961551527802;745.3068646159015;748.5097261293861;4360.890977725582;4393.758343291086;4407.184670835905;4438.400815889878;4455.465344158722;21138.471538211666;21885.781142188374;22169.667454988186;22218.222362217246;22805.429864253194;21338;22276.443088922908;22277.777222227895;22363.55272894533;22723.659145112506;8811.559422028873;10015.849762253718;10031.347962382422;10962.835557466644;11250.887491125148;8332.416730828783;8355.206255405727;8492.532910689972;8530.019047809581;8563.443376180778;18943.621127577648;19590.90204548968;19743.308984185485;19767.50581235423;19814.60370792547;19696.704549432056;19762.20951161995;20328.695069573674;20512.07695653729;20606.484837879172;11832.230904991147;11945.641630751092;11989.940050299692;12038;12088.456019479321;13627.386767595284;13692.794608080687;13812.861871381157;13816.101953372998;13828.516001939885;11578.826317605075;11695.771943945763;11721;11795.233309834834;11921.940390297994;10650.8934910653;10745.247832651952;10791.352518848895;10948.781024379627;11078.390688512209;10000.549975250986;10146.985301469795;10262.846057309296;10266;10304.124149447382;6336.841578960379;6451.741930322734;6495.0582165586675;6575.769848055295;6595.967020164869;6683.498737594603;6756.831079222862;6769.4922880785125;6897.89653155193;6914.965425172842 11:59:05 INFO - PID 3973 | |4;prototype.html;498.33223480536077;507.7613521644827;525.61104782461;527.2565682387833;538.6471860931089;6099.7865074722395;6292.46514046306;6296.842578935529;6347.714352854121;6352.015437607172;6107.7556897724035;6115.571909966304;6151.063319475539;6201.813945581628;6211.720472578733;4873.122837889178;4950.257461380804;4959.578435832958;4984.725840078794;5017.544911975523;4882.48642920694;4956.653034287601;5047.545720885119;5049.646524743251;5052.292679024939;4953.405591329046;4986.775595098211;5004.499550044985;5009.849704508871;5010.974945125269;4873.195922672755;4879.731614761205;4899.608031357483;4926.75366231687;4991.226359914219;4333.76810942365;4382.561743825624;4390.890227744332;4418.630224630375;4482.484514280867;6013.6692481913915;6053.152558641794;6084.939150608481;6090.756369745205;6094.312940670919;5616.157576363537;5656.321241451011;5662.575306851962;5673.8297851064535;5675.716214189274;6472.190976127984;6570.671466426659;6572.638504882229;6592.912169492028;6602.580445204256;4702.882427939329;4786.253017648533;4790.233562629997;4792.185328494164;4825;6749.831254218684;6841.247462779091;6844.691988860513;6897.172339319314;6921.861562768717;4983.277424773388;5014.6991180529285;5040.243963405518;5055.443901170868;5066.138756411346;5062.493750624908;5069.138246498031;5075.949240507622;5085.516875896784;5141.562967147835;5719.5138413235345;5732.971335143381;5745.253117094751;5756.395578464201;5782.971085144547;6582.41258514111;6655.367740064686;6673.699683514254;6697.263301036882;6751.527393082437;1629.771831943505;1707.9316827327016;1721.4233231867465;1738.75657407963;1777.4134535603478;1112.8386383974278;1172.3200543684643;1179.1981452612306;1183.8398369597842;1194.3371428856894;5487.363178114487;5492.945070549324;5666.178404131378;5694.914576281359;5734.483896449339;6341.54627020771;6376.521760867953;6404.423601875854;6421.486281097501;6472.288048314682;5493.478119578714;5638.915416268759;5650.802221922213;5704.714764261853;5729.226554415184;3509.771864828778;3557.6442355764216;3562.1628917204434;3592.892213233607;3593.3711600469815;6289.452771627498;6295.464885484785;6453.386928241809;6475.740970361227;6476.805695829133;6847.794566163023;6902.585844849325;6916.896246556305;6928.792136235921;6935.6878940447805;6335.239771227482;6406.935930640727;6447.097406363019;6494.6103233806125;6501.707423165874;6583.901241481286;6660.433863121495;6672.499562532732;6727.360900714424;6758.2903795102775;6651.800445986628;6653.600783952978;6653.866922661617;6725.226598941184;6785.830354241183;6527.5430719849155;6569.4744420447205;6576.210854697467;6592.90110648331;6602.151397608677;4892.608591312615;4947.529984651596;4972.154733695208;4978.30303757467;5013.974930125326;6554.377334153248;6601.867962640624;6658.533902626769;6658.803774188514;6724.4284235840505;6226.742124165185;6304.5271604628915;6379.330170332234;6396.520260980352;6433.903491447726;6313.042956683443;6349.555531112963;6390.616563006234;6471.25580558223;6480.157579514633;6114.6636934969;6341.302456729663;6445.25879523842;6477.611343319416;6492.448141907991;6245.843853903507;6408.1349017881985;6492.798832215866;6507.544471887112;6514.250861151028;6257.311695713559;6291.96854015727;6304.959681652476;6348.5238607105575;6387.808365749035 11:59:05 INFO - PID 3973 | |5;yui.html;900.3157600223828;906.8322360363337;915.9404638698484;922.7231830450863;928.6053427293401;18482.26070957162;19493.317733879318;19747.901260493676;19769.99999999998;19832.70250946237;17857.732134017966;17931.91034044831;17996.820031799678;18056.27774889006;18167.273309067656;963.036963036963;979.211734553684;984.3847595252967;984.7488890332991;984.9606015759362;994.9701508954743;1000.7248006798152;1002.8295189817749;1003.0571263012781;1003.7741508160642;1002.8997100289986;1023.4115383654391;1036.2228328753436;1040.7138037039838;1047.1831971062545;999.2655398282257;1002.904724051214;1007.3603261928655;1009.8636684047633;1013.1337706261152;739.9408047356198;744.5011842065829;746.5520687587458;748.8015675845851;749.741339237962;19554.413367598994;19649.9017504913;19717.605647887107;19767.11048002829;19838.801611983985;21022.159113635436;21375.358739237847;22004;22188.88905555478;22193.556128877495;17626.559336016573;18031.459056228334;18085.547861303443;18120.63758724831;18316.17577209029;3675.4486826976167;3676.8161591920566;3699.815009249554;3705.7591256568508;3726.981365093184;108381;150117.24941375334;150658;154333;154676.22661886617;14413.639659008399;14653.12081275127;14711.117332960057;14780.48268310604;14848.554543363716;32210.19474513156;33068.1732956678;33130.66869331324;33150.502742458884;33172.834135829646;9451.196648284835;9541.379810312308;9616.615335386647;9636.951815240878;9661.082197191256;4564.292534657134;4624.583787459145;4630.444346678353;4647.814087436533;4664.860054198311;5506.174073888868;5588.804391846347;5611.915821262684;5674.177244299553;5696.857578560486;1102.4653043274006;1105.4141305108144;1131.3607811586428;1138.869030061537;1143.2454579977175;676.3912478769147;681.7375310505491;690.4200471603876;702.940250078749;703.2264509040117;11627.709307267216;11772.646820595395;12039.939800300943;12179.817302740466;12448.128630995925;640.8846407646575;651.3616655677463;659.3472462262422;666.2604508995012;668.7692746002622;5422.75597598109;5444.782208711607;5514.972425137928;5562.499375056264;5620.241267428844;126076.36961815132;126535;127308;130644.3467782674;131453;112415.4379228115;118431.40784296195;122497;122605;122668.38665806614;100718.4964075175;103290;104763;106314.46842765891;106781;10329.483525823829;10532.736681583021;10541.156707463231;10569.154467642416;10724.356538607708;47311.29033064576;48245.5175448241;48936;49357.25964110613;50240.246396304814;60982.69508652428;63173;63488.68255658692;63587;64047.03929440969;16095.67808643844;16156.919215403848;16342.836571634132;16382.344706211617;16533.91733041327;18229.726554101966;18435.26258949627;18560.164792584637;18673.626527469103;18899.527511811764;15554.300056497259;15753.448629298378;15828.12945287974;16041;16058.8394116062;15912.52262432129;16181.514554563382;16234.350625974828;16239.43161989372;16433.506994790176;16906.32374704998;16962.66074678524;17004.404845830337;17084.316627335265;17344.739828902326;12593.93703031479;12595.24428534291;12807.80788288195;12990.415431305802;12996.935015324863;12473.438695258918;12671.683207919876;12694.301813400352;12843.972482201589;12954.093213474966 11:59:05 INFO - PID 3973 | __end_tp_report 11:59:05 INFO - PID 3973 | __start_cc_report 11:59:05 INFO - PID 3973 | _x_x_mozilla_cycle_collect,277 11:59:05 INFO - PID 3973 | __end_cc_report 11:59:05 INFO - PID 3973 | __startTimestamp1507143545342__endTimestamp 11:59:05 INFO - PID 3973 | 11:59:05 INFO - PID 3973 | ------- Summary: start ------- 11:59:05 INFO - PID 3973 | Number of tests: 6 11:59:05 INFO - PID 3973 | 11:59:05 INFO - PID 3973 | [#0] dojo.html Cycles:165 Average:6171.20 Median:6479.87 stddev:891.88 (13.8%) stddev-sans-first:861.24 11:59:05 INFO - PID 3973 | Values: 3090.0 3128.9 3135.9 3139.4 3154.6 6119.0 6264.1 6275.6 6339.7 6417.1 6196.6 6232.9 6258.7 6405.2 6434.2 5692.9 5810.5 5824.0 5833.3 5885.8 111.7 5356.6 5637.4 5841.8 5843.3 5637.6 5698.7 5706.3 5718.3 5800.8 5792.9 5856.5 5861.6 5870.7 5886.2 5738.5 5766.0 5851.8 5855.7 5855.9 6220.1 6226.2 6243.8 6244.3 6367.9 6702.3 6715.8 6793.8 6804.7 6813.9 6749.8 6783.7 6881.2 6920.4 6939.4 6281.6 6298.3 6303.7 6373.6 6380.7 6843.5 6887.4 6909.7 6923.0 7073.9 6493.3 6564.4 6580.6 6593.2 6606.5 6642.2 6694.0 6812.2 6847.3 6862.2 6656.0 6788.7 6814.4 6826.5 6833.0 6731.9 6781.5 6816.6 6826.4 6909.6 5218.6 5219.8 5275.4 5311.2 5318.3 4617.5 4625.7 4644.6 4695.5 4749.7 5811.2 5862.7 5890.1 5893.9 5895.6 6739.0 6788.4 6811.2 6832.2 6890.3 5670.5 5756.6 5777.5 5840.8 5879.6 5768.3 5798.6 5822.3 5860.8 5871.9 6530.4 6547.8 6548.7 6551.0 6564.8 6792.5 6816.7 6851.1 6868.4 6882.3 6472.1 6479.9 6555.3 6559.2 6583.1 6503.7 6560.9 6619.8 6734.9 6785.9 6680.6 6681.3 6758.9 6763.2 6774.7 6497.3 6524.5 6556.8 6610.1 6614.1 6565.4 6662.3 6676.2 6681.9 6690.7 6487.4 6522.2 6545.2 6583.8 6621.5 6438.1 6595.8 6599.8 6616.0 6732.8 6177.1 6202.0 6242.4 6248.2 6260.4 11:59:05 INFO - PID 3973 | 11:59:05 INFO - PID 3973 | [#1] ext.html Cycles:180 Average:37667.79 Median:19194.14 stddev:54360.51 (283.2%) stddev-sans-first:54442.77 11:59:05 INFO - PID 3973 | Values: 866.2 869.5 879.6 884.6 891.1 41720.6 42480.6 42511.0 42762.8 42851.1 38075.4 38639.6 38725.4 38999.0 39074.0 7161.0 7310.9 7332.2 7337.5 7339.2 7152.6 7199.8 7203.0 7235.7 7245.9 7128.3 7214.0 7901.5 8089.9 8134.4 7935.6 8063.0 8152.5 8152.7 8153.1 7980.3 7981.4 8067.6 8090.6 8093.1 38066.6 38545.4 38843.6 38884.6 38902.2 3571.8 3579.7 3582.2 3596.6 3647.9 31621.4 31993.5 32022.4 32028.8 32122.8 4993.5 5136.9 5153.5 5164.5 5194.8 182161.0 182554.0 182754.0 184192.0 184666.0 42250.4 42808.0 48031.3 50221.2 51615.2 53101.0 53153.0 53239.5 53313.0 53436.5 13994.0 14042.7 14139.7 14150.9 16026.5 11198.5 11274.2 11274.9 11277.4 11300.5 13708.0 13809.2 13811.9 13857.6 14003.4 5521.5 5661.5 5708.9 5745.5 5789.2 993.8 1004.4 1020.7 1036.0 1041.5 23811.5 23991.0 24110.3 24146.2 24317.0 1119.4 1134.5 1146.1 1148.1 1148.9 12626.4 12764.7 12781.4 12796.7 12917.0 241219.0 242535.0 243362.0 245012.0 245177.0 53708.0 53723.2 53851.5 53921.5 53954.2 1401.4 1465.1 1475.3 1479.6 1481.4 23347.8 23400.5 23493.5 23726.3 23811.5 34299.8 34419.0 38368.2 38721.2 38858.0 196105.0 196745.0 196789.0 197159.0 197294.0 34332.8 34551.1 34664.7 34787.3 34816.5 41153.4 43353.0 43869.8 43926.1 43988.8 31258.8 31551.7 31748.5 31759.8 31799.8 31142.5 31279.5 31820.7 31834.4 31956.5 36079.6 36202.3 36230.3 36472.3 36506.5 30746.8 30956.0 31171.7 31282.7 31470.4 23067.5 23846.4 24082.3 24305.6 24495.8 11:59:05 INFO - PID 3973 | 11:59:05 INFO - PID 3973 | [#2] jquery.html Cycles:180 Average:35321.71 Median:21398.39 stddev:79994.18 (373.8%) stddev-sans-first:80176.06 11:59:05 INFO - PID 3973 | Values: 582.2 584.9 590.8 602.4 628.8 21671.9 22120.3 22319.7 22434.3 22513.0 22851.9 24178.4 24280.0 24306.8 24326.0 6490.4 6603.0 6636.2 6648.3 6648.9 6502.2 6612.5 6613.6 6615.6 6624.2 6176.4 6495.6 6513.4 6514.7 6516.8 6445.7 6514.8 6521.5 6530.9 6533.3 5910.9 6022.8 6076.9 6118.2 6167.7 27370.9 28186.2 28235.3 28370.3 28372.9 2082.5 2083.2 2119.7 2121.2 2122.7 18463.6 19418.4 19675.5 19700.2 19705.4 2413.7 2470.4 2502.7 2519.7 2525.9 113950.4 118777.0 141351.0 141510.0 145313.3 18626.6 21208.5 21248.3 21438.9 21693.8 42269.4 42285.0 42331.6 42361.2 42594.9 11705.4 11757.4 11783.8 11863.9 12026.5 9858.8 9944.6 9989.1 9998.9 10114.9 10988.2 11026.0 11155.1 11220.3 11654.9 3772.0 4167.8 4345.9 4429.3 4491.2 951.5 972.0 979.7 980.9 986.4 18713.3 18775.6 18847.5 19160.8 19246.5 1036.9 1037.5 1041.8 1048.6 1053.2 10184.4 10332.6 10367.7 10476.5 10653.8 458567.0 468980.0 479310.0 480158.0 482784.0 119184.0 119576.0 119663.0 119800.4 119836.0 1011.2 1119.9 1157.5 1180.2 1186.7 19373.0 19511.2 19708.1 19913.7 19975.1 55928.9 57746.1 58622.4 58633.8 59534.0 73929.6 74333.6 75123.6 75813.0 76046.6 18796.4 19548.1 19549.0 19580.3 19713.3 21310.3 21357.9 21864.3 21903.7 21952.0 16561.8 17455.2 17568.6 17619.6 17636.2 15316.0 15733.7 15808.8 15900.4 16350.9 17751.6 17999.3 18059.1 18174.4 18295.2 18956.3 18972.3 18984.6 19054.6 19107.3 17354.2 17531.9 17550.5 17599.0 17676.6 11:59:05 INFO - PID 3973 | 11:59:05 INFO - PID 3973 | [#3] mootools.html Cycles:180 Average:9531.43 Median:2689.75 stddev:6955.12 (258.6%) stddev-sans-first:6947.57 11:59:05 INFO - PID 3973 | Values: 1364.6 1413.5 1414.0 1420.3 1431.8 15305.7 15888.1 15904.1 15971.4 16016.4 15721.5 15856.0 15865.8 15866.6 15876.8 2719.9 2839.9 2840.6 2841.1 2847.3 2805.7 2820.3 2830.4 2840.7 2855.6 2671.3 2761.8 2761.9 2766.0 2769.0 2686.2 2696.6 2712.2 2715.9 2717.0 2667.8 2674.8 2685.8 2693.3 2701.2 14741.3 14930.6 15016.7 15153.3 15264.8 7915.4 8200.4 8255.0 8261.5 8268.3 5138.3 5330.9 5487.3 5600.8 5603.1 1896.4 1906.7 1940.2 1982.3 1985.2 24373.6 25216.7 27157.2 27955.7 27976.2 7193.5 7205.5 7230.9 7356.1 7421.6 20061.5 20061.5 20075.9 20123.4 20204.3 8263.3 8279.8 8333.4 8338.3 8338.6 7207.4 7303.0 7656.4 7666.8 7687.7 5566.3 5832.6 5873.1 5874.6 5946.7 1775.4 1838.9 1841.7 1856.8 1868.4 842.9 843.8 853.8 862.2 869.9 7650.3 7766.1 7858.8 7952.4 7960.5 730.4 733.1 736.4 745.3 748.5 4360.9 4393.8 4407.2 4438.4 4455.5 21138.5 21885.8 22169.7 22218.2 22805.4 21338.0 22276.4 22277.8 22363.6 22723.7 8811.6 10015.8 10031.3 10962.8 11250.9 8332.4 8355.2 8492.5 8530.0 8563.4 18943.6 19590.9 19743.3 19767.5 19814.6 19696.7 19762.2 20328.7 20512.1 20606.5 11832.2 11945.6 11989.9 12038.0 12088.5 13627.4 13692.8 13812.9 13816.1 13828.5 11578.8 11695.8 11721.0 11795.2 11921.9 10650.9 10745.2 10791.4 10948.8 11078.4 10000.5 10147.0 10262.8 10266.0 10304.1 6336.8 6451.7 6495.1 6575.8 6596.0 6683.5 6756.8 6769.5 6897.9 6915.0 11:59:05 INFO - PID 3973 | 11:59:05 INFO - PID 3973 | [#4] prototype.html Cycles:180 Average:5470.77 Median:6103.77 stddev:1538.02 (25.2%) stddev-sans-first:1496.36 11:59:05 INFO - PID 3973 | Values: 498.3 507.8 525.6 527.3 538.6 6099.8 6292.5 6296.8 6347.7 6352.0 6107.8 6115.6 6151.1 6201.8 6211.7 4873.1 4950.3 4959.6 4984.7 5017.5 4882.5 4956.7 5047.5 5049.6 5052.3 4953.4 4986.8 5004.5 5009.8 5011.0 4873.2 4879.7 4899.6 4926.8 4991.2 4333.8 4382.6 4390.9 4418.6 4482.5 6013.7 6053.2 6084.9 6090.8 6094.3 5616.2 5656.3 5662.6 5673.8 5675.7 6472.2 6570.7 6572.6 6592.9 6602.6 4702.9 4786.3 4790.2 4792.2 4825.0 6749.8 6841.2 6844.7 6897.2 6921.9 4983.3 5014.7 5040.2 5055.4 5066.1 5062.5 5069.1 5075.9 5085.5 5141.6 5719.5 5733.0 5745.3 5756.4 5783.0 6582.4 6655.4 6673.7 6697.3 6751.5 1629.8 1707.9 1721.4 1738.8 1777.4 1112.8 1172.3 1179.2 1183.8 1194.3 5487.4 5492.9 5666.2 5694.9 5734.5 6341.5 6376.5 6404.4 6421.5 6472.3 5493.5 5638.9 5650.8 5704.7 5729.2 3509.8 3557.6 3562.2 3592.9 3593.4 6289.5 6295.5 6453.4 6475.7 6476.8 6847.8 6902.6 6916.9 6928.8 6935.7 6335.2 6406.9 6447.1 6494.6 6501.7 6583.9 6660.4 6672.5 6727.4 6758.3 6651.8 6653.6 6653.9 6725.2 6785.8 6527.5 6569.5 6576.2 6592.9 6602.2 4892.6 4947.5 4972.2 4978.3 5014.0 6554.4 6601.9 6658.5 6658.8 6724.4 6226.7 6304.5 6379.3 6396.5 6433.9 6313.0 6349.6 6390.6 6471.3 6480.2 6114.7 6341.3 6445.3 6477.6 6492.4 6245.8 6408.1 6492.8 6507.5 6514.3 6257.3 6292.0 6305.0 6348.5 6387.8 11:59:05 INFO - PID 3973 | 11:59:05 INFO - PID 3973 | [#5] yui.html Cycles:180 Average:25606.43 Median:18143.96 stddev:37679.24 (207.7%) stddev-sans-first:37739.27 11:59:05 INFO - PID 3973 | Values: 900.3 906.8 915.9 922.7 928.6 18482.3 19493.3 19747.9 19770.0 19832.7 17857.7 17931.9 17996.8 18056.3 18167.3 963.0 979.2 984.4 984.7 985.0 995.0 1000.7 1002.8 1003.1 1003.8 1002.9 1023.4 1036.2 1040.7 1047.2 999.3 1002.9 1007.4 1009.9 1013.1 739.9 744.5 746.6 748.8 749.7 19554.4 19649.9 19717.6 19767.1 19838.8 21022.2 21375.4 22004.0 22188.9 22193.6 17626.6 18031.5 18085.5 18120.6 18316.2 3675.4 3676.8 3699.8 3705.8 3727.0 108381.0 150117.2 150658.0 154333.0 154676.2 14413.6 14653.1 14711.1 14780.5 14848.6 32210.2 33068.2 33130.7 33150.5 33172.8 9451.2 9541.4 9616.6 9637.0 9661.1 4564.3 4624.6 4630.4 4647.8 4664.9 5506.2 5588.8 5611.9 5674.2 5696.9 1102.5 1105.4 1131.4 1138.9 1143.2 676.4 681.7 690.4 702.9 703.2 11627.7 11772.6 12039.9 12179.8 12448.1 640.9 651.4 659.3 666.3 668.8 5422.8 5444.8 5515.0 5562.5 5620.2 126076.4 126535.0 127308.0 130644.3 131453.0 112415.4 118431.4 122497.0 122605.0 122668.4 100718.5 103290.0 104763.0 106314.5 106781.0 10329.5 10532.7 10541.2 10569.2 10724.4 47311.3 48245.5 48936.0 49357.3 50240.2 60982.7 63173.0 63488.7 63587.0 64047.0 16095.7 16156.9 16342.8 16382.3 16533.9 18229.7 18435.3 18560.2 18673.6 18899.5 15554.3 15753.4 15828.1 16041.0 16058.8 15912.5 16181.5 16234.4 16239.4 16433.5 16906.3 16962.7 17004.4 17084.3 17344.7 12593.9 12595.2 12807.8 12990.4 12996.9 12473.4 12671.7 12694.3 12844.0 12954.1 11:59:05 INFO - PID 3973 | -------- Summary: end -------- 11:59:05 INFO - PID 3973 | 11:59:06 INFO - TEST-INFO | 3973: exit 0 11:59:06 INFO - TEST-OK | dromaeo_css | took 1114356ms 11:59:06 INFO - TEST-START | kraken 11:59:06 INFO - Initialising browser for kraken test... 11:59:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50765/getInfo.html -profile /tmp/tmpc4Wwrz/profile 11:59:06 INFO - TEST-INFO | started process 4416 (/builds/slave/test/build/application/firefox/firefox http://localhost:50765/getInfo.html) 11:59:11 INFO - TEST-INFO | 4416: exit 0 11:59:12 INFO - Browser initialized. 11:59:12 INFO - Running cycle 1/1 for kraken test... 11:59:12 INFO - Using env: {'DISPLAY': ':0', 11:59:12 INFO - 'HOME': '/home/cltbld', 11:59:12 INFO - 'JSGC_DISABLE_POISONING': '1', 11:59:12 INFO - 'LANG': 'en_US.UTF-8', 11:59:12 INFO - 'LANGUAGE': 'en_US:en', 11:59:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:59:12 INFO - 'LOGNAME': 'cltbld', 11:59:12 INFO - 'MAIL': '/var/mail/cltbld', 11:59:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:59:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:59:12 INFO - 'MOZ_ACCELERATED': '1', 11:59:12 INFO - 'MOZ_CRASHREPORTER': '1', 11:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:59:12 INFO - 'MOZ_NO_REMOTE': '1', 11:59:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:59:12 INFO - 'MOZ_WEBRENDER': '1', 11:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:12 INFO - 'NO_EM_RESTART': '1', 11:59:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:12 INFO - 'PWD': '/builds/slave/test', 11:59:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:59:12 INFO - 'RUST_BACKTRACE': 'full', 11:59:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:59:12 INFO - 'SHELL': '/bin/bash', 11:59:12 INFO - 'SHLVL': '1', 11:59:12 INFO - 'TERM': 'linux', 11:59:12 INFO - 'TMOUT': '86400', 11:59:12 INFO - 'USER': 'cltbld', 11:59:12 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047', 11:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:12 INFO - '_': '/tools/buildbot/bin/python'} 11:59:12 INFO - TEST-INFO | started process 4698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc4Wwrz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:59:12 INFO - PID 4698 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:59:13 INFO - PID 4698 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:59:13 INFO - PID 4698 | 11:59:13 INFO - PID 4698 | (/builds/slave/test/build/application/firefox/firefox:4759): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:59:13 INFO - PID 4698 | 11:59:23 INFO - PID 4698 | RSS: Main: 195284992 11:59:23 INFO - PID 4698 | 11:59:26 INFO - PID 4698 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50765/tests/kraken/driver.html?testName=audio-beat-detection) 11:59:27 INFO - PID 4698 | RSS: Main: 191574016 11:59:27 INFO - PID 4698 | 11:59:29 INFO - PID 4698 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50765/tests/kraken/driver.html?testName=audio-dft) 11:59:30 INFO - PID 4698 | RSS: Main: 192126976 11:59:30 INFO - PID 4698 | 11:59:33 INFO - PID 4698 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50765/tests/kraken/driver.html?testName=audio-fft) 11:59:34 INFO - PID 4698 | RSS: Main: 188850176 11:59:34 INFO - PID 4698 | 11:59:36 INFO - PID 4698 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50765/tests/kraken/driver.html?testName=audio-oscillator) 11:59:36 INFO - PID 4698 | RSS: Main: 188813312 11:59:36 INFO - PID 4698 | 11:59:39 INFO - PID 4698 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50765/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:59:39 INFO - PID 4698 | RSS: Main: 190021632 11:59:39 INFO - PID 4698 | 11:59:43 INFO - PID 4698 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50765/tests/kraken/driver.html?testName=imaging-darkroom) 11:59:43 INFO - PID 4698 | RSS: Main: 192172032 11:59:43 INFO - PID 4698 | 11:59:47 INFO - PID 4698 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50765/tests/kraken/driver.html?testName=imaging-desaturate) 11:59:47 INFO - PID 4698 | RSS: Main: 192307200 11:59:47 INFO - PID 4698 | 11:59:50 INFO - PID 4698 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50765/tests/kraken/driver.html?testName=json-parse-financial) 11:59:51 INFO - PID 4698 | RSS: Main: 192139264 11:59:51 INFO - PID 4698 | 11:59:53 INFO - PID 4698 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50765/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:59:53 INFO - PID 4698 | RSS: Main: 191729664 11:59:53 INFO - PID 4698 | 11:59:55 INFO - PID 4698 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:59:56 INFO - PID 4698 | RSS: Main: 189341696 11:59:56 INFO - PID 4698 | 11:59:58 INFO - PID 4698 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:59:59 INFO - PID 4698 | RSS: Main: 189550592 11:59:59 INFO - PID 4698 | 12:00:01 INFO - PID 4698 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:00:02 INFO - PID 4698 | RSS: Main: 189612032 12:00:02 INFO - PID 4698 | 12:00:05 INFO - PID 4698 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:00:05 INFO - PID 4698 | RSS: Main: 190087168 12:00:05 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50765/tests/kraken/driver.html?testName=ai-astar) 12:00:07 INFO - PID 4698 | RSS: Main: 190918656 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | __start_tp_report 12:00:07 INFO - PID 4698 | _x_x_mozilla_page_load 12:00:07 INFO - PID 4698 | _x_x_mozilla_page_load_details 12:00:07 INFO - PID 4698 | |i|pagename|runs| 12:00:07 INFO - PID 4698 | |0;ai-astar;115;111;109;109;111;110;112;115;110;106 12:00:07 INFO - PID 4698 | |1;audio-beat-detection;122;123;140;123;125;122;119;120;120;119 12:00:07 INFO - PID 4698 | |2;audio-dft;162;164;163;165;162;166;164;174;171;163 12:00:07 INFO - PID 4698 | |3;audio-fft;75;79;73;80;76;80;80;74;80;80 12:00:07 INFO - PID 4698 | |4;audio-oscillator;79;80;83;81;79;82;86;84;85;84 12:00:07 INFO - PID 4698 | |5;imaging-gaussian-blur;121;122;123;114;122;111;115;114;115;114 12:00:07 INFO - PID 4698 | |6;imaging-darkroom;149;153;153;154;158;152;159;149;154;149 12:00:07 INFO - PID 4698 | |7;imaging-desaturate;95;97;94;100;94;94;99;94;96;95 12:00:07 INFO - PID 4698 | |8;json-parse-financial;50;51;59;51;54;53;65;52;50;49 12:00:07 INFO - PID 4698 | |9;json-stringify-tinderbox;43;44;37;46;43;45;48;39;45;42 12:00:07 INFO - PID 4698 | |10;stanford-crypto-aes;71;75;81;85;75;72;78;75;72;78 12:00:07 INFO - PID 4698 | |11;stanford-crypto-ccm;120;114;122;114;109;107;111;120;110;125 12:00:07 INFO - PID 4698 | |12;stanford-crypto-pbkdf2;172;179;176;162;176;165;160;165;171;162 12:00:07 INFO - PID 4698 | |13;stanford-crypto-sha256-iterative;73;62;71;65;64;65;67;65;65;67 12:00:07 INFO - PID 4698 | __end_tp_report 12:00:07 INFO - PID 4698 | __start_cc_report 12:00:07 INFO - PID 4698 | _x_x_mozilla_cycle_collect,734 12:00:07 INFO - PID 4698 | __end_cc_report 12:00:07 INFO - PID 4698 | __startTimestamp1507143607813__endTimestamp 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | ------- Summary: start ------- 12:00:07 INFO - PID 4698 | Number of tests: 14 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.74 (2.5%) stddev-sans-first:2.45 12:00:07 INFO - PID 4698 | Values: 115.0 111.0 109.0 109.0 111.0 110.0 112.0 115.0 110.0 106.0 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | [#1] audio-beat-detection Cycles:10 Average:123.30 Median:122.50 stddev:6.18 (5.0%) stddev-sans-first:6.54 12:00:07 INFO - PID 4698 | Values: 122.0 123.0 140.0 123.0 125.0 122.0 119.0 120.0 120.0 119.0 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.50 stddev:4.01 (2.4%) stddev-sans-first:4.06 12:00:07 INFO - PID 4698 | Values: 162.0 164.0 163.0 165.0 162.0 166.0 164.0 174.0 171.0 163.0 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | [#3] audio-fft Cycles:10 Average:77.70 Median:80.00 stddev:2.87 (3.6%) stddev-sans-first:2.87 12:00:07 INFO - PID 4698 | Values: 75.0 79.0 73.0 80.0 76.0 80.0 80.0 74.0 80.0 80.0 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | [#4] audio-oscillator Cycles:10 Average:82.30 Median:83.50 stddev:2.50 (3.0%) stddev-sans-first:2.35 12:00:07 INFO - PID 4698 | Values: 79.0 80.0 83.0 81.0 79.0 82.0 86.0 84.0 85.0 84.0 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:118.00 stddev:4.38 (3.7%) stddev-sans-first:4.42 12:00:07 INFO - PID 4698 | Values: 121.0 122.0 123.0 114.0 122.0 111.0 115.0 114.0 115.0 114.0 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | [#6] imaging-darkroom Cycles:10 Average:153.00 Median:153.50 stddev:3.53 (2.3%) stddev-sans-first:3.43 12:00:07 INFO - PID 4698 | Values: 149.0 153.0 153.0 154.0 158.0 152.0 159.0 149.0 154.0 149.0 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:2.20 (2.3%) stddev-sans-first:2.32 12:00:07 INFO - PID 4698 | Values: 95.0 97.0 94.0 100.0 94.0 94.0 99.0 94.0 96.0 95.0 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:52.50 stddev:4.97 (9.5%) stddev-sans-first:5.12 12:00:07 INFO - PID 4698 | Values: 50.0 51.0 59.0 51.0 54.0 53.0 65.0 52.0 50.0 49.0 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | [#9] json-stringify-tinderbox Cycles:10 Average:43.20 Median:44.50 stddev:3.26 (7.3%) stddev-sans-first:3.46 12:00:07 INFO - PID 4698 | Values: 43.0 44.0 37.0 46.0 43.0 45.0 48.0 39.0 45.0 42.0 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.50 stddev:4.39 (5.7%) stddev-sans-first:4.24 12:00:07 INFO - PID 4698 | Values: 71.0 75.0 81.0 85.0 75.0 72.0 78.0 75.0 72.0 78.0 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | [#11] stanford-crypto-ccm Cycles:10 Average:115.20 Median:117.00 stddev:6.16 (5.3%) stddev-sans-first:6.28 12:00:07 INFO - PID 4698 | Values: 120.0 114.0 122.0 114.0 109.0 107.0 111.0 120.0 110.0 125.0 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:171.50 stddev:6.84 (4.0%) stddev-sans-first:7.16 12:00:07 INFO - PID 4698 | Values: 172.0 179.0 176.0 162.0 176.0 165.0 160.0 165.0 171.0 162.0 12:00:07 INFO - PID 4698 | 12:00:07 INFO - PID 4698 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:3.31 (5.0%) stddev-sans-first:2.50 12:00:07 INFO - PID 4698 | Values: 73.0 62.0 71.0 65.0 64.0 65.0 67.0 65.0 65.0 67.0 12:00:07 INFO - PID 4698 | -------- Summary: end -------- 12:00:07 INFO - PID 4698 | 12:00:08 INFO - PID 4698 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:00:08 INFO - TEST-INFO | 4698: exit 0 12:00:08 INFO - TEST-OK | kraken | took 62588ms 12:00:08 INFO - SUITE-END | took 1176s 12:00:08 INFO - Completed test suite (00:19:37) 12:00:08 INFO - javascript benchmark 12:00:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8620.071170991841, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.0420869530444, 3128.85920133594, 3135.858886350114, 3139.419207446621, 3154.6372167200752, 6118.96940515298, 6264.091706702526, 6275.592086514379, 6339.6830158492, 6417.06952491889, 6196.566240363177, 6232.937670623292, 6258.718357673904, 6405.19935008124, 6434.227892652888, 5692.943070569283, 5810.506106980912, 5824.039033559478, 5833.270841144857, 5885.7939972100985, 111.67809702773103, 5356.625036247464, 5637.379888212294, 5841.824745257649, 5843.328017278025, 5637.577181711388, 5698.715064246791, 5706.28671416073, 5718.285214348207, 5800.7679692812235, 5792.913106303409, 5856.472917437409, 5861.648301101947, 5870.706464676792, 5886.234789477383, 5738.512226460714, 5766.0197766379815, 5851.824445266649, 5855.677937713424, 5855.853603659943, 6220.066989951498, 6226.190595222637, 6243.750249989995, 6244.281907580641, 6367.904481432736, 6702.296258892795, 6715.764948226789, 6793.796186114425, 6804.65976701163, 6813.897791533131, 6749.831254218635, 6783.694733736994, 6881.243063263037, 6920.411764999981, 6939.444844412435, 6281.560290779647, 6298.307186209513, 6303.684815759239, 6373.649449280288, 6380.7128679209545, 6843.520953533304, 6887.380135787703, 6909.689063992132, 6922.965385173042, 7073.92926070743, 6493.31820158886, 6564.442022428051, 6580.5722628029025, 6593.208814942238, 6606.504512161607, 6642.169728783902, 6694.0, 6812.182538095461, 6847.349501797321, 6862.245153033163, 6656.034874943203, 6788.660566971632, 6814.420774234147, 6826.522143449911, 6833.0, 6731.932680673229, 6781.491388145909, 6816.591004539743, 6826.385625293748, 6909.619970901548, 5218.608604354688, 5219.765110570033, 5275.393329767126, 5311.176767601028, 5318.335208098988, 4617.538246175355, 4625.676202665781, 4644.605208557243, 4695.530446955346, 4749.691270067435, 5811.215485909348, 5862.677552734641, 5890.057590785454, 5893.911591326134, 5895.587308888336, 6739.0, 6788.422984046312, 6811.182658081062, 6832.180138383326, 6890.345417185359, 5670.5180059695385, 5756.625819321731, 5777.537796976232, 5840.8247752567495, 5879.617824841372, 5768.307803063659, 5798.565107616945, 5822.301323841081, 5860.765569377178, 5871.94128058714, 6530.444912182517, 6547.836304092436, 6548.70530826114, 6550.967245163839, 6564.835879102965, 6792.490563207681, 6816.693248803816, 6851.07510486088, 6868.381845633917, 6882.346177113166, 6472.126262954441, 6479.870402591828, 6555.2789193187755, 6559.245686746085, 6583.078369028244, 6503.739850405931, 6560.9343906562235, 6619.768308109193, 6734.8653026940165, 6785.93214067853, 6680.5991640501725, 6681.2650608434005, 6758.86482270342, 6763.154605674291, 6774.661266936535, 6497.31778163305, 6524.543281970216, 6556.8360790980605, 6610.140681711539, 6614.107095542233, 6565.409113179837, 6662.333766623299, 6676.198856137295, 6681.933180668131, 6690.665466726741, 6487.351264873475, 6522.184726909137, 6545.21457425112, 6583.80248592543, 6621.5364924454825, 6438.130852334875, 6595.8021259362295, 6599.8020059398295, 6615.966920165561, 6732.764353247613, 6177.135201071944, 6202.038684003986, 6242.438180563771, 6248.156498872594, 6260.373962603885], "value": 6105.825600320088, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [866.1987661413199, 869.5174178331026, 879.6349514951296, 884.5577211394303, 891.140049851893, 41720.58279417205, 42480.57519424805, 42511.0, 42762.786186069025, 42851.14297714044, 38075.42886856692, 38639.613603864025, 38725.41911871317, 38999.0, 39074.0, 7160.96419517903, 7310.853782924339, 7332.1934587195365, 7337.523061001045, 7339.229380915007, 7152.570845749246, 7199.784006479814, 7203.0, 7235.746748863791, 7245.855082898365, 7128.287171282856, 7213.963930180368, 7901.48640338379, 8089.919100808976, 8134.389920755967, 7935.603219838985, 8063.0, 8152.510849349058, 8152.714654987047, 8153.143919888385, 7980.321672657831, 7981.3614910807, 8067.596620168968, 8090.635921383552, 8093.109757926623, 38066.619333806586, 38545.421818672745, 38843.61156388428, 38884.611153888385, 38902.22195556101, 3571.8035508047046, 3579.6957258633047, 3582.22982058856, 3596.62235465275, 3647.854085836563, 31621.367572648647, 31993.52009719856, 32022.35955280881, 32028.839855800572, 32122.839385802923, 4993.475685053054, 5136.897262054776, 5153.458886816868, 5164.509371609691, 5194.844154675366, 182161.0, 182553.99999999866, 182754.0, 184192.0, 184666.0, 42250.36624450636, 42808.0, 48031.27953080706, 50221.24668129981, 51615.225771613455, 53101.0, 53153.0, 53239.46760532345, 53313.0, 53436.46563534393, 13994.0, 14042.719145617235, 14139.717205655828, 14150.85849141516, 16026.519204423887, 11198.496067676973, 11274.210805243718, 11274.887251127384, 11277.379744113989, 11300.54797808095, 13708.0, 13809.240491772847, 13811.861881381259, 13857.584272471842, 14003.439862405594, 5521.503064724194, 5661.490465858093, 5708.942910570924, 5745.454181852718, 5789.218455508537, 993.821112199811, 1004.4324956399611, 1020.739711373595, 1035.9896401035894, 1041.4948749856314, 23811.523769524512, 23991.040358385817, 24110.276691699277, 24146.154884578955, 24317.0, 1119.4179026905963, 1134.4967917509334, 1146.1232157399595, 1148.0930065248526, 1148.91427600918, 12626.408552441462, 12764.744705106032, 12781.360931953364, 12796.744065118646, 12917.0, 241219.0, 242535.0, 243362.0, 245012.0, 245177.0, 53708.0, 53723.19415208775, 53851.46148538543, 53921.460785391646, 53954.19068713972, 1401.4324198699544, 1465.0843222985634, 1475.2918599072505, 1479.615300022002, 1481.4222453243028, 23347.766522334558, 23400.531989360457, 23493.53012939766, 23726.288211353687, 23811.523769524858, 34299.82850085734, 34419.0, 38368.2326353477, 38721.22557548777, 38858.0, 196105.0, 196745.0, 196789.0, 197159.0, 197294.0, 34332.82833585916, 34551.136221594665, 34664.65335346614, 34787.30425391529, 34816.47775283322, 41153.38269925894, 43353.0, 43869.78065109654, 43926.12147757091, 43988.78005609952, 31258.843705781324, 31551.684483154873, 31748.523772143897, 31759.84120079385, 31799.841000794848, 31142.532862006636, 31279.53080703837, 31820.68179318177, 31834.36331273408, 31956.52065218977, 36079.63920360763, 36202.27595448129, 36230.27539449249, 36472.27055458929, 36506.45240321344, 30746.846265768527, 30956.0, 31171.688283117786, 31282.68717312889, 31470.37059258848, 23067.538649226586, 23846.403839904142, 24082.277531674077, 24305.576349172996, 24495.75504245006], "value": 17096.491286936518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.2023827356522, 584.9298084229893, 590.7784580782206, 602.3614968133777, 628.8270725550473, 21671.891640541795, 22120.336389908287, 22319.665205021898, 22434.3269701909, 22513.0, 22851.885740571273, 24178.395540111505, 24280.0, 24306.75693243067, 24326.0, 6490.383413575714, 6603.042558828967, 6636.170478690164, 6648.335166483362, 6648.867022659544, 6502.2197336319705, 6612.537122401433, 6613.603183808963, 6615.636140012298, 6624.1719785026635, 6176.351483094255, 6495.610263384188, 6513.446357059655, 6514.739410423577, 6516.771912983047, 6445.742170313182, 6514.77198298062, 6521.510886683518, 6530.869382612321, 6533.314002029813, 5910.940890591125, 6022.8494287642725, 6076.908846367308, 6118.174046503754, 6167.691615419211, 27370.863145684343, 28186.15441536757, 28235.29411764702, 28370.29074273139, 28372.858135709397, 2082.541840795023, 2083.2396175396025, 2119.6502577074766, 2121.1727426303755, 2122.7028216049766, 18463.630727385378, 19418.41744747646, 19675.508112297164, 19700.211991520322, 19705.408837734893, 2413.722421921484, 2470.3700556358012, 2502.7121880983736, 2519.685039370079, 2525.9242222733346, 113950.43024784906, 118777.0, 141351.0, 141510.0, 145313.2734336332, 18626.627467450577, 21208.469788255417, 21248.25631102904, 21438.892805536183, 21693.783062169492, 42269.36595951063, 42285.0, 42331.576684233376, 42361.15277694429, 42594.935126621465, 11705.414729263503, 11757.353345565905, 11783.823242651368, 11863.940680296544, 12026.4588093536, 9858.80282394348, 9944.552495137736, 9989.100980911753, 9998.850017249748, 10114.898851011396, 10988.175886808522, 11026.0, 11155.107591392669, 11220.27068240578, 11654.88345116555, 3771.981140094282, 4167.770772607475, 4345.891352716208, 4429.269170586882, 4491.236489796743, 951.4861974533675, 972.0231167676582, 979.7109852593502, 980.9362391444533, 986.4328011393477, 18713.251469941322, 18775.624487510173, 18847.53602384479, 19160.808391915903, 19246.518837028907, 1036.8600238967642, 1037.4605205293205, 1041.807265655856, 1048.6382198141782, 1053.2364036073939, 10184.388936663823, 10332.638357657595, 10367.688969330931, 10476.547467326509, 10653.78692426147, 458567.0, 468980.0, 479310.0, 480158.0, 482784.0, 119184.0, 119576.0, 119663.0, 119800.40099799445, 119836.0, 1011.1556850030307, 1119.8824123467082, 1157.4907040901976, 1180.1620849196995, 1186.6618013866007, 19373.0, 19511.21955121836, 19708.113134908675, 19913.701294480306, 19975.101120449322, 55928.88142237214, 57746.133807992075, 58622.41377586169, 58633.82732345415, 59534.0, 73929.6303518479, 74333.628331858, 75123.62438187774, 75813.0, 76046.61976690081, 18796.436106916815, 19548.120334585263, 19549.022548872214, 19580.314688985818, 19713.310034148737, 21310.254141104986, 21357.89321053447, 21864.250859931486, 21903.67144492802, 21952.0, 16561.751573726164, 17455.214515346586, 17568.56078598045, 17619.647607048042, 17636.20637071309, 15316.0, 15733.685326293638, 15808.841911580737, 15900.443484477988, 16350.918245409173, 17751.64496710033, 17999.280028799225, 18059.097045147428, 18174.36389726353, 18295.17671704803, 18956.336528221447, 18972.335968241045, 18984.620307594047, 19054.618907622047, 19107.331243406414, 17354.219060142575, 17531.912340438215, 17550.473485795446, 17599.0, 17676.558086047437], "value": 12675.948175528765, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.6110858405352, 1413.5264686330086, 1413.9505117320896, 1420.2898550724638, 1431.756601377766, 15305.693886122272, 15888.126153061577, 15904.125273109974, 15971.361145554178, 16016.439424620141, 15721.528354149365, 15856.0, 15865.762013569776, 15866.603334916634, 15876.761848572281, 2719.864006799662, 2839.9006034788786, 2840.61651677023, 2841.076650088719, 2847.288177955511, 2805.6633204015443, 2820.2667306500357, 2830.4339132173545, 2840.730130637586, 2855.585940038693, 2671.2921075914896, 2761.765249953756, 2761.8619069046567, 2766.0180635874276, 2768.958465623017, 2686.194141757475, 2696.5820297853766, 2712.186344096773, 2715.9049433269743, 2717.021872126033, 2667.8265912715806, 2674.8261363011343, 2685.78513718902, 2693.299742067057, 2701.1761412769097, 14741.262936853114, 14930.552083437515, 15016.699666006618, 15153.318100685385, 15264.847351526454, 7915.406344524184, 8200.384971127189, 8255.0, 8261.463004904663, 8268.338532917352, 5138.306328645623, 5330.92003619946, 5487.341519017744, 5600.803971861006, 5603.103503439471, 1896.4026331705468, 1906.65680177568, 1940.2142132436386, 1982.3161009451717, 1985.1662301833264, 24373.63439548408, 25216.747832521807, 27157.185284441497, 27955.72044279531, 27976.160715178576, 7193.529303564952, 7205.531640443354, 7230.891536626955, 7356.080489938758, 7421.591812450367, 20061.49846253826, 20061.498462538555, 20075.899620501805, 20123.390128789662, 20204.29284975019, 8263.297619702393, 8279.751607451786, 8333.374996875258, 8338.332933365316, 8338.583070846433, 7207.387372073433, 7302.963485182647, 7656.425768067417, 7666.808329791688, 7687.730929417444, 5566.276384070045, 5832.62087964281, 5873.119032145212, 5874.618149820248, 5946.70266486674, 1775.4407361681028, 1838.9150401263319, 1841.6500864835639, 1856.832885040353, 1868.4394681595468, 842.8988521377474, 843.7721815110009, 853.8164294676675, 862.2369203255164, 869.8999615044224, 7650.273224043707, 7766.145723970359, 7858.803529911684, 7952.443328966917, 7960.522368657899, 730.3718801830422, 733.0946281342538, 736.3961551527802, 745.3068646159015, 748.5097261293861, 4360.890977725582, 4393.758343291086, 4407.184670835905, 4438.400815889878, 4455.465344158722, 21138.471538211666, 21885.781142188374, 22169.667454988186, 22218.222362217246, 22805.429864253194, 21338.0, 22276.443088922908, 22277.777222227895, 22363.55272894533, 22723.659145112506, 8811.559422028873, 10015.849762253718, 10031.347962382422, 10962.835557466644, 11250.887491125148, 8332.416730828783, 8355.206255405727, 8492.532910689972, 8530.019047809581, 8563.443376180778, 18943.621127577648, 19590.90204548968, 19743.308984185485, 19767.50581235423, 19814.60370792547, 19696.704549432056, 19762.20951161995, 20328.695069573674, 20512.07695653729, 20606.484837879172, 11832.230904991147, 11945.641630751092, 11989.940050299692, 12038.0, 12088.456019479321, 13627.386767595284, 13692.794608080687, 13812.861871381157, 13816.101953372998, 13828.516001939885, 11578.826317605075, 11695.771943945763, 11721.0, 11795.233309834834, 11921.940390297994, 10650.8934910653, 10745.247832651952, 10791.352518848895, 10948.781024379627, 11078.390688512209, 10000.549975250986, 10146.985301469795, 10262.846057309296, 10266.0, 10304.124149447382, 6336.841578960379, 6451.741930322734, 6495.0582165586675, 6575.769848055295, 6595.967020164869, 6683.498737594603, 6756.831079222862, 6769.4922880785125, 6897.89653155193, 6914.965425172842], "value": 6732.043974190151, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.33223480536077, 507.7613521644827, 525.61104782461, 527.2565682387833, 538.6471860931089, 6099.7865074722395, 6292.46514046306, 6296.842578935529, 6347.714352854121, 6352.015437607172, 6107.7556897724035, 6115.571909966304, 6151.063319475539, 6201.813945581628, 6211.720472578733, 4873.122837889178, 4950.257461380804, 4959.578435832958, 4984.725840078794, 5017.544911975523, 4882.48642920694, 4956.653034287601, 5047.545720885119, 5049.646524743251, 5052.292679024939, 4953.405591329046, 4986.775595098211, 5004.499550044985, 5009.849704508871, 5010.974945125269, 4873.195922672755, 4879.731614761205, 4899.608031357483, 4926.75366231687, 4991.226359914219, 4333.76810942365, 4382.561743825624, 4390.890227744332, 4418.630224630375, 4482.484514280867, 6013.6692481913915, 6053.152558641794, 6084.939150608481, 6090.756369745205, 6094.312940670919, 5616.157576363537, 5656.321241451011, 5662.575306851962, 5673.8297851064535, 5675.716214189274, 6472.190976127984, 6570.671466426659, 6572.638504882229, 6592.912169492028, 6602.580445204256, 4702.882427939329, 4786.253017648533, 4790.233562629997, 4792.185328494164, 4825.0, 6749.831254218684, 6841.247462779091, 6844.691988860513, 6897.172339319314, 6921.861562768717, 4983.277424773388, 5014.6991180529285, 5040.243963405518, 5055.443901170868, 5066.138756411346, 5062.493750624908, 5069.138246498031, 5075.949240507622, 5085.516875896784, 5141.562967147835, 5719.5138413235345, 5732.971335143381, 5745.253117094751, 5756.395578464201, 5782.971085144547, 6582.41258514111, 6655.367740064686, 6673.699683514254, 6697.263301036882, 6751.527393082437, 1629.771831943505, 1707.9316827327016, 1721.4233231867465, 1738.75657407963, 1777.4134535603478, 1112.8386383974278, 1172.3200543684643, 1179.1981452612306, 1183.8398369597842, 1194.3371428856894, 5487.363178114487, 5492.945070549324, 5666.178404131378, 5694.914576281359, 5734.483896449339, 6341.54627020771, 6376.521760867953, 6404.423601875854, 6421.486281097501, 6472.288048314682, 5493.478119578714, 5638.915416268759, 5650.802221922213, 5704.714764261853, 5729.226554415184, 3509.771864828778, 3557.6442355764216, 3562.1628917204434, 3592.892213233607, 3593.3711600469815, 6289.452771627498, 6295.464885484785, 6453.386928241809, 6475.740970361227, 6476.805695829133, 6847.794566163023, 6902.585844849325, 6916.896246556305, 6928.792136235921, 6935.6878940447805, 6335.239771227482, 6406.935930640727, 6447.097406363019, 6494.6103233806125, 6501.707423165874, 6583.901241481286, 6660.433863121495, 6672.499562532732, 6727.360900714424, 6758.2903795102775, 6651.800445986628, 6653.600783952978, 6653.866922661617, 6725.226598941184, 6785.830354241183, 6527.5430719849155, 6569.4744420447205, 6576.210854697467, 6592.90110648331, 6602.151397608677, 4892.608591312615, 4947.529984651596, 4972.154733695208, 4978.30303757467, 5013.974930125326, 6554.377334153248, 6601.867962640624, 6658.533902626769, 6658.803774188514, 6724.4284235840505, 6226.742124165185, 6304.5271604628915, 6379.330170332234, 6396.520260980352, 6433.903491447726, 6313.042956683443, 6349.555531112963, 6390.616563006234, 6471.25580558223, 6480.157579514633, 6114.6636934969, 6341.302456729663, 6445.25879523842, 6477.611343319416, 6492.448141907991, 6245.843853903507, 6408.1349017881985, 6492.798832215866, 6507.544471887112, 6514.250861151028, 6257.311695713559, 6291.96854015727, 6304.959681652476, 6348.5238607105575, 6387.808365749035], "value": 5016.4246339633655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.3157600223828, 906.8322360363337, 915.9404638698484, 922.7231830450863, 928.6053427293401, 18482.26070957162, 19493.317733879318, 19747.901260493676, 19769.99999999998, 19832.70250946237, 17857.732134017966, 17931.91034044831, 17996.820031799678, 18056.27774889006, 18167.273309067656, 963.036963036963, 979.211734553684, 984.3847595252967, 984.7488890332991, 984.9606015759362, 994.9701508954743, 1000.7248006798152, 1002.8295189817749, 1003.0571263012781, 1003.7741508160642, 1002.8997100289986, 1023.4115383654391, 1036.2228328753436, 1040.7138037039838, 1047.1831971062545, 999.2655398282257, 1002.904724051214, 1007.3603261928655, 1009.8636684047633, 1013.1337706261152, 739.9408047356198, 744.5011842065829, 746.5520687587458, 748.8015675845851, 749.741339237962, 19554.413367598994, 19649.9017504913, 19717.605647887107, 19767.11048002829, 19838.801611983985, 21022.159113635436, 21375.358739237847, 22004.0, 22188.88905555478, 22193.556128877495, 17626.559336016573, 18031.459056228334, 18085.547861303443, 18120.63758724831, 18316.17577209029, 3675.4486826976167, 3676.8161591920566, 3699.815009249554, 3705.7591256568508, 3726.981365093184, 108381.0, 150117.24941375334, 150658.0, 154333.0, 154676.22661886617, 14413.639659008399, 14653.12081275127, 14711.117332960057, 14780.48268310604, 14848.554543363716, 32210.19474513156, 33068.1732956678, 33130.66869331324, 33150.502742458884, 33172.834135829646, 9451.196648284835, 9541.379810312308, 9616.615335386647, 9636.951815240878, 9661.082197191256, 4564.292534657134, 4624.583787459145, 4630.444346678353, 4647.814087436533, 4664.860054198311, 5506.174073888868, 5588.804391846347, 5611.915821262684, 5674.177244299553, 5696.857578560486, 1102.4653043274006, 1105.4141305108144, 1131.3607811586428, 1138.869030061537, 1143.2454579977175, 676.3912478769147, 681.7375310505491, 690.4200471603876, 702.940250078749, 703.2264509040117, 11627.709307267216, 11772.646820595395, 12039.939800300943, 12179.817302740466, 12448.128630995925, 640.8846407646575, 651.3616655677463, 659.3472462262422, 666.2604508995012, 668.7692746002622, 5422.75597598109, 5444.782208711607, 5514.972425137928, 5562.499375056264, 5620.241267428844, 126076.36961815132, 126535.0, 127308.0, 130644.3467782674, 131453.0, 112415.4379228115, 118431.40784296195, 122497.0, 122605.0, 122668.38665806614, 100718.4964075175, 103290.0, 104763.0, 106314.46842765891, 106781.0, 10329.483525823829, 10532.736681583021, 10541.156707463231, 10569.154467642416, 10724.356538607708, 47311.29033064576, 48245.5175448241, 48936.0, 49357.25964110613, 50240.246396304814, 60982.69508652428, 63173.0, 63488.68255658692, 63587.0, 64047.03929440969, 16095.67808643844, 16156.919215403848, 16342.836571634132, 16382.344706211617, 16533.91733041327, 18229.726554101966, 18435.26258949627, 18560.164792584637, 18673.626527469103, 18899.527511811764, 15554.300056497259, 15753.448629298378, 15828.12945287974, 16041.0, 16058.8394116062, 15912.52262432129, 16181.514554563382, 16234.350625974828, 16239.43161989372, 16433.506994790176, 16906.32374704998, 16962.66074678524, 17004.404845830337, 17084.316627335265, 17344.739828902326, 12593.93703031479, 12595.24428534291, 12807.80788288195, 12990.415431305802, 12996.935015324863, 12473.438695258918, 12671.683207919876, 12694.301813400352, 12843.972482201589, 12954.093213474966], "value": 9180.474879787147, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1448.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 109.0, 109.0, 111.0, 110.0, 112.0, 115.0, 110.0, 106.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 123.0, 140.0, 123.0, 125.0, 122.0, 119.0, 120.0, 120.0, 119.0], "value": 123.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 165.0, 162.0, 166.0, 164.0, 174.0, 171.0, 163.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 73.0, 80.0, 76.0, 80.0, 80.0, 74.0, 80.0, 80.0], "value": 77.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 83.0, 81.0, 79.0, 82.0, 86.0, 84.0, 85.0, 84.0], "value": 82.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 123.0, 114.0, 122.0, 111.0, 115.0, 114.0, 115.0, 114.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 153.0, 153.0, 154.0, 158.0, 152.0, 159.0, 149.0, 154.0, 149.0], "value": 153.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 94.0, 100.0, 94.0, 94.0, 99.0, 94.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 59.0, 51.0, 54.0, 53.0, 65.0, 52.0, 50.0, 49.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 44.0, 37.0, 46.0, 43.0, 45.0, 48.0, 39.0, 45.0, 42.0], "value": 43.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 81.0, 85.0, 75.0, 72.0, 78.0, 75.0, 72.0, 78.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 114.0, 122.0, 114.0, 109.0, 107.0, 111.0, 120.0, 110.0, 125.0], "value": 115.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 179.0, 176.0, 162.0, 176.0, 165.0, 160.0, 165.0, 171.0, 162.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 62.0, 71.0, 65.0, 64.0, 65.0, 67.0, 65.0, 65.0, 67.0], "value": 66.4, "unit": "score"}]}]} 12:00:09 INFO - Return code: 0 12:00:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:00:09 INFO - # TBPL SUCCESS # 12:00:09 INFO - Running post-action listener: _package_coverage_data 12:00:09 INFO - Running post-action listener: _resource_record_post_action 12:00:09 INFO - [mozharness: 2017-10-04 19:00:09.111932Z] Finished run-tests step (success) 12:00:09 INFO - Running post-run listener: _resource_record_post_run 12:00:09 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 15962112; Write bytes: 485224448; Read time: 5700; Write time: 369852 12:00:09 INFO - TinderboxPrint: CPU usage
13.2% 12:00:09 INFO - TinderboxPrint: I/O read bytes / time
15,962,112 / 5,700 12:00:09 INFO - TinderboxPrint: I/O write bytes / time
485,224,448 / 369,852 12:00:09 INFO - TinderboxPrint: CPU idle
8,266.5 (86.7%) 12:00:09 INFO - TinderboxPrint: CPU user
1,198.2 (12.6%) 12:00:09 INFO - TinderboxPrint: Swap in / out
0 / 0 12:00:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 84254720; Read time: 160; Write time: 34924 12:00:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:00:09 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 13807616; Write bytes: 313061376; Read time: 5108; Write time: 259696 12:00:09 INFO - Running post-run listener: _upload_blobber_files 12:00:09 INFO - Blob upload gear active. 12:00:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:00:09 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 12:00:09 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'] 12:00:09 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 12:00:10 INFO - (blobuploader) - INFO - Open directory for files ... 12:00:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:00:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:00:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:13 INFO - (blobuploader) - INFO - Done attempting. 12:00:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:00:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:14 INFO - (blobuploader) - INFO - Done attempting. 12:00:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:00:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:00:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:16 INFO - (blobuploader) - INFO - Done attempting. 12:00:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:00:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:00:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:18 INFO - (blobuploader) - INFO - Done attempting. 12:00:18 INFO - (blobuploader) - INFO - Iteration through files over. 12:00:18 INFO - Return code: 0 12:00:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:00:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:00:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fa8ae85132f4f15b14ab6e047acb3aeb696c7b6716397dc02933be9f48d48f005f54de9762852a008363724659481e4f60b2c0bda04aab95d51f9941aca931a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/841f5ee30fd2e33e2bebf854d2534b62c616234478c950f7d9ce45d2496280dabe993db6ad16fc1aa29ace5fbd1f4e9a01defee918cd1886adcdb8da8a88892e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c09ee53bbff1ab5919fe09c8c808b804a510822ed1440ce82aec30035e93649a59738a5cbfaf2b15c38c1aa07bb5663cc620a9e2a0d03df59539a97e1e4feb60", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8350e6fc8f2224ff64cc8310cc9ed17d65a8853532bcc607c3c89102cb5ade4a10fcc19c6a5159537301a3a5396039e75773709d515420e59c55cdae4eb85c1"} 12:00:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:00:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:00:18 INFO - Contents: 12:00:18 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fa8ae85132f4f15b14ab6e047acb3aeb696c7b6716397dc02933be9f48d48f005f54de9762852a008363724659481e4f60b2c0bda04aab95d51f9941aca931a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/841f5ee30fd2e33e2bebf854d2534b62c616234478c950f7d9ce45d2496280dabe993db6ad16fc1aa29ace5fbd1f4e9a01defee918cd1886adcdb8da8a88892e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c09ee53bbff1ab5919fe09c8c808b804a510822ed1440ce82aec30035e93649a59738a5cbfaf2b15c38c1aa07bb5663cc620a9e2a0d03df59539a97e1e4feb60", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8350e6fc8f2224ff64cc8310cc9ed17d65a8853532bcc607c3c89102cb5ade4a10fcc19c6a5159537301a3a5396039e75773709d515420e59c55cdae4eb85c1"} 12:00:18 INFO - Running post-run listener: copy_logs_to_upload_dir 12:00:18 INFO - Copying logs to upload dir... 12:00:18 INFO - mkdir: /builds/slave/test/build/upload/logs 12:00:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.388156 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-10-04 12:00:18.321516) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 12:00:18.332198) ========= 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=438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047 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/4fa8ae85132f4f15b14ab6e047acb3aeb696c7b6716397dc02933be9f48d48f005f54de9762852a008363724659481e4f60b2c0bda04aab95d51f9941aca931a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/841f5ee30fd2e33e2bebf854d2534b62c616234478c950f7d9ce45d2496280dabe993db6ad16fc1aa29ace5fbd1f4e9a01defee918cd1886adcdb8da8a88892e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c09ee53bbff1ab5919fe09c8c808b804a510822ed1440ce82aec30035e93649a59738a5cbfaf2b15c38c1aa07bb5663cc620a9e2a0d03df59539a97e1e4feb60", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8350e6fc8f2224ff64cc8310cc9ed17d65a8853532bcc607c3c89102cb5ade4a10fcc19c6a5159537301a3a5396039e75773709d515420e59c55cdae4eb85c1"} build_url:https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011145 build_url: 'https://queue.taskcluster.net/v1/task/BavWyDaiT8KnVg76Xnu26Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fa8ae85132f4f15b14ab6e047acb3aeb696c7b6716397dc02933be9f48d48f005f54de9762852a008363724659481e4f60b2c0bda04aab95d51f9941aca931a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/841f5ee30fd2e33e2bebf854d2534b62c616234478c950f7d9ce45d2496280dabe993db6ad16fc1aa29ace5fbd1f4e9a01defee918cd1886adcdb8da8a88892e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c09ee53bbff1ab5919fe09c8c808b804a510822ed1440ce82aec30035e93649a59738a5cbfaf2b15c38c1aa07bb5663cc620a9e2a0d03df59539a97e1e4feb60", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8350e6fc8f2224ff64cc8310cc9ed17d65a8853532bcc607c3c89102cb5ade4a10fcc19c6a5159537301a3a5396039e75773709d515420e59c55cdae4eb85c1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 12:00:18.363186) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 12:00:18.363597) ========= 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=438111f3d31ce799eff2119d000001bc-1507134194.820691-1530704047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 12:00:18.445645) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 12:00:18.445973) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 12:00:18.446258) ========= ========= Total master_lag: 0.27 =========