builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-080 starttime: 1504954890.07 results: success (0) revision: e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:30.065753) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:30.066165) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:30.066453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:30.879149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:30.879458) ========= 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=781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-09 04:01:30-- 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% 91.6M=0s 2017-09-09 04:01:30 (91.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123029 ========= master_lag: 0.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:31.249681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:31.250051) ========= 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=781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018826 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:31.288280) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:31.288610) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 --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 e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 --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=781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-09 04:01:31,306 truncating revision to first 12 chars 2017-09-09 04:01:31,306 Setting DEBUG logging. 2017-09-09 04:01:31,306 attempt 1/10 2017-09-09 04:01:31,306 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e0d88cd771d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-09 04:01:31,586 unpacking tar archive at: mozilla-central-e0d88cd771d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.581830 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:32.005939) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:32.006269) ========= script_repo_revision: e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:32.006677) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:32.011051) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:32.027907) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-09 04:01:32.028282) ========= /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=781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:01:32 INFO - MultiFileLogger online at 20170909 04:01:32 in /builds/slave/test 04:01:32 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 04:01:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:01:32 INFO - {'append_to_log': False, 04:01:32 INFO - 'base_work_dir': '/builds/slave/test', 04:01:32 INFO - 'blob_upload_branch': 'Firefox', 04:01:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:01:32 INFO - 'branch': 'Firefox', 04:01:32 INFO - 'buildbot_json_path': 'buildprops.json', 04:01:32 INFO - 'code_coverage': False, 04:01:32 INFO - 'config_files': ('talos/linux_config.py',), 04:01:32 INFO - 'default_actions': ('clobber', 04:01:32 INFO - 'read-buildbot-config', 04:01:32 INFO - 'download-and-extract', 04:01:32 INFO - 'populate-webroot', 04:01:32 INFO - 'create-virtualenv', 04:01:32 INFO - 'install', 04:01:32 INFO - 'setup-mitmproxy', 04:01:32 INFO - 'run-tests'), 04:01:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:01:32 INFO - 'disable_ccov_upload': False, 04:01:32 INFO - 'disable_stylo': False, 04:01:32 INFO - 'download_minidump_stackwalk': True, 04:01:32 INFO - 'download_symbols': 'ondemand', 04:01:32 INFO - 'enable_stylo': False, 04:01:32 INFO - 'enable_webrender': False, 04:01:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:01:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:01:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:01:32 INFO - 'gecko_profile': False, 04:01:32 INFO - 'gecko_profile_interval': 0, 04:01:32 INFO - 'installer_path': 'installer.exe', 04:01:32 INFO - 'log_level': 'info', 04:01:32 INFO - 'log_name': 'talos', 04:01:32 INFO - 'log_to_console': True, 04:01:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:01:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:01:32 INFO - 'opt_config_files': (), 04:01:32 INFO - 'pip_index': False, 04:01:32 INFO - 'suite': 'dromaeojs-e10s', 04:01:32 INFO - 'system_bits': '32', 04:01:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:01:32 INFO - 'title': 'talos-linux64-ix-080', 04:01:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:01:32 INFO - 'use_talos_json': True, 04:01:32 INFO - 'verify': 'False', 04:01:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:01:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:01:32 INFO - 'work_dir': 'build'} 04:01:32 INFO - [mozharness: 2017-09-09 11:01:32.179823Z] Running clobber step. 04:01:32 INFO - Running pre-action listener: _resource_record_pre_action 04:01:32 INFO - Running main action method: clobber 04:01:32 INFO - rmtree: /builds/slave/test/build 04:01:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:01:33 INFO - Running post-action listener: _resource_record_post_action 04:01:33 INFO - [mozharness: 2017-09-09 11:01:33.710580Z] Finished clobber step (success) 04:01:33 INFO - [mozharness: 2017-09-09 11:01:33.710679Z] Running read-buildbot-config step. 04:01:33 INFO - Running pre-action listener: _resource_record_pre_action 04:01:33 INFO - Running main action method: read_buildbot_config 04:01:33 INFO - Using buildbot properties: 04:01:33 INFO - { 04:01:33 INFO - "project": "", 04:01:33 INFO - "product": "firefox", 04:01:33 INFO - "who": "archaeopteryx@coole-files.de", 04:01:33 INFO - "installer_path": "public/build/target.tar.bz2", 04:01:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:01:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:01:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 04:01:33 INFO - "stage_platform": "linux64-pgo", 04:01:33 INFO - "basedir": "/builds/slave/test", 04:01:33 INFO - "buildnumber": 145, 04:01:33 INFO - "platform": "ubuntu64_hw", 04:01:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:01:33 INFO - "slavebuilddir": "test", 04:01:33 INFO - "taskId": "FS8SBlxRQfaRKWb4GwGgCA", 04:01:33 INFO - "branch": "mozilla-central", 04:01:33 INFO - "script_repo_revision": "production", 04:01:33 INFO - "revision": "e0d88cd771d6791be4eaed4ada9315f4b26e2ad1", 04:01:33 INFO - "slavename": "talos-linux64-ix-080", 04:01:33 INFO - "repo_path": "mozilla-central" 04:01:33 INFO - } 04:01:33 INFO - Finding installer, test and symbols from parent task. 04:01:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FS8SBlxRQfaRKWb4GwGgCA'}, attempt #1 04:01:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FS8SBlxRQfaRKWb4GwGgCA'}, attempt #1 04:01:34 INFO - Task dependencies: HkGfihTsQnqFjbjqcJcq_w 04:01:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w'}, attempt #1 04:01:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2 04:01:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.test_packages.json 04:01:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.crashreporter-symbols.zip 04:01:35 INFO - Running post-action listener: _resource_record_post_action 04:01:35 INFO - [mozharness: 2017-09-09 11:01:35.063819Z] Finished read-buildbot-config step (success) 04:01:35 INFO - [mozharness: 2017-09-09 11:01:35.064128Z] Running download-and-extract step. 04:01:35 INFO - Running pre-action listener: _resource_record_pre_action 04:01:35 INFO - Running main action method: download_and_extract 04:01:35 INFO - mkdir: /builds/slave/test/build/tests 04:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:35 INFO - trying https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.test_packages.json 04:01:35 INFO - Downloading https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:01:35 INFO - Downloaded 989 bytes. 04:01:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:01:35 INFO - Using the following test package requirements: 04:01:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:01:35 INFO - u'common': [u'target.common.tests.zip'], 04:01:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:01:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:01:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:01:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:01:35 INFO - u'mozbase': [u'target.common.tests.zip'], 04:01:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:01:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:01:35 INFO - u'web-platform': [u'target.common.tests.zip', 04:01:35 INFO - u'target.web-platform.tests.tar.gz'], 04:01:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:01:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:01:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.common.tests.zip 04:01:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:01:35 INFO - Fetch https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.common.tests.zip into memory 04:01:36 INFO - Content-Length response header: 55691549 04:01:36 INFO - Bytes received: 55691549 04:01:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.talos.tests.zip 04:01:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:01:47 INFO - Fetch https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.talos.tests.zip into memory 04:01:48 INFO - Content-Length response header: 14497963 04:01:48 INFO - Bytes received: 14497963 04:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:48 INFO - trying https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2 04:01:48 INFO - Downloading https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:01:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:01:50 INFO - Downloaded 63617828 bytes. 04:01:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2 04:01:50 INFO - mkdir: /builds/slave/test/properties 04:01:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:01:50 INFO - Writing to file /builds/slave/test/properties/build_url 04:01:50 INFO - Contents: 04:01:50 INFO - build_url:https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2 04:01:50 INFO - Running post-action listener: _resource_record_post_action 04:01:50 INFO - Running post-action listener: find_tests_for_verification 04:01:50 INFO - Running post-action listener: set_extra_try_arguments 04:01:50 INFO - [mozharness: 2017-09-09 11:01:50.048098Z] Finished download-and-extract step (success) 04:01:50 INFO - [mozharness: 2017-09-09 11:01:50.048233Z] Running populate-webroot step. 04:01:50 INFO - Running pre-action listener: _resource_record_pre_action 04:01:50 INFO - Running main action method: populate_webroot 04:01:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:01:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:50 INFO - 'tests': ['tresize', 04:01:50 INFO - 'tcanvasmark']}, 04:01:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:01:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:50 INFO - 'tests': ['dromaeo_css', 04:01:50 INFO - 'kraken']}, 04:01:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:01:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:01:50 INFO - 'talos_options': ['--disable-stylo'], 04:01:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:01:50 INFO - 'tests': ['damp', 'tps']}, 04:01:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:01:50 INFO - 'talos_options': ['--disable-stylo'], 04:01:50 INFO - 'tests': ['damp', 'tps']}, 04:01:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:01:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:50 INFO - 'tests': ['dromaeo_dom']}, 04:01:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:01:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:50 INFO - 'tests': ['basic_compositor_video', 04:01:50 INFO - 'glvideo']}, 04:01:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:01:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:01:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:01:50 INFO - 'talos_options': ['--disable-stylo'], 04:01:50 INFO - 'tests': ['ts_paint_webext', 04:01:50 INFO - 'tp5o_webext']}, 04:01:50 INFO - 'other-e10s': {'tests': ['a11yr', 04:01:50 INFO - 'ts_paint', 04:01:50 INFO - 'tpaint', 04:01:50 INFO - 'sessionrestore', 04:01:50 INFO - 'sessionrestore_many_windows', 04:01:50 INFO - 'sessionrestore_no_auto_restore', 04:01:50 INFO - 'tabpaint']}, 04:01:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:50 INFO - 'tests': ['a11yr', 04:01:50 INFO - 'ts_paint', 04:01:50 INFO - 'tpaint', 04:01:50 INFO - 'sessionrestore', 04:01:50 INFO - 'sessionrestore_many_windows', 04:01:50 INFO - 'sessionrestore_no_auto_restore', 04:01:50 INFO - 'tabpaint']}, 04:01:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:01:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:01:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:50 INFO - 'tests': ['bloom_basic_singleton']}, 04:01:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:50 INFO - 'tests': ['bloom_basic']}, 04:01:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:01:50 INFO - 'tsvgr_opacity', 04:01:50 INFO - 'tart', 04:01:50 INFO - 'tscrollx', 04:01:50 INFO - 'tsvg_static']}, 04:01:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:50 INFO - 'tests': ['tsvgx', 04:01:50 INFO - 'tsvgr_opacity', 04:01:50 INFO - 'tart', 04:01:50 INFO - 'tscrollx', 04:01:50 INFO - 'tsvg_static']}, 04:01:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:01:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:01:50 INFO - 'talos_options': ['--disable-stylo'], 04:01:50 INFO - 'tests': ['tp5o']}, 04:01:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:01:50 INFO - 'talos_options': ['--mitmproxy', 04:01:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:01:50 INFO - '--firstNonBlankPaint'], 04:01:50 INFO - 'tests': ['tp6_google', 04:01:50 INFO - 'tp6_youtube', 04:01:50 INFO - 'tp6_amazon', 04:01:50 INFO - 'tp6_facebook']}, 04:01:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:01:50 INFO - 'talos_options': ['--disable-stylo', 04:01:50 INFO - '--mitmproxy', 04:01:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:01:50 INFO - '--firstNonBlankPaint'], 04:01:50 INFO - 'tests': ['tp6_google', 04:01:50 INFO - 'tp6_youtube', 04:01:50 INFO - 'tp6_amazon', 04:01:50 INFO - 'tp6_facebook']}, 04:01:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:01:50 INFO - 'talos_options': ['--stylo-threads=1', 04:01:50 INFO - '--mitmproxy', 04:01:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:01:50 INFO - '--firstNonBlankPaint'], 04:01:50 INFO - 'tests': ['tp6_google', 04:01:50 INFO - 'tp6_youtube', 04:01:50 INFO - 'tp6_amazon', 04:01:50 INFO - 'tp6_facebook']}, 04:01:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:01:50 INFO - 'talos_options': ['--xperf_path', 04:01:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:50 INFO - 'tests': ['tp5n']}, 04:01:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:01:50 INFO - 'talos_options': ['--disable-stylo', 04:01:50 INFO - '--xperf_path', 04:01:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:50 INFO - 'tests': ['tp5n']}}} 04:01:50 INFO - Running post-action listener: _resource_record_post_action 04:01:50 INFO - [mozharness: 2017-09-09 11:01:50.065942Z] Finished populate-webroot step (success) 04:01:50 INFO - [mozharness: 2017-09-09 11:01:50.066083Z] Running create-virtualenv step. 04:01:50 INFO - Running pre-action listener: _resource_record_pre_action 04:01:50 INFO - Running main action method: create_virtualenv 04:01:50 INFO - Creating virtualenv /builds/slave/test/build/venv 04:01:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:01:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:01:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:01:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:01:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:01:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:01:51 INFO - Installing pip...............done. 04:01:51 INFO - Return code: 0 04:01:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:01:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:01:51 INFO - Reading from file tmpfile_stdout 04:01:51 INFO - Output received: 04:01:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:01:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2090>, '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 0x2ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdcf90>, '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': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', '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 04:01:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:01:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:01:51 INFO - Using env: {'DISPLAY': ':0', 04:01:51 INFO - 'HOME': '/home/cltbld', 04:01:51 INFO - 'LANG': 'en_US.UTF-8', 04:01:51 INFO - 'LANGUAGE': 'en_US:en', 04:01:51 INFO - 'LOGNAME': 'cltbld', 04:01:51 INFO - 'MAIL': '/var/mail/cltbld', 04:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:51 INFO - 'MOZ_NO_REMOTE': '1', 04:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:51 INFO - 'NO_EM_RESTART': '1', 04:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:51 INFO - 'PWD': '/builds/slave/test', 04:01:51 INFO - 'SHELL': '/bin/bash', 04:01:51 INFO - 'SHLVL': '1', 04:01:51 INFO - 'TERM': 'linux', 04:01:51 INFO - 'TMOUT': '86400', 04:01:51 INFO - 'USER': 'cltbld', 04:01:51 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', 04:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:51 INFO - '_': '/tools/buildbot/bin/python'} 04:01:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:01:52 INFO - Downloading/unpacking pip>=1.5 04:01:52 INFO - Running setup.py egg_info for package pip 04:01:52 INFO - warning: no files found matching 'pip/cacert.pem' 04:01:52 INFO - warning: no files found matching '*.html' under directory 'docs' 04:01:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:01:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:01:52 INFO - Installing collected packages: pip 04:01:52 INFO - Found existing installation: pip 1.1 04:01:52 INFO - Uninstalling pip: 04:01:52 INFO - Successfully uninstalled pip 04:01:52 INFO - Running setup.py install for pip 04:01:52 INFO - warning: no files found matching 'pip/cacert.pem' 04:01:52 INFO - warning: no files found matching '*.html' under directory 'docs' 04:01:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:01:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:01:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:01:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:01:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:01:52 INFO - Successfully installed pip 04:01:52 INFO - Cleaning up... 04:01:52 INFO - Return code: 0 04:01:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:52 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 0x29721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2090>, '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 0x2ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdcf90>, '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': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', '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 04:01:52 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 04:01:52 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 04:01:52 INFO - Using env: {'DISPLAY': ':0', 04:01:52 INFO - 'HOME': '/home/cltbld', 04:01:52 INFO - 'LANG': 'en_US.UTF-8', 04:01:52 INFO - 'LANGUAGE': 'en_US:en', 04:01:52 INFO - 'LOGNAME': 'cltbld', 04:01:52 INFO - 'MAIL': '/var/mail/cltbld', 04:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:52 INFO - 'MOZ_NO_REMOTE': '1', 04:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:52 INFO - 'NO_EM_RESTART': '1', 04:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:52 INFO - 'PWD': '/builds/slave/test', 04:01:52 INFO - 'SHELL': '/bin/bash', 04:01:52 INFO - 'SHLVL': '1', 04:01:52 INFO - 'TERM': 'linux', 04:01:52 INFO - 'TMOUT': '86400', 04:01:52 INFO - 'USER': 'cltbld', 04:01:52 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', 04:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:52 INFO - '_': '/tools/buildbot/bin/python'} 04:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:53 INFO - Downloading/unpacking psutil>=3.1.1 04:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:01:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:54 INFO - Installing collected packages: psutil 04:01:54 INFO - Running setup.py install for psutil 04:01:54 INFO - building 'psutil._psutil_linux' extension 04:01:54 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 04:01:54 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 04:01:54 INFO - building 'psutil._psutil_posix' extension 04:01:54 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 04:01:54 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 04:01:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:54 INFO - Successfully installed psutil 04:01:54 INFO - Cleaning up... 04:01:54 INFO - Return code: 0 04:01:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01: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')]} 04:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2090>, '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 0x2ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdcf90>, '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': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', '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 04:01: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:01: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 mozsystemmonitor==0.3 04:01:54 INFO - Using env: {'DISPLAY': ':0', 04:01:54 INFO - 'HOME': '/home/cltbld', 04:01:54 INFO - 'LANG': 'en_US.UTF-8', 04:01:54 INFO - 'LANGUAGE': 'en_US:en', 04:01:54 INFO - 'LOGNAME': 'cltbld', 04:01:54 INFO - 'MAIL': '/var/mail/cltbld', 04:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:54 INFO - 'MOZ_NO_REMOTE': '1', 04:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:54 INFO - 'NO_EM_RESTART': '1', 04:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:54 INFO - 'PWD': '/builds/slave/test', 04:01:54 INFO - 'SHELL': '/bin/bash', 04:01:54 INFO - 'SHLVL': '1', 04:01:54 INFO - 'TERM': 'linux', 04:01:54 INFO - 'TMOUT': '86400', 04:01:54 INFO - 'USER': 'cltbld', 04:01:54 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', 04:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:54 INFO - '_': '/tools/buildbot/bin/python'} 04:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:01: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 04:01: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 04:01: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 04:01: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 04:01:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:01:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:01:56 INFO - Installing collected packages: mozsystemmonitor 04:01:56 INFO - Running setup.py install for mozsystemmonitor 04:01:56 INFO - Successfully installed mozsystemmonitor 04:01:56 INFO - Cleaning up... 04:01:57 INFO - Return code: 0 04:01:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01: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')]} 04:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01: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', '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 0x29721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2090>, '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 0x2ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdcf90>, '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': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', '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 04:01: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:01: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 jsonschema==2.5.1 04:01:57 INFO - Using env: {'DISPLAY': ':0', 04:01:57 INFO - 'HOME': '/home/cltbld', 04:01:57 INFO - 'LANG': 'en_US.UTF-8', 04:01:57 INFO - 'LANGUAGE': 'en_US:en', 04:01:57 INFO - 'LOGNAME': 'cltbld', 04:01:57 INFO - 'MAIL': '/var/mail/cltbld', 04:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:57 INFO - 'MOZ_NO_REMOTE': '1', 04:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:57 INFO - 'NO_EM_RESTART': '1', 04:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:57 INFO - 'PWD': '/builds/slave/test', 04:01:57 INFO - 'SHELL': '/bin/bash', 04:01:57 INFO - 'SHLVL': '1', 04:01:57 INFO - 'TERM': 'linux', 04:01:57 INFO - 'TMOUT': '86400', 04:01:57 INFO - 'USER': 'cltbld', 04:01:57 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', 04:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:57 INFO - '_': '/tools/buildbot/bin/python'} 04:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:57 INFO - Downloading/unpacking jsonschema==2.5.1 04:01: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 04:01: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 04:01: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 04:01: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 04:01:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:01:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:01: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 04:01: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 04:01: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 04:01: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 04:01:59 INFO - Downloading functools32-3.2.3-2.tar.gz 04:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:01:59 INFO - warning: no files found matching '*.txt' 04:01:59 INFO - no previously-included directories found matching 'build' 04:01:59 INFO - no previously-included directories found matching 'dist' 04:01:59 INFO - no previously-included directories found matching '.git*' 04:01:59 INFO - Installing collected packages: jsonschema, functools32 04:01:59 INFO - Running setup.py install for functools32 04:01:59 INFO - warning: no files found matching '*.txt' 04:01:59 INFO - no previously-included directories found matching 'build' 04:01:59 INFO - no previously-included directories found matching 'dist' 04:01:59 INFO - no previously-included directories found matching '.git*' 04:01:59 INFO - Successfully installed jsonschema functools32 04:01:59 INFO - Cleaning up... 04:01:59 INFO - Return code: 0 04:01:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01: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')]} 04:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01: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', '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 0x29721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2090>, '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 0x2ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdcf90>, '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': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', '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 04:01: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:01: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 functools32==3.2.3-2 04:01:59 INFO - Using env: {'DISPLAY': ':0', 04:01:59 INFO - 'HOME': '/home/cltbld', 04:01:59 INFO - 'LANG': 'en_US.UTF-8', 04:01:59 INFO - 'LANGUAGE': 'en_US:en', 04:01:59 INFO - 'LOGNAME': 'cltbld', 04:01:59 INFO - 'MAIL': '/var/mail/cltbld', 04:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:59 INFO - 'MOZ_NO_REMOTE': '1', 04:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:59 INFO - 'NO_EM_RESTART': '1', 04:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:59 INFO - 'PWD': '/builds/slave/test', 04:01:59 INFO - 'SHELL': '/bin/bash', 04:01:59 INFO - 'SHLVL': '1', 04:01:59 INFO - 'TERM': 'linux', 04:01:59 INFO - 'TMOUT': '86400', 04:01:59 INFO - 'USER': 'cltbld', 04:01:59 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', 04:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:59 INFO - '_': '/tools/buildbot/bin/python'} 04:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:02:00 INFO - Cleaning up... 04:02:00 INFO - Return code: 0 04:02:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02: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')]} 04:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02: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', '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 0x29721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2090>, '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 0x2ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdcf90>, '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': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', '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 04:02: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:02: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 blobuploader==1.2.4 04:02:00 INFO - Using env: {'DISPLAY': ':0', 04:02:00 INFO - 'HOME': '/home/cltbld', 04:02:00 INFO - 'LANG': 'en_US.UTF-8', 04:02:00 INFO - 'LANGUAGE': 'en_US:en', 04:02:00 INFO - 'LOGNAME': 'cltbld', 04:02:00 INFO - 'MAIL': '/var/mail/cltbld', 04:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:00 INFO - 'MOZ_NO_REMOTE': '1', 04:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:00 INFO - 'NO_EM_RESTART': '1', 04:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:00 INFO - 'PWD': '/builds/slave/test', 04:02:00 INFO - 'SHELL': '/bin/bash', 04:02:00 INFO - 'SHLVL': '1', 04:02:00 INFO - 'TERM': 'linux', 04:02:00 INFO - 'TMOUT': '86400', 04:02:00 INFO - 'USER': 'cltbld', 04:02:00 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', 04:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:00 INFO - '_': '/tools/buildbot/bin/python'} 04:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:00 INFO - Downloading/unpacking blobuploader==1.2.4 04:02: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 04:02: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 04:02: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 04:02: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 04:02:01 INFO - Downloading blobuploader-1.2.4.tar.gz 04:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:02:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:02: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 04:02: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 04:02: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 04:02: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 04:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:02:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:02: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 04:02: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 04:02: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 04:02: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 04:02:02 INFO - Downloading docopt-0.6.1.tar.gz 04:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:02:02 INFO - Installing collected packages: blobuploader, requests, docopt 04:02:02 INFO - Running setup.py install for blobuploader 04:02:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:02:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:02:02 INFO - Running setup.py install for requests 04:02:02 INFO - Running setup.py install for docopt 04:02:02 INFO - Successfully installed blobuploader requests docopt 04:02:02 INFO - Cleaning up... 04:02:02 INFO - Return code: 0 04:02:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:02 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 0x29721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2090>, '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 0x2ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdcf90>, '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': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', '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 04:02:02 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 04:02:02 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 04:02:02 INFO - Using env: {'DISPLAY': ':0', 04:02:02 INFO - 'HOME': '/home/cltbld', 04:02:02 INFO - 'LANG': 'en_US.UTF-8', 04:02:02 INFO - 'LANGUAGE': 'en_US:en', 04:02:02 INFO - 'LOGNAME': 'cltbld', 04:02:02 INFO - 'MAIL': '/var/mail/cltbld', 04:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:02 INFO - 'MOZ_NO_REMOTE': '1', 04:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:02 INFO - 'NO_EM_RESTART': '1', 04:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:02 INFO - 'PWD': '/builds/slave/test', 04:02:02 INFO - 'SHELL': '/bin/bash', 04:02:02 INFO - 'SHLVL': '1', 04:02:02 INFO - 'TERM': 'linux', 04:02:02 INFO - 'TMOUT': '86400', 04:02:02 INFO - 'USER': 'cltbld', 04:02:02 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', 04:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:02 INFO - '_': '/tools/buildbot/bin/python'} 04:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:02 INFO - Running setup.py (path:/tmp/pip-gNMIsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:02 INFO - Running setup.py (path:/tmp/pip-GQFn82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:03 INFO - Running setup.py (path:/tmp/pip-cLKOCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:03 INFO - Running setup.py (path:/tmp/pip-xc6FRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:03 INFO - Running setup.py (path:/tmp/pip-V_6mtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:03 INFO - Running setup.py (path:/tmp/pip-tuTZEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:03 INFO - Running setup.py (path:/tmp/pip-dQOUTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:03 INFO - Running setup.py (path:/tmp/pip-UnK2Qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:03 INFO - Running setup.py (path:/tmp/pip-QnRND7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:03 INFO - Running setup.py (path:/tmp/pip-FNYLJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:03 INFO - Running setup.py (path:/tmp/pip-3PXSLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:03 INFO - Running setup.py (path:/tmp/pip-8CRuyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:03 INFO - Running setup.py (path:/tmp/pip-Le0JKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:03 INFO - Running setup.py (path:/tmp/pip-Akuk0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:03 INFO - Running setup.py (path:/tmp/pip-8LwhzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:03 INFO - Running setup.py (path:/tmp/pip-pl8Fr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:04 INFO - Running setup.py (path:/tmp/pip-B7TqLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:02:04 INFO - Running setup.py install for manifestparser 04:02:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:02:04 INFO - Running setup.py install for mozcrash 04:02:04 INFO - Running setup.py install for mozdebug 04:02:04 INFO - Running setup.py install for mozdevice 04:02:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:02:04 INFO - Running setup.py install for mozfile 04:02:04 INFO - Running setup.py install for mozhttpd 04:02:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:02:04 INFO - Running setup.py install for mozinfo 04:02:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:02:04 INFO - Running setup.py install for mozInstall 04:02:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:02:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:02:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:02:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:02:04 INFO - Running setup.py install for mozleak 04:02:04 INFO - Running setup.py install for mozlog 04:02:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:02:05 INFO - Running setup.py install for moznetwork 04:02:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:02:05 INFO - Running setup.py install for mozprocess 04:02:05 INFO - Running setup.py install for mozprofile 04:02:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:02:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:02:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:02:05 INFO - Running setup.py install for mozrunner 04:02:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:02:05 INFO - Running setup.py install for mozscreenshot 04:02:05 INFO - Running setup.py install for moztest 04:02:05 INFO - Running setup.py install for mozversion 04:02:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:02:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:02:05 INFO - Cleaning up... 04:02:05 INFO - Return code: 0 04:02:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:05 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 0x29721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2090>, '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 0x2ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdcf90>, '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': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', '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 04:02:05 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 04:02:05 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 04:02:05 INFO - Using env: {'DISPLAY': ':0', 04:02:05 INFO - 'HOME': '/home/cltbld', 04:02:05 INFO - 'LANG': 'en_US.UTF-8', 04:02:05 INFO - 'LANGUAGE': 'en_US:en', 04:02:05 INFO - 'LOGNAME': 'cltbld', 04:02:05 INFO - 'MAIL': '/var/mail/cltbld', 04:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:05 INFO - 'MOZ_NO_REMOTE': '1', 04:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:05 INFO - 'NO_EM_RESTART': '1', 04:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:05 INFO - 'PWD': '/builds/slave/test', 04:02:05 INFO - 'SHELL': '/bin/bash', 04:02:05 INFO - 'SHLVL': '1', 04:02:05 INFO - 'TERM': 'linux', 04:02:05 INFO - 'TMOUT': '86400', 04:02:05 INFO - 'USER': 'cltbld', 04:02:05 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', 04:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:05 INFO - '_': '/tools/buildbot/bin/python'} 04:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:06 INFO - Running setup.py (path:/tmp/pip-BLDedk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:06 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)) 04:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:06 INFO - Running setup.py (path:/tmp/pip-o8ZmNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:06 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)) 04:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:06 INFO - Running setup.py (path:/tmp/pip-hGhw50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:06 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)) 04:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:06 INFO - Running setup.py (path:/tmp/pip-Mc2iB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:06 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)) 04:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:06 INFO - Running setup.py (path:/tmp/pip-z2kPys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:06 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)) 04:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:06 INFO - Running setup.py (path:/tmp/pip-8FYO_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:06 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)) 04:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:06 INFO - Running setup.py (path:/tmp/pip-66HE1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:06 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)) 04:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:06 INFO - Running setup.py (path:/tmp/pip-baEGNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:06 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)) 04:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:06 INFO - Running setup.py (path:/tmp/pip-gObIkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:06 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)) 04:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:06 INFO - Running setup.py (path:/tmp/pip-kdNqLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:06 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)) 04:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:06 INFO - Running setup.py (path:/tmp/pip-YCPUOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:06 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)) 04:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:06 INFO - Running setup.py (path:/tmp/pip-RQcOT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:06 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)) 04:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:06 INFO - Running setup.py (path:/tmp/pip-RxiCci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02: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)) 04:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:07 INFO - Running setup.py (path:/tmp/pip-XGc21M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02: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)) 04:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:07 INFO - Running setup.py (path:/tmp/pip-9kLrOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:07 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)) 04:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:07 INFO - Running setup.py (path:/tmp/pip-eT8ghs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:07 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)) 04:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:07 INFO - Running setup.py (path:/tmp/pip-P3hYxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:07 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)) 04:02:07 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)) 04:02:07 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)) 04:02:07 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)) 04:02:07 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)) 04:02:07 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)) 04:02:07 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)) 04:02:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:02:07 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 04:02:07 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 04:02:07 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 04:02:07 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 04:02:08 INFO - Downloading blessings-1.6.tar.gz 04:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:02:08 INFO - Installing collected packages: blessings 04:02:08 INFO - Running setup.py install for blessings 04:02:08 INFO - Successfully installed blessings 04:02:08 INFO - Cleaning up... 04:02:08 INFO - Return code: 0 04:02:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:02:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:08 INFO - Reading from file tmpfile_stdout 04:02:08 INFO - Current package versions: 04:02:08 INFO - argparse == 1.2.1 04:02:08 INFO - blessings == 1.6 04:02:08 INFO - blobuploader == 1.2.4 04:02:08 INFO - docopt == 0.6.1 04:02:08 INFO - functools32 == 3.2.3-2 04:02:08 INFO - jsonschema == 2.5.1 04:02:08 INFO - manifestparser == 1.1 04:02:08 INFO - mozInstall == 1.13 04:02:08 INFO - mozcrash == 1.0 04:02:08 INFO - mozdebug == 0.1 04:02:08 INFO - mozdevice == 0.51 04:02:08 INFO - mozfile == 1.2 04:02:08 INFO - mozhttpd == 0.7 04:02:08 INFO - mozinfo == 0.10 04:02:08 INFO - mozleak == 0.1 04:02:08 INFO - mozlog == 3.5 04:02:08 INFO - moznetwork == 0.27 04:02:08 INFO - mozprocess == 0.25 04:02:08 INFO - mozprofile == 0.28 04:02:08 INFO - mozrunner == 6.13 04:02:08 INFO - mozscreenshot == 0.1 04:02:08 INFO - mozsystemmonitor == 0.3 04:02:08 INFO - moztest == 0.8 04:02:08 INFO - mozversion == 1.4 04:02:08 INFO - psutil == 3.1.1 04:02:08 INFO - requests == 1.2.3 04:02:08 INFO - wsgiref == 0.1.2 04:02:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:08 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 0x29721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2090>, '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 0x2ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdcf90>, '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': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', '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 04:02:08 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 04:02:08 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 04:02:08 INFO - Using env: {'DISPLAY': ':0', 04:02:08 INFO - 'HOME': '/home/cltbld', 04:02:08 INFO - 'LANG': 'en_US.UTF-8', 04:02:08 INFO - 'LANGUAGE': 'en_US:en', 04:02:08 INFO - 'LOGNAME': 'cltbld', 04:02:08 INFO - 'MAIL': '/var/mail/cltbld', 04:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:08 INFO - 'MOZ_NO_REMOTE': '1', 04:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:08 INFO - 'NO_EM_RESTART': '1', 04:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:08 INFO - 'PWD': '/builds/slave/test', 04:02:08 INFO - 'SHELL': '/bin/bash', 04:02:08 INFO - 'SHLVL': '1', 04:02:08 INFO - 'TERM': 'linux', 04:02:08 INFO - 'TMOUT': '86400', 04:02:08 INFO - 'USER': 'cltbld', 04:02:08 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', 04:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:08 INFO - '_': '/tools/buildbot/bin/python'} 04:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02: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)) 04:02: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)) 04:02: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)) 04:02: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)) 04:02: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)) 04:02: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)) 04:02: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)) 04:02: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)) 04:02: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)) 04:02:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:02: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 04:02: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 04:02: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 04:02: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 04:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:02:10 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)) 04:02:10 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)) 04:02:10 INFO - Installing collected packages: simplejson 04:02:10 INFO - Running setup.py install for simplejson 04:02:10 INFO - building 'simplejson._speedups' extension 04:02:10 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 04:02:11 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 04:02:11 INFO - Successfully installed simplejson 04:02:11 INFO - Cleaning up... 04:02:11 INFO - Return code: 0 04:02:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:11 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 0x29721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2090>, '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 0x2ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdcf90>, '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': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', '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 04:02:11 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 04:02:11 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 04:02:11 INFO - Using env: {'DISPLAY': ':0', 04:02:11 INFO - 'HOME': '/home/cltbld', 04:02:11 INFO - 'LANG': 'en_US.UTF-8', 04:02:11 INFO - 'LANGUAGE': 'en_US:en', 04:02:11 INFO - 'LOGNAME': 'cltbld', 04:02:11 INFO - 'MAIL': '/var/mail/cltbld', 04:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:11 INFO - 'MOZ_NO_REMOTE': '1', 04:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:11 INFO - 'NO_EM_RESTART': '1', 04:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:11 INFO - 'PWD': '/builds/slave/test', 04:02:11 INFO - 'SHELL': '/bin/bash', 04:02:11 INFO - 'SHLVL': '1', 04:02:11 INFO - 'TERM': 'linux', 04:02:11 INFO - 'TMOUT': '86400', 04:02:11 INFO - 'USER': 'cltbld', 04:02:11 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', 04:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:11 INFO - '_': '/tools/buildbot/bin/python'} 04:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:02:11 INFO - Cleaning up... 04:02:11 INFO - Return code: 0 04:02:11 INFO - Running post-action listener: _resource_record_post_action 04:02:11 INFO - Running post-action listener: _start_resource_monitoring 04:02:11 INFO - Starting resource monitoring. 04:02:11 INFO - [mozharness: 2017-09-09 11:02:11.532748Z] Finished create-virtualenv step (success) 04:02:11 INFO - [mozharness: 2017-09-09 11:02:11.533261Z] Running install step. 04:02:11 INFO - Running pre-action listener: _resource_record_pre_action 04:02:11 INFO - Running main action method: install 04:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:11 INFO - Reading from file tmpfile_stdout 04:02:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:02:11 INFO - Reading from file tmpfile_stdout 04:02:11 INFO - Output received: 04:02:11 INFO - Usage: mozinstall [options] installer 04:02:11 INFO - Options: 04:02:11 INFO - -h, --help show this help message and exit 04:02:11 INFO - -d DEST, --destination=DEST 04:02:11 INFO - Directory to install application into. [default: 04:02:11 INFO - "/builds/slave/test"] 04:02:11 INFO - --app=APP Application being installed. [default: firefox] 04:02:11 INFO - mkdir: /builds/slave/test/build/application 04:02:11 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'] 04:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:02:28 INFO - Reading from file tmpfile_stdout 04:02:28 INFO - Output received: 04:02:28 INFO - /builds/slave/test/build/application/firefox/firefox 04:02:28 INFO - Running post-action listener: _resource_record_post_action 04:02:28 INFO - [mozharness: 2017-09-09 11:02:28.248449Z] Finished install step (success) 04:02:28 INFO - [mozharness: 2017-09-09 11:02:28.248704Z] Running setup-mitmproxy step. 04:02:28 INFO - Running pre-action listener: _resource_record_pre_action 04:02:28 INFO - Running main action method: setup_mitmproxy 04:02:28 INFO - Skipping: mitmproxy is not required 04:02:28 INFO - Running post-action listener: _resource_record_post_action 04:02:28 INFO - [mozharness: 2017-09-09 11:02:28.249907Z] Finished setup-mitmproxy step (success) 04:02:28 INFO - [mozharness: 2017-09-09 11:02:28.250139Z] Running run-tests step. 04:02:28 INFO - Running pre-action listener: _resource_record_pre_action 04:02:28 INFO - Running pre-action listener: _set_gcov_prefix 04:02:28 INFO - Running main action method: run_tests 04:02:28 WARNING - Try message not found. 04:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:02:28 INFO - Python 2.7.3 04:02:28 INFO - Return code: 0 04:02:28 INFO - grabbing minidump binary from tooltool 04:02:28 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')]} 04:02:28 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 0x2ce2090>, '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 0x2ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdcf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:02:28 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 04:02:28 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 04:02:28 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 04:02:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:02:28 INFO - Return code: 0 04:02:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:02:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:02:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:02:28 INFO - ENV: RUST_BACKTRACE is now full 04:02:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:02:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:02:28 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/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 04:02:28 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/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --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 04:02:28 INFO - Using env: {'DISPLAY': ':0', 04:02:28 INFO - 'HOME': '/home/cltbld', 04:02:28 INFO - 'LANG': 'en_US.UTF-8', 04:02:28 INFO - 'LANGUAGE': 'en_US:en', 04:02:28 INFO - 'LOGNAME': 'cltbld', 04:02:28 INFO - 'MAIL': '/var/mail/cltbld', 04:02:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:28 INFO - 'MOZ_NO_REMOTE': '1', 04:02:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:28 INFO - 'NO_EM_RESTART': '1', 04:02:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:28 INFO - 'PWD': '/builds/slave/test', 04:02:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:28 INFO - 'RUST_BACKTRACE': 'full', 04:02:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:02:28 INFO - 'SHELL': '/bin/bash', 04:02:28 INFO - 'SHLVL': '1', 04:02:28 INFO - 'TERM': 'linux', 04:02:28 INFO - 'TMOUT': '86400', 04:02:28 INFO - 'USER': 'cltbld', 04:02:28 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', 04:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:28 INFO - '_': '/tools/buildbot/bin/python'} 04:02:28 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/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 04:02:28 INFO - mozversion application_buildid: 20170909094348 04:02:28 INFO - mozversion application_changeset: e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 04:02:28 INFO - mozversion application_display_name: Nightly 04:02:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:02:28 INFO - mozversion application_name: Firefox 04:02:28 INFO - mozversion application_remotingname: firefox 04:02:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:02:28 INFO - mozversion application_vendor: Mozilla 04:02:28 INFO - mozversion application_version: 57.0a1 04:02:28 INFO - mozversion platform_buildid: 20170909094348 04:02:28 INFO - mozversion platform_changeset: e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 04:02:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:02:28 INFO - mozversion platform_version: 57.0a1 04:02:28 INFO - using testdate: 1504954948 04:02:28 INFO - actual date: 1504954948 04:02:28 INFO - starting webserver on 'localhost:37922' 04:02:28 INFO - SUITE-START | Running 2 tests 04:02:28 INFO - TEST-START | dromaeo_css 04:02:28 INFO - Initialising browser for dromaeo_css test... 04:02:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37922/getInfo.html -profile /tmp/tmpHuNxNP/profile 04:02:28 INFO - TEST-INFO | started process 6609 (/builds/slave/test/build/application/firefox/firefox http://localhost:37922/getInfo.html) 04:02:34 INFO - TEST-INFO | 6609: exit 0 04:02:34 INFO - Browser initialized. 04:02:34 INFO - Running cycle 1/1 for dromaeo_css test... 04:02:34 INFO - Using env: {'DISPLAY': ':0', 04:02:34 INFO - 'HOME': '/home/cltbld', 04:02:34 INFO - 'JSGC_DISABLE_POISONING': '1', 04:02:34 INFO - 'LANG': 'en_US.UTF-8', 04:02:34 INFO - 'LANGUAGE': 'en_US:en', 04:02:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:02:34 INFO - 'LOGNAME': 'cltbld', 04:02:34 INFO - 'MAIL': '/var/mail/cltbld', 04:02:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:34 INFO - 'MOZ_CRASHREPORTER': '1', 04:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:02:34 INFO - 'MOZ_NO_REMOTE': '1', 04:02:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:34 INFO - 'NO_EM_RESTART': '1', 04:02:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:34 INFO - 'PWD': '/builds/slave/test', 04:02:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:34 INFO - 'RUST_BACKTRACE': 'full', 04:02:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:02:34 INFO - 'SHELL': '/bin/bash', 04:02:34 INFO - 'SHLVL': '1', 04:02:34 INFO - 'TERM': 'linux', 04:02:34 INFO - 'TMOUT': '86400', 04:02:34 INFO - 'USER': 'cltbld', 04:02:34 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', 04:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:34 INFO - '_': '/tools/buildbot/bin/python'} 04:02:34 INFO - TEST-INFO | started process 6812 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHuNxNP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:35 INFO - PID 6812 | 04:02:35 INFO - PID 6812 | (/builds/slave/test/build/application/firefox/firefox:6863): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:02:35 INFO - PID 6812 | 04:02:46 INFO - PID 6812 | RSS: Main: 164540416 04:02:46 INFO - PID 6812 | 04:05:43 INFO - PID 6812 | Cycle 1(1): loaded http://localhost:37922/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37922/tests/dromaeo/cssquery-ext.html) 04:05:44 INFO - PID 6812 | RSS: Main: 168235008 04:05:44 INFO - PID 6812 | 04:08:46 INFO - PID 6812 | Cycle 1(1): loaded http://localhost:37922/tests/dromaeo/cssquery-ext.html (next: http://localhost:37922/tests/dromaeo/cssquery-jquery.html) 04:08:46 INFO - PID 6812 | RSS: Main: 164241408 04:08:46 INFO - PID 6812 | 04:11:48 INFO - PID 6812 | Cycle 1(1): loaded http://localhost:37922/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37922/tests/dromaeo/cssquery-mootools.html) 04:11:49 INFO - PID 6812 | RSS: Main: 166318080 04:11:49 INFO - PID 6812 | 04:14:50 INFO - PID 6812 | Cycle 1(1): loaded http://localhost:37922/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37922/tests/dromaeo/cssquery-prototype.html) 04:14:51 INFO - PID 6812 | RSS: Main: 165777408 04:14:51 INFO - PID 6812 | 04:17:54 INFO - PID 6812 | Cycle 1(1): loaded http://localhost:37922/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37922/tests/dromaeo/cssquery-yui.html) 04:17:54 INFO - PID 6812 | RSS: Main: 167182336 04:17:54 INFO - PID 6812 | 04:20:56 INFO - PID 6812 | Cycle 1(1): loaded http://localhost:37922/tests/dromaeo/cssquery-yui.html (next: http://localhost:37922/tests/dromaeo/cssquery-dojo.html) 04:20:56 INFO - PID 6812 | RSS: Main: 169869312 04:20:56 INFO - PID 6812 | 04:20:56 INFO - PID 6812 | __start_tp_report 04:20:56 INFO - PID 6812 | _x_x_mozilla_page_load 04:20:56 INFO - PID 6812 | _x_x_mozilla_page_load_details 04:20:56 INFO - PID 6812 | |i|pagename|runs| 04:20:56 INFO - PID 6812 | |0;dojo.html;3861.517310336207;3876.8255428505713;3879.592642772509;3882.650561449469;3896.415537669351;6160.19917410736;6295.716692748826;6311.053341998702;6332.936670633292;6382.234131904178;6367.458766004896;6379.17070780799;6391.360863913618;6402.487800975922;6460.966245400748;5646.661200327973;5665.745041473144;5674.631148975324;5734.827955161351;5736.11090281005;5572.359178694442;5667.319921609413;5688.459596338341;5747.396523365049;5766.740496677659;5634.915476267859;5640.097584386499;5664.753754174075;5699.515541179005;5711.657300561979;5643.097104463307;5659.094544872801;5718.628289161191;5727.885442291173;5732.971335143339;5596.972015139898;5636.859078523029;5638.774449022034;5668.943310566883;5682.516986056149;6170.907436388457;6251.874962500725;6290.150829637986;6290.308066112724;6305.558610897239;6774.458043356569;6784.7964561063245;6866.759663411806;6867.3476019778045;6877.140357455318;6782.559133656346;6871.896921546181;6885.793426197222;6893.379595836349;6965.895511567331;6328.145700330489;6377.1709677742065;6399.648019358933;6435.710393032325;6437.871242575122;6884.105066341343;7046.084009078787;7057.294270572902;7059.329363710439;7070.151581810215;6701.564398314094;6719.260881303053;6746.359095885883;6794.8301292467095;6810.216825065181;6927.93072069283;6941.930580694229;6943.340382663639;6948.478864085214;6985.371316581431;6811.625360605214;6882.242953275136;6884.931150688529;6887.345702158287;6896.413804826546;6749.190097188369;6759.053732477457;6848.3494068063455;6932.480063995221;6936.4797640177185;4913.950860491421;4916.950830491649;4925.1873440881855;4926.950730492649;4928.285398617252;4485.641148708096;4500.459944806578;4510.0979804039325;4524.049949510574;4542.477615074243;6181.938180618226;6265.749370025148;6313.905291420632;6318.147050148171;6362.491000719931;6688.331166883273;6740.157480314961;6756.560823546453;6829.965850170717;6843.110395648534;6127.448529632355;6145.8156255312415;6234.064890266496;6240.4071613196675;6267.96866015667;5448.809291674773;5521.4478552144465;5529.0324193266015;5529.944700553024;5538.86152846174;7014.438844892396;7117.395021423237;7132.108486439195;7215.458840586872;7225.169105552824;6683.899741503784;6759.087523184504;6763;6848.657567121723;6860.656967151723;7116.217216106328;7179.317964793545;7197;7206.135263768381;7211.062561867134;6768;6780.69486873082;6828.897566536605;6900.206476255295;6912.688928998307;6671.566348187546;6813.148356455443;6827.487938404739;6908.93091069103;6918.896216556856;6583.967080164569;6599.9010014848855;6601;6603.339666033358;6603.570767900071;6615.834604134935;6637;6650.667466626553;6665.433438157811;6696.497762667722;6456.418922296828;6459.580127291711;6483.513736469689;6525.086487891794;6568.573042752206;6478.1578394808375;6579.374959378852;6627.271000189879;6637.668116594247;6730.226024007302;6466.773662921775;6517.4134327910715;6539.836504087436;6543.967280163569;6557.278699342973 04:20:56 INFO - PID 6812 | |1;ext.html;933.8412469880118;942.1897168435145;960.4717405427016;991;995.5818556206392;44642.33036504451;45494.54505454949;45521.77239113804;45601;45630.08739825201;45882.08235835281;46929.76535117328;46937.76531117348;46963.76518117413;46985.53014469854;8028.718994835182;8127.146649601796;8139.918600814005;8143.42995990278;8170.632321545515;7980.481268717544;8085.110637829834;8105.06791718954;8106.310963568104;8107.594620268992;8124.6343914523695;8127.349812015054;8144.104148543655;8147.388945829057;8152.225538573826;8092.797680057986;8111.107778144399;8122.796930076736;8128.7561373158605;8130.837383252331;7992.200779922019;8003.999500062492;8021.037475502919;8041.276285134366;8043.879341809878;41188.58811411878;41244.38133428001;41301.1739765206;41363.586364136274;41578.37632435516;3740.4763333133383;3741.158239396141;3741.906452338686;3753.3619284721663;3765.2093060457337;33952.83023584891;33957.830210848784;33973.15067123317;34020;34029.6597034029;5500.28496295483;5502.2296878437055;5509;5512.586556008276;5537.363203231599;222609;222822;222866;223017;223188;52837;52850.73574632102;52959.470405296226;53041.469585303654;53088.203676944875;54892.17661735077;55114.72442637761;55152.72423637936;55176.44823551713;55253.723731381084;17761.911190444225;17814.287428502976;17864;17871.463856084338;17871.642567148843;14602.926985365006;14626.488072917396;14639.194844283667;14643.12141271527;14644.12135271887;13855.653608659864;14269.429222831179;14341.85658143426;14371.13773173613;14479.493217737328;5091.567216786615;5154.690718556899;5171.844844654666;5196.636235463481;5346.652467589594;1031.8134145732467;1040.6045702633103;1062.0335494699787;1064.095518809006;1075.8816530181673;25161.874190629296;25205.495890082097;25206.621900671504;25248.242552723448;25389;1144.988550114505;1146.220570012383;1160.3618010094415;1162.1806626328419;1207.02834218455;13238.73522529544;13250.801237981437;13298.069135160446;13417.322834645669;13435.798463023062;281431;285092;285363;286542;286989;62229.688851556355;63422.68288658527;63620.36379636237;63724.681376592824;63790.68104659447;1458.5915943535827;1512.3950419831936;1518.6431188670654;1520.1715065289222;1535.7807967486874;30401.23996900095;30814.229644258176;31013;31109;31178.844105780234;40670.59329406668;40899.591004089576;40921.79539102405;41017.58982410138;41062.99999999881;235505.40225690228;236029;236244;236544;237157;35756.74851380189;36066.27867442689;36123.819380902925;36170.638293617776;36530.26939461143;46120;46161.76919115383;46549.767251163525;46723.76638116788;46841.53158468372;34338.31323373569;34611.48082778811;35375.23123843746;35443.11392215112;35734.8213258932;34462.655373445945;34595.82702086474;34646.48030279598;34884.65115348814;35065.47401788924;39769.80115099406;41126.383104254055;41242.58757412388;41709.374359384026;41736.79131604323;33330.83334583312;33578.49632255567;33843.323133537684;33964;34190;24961.0015599374;25141;25254.116105936206;25293.494130116927;25498 04:20:56 INFO - PID 6812 | |2;jquery.html;586.2876604925016;600.4565867889559;607.1712112965802;607.3076692570468;623.4731651754267;23196.188133415333;24156.516869662595;24214;24233;24244.636330455036;24868.253952381456;26619.334516637045;26885.327866803338;26901.192964211106;26985.73014269857;6445.742170313182;6626.801195964129;6628.900566491507;6636.236832764245;6640.435562977129;6472.190976127984;6494.090827284161;6566.8686626267445;6636.933630663704;6669;6647.169103862017;6650.634215118166;6653.135092437977;6655.733770649168;6658.30087840777;6651.068850360954;6663.16710411201;6665.266820649725;6668.833279168011;6671.199456065255;6193.4425901669065;6215.595986260923;6219.253689557237;6234.844128896814;6236.563440559163;30311.393772124433;30724;30996.690033099607;31089.84455077733;31278.530822037686;2262.0386335807216;2287.2452090809993;2287.565362581104;2289.278877153691;2290.484640955788;20106.597868042558;20547.691784623094;20829.79170208309;21430.464238394008;21545;2529.8229123961332;2542.9491410171877;2570.498752743216;2586.2241327601832;2591.5464793661035;143856;149754;155988.22005889897;163725.18137409355;164564;16021.43924962644;16446.424375146813;16615.833841661428;16923.746143807854;17045.40341088056;25982;25997.74002259991;26059.73940260573;26104.60843087355;26121.477570448485;10883.78232435347;10974.902509748961;11109;11192.160587955774;11199.160062995308;10121.544530496145;10168.745781355377;10220.846687299696;10282.691519254435;10294.433806140734;9687.66093186735;9956;9990.40057596532;10002.699919002442;10279.486025698685;2776.319801648609;2830.2216890355317;2886.270752556174;2911.315840777416;2973.8439631267156;1045.430240518919;1049.58541376156;1052.231870734353;1054.6466933577337;1058.5289546152042;20932.790672093084;21777.23779667704;21813;21913.452163696034;22189.11243550272;1098.357460885391;1111.2776695148218;1118.2898859224288;1118.78743038824;1121.2319561100671;11710.590129345432;11968.640940771791;12090.09324300681;12130.818037729441;12318.322492262832;580178;600644;617182;625612;629514;132361;132391;134654;137558;137820.31089844488;1127.813910704741;1174.9353785541878;1219.4878151176526;1229.6372570091844;1271.1800888426912;21943.341699749035;22497.5500489986;22503;22584.983675734304;22630.66054009224;62762.686186568775;63468;63638;63704.68147659232;64664.67667661631;81097;81559.59220204098;81587;81697;81830.59084704539;14719.411223551366;15076.924615376853;15657.982231154938;15679.843201567839;15767;23944.88027559851;24149.879250603633;24175.51648967046;24292.271231863073;24306.75693243045;18126.18432170582;19006.809931900505;19959.900200498905;20350.28773992903;20382.388528344174;15930;17202.225899834288;17389.565260868578;17441.127943603024;17606.647867042844;18897.811021889604;18990.905045474683;19461.708074378614;19479;20490.897545512176;15341.923290383476;15426;15466.381344746535;15531.922340388226;15540.300686469362;19289.8071019288;19429.319973800848;19621.901890490455;19652.901735491232;19657.705134422707 04:20:56 INFO - PID 6812 | |3;mootools.html;1404.7050119474911;1455.2796365798931;1462.6343414146468;1463.817022872141;1464.78760579716;16536.586585335357;17116.74324885126;17133.400330988417;17148.571285717833;17185.656286874255;16656.83343166568;16719.749203761952;16754;16757;16802.579935501617;2637.9340516487096;2772.639556857606;2779.291280723423;2779.4163225722523;2780.5968134620466;2605.8566778827158;2739.52058389781;2771.722827717222;2778.4304217635336;2779.4163225722623;2749.6562929633797;2763.5163846326814;2766.7233276672373;2769.9307517312027;2773.88904443822;2657.0567448555776;2677;2690.730926907313;2696.150712525568;2701.810873238874;2644.947101057968;2659.188947371051;2737.2609395463314;2741.972580274192;2758.8068835181543;16403.58991025222;16518.66962660752;16538.83461165385;16554.089525076117;16559.668806623922;8017.318527925133;8271.048829384637;8276.83446331076;8280.254777070033;8282.71010514635;5501.944980550184;5713.781248007512;5737.196792449061;5760.481556659879;5851;2013.8892360920142;2033.8305474352308;2041.2345370486069;2044.47865794223;2057.907394167266;29954.55068173979;30306.84846575753;30336.696633033607;30366.240843978856;30431.23921901948;6610.3720146586;6637.933620663828;6834.282400347991;6847.726090956406;7135.857282854314;19741.802581974283;19746.40760777179;19750.30873919406;19784.50538736514;19858;8219.794505137419;8402.747917562483;8409.789755256044;8415.032271288757;8417.368697347723;7392.593407362647;7454.40364770817;7596.2023987481625;7625.504342217849;7635.503692259986;5300.522952934254;5456.427075157131;5459.617826752089;5482.506574408322;5534.086875665551;1617.1887486015737;1622.3105180298326;1624.350259896051;1634.9100799455907;1658.9253483593268;928.4939707859232;953.7472569769017;958.6548842416724;963.0898800633474;972.7422233108091;8269.503829770232;8325.375596830261;8364.874526882102;8396.748097557083;8416.663333466593;776.5263189454429;784.2236186175645;784.7606480023647;786.5477350523357;797.2625321577517;5002.549770520671;5089.4147173074825;5375.973120134374;5528.834134975958;5636.915446268227;24132.51734965291;25281.620775688378;25597.104101356363;25637.8718106412;25742.35644108875;24737;25240;25463.61804572933;25477.36306592313;25516.234512964642;12376.381180940916;12400;12431;12548.309842958543;12622;9043.593038313424;9054.954725226331;9062.592183351897;9110.453372797654;9204.723858284262;20536.38390848277;20732.378028659165;21016.159353626295;21462.03420846097;21742.565148697253;21696.349109526738;21841.78158218461;21919.342419727433;22040.559188815812;22156.556868862855;12012.33932133706;12042.277463352228;12080.275183489019;12138.817917731418;12147.574834880737;14518.637034074232;14733.04235224707;14741.1892345922;14744;14758.114513129247;12256.87743122593;12263.018958483122;12423.31671758062;12451.564195253122;12527.436265368262;11825.82261266099;11916.880831191924;11928.701782455508;12155.939220303842;12209.816852747039;10438.373697577867;10446.425446600206;10596.788064238517;10627.574897004033;10635.627753028606;7966.641501132347;8022.9197708022175;8068.749343851712;8082.070561885458;8150.633221504928;8004.239597238253;8029.759107226559;8067.556284404414;8184.672613095409;8186.09952905168 04:20:56 INFO - PID 6812 | |4;prototype.html;547.3404547520239;554.37078915431;565.4430386069723;575.234937533081;582.798934367643;6133.478654314383;6190.288116866556;6247.564229397128;6249.187605611275;6278.434940855322;6136.601120927136;6147.815565533041;6162.815115546529;6183.650212919085;6216.378362163781;5017.573506251973;5108.8978220435565;5113.130767769489;5118.053160165363;5118.257852611369;4829.517048295177;4900.901981960359;4918.409790825088;4967.627427942901;5076.949230507685;4819.1325561398935;4879.487653796354;4889.559939605435;4892.8532144035735;4902.142125128088;4835.419749630032;4855.781489832966;4880.999395123991;4902.632302577304;4906;4333.696641235115;4418.911621767579;4456.131054444385;4482.708623939434;4519.796609152563;6108.480779133779;6131.9386806131815;6139.38606139387;6148.647297594522;6196.225471816023;5741.138829175616;5816.447437493473;5847.7953271635715;5851.912221316684;5859.8535036624;6544.901826472606;6570.967145164292;6590;6606.8348291293105;6612.93387066128;4787.521247875219;5022.522860328263;5027.918997415573;5044.445111037783;5055.595552355802;6727.226368967583;6736.797896063126;6843.931560684379;6899.310068993111;6972.825679357955;5603.327600687943;5616.438356164433;5633.774649013993;5647.858803529944;5650.519705825051;5710.8863771564975;5724.141378793214;5724.398938111438;5791.131330300404;5791.449812267828;6021.6989150542295;6045.848853778691;6104.542159338067;6140.846478837975;6149.569530132848;6661.26726060133;6663.9004564247325;6668.633225172565;6690.799276021728;6701.564398314094;1975.7332760077493;1979.2775636892432;1999.2902519605332;2003.8096380843797;2008.4175589079002;1436.755751522223;1494.6338147154017;1504.7893294938717;1515.2953876447505;1542.7994360733032;6054.697265136813;6083.148359229712;6083.574149809471;6103.35914728956;6164.568480206342;6596.637184954873;6634.303398143222;6666.633335166515;6667.599944003376;6696;6073.423024812724;6077.787277445268;6138.710870717199;6168.383161683796;6192.907106393408;3483.512308276843;3506.316268327703;3529.858805647745;3532.8586856525967;3539.8053107078845;6934.341237582422;7070.681819318143;7076.540024898365;7085.362317391459;7105.928940710527;6977.616231107338;6982.755603553851;6987.371136597731;6991.580505169706;7034.5427547209265;6878.38094571491;6958.860822783618;7005.299470052954;7007.6846541904715;7053.470989675795;6578.210614726264;6604.669766511752;6644.036614690746;6651.268360480247;6714.52998290115;6573.934260657332;6631;6649.700763465559;6652.567583107082;6731.966340168267;7048.647567621701;7057.941308803721;7087.468439866928;7117.3238542338395;7122.643867806485;5616.5787565931905;5648.57635677334;5672.5745569081655;5682.692980614399;5699.287589051369;6544.9672751635935;6651.733930642914;6658.533902626769;6775.220849602161;6833.521653484408;6260.217472815898;6404.839879002876;6412.9358706414205;6509.511786616117;6564.409203171737;6475.417212450902;6505.544611877123;6534.542582019213;6537.444317232898;6558.278589355263;6423.197100362455;6443.130177425987;6450.354964503512;6494.837629059311;6496.123023391781;6503.25212600557;6527.715299645086;6596.736130554724;6602.953084543807;6631.602103873783;6159.353267906985;6241.656708881055;6244.65654389013;6307.463865571478;6332.810015699536 04:20:56 INFO - PID 6812 | |5;yui.html;953.4946478366468;964.2286171063149;971.0968799016912;973.3305438496872;979.1298619636495;20505;20741;21817.127314907426;21822.563548729016;21899.67150492744;19969.900150499263;20223.191072357124;20326.69509957348;21253.787462125412;22042.33872983813;1056.4770438632868;1062.8724553053644;1066.4188017530425;1069.4011353641947;1069.6577095329499;1045.8797238317616;1074.511097450658;1078.8543546621183;1079.3254216114929;1079.773247618001;1125.6904351303376;1125.9324440533553;1126.752114534805;1126.8028095083368;1135.4663308245113;1113.6603335982481;1114.6656003199007;1115.9609413670523;1117.1732917640968;1132.4960392625285;825.8843761873343;826.8925039744795;828.7555171224503;828.8300898315831;835.6907944060675;18001.369952051617;18812.905935470237;18930.621387572308;18942.052897355075;18987.525311867175;20710.89644551783;20842.166313347447;21254.787452125434;21255.5748885023;21262.78737212639;18137;18379.632407351914;18429.815701842945;18483.537911552183;18564.814351856443;3842.1931394407206;3932.4494570760116;3953.3872249801325;3965.980170099131;3970.980145099285;157962;159760.20119899441;161293;161483;162390.188049059;15449.382024718885;15766.842331576767;15983.520494384955;16044.75932861008;16136.75794863078;28970.27574310617;30826.383472330428;30945.69054309473;30957;31012.379752404824;8692.478451292942;8782.165694259034;8790.42862213954;8793.164649358301;8801.25189358899;4313.309870420718;4337.414449049401;4377.058932329564;4393.055493069006;4404.823807047682;5902.2327097477055;5920.526357891358;6033.125196846433;6043.667598282049;6056.4246396593135;1040.1886528507775;1083.0685610375072;1083.6369816111692;1086.1256688365784;1095.4905968724581;718.6263143165525;729.5258082246582;734.1227233455969;742.1354122447289;759.4418102694515;12451.447453272058;12975.286359250144;13155.73688526224;13362.799558006638;13630;733.8275505256261;737.7602279259262;743.4424181863602;743.9814004649927;748.2106377771503;6085.847853803691;6136.5090792737365;6159;6234.220722409699;6258.217722784652;147190;147918;149910.25044874707;150015;153304.23347883188;128123;129817;132831;133321;137428;116048;118075;118622;119104;120811.99999999824;11673.708157296136;11703.531858725897;11849.407529623657;12074.637760867188;12076;53502.73248633888;55379;56158.71920640534;56718.432815671316;56834.431655682914;67488.66255668887;67510.32489675237;67582.66208668925;67772.661136694;68432.6578367105;13893.027488075737;14103.717925641224;14127.15237085778;14174.14955102697;14224.857751422767;16978.40575579849;17277.913610431868;17302.5674358137;17377.304907803547;17397.739033914753;16106;16312.265948032604;16315.51053468398;16362;16443.83556164423;15808.130552819704;15855.20723963774;15925.761113583074;16012.439564615182;16014.199290035218;15808.52574422769;16057;16076.839231608003;16149.111798850707;16155.596110097342;12763.936180319039;12777.93611031976;13061.21632702041;13069.15050521713;13107.737845243233;12273.07951903593;12321.93839030799;12495.375231238584;12544.87455125437;12559.246445213317 04:20:56 INFO - PID 6812 | __end_tp_report 04:20:56 INFO - PID 6812 | __start_cc_report 04:20:56 INFO - PID 6812 | _x_x_mozilla_cycle_collect,357 04:20:56 INFO - PID 6812 | __end_cc_report 04:20:56 INFO - PID 6812 | __startTimestamp1504956056643__endTimestamp 04:20:56 INFO - PID 6812 | 04:20:56 INFO - PID 6812 | ------- Summary: start ------- 04:20:56 INFO - PID 6812 | Number of tests: 6 04:20:56 INFO - PID 6812 | 04:20:56 INFO - PID 6812 | [#0] dojo.html Cycles:165 Average:6292.52 Median:6539.84 stddev:759.61 (11.6%) stddev-sans-first:737.61 04:20:56 INFO - PID 6812 | Values: 3861.5 3876.8 3879.6 3882.7 3896.4 6160.2 6295.7 6311.1 6332.9 6382.2 6367.5 6379.2 6391.4 6402.5 6461.0 5646.7 5665.7 5674.6 5734.8 5736.1 5572.4 5667.3 5688.5 5747.4 5766.7 5634.9 5640.1 5664.8 5699.5 5711.7 5643.1 5659.1 5718.6 5727.9 5733.0 5597.0 5636.9 5638.8 5668.9 5682.5 6170.9 6251.9 6290.2 6290.3 6305.6 6774.5 6784.8 6866.8 6867.3 6877.1 6782.6 6871.9 6885.8 6893.4 6965.9 6328.1 6377.2 6399.6 6435.7 6437.9 6884.1 7046.1 7057.3 7059.3 7070.2 6701.6 6719.3 6746.4 6794.8 6810.2 6927.9 6941.9 6943.3 6948.5 6985.4 6811.6 6882.2 6884.9 6887.3 6896.4 6749.2 6759.1 6848.3 6932.5 6936.5 4914.0 4917.0 4925.2 4927.0 4928.3 4485.6 4500.5 4510.1 4524.0 4542.5 6181.9 6265.7 6313.9 6318.1 6362.5 6688.3 6740.2 6756.6 6830.0 6843.1 6127.4 6145.8 6234.1 6240.4 6268.0 5448.8 5521.4 5529.0 5529.9 5538.9 7014.4 7117.4 7132.1 7215.5 7225.2 6683.9 6759.1 6763.0 6848.7 6860.7 7116.2 7179.3 7197.0 7206.1 7211.1 6768.0 6780.7 6828.9 6900.2 6912.7 6671.6 6813.1 6827.5 6908.9 6918.9 6584.0 6599.9 6601.0 6603.3 6603.6 6615.8 6637.0 6650.7 6665.4 6696.5 6456.4 6459.6 6483.5 6525.1 6568.6 6478.2 6579.4 6627.3 6637.7 6730.2 6466.8 6517.4 6539.8 6544.0 6557.3 04:20:56 INFO - PID 6812 | 04:20:56 INFO - PID 6812 | [#1] ext.html Cycles:180 Average:43123.88 Median:3740.82 stddev:64896.00 (1734.8%) stddev-sans-first:65000.73 04:20:56 INFO - PID 6812 | Values: 933.8 942.2 960.5 991.0 995.6 44642.3 45494.5 45521.8 45601.0 45630.1 45882.1 46929.8 46937.8 46963.8 46985.5 8028.7 8127.1 8139.9 8143.4 8170.6 7980.5 8085.1 8105.1 8106.3 8107.6 8124.6 8127.3 8144.1 8147.4 8152.2 8092.8 8111.1 8122.8 8128.8 8130.8 7992.2 8004.0 8021.0 8041.3 8043.9 41188.6 41244.4 41301.2 41363.6 41578.4 3740.5 3741.2 3741.9 3753.4 3765.2 33952.8 33957.8 33973.2 34020.0 34029.7 5500.3 5502.2 5509.0 5512.6 5537.4 222609.0 222822.0 222866.0 223017.0 223188.0 52837.0 52850.7 52959.5 53041.5 53088.2 54892.2 55114.7 55152.7 55176.4 55253.7 17761.9 17814.3 17864.0 17871.5 17871.6 14602.9 14626.5 14639.2 14643.1 14644.1 13855.7 14269.4 14341.9 14371.1 14479.5 5091.6 5154.7 5171.8 5196.6 5346.7 1031.8 1040.6 1062.0 1064.1 1075.9 25161.9 25205.5 25206.6 25248.2 25389.0 1145.0 1146.2 1160.4 1162.2 1207.0 13238.7 13250.8 13298.1 13417.3 13435.8 281431.0 285092.0 285363.0 286542.0 286989.0 62229.7 63422.7 63620.4 63724.7 63790.7 1458.6 1512.4 1518.6 1520.2 1535.8 30401.2 30814.2 31013.0 31109.0 31178.8 40670.6 40899.6 40921.8 41017.6 41063.0 235505.4 236029.0 236244.0 236544.0 237157.0 35756.7 36066.3 36123.8 36170.6 36530.3 46120.0 46161.8 46549.8 46723.8 46841.5 34338.3 34611.5 35375.2 35443.1 35734.8 34462.7 34595.8 34646.5 34884.7 35065.5 39769.8 41126.4 41242.6 41709.4 41736.8 33330.8 33578.5 33843.3 33964.0 34190.0 24961.0 25141.0 25254.1 25293.5 25498.0 04:20:56 INFO - PID 6812 | 04:20:56 INFO - PID 6812 | [#2] jquery.html Cycles:180 Average:40383.88 Median:12423.51 stddev:102412.02 (824.3%) stddev-sans-first:102655.72 04:20:56 INFO - PID 6812 | Values: 586.3 600.5 607.2 607.3 623.5 23196.2 24156.5 24214.0 24233.0 24244.6 24868.3 26619.3 26885.3 26901.2 26985.7 6445.7 6626.8 6628.9 6636.2 6640.4 6472.2 6494.1 6566.9 6636.9 6669.0 6647.2 6650.6 6653.1 6655.7 6658.3 6651.1 6663.2 6665.3 6668.8 6671.2 6193.4 6215.6 6219.3 6234.8 6236.6 30311.4 30724.0 30996.7 31089.8 31278.5 2262.0 2287.2 2287.6 2289.3 2290.5 20106.6 20547.7 20829.8 21430.5 21545.0 2529.8 2542.9 2570.5 2586.2 2591.5 143856.0 149754.0 155988.2 163725.2 164564.0 16021.4 16446.4 16615.8 16923.7 17045.4 25982.0 25997.7 26059.7 26104.6 26121.5 10883.8 10974.9 11109.0 11192.2 11199.2 10121.5 10168.7 10220.8 10282.7 10294.4 9687.7 9956.0 9990.4 10002.7 10279.5 2776.3 2830.2 2886.3 2911.3 2973.8 1045.4 1049.6 1052.2 1054.6 1058.5 20932.8 21777.2 21813.0 21913.5 22189.1 1098.4 1111.3 1118.3 1118.8 1121.2 11710.6 11968.6 12090.1 12130.8 12318.3 580178.0 600644.0 617182.0 625612.0 629514.0 132361.0 132391.0 134654.0 137558.0 137820.3 1127.8 1174.9 1219.5 1229.6 1271.2 21943.3 22497.6 22503.0 22585.0 22630.7 62762.7 63468.0 63638.0 63704.7 64664.7 81097.0 81559.6 81587.0 81697.0 81830.6 14719.4 15076.9 15658.0 15679.8 15767.0 23944.9 24149.9 24175.5 24292.3 24306.8 18126.2 19006.8 19959.9 20350.3 20382.4 15930.0 17202.2 17389.6 17441.1 17606.6 18897.8 18990.9 19461.7 19479.0 20490.9 15341.9 15426.0 15466.4 15531.9 15540.3 19289.8 19429.3 19621.9 19652.9 19657.7 04:20:56 INFO - PID 6812 | 04:20:56 INFO - PID 6812 | [#3] mootools.html Cycles:180 Average:10268.65 Median:2683.87 stddev:7747.88 (288.7%) stddev-sans-first:7741.00 04:20:56 INFO - PID 6812 | Values: 1404.7 1455.3 1462.6 1463.8 1464.8 16536.6 17116.7 17133.4 17148.6 17185.7 16656.8 16719.7 16754.0 16757.0 16802.6 2637.9 2772.6 2779.3 2779.4 2780.6 2605.9 2739.5 2771.7 2778.4 2779.4 2749.7 2763.5 2766.7 2769.9 2773.9 2657.1 2677.0 2690.7 2696.2 2701.8 2644.9 2659.2 2737.3 2742.0 2758.8 16403.6 16518.7 16538.8 16554.1 16559.7 8017.3 8271.0 8276.8 8280.3 8282.7 5501.9 5713.8 5737.2 5760.5 5851.0 2013.9 2033.8 2041.2 2044.5 2057.9 29954.6 30306.8 30336.7 30366.2 30431.2 6610.4 6637.9 6834.3 6847.7 7135.9 19741.8 19746.4 19750.3 19784.5 19858.0 8219.8 8402.7 8409.8 8415.0 8417.4 7392.6 7454.4 7596.2 7625.5 7635.5 5300.5 5456.4 5459.6 5482.5 5534.1 1617.2 1622.3 1624.4 1634.9 1658.9 928.5 953.7 958.7 963.1 972.7 8269.5 8325.4 8364.9 8396.7 8416.7 776.5 784.2 784.8 786.5 797.3 5002.5 5089.4 5376.0 5528.8 5636.9 24132.5 25281.6 25597.1 25637.9 25742.4 24737.0 25240.0 25463.6 25477.4 25516.2 12376.4 12400.0 12431.0 12548.3 12622.0 9043.6 9055.0 9062.6 9110.5 9204.7 20536.4 20732.4 21016.2 21462.0 21742.6 21696.3 21841.8 21919.3 22040.6 22156.6 12012.3 12042.3 12080.3 12138.8 12147.6 14518.6 14733.0 14741.2 14744.0 14758.1 12256.9 12263.0 12423.3 12451.6 12527.4 11825.8 11916.9 11928.7 12155.9 12209.8 10438.4 10446.4 10596.8 10627.6 10635.6 7966.6 8022.9 8068.7 8082.1 8150.6 8004.2 8029.8 8067.6 8184.7 8186.1 04:20:56 INFO - PID 6812 | 04:20:56 INFO - PID 6812 | [#4] prototype.html Cycles:180 Average:5655.66 Median:6163.69 stddev:1538.85 (25.0%) stddev-sans-first:1494.64 04:20:56 INFO - PID 6812 | Values: 547.3 554.4 565.4 575.2 582.8 6133.5 6190.3 6247.6 6249.2 6278.4 6136.6 6147.8 6162.8 6183.7 6216.4 5017.6 5108.9 5113.1 5118.1 5118.3 4829.5 4900.9 4918.4 4967.6 5076.9 4819.1 4879.5 4889.6 4892.9 4902.1 4835.4 4855.8 4881.0 4902.6 4906.0 4333.7 4418.9 4456.1 4482.7 4519.8 6108.5 6131.9 6139.4 6148.6 6196.2 5741.1 5816.4 5847.8 5851.9 5859.9 6544.9 6571.0 6590.0 6606.8 6612.9 4787.5 5022.5 5027.9 5044.4 5055.6 6727.2 6736.8 6843.9 6899.3 6972.8 5603.3 5616.4 5633.8 5647.9 5650.5 5710.9 5724.1 5724.4 5791.1 5791.4 6021.7 6045.8 6104.5 6140.8 6149.6 6661.3 6663.9 6668.6 6690.8 6701.6 1975.7 1979.3 1999.3 2003.8 2008.4 1436.8 1494.6 1504.8 1515.3 1542.8 6054.7 6083.1 6083.6 6103.4 6164.6 6596.6 6634.3 6666.6 6667.6 6696.0 6073.4 6077.8 6138.7 6168.4 6192.9 3483.5 3506.3 3529.9 3532.9 3539.8 6934.3 7070.7 7076.5 7085.4 7105.9 6977.6 6982.8 6987.4 6991.6 7034.5 6878.4 6958.9 7005.3 7007.7 7053.5 6578.2 6604.7 6644.0 6651.3 6714.5 6573.9 6631.0 6649.7 6652.6 6732.0 7048.6 7057.9 7087.5 7117.3 7122.6 5616.6 5648.6 5672.6 5682.7 5699.3 6545.0 6651.7 6658.5 6775.2 6833.5 6260.2 6404.8 6412.9 6509.5 6564.4 6475.4 6505.5 6534.5 6537.4 6558.3 6423.2 6443.1 6450.4 6494.8 6496.1 6503.3 6527.7 6596.7 6603.0 6631.6 6159.4 6241.7 6244.7 6307.5 6332.8 04:20:56 INFO - PID 6812 | 04:20:56 INFO - PID 6812 | [#5] yui.html Cycles:180 Average:27758.49 Median:17128.16 stddev:42619.83 (248.8%) stddev-sans-first:42691.87 04:20:56 INFO - PID 6812 | Values: 953.5 964.2 971.1 973.3 979.1 20505.0 20741.0 21817.1 21822.6 21899.7 19969.9 20223.2 20326.7 21253.8 22042.3 1056.5 1062.9 1066.4 1069.4 1069.7 1045.9 1074.5 1078.9 1079.3 1079.8 1125.7 1125.9 1126.8 1126.8 1135.5 1113.7 1114.7 1116.0 1117.2 1132.5 825.9 826.9 828.8 828.8 835.7 18001.4 18812.9 18930.6 18942.1 18987.5 20710.9 20842.2 21254.8 21255.6 21262.8 18137.0 18379.6 18429.8 18483.5 18564.8 3842.2 3932.4 3953.4 3966.0 3971.0 157962.0 159760.2 161293.0 161483.0 162390.2 15449.4 15766.8 15983.5 16044.8 16136.8 28970.3 30826.4 30945.7 30957.0 31012.4 8692.5 8782.2 8790.4 8793.2 8801.3 4313.3 4337.4 4377.1 4393.1 4404.8 5902.2 5920.5 6033.1 6043.7 6056.4 1040.2 1083.1 1083.6 1086.1 1095.5 718.6 729.5 734.1 742.1 759.4 12451.4 12975.3 13155.7 13362.8 13630.0 733.8 737.8 743.4 744.0 748.2 6085.8 6136.5 6159.0 6234.2 6258.2 147190.0 147918.0 149910.3 150015.0 153304.2 128123.0 129817.0 132831.0 133321.0 137428.0 116048.0 118075.0 118622.0 119104.0 120812.0 11673.7 11703.5 11849.4 12074.6 12076.0 53502.7 55379.0 56158.7 56718.4 56834.4 67488.7 67510.3 67582.7 67772.7 68432.7 13893.0 14103.7 14127.2 14174.1 14224.9 16978.4 17277.9 17302.6 17377.3 17397.7 16106.0 16312.3 16315.5 16362.0 16443.8 15808.1 15855.2 15925.8 16012.4 16014.2 15808.5 16057.0 16076.8 16149.1 16155.6 12763.9 12777.9 13061.2 13069.2 13107.7 12273.1 12321.9 12495.4 12544.9 12559.2 04:20:56 INFO - PID 6812 | -------- Summary: end -------- 04:20:56 INFO - PID 6812 | 04:20:57 INFO - TEST-INFO | 6812: exit 0 04:20:57 INFO - TEST-OK | dromaeo_css | took 1108733ms 04:20:57 INFO - TEST-START | kraken 04:20:57 INFO - Initialising browser for kraken test... 04:20:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37922/getInfo.html -profile /tmp/tmpgPKytx/profile 04:20:57 INFO - TEST-INFO | started process 7201 (/builds/slave/test/build/application/firefox/firefox http://localhost:37922/getInfo.html) 04:21:03 INFO - TEST-INFO | 7201: exit 0 04:21:03 INFO - Browser initialized. 04:21:03 INFO - Running cycle 1/1 for kraken test... 04:21:03 INFO - Using env: {'DISPLAY': ':0', 04:21:03 INFO - 'HOME': '/home/cltbld', 04:21:03 INFO - 'JSGC_DISABLE_POISONING': '1', 04:21:03 INFO - 'LANG': 'en_US.UTF-8', 04:21:03 INFO - 'LANGUAGE': 'en_US:en', 04:21:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:21:03 INFO - 'LOGNAME': 'cltbld', 04:21:03 INFO - 'MAIL': '/var/mail/cltbld', 04:21:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:21:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:21:03 INFO - 'MOZ_CRASHREPORTER': '1', 04:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:21:03 INFO - 'MOZ_NO_REMOTE': '1', 04:21:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:03 INFO - 'NO_EM_RESTART': '1', 04:21:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:03 INFO - 'PWD': '/builds/slave/test', 04:21:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:21:03 INFO - 'RUST_BACKTRACE': 'full', 04:21:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:21:03 INFO - 'SHELL': '/bin/bash', 04:21:03 INFO - 'SHLVL': '1', 04:21:03 INFO - 'TERM': 'linux', 04:21:03 INFO - 'TMOUT': '86400', 04:21:03 INFO - 'USER': 'cltbld', 04:21:03 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393', 04:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:03 INFO - '_': '/tools/buildbot/bin/python'} 04:21:03 INFO - TEST-INFO | started process 7405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgPKytx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:04 INFO - PID 7405 | 04:21:04 INFO - PID 7405 | (/builds/slave/test/build/application/firefox/firefox:7457): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:21:04 INFO - PID 7405 | 04:21:14 INFO - PID 7405 | RSS: Main: 160817152 04:21:14 INFO - PID 7405 | 04:21:17 INFO - PID 7405 | Cycle 1(1): loaded http://localhost:37922/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37922/tests/kraken/driver.html?testName=audio-beat-detection) 04:21:18 INFO - PID 7405 | RSS: Main: 166445056 04:21:18 INFO - PID 7405 | 04:21:20 INFO - PID 7405 | Cycle 1(1): loaded http://localhost:37922/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37922/tests/kraken/driver.html?testName=audio-dft) 04:21:21 INFO - PID 7405 | RSS: Main: 166932480 04:21:21 INFO - PID 7405 | 04:21:24 INFO - PID 7405 | Cycle 1(1): loaded http://localhost:37922/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37922/tests/kraken/driver.html?testName=audio-fft) 04:21:25 INFO - PID 7405 | RSS: Main: 161845248 04:21:25 INFO - PID 7405 | 04:21:27 INFO - PID 7405 | Cycle 1(1): loaded http://localhost:37922/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37922/tests/kraken/driver.html?testName=audio-oscillator) 04:21:27 INFO - PID 7405 | RSS: Main: 163209216 04:21:27 INFO - PID 7405 | 04:21:29 INFO - PID 7405 | Cycle 1(1): loaded http://localhost:37922/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37922/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:21:30 INFO - PID 7405 | RSS: Main: 162889728 04:21:30 INFO - PID 7405 | 04:21:33 INFO - PID 7405 | Cycle 1(1): loaded http://localhost:37922/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37922/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:34 INFO - PID 7405 | RSS: Main: 164573184 04:21:34 INFO - PID 7405 | 04:21:37 INFO - PID 7405 | Cycle 1(1): loaded http://localhost:37922/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37922/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:38 INFO - PID 7405 | RSS: Main: 167444480 04:21:38 INFO - PID 7405 | 04:21:40 INFO - PID 7405 | Cycle 1(1): loaded http://localhost:37922/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37922/tests/kraken/driver.html?testName=json-parse-financial) 04:21:41 INFO - PID 7405 | RSS: Main: 166502400 04:21:41 INFO - PID 7405 | 04:21:43 INFO - PID 7405 | Cycle 1(1): loaded http://localhost:37922/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37922/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:21:43 INFO - PID 7405 | RSS: Main: 165855232 04:21:43 INFO - PID 7405 | 04:21:45 INFO - PID 7405 | Cycle 1(1): loaded http://localhost:37922/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37922/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:21:45 INFO - PID 7405 | RSS: Main: 166244352 04:21:45 INFO - PID 7405 | 04:21:47 INFO - PID 7405 | Cycle 1(1): loaded http://localhost:37922/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37922/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:21:48 INFO - PID 7405 | RSS: Main: 165982208 04:21:48 INFO - PID 7405 | 04:21:51 INFO - PID 7405 | Cycle 1(1): loaded http://localhost:37922/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37922/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:21:51 INFO - PID 7405 | RSS: Main: 166281216 04:21:51 INFO - PID 7405 | 04:21:54 INFO - PID 7405 | Cycle 1(1): loaded http://localhost:37922/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37922/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:21:55 INFO - PID 7405 | RSS: Main: 166600704 04:21:55 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | Cycle 1(1): loaded http://localhost:37922/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37922/tests/kraken/driver.html?testName=ai-astar) 04:21:56 INFO - PID 7405 | RSS: Main: 168751104 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | __start_tp_report 04:21:56 INFO - PID 7405 | _x_x_mozilla_page_load 04:21:56 INFO - PID 7405 | _x_x_mozilla_page_load_details 04:21:56 INFO - PID 7405 | |i|pagename|runs| 04:21:56 INFO - PID 7405 | |0;ai-astar;105;105;106;106;108;106;108;107;107;105 04:21:56 INFO - PID 7405 | |1;audio-beat-detection;113;117;114;112;112;114;117;136;112;112 04:21:56 INFO - PID 7405 | |2;audio-dft;161;165;164;163;162;163;163;162;161;166 04:21:56 INFO - PID 7405 | |3;audio-fft;75;73;73;74;73;73;73;76;75;75 04:21:56 INFO - PID 7405 | |4;audio-oscillator;83;82;81;78;76;78;77;77;77;79 04:21:56 INFO - PID 7405 | |5;imaging-gaussian-blur;114;114;114;113;113;113;113;113;110;114 04:21:56 INFO - PID 7405 | |6;imaging-darkroom;148;149;149;148;149;151;151;150;149;152 04:21:56 INFO - PID 7405 | |7;imaging-desaturate;93;94;94;94;94;95;94;94;95;94 04:21:56 INFO - PID 7405 | |8;json-parse-financial;48;45;46;46;45;44;46;43;43;47 04:21:56 INFO - PID 7405 | |9;json-stringify-tinderbox;36;36;37;36;37;36;36;37;36;36 04:21:56 INFO - PID 7405 | |10;stanford-crypto-aes;74;75;72;71;71;72;74;70;72;75 04:21:56 INFO - PID 7405 | |11;stanford-crypto-ccm;115;107;111;111;109;112;113;115;113;110 04:21:56 INFO - PID 7405 | |12;stanford-crypto-pbkdf2;153;154;163;154;155;154;152;157;155;161 04:21:56 INFO - PID 7405 | |13;stanford-crypto-sha256-iterative;62;60;58;59;64;59;59;57;69;58 04:21:56 INFO - PID 7405 | __end_tp_report 04:21:56 INFO - PID 7405 | __start_cc_report 04:21:56 INFO - PID 7405 | _x_x_mozilla_cycle_collect,888 04:21:56 INFO - PID 7405 | __end_cc_report 04:21:56 INFO - PID 7405 | __startTimestamp1504956116963__endTimestamp 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | ------- Summary: start ------- 04:21:56 INFO - PID 7405 | Number of tests: 14 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | [#0] ai-astar Cycles:10 Average:106.30 Median:106.50 stddev:1.16 (1.1%) stddev-sans-first:1.13 04:21:56 INFO - PID 7405 | Values: 105.0 105.0 106.0 106.0 108.0 106.0 108.0 107.0 107.0 105.0 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | [#1] audio-beat-detection Cycles:10 Average:115.90 Median:114.00 stddev:7.32 (6.4%) stddev-sans-first:7.69 04:21:56 INFO - PID 7405 | Values: 113.0 117.0 114.0 112.0 112.0 114.0 117.0 136.0 112.0 112.0 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.63 (1.0%) stddev-sans-first:1.56 04:21:56 INFO - PID 7405 | Values: 161.0 165.0 164.0 163.0 162.0 163.0 163.0 162.0 161.0 166.0 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | [#3] audio-fft Cycles:10 Average:74.00 Median:74.50 stddev:1.15 (1.5%) stddev-sans-first:1.17 04:21:56 INFO - PID 7405 | Values: 75.0 73.0 73.0 74.0 73.0 73.0 73.0 76.0 75.0 75.0 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:78.50 stddev:2.39 (3.1%) stddev-sans-first:2.00 04:21:56 INFO - PID 7405 | Values: 83.0 82.0 81.0 78.0 76.0 78.0 77.0 77.0 77.0 79.0 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.50 stddev:1.20 (1.1%) stddev-sans-first:1.22 04:21:56 INFO - PID 7405 | Values: 114.0 114.0 114.0 113.0 113.0 113.0 113.0 113.0 110.0 114.0 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:149.50 stddev:1.35 (0.9%) stddev-sans-first:1.30 04:21:56 INFO - PID 7405 | Values: 148.0 149.0 149.0 148.0 149.0 151.0 151.0 150.0 149.0 152.0 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 04:21:56 INFO - PID 7405 | Values: 93.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | [#8] json-parse-financial Cycles:10 Average:45.30 Median:46.00 stddev:1.64 (3.6%) stddev-sans-first:1.41 04:21:56 INFO - PID 7405 | Values: 48.0 45.0 46.0 46.0 45.0 44.0 46.0 43.0 43.0 47.0 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | [#9] json-stringify-tinderbox Cycles:10 Average:36.30 Median:36.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 04:21:56 INFO - PID 7405 | Values: 36.0 36.0 37.0 36.0 37.0 36.0 36.0 37.0 36.0 36.0 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | [#10] stanford-crypto-aes Cycles:10 Average:72.60 Median:73.00 stddev:1.78 (2.4%) stddev-sans-first:1.81 04:21:56 INFO - PID 7405 | Values: 74.0 75.0 72.0 71.0 71.0 72.0 74.0 70.0 72.0 75.0 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | [#11] stanford-crypto-ccm Cycles:10 Average:111.60 Median:112.50 stddev:2.55 (2.3%) stddev-sans-first:2.39 04:21:56 INFO - PID 7405 | Values: 115.0 107.0 111.0 111.0 109.0 112.0 113.0 115.0 113.0 110.0 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.80 Median:155.00 stddev:3.55 (2.3%) stddev-sans-first:3.62 04:21:56 INFO - PID 7405 | Values: 153.0 154.0 163.0 154.0 155.0 154.0 152.0 157.0 155.0 161.0 04:21:56 INFO - PID 7405 | 04:21:56 INFO - PID 7405 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:59.50 stddev:3.63 (6.1%) stddev-sans-first:3.81 04:21:56 INFO - PID 7405 | Values: 62.0 60.0 58.0 59.0 64.0 59.0 59.0 57.0 69.0 58.0 04:21:56 INFO - PID 7405 | -------- Summary: end -------- 04:21:56 INFO - PID 7405 | 04:21:57 INFO - PID 7405 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:21:57 INFO - TEST-INFO | 7405: exit 0 04:21:57 INFO - TEST-OK | kraken | took 60352ms 04:21:57 INFO - SUITE-END | took 1169s 04:21:58 INFO - Completed test suite (00:19:29) 04:21:58 INFO - javascript benchmark 04:21:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9015.93979311987, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3861.517310336207, 3876.8255428505713, 3879.592642772509, 3882.650561449469, 3896.415537669351, 6160.19917410736, 6295.716692748826, 6311.053341998702, 6332.936670633292, 6382.234131904178, 6367.458766004896, 6379.17070780799, 6391.360863913618, 6402.487800975922, 6460.966245400748, 5646.661200327973, 5665.745041473144, 5674.631148975324, 5734.827955161351, 5736.11090281005, 5572.359178694442, 5667.319921609413, 5688.459596338341, 5747.396523365049, 5766.740496677659, 5634.915476267859, 5640.097584386499, 5664.753754174075, 5699.515541179005, 5711.657300561979, 5643.097104463307, 5659.094544872801, 5718.628289161191, 5727.885442291173, 5732.971335143339, 5596.972015139898, 5636.859078523029, 5638.774449022034, 5668.943310566883, 5682.516986056149, 6170.907436388457, 6251.874962500725, 6290.150829637986, 6290.308066112724, 6305.558610897239, 6774.458043356569, 6784.7964561063245, 6866.759663411806, 6867.3476019778045, 6877.140357455318, 6782.559133656346, 6871.896921546181, 6885.793426197222, 6893.379595836349, 6965.895511567331, 6328.145700330489, 6377.1709677742065, 6399.648019358933, 6435.710393032325, 6437.871242575122, 6884.105066341343, 7046.084009078787, 7057.294270572902, 7059.329363710439, 7070.151581810215, 6701.564398314094, 6719.260881303053, 6746.359095885883, 6794.8301292467095, 6810.216825065181, 6927.93072069283, 6941.930580694229, 6943.340382663639, 6948.478864085214, 6985.371316581431, 6811.625360605214, 6882.242953275136, 6884.931150688529, 6887.345702158287, 6896.413804826546, 6749.190097188369, 6759.053732477457, 6848.3494068063455, 6932.480063995221, 6936.4797640177185, 4913.950860491421, 4916.950830491649, 4925.1873440881855, 4926.950730492649, 4928.285398617252, 4485.641148708096, 4500.459944806578, 4510.0979804039325, 4524.049949510574, 4542.477615074243, 6181.938180618226, 6265.749370025148, 6313.905291420632, 6318.147050148171, 6362.491000719931, 6688.331166883273, 6740.157480314961, 6756.560823546453, 6829.965850170717, 6843.110395648534, 6127.448529632355, 6145.8156255312415, 6234.064890266496, 6240.4071613196675, 6267.96866015667, 5448.809291674773, 5521.4478552144465, 5529.0324193266015, 5529.944700553024, 5538.86152846174, 7014.438844892396, 7117.395021423237, 7132.108486439195, 7215.458840586872, 7225.169105552824, 6683.899741503784, 6759.087523184504, 6763.0, 6848.657567121723, 6860.656967151723, 7116.217216106328, 7179.317964793545, 7197.0, 7206.135263768381, 7211.062561867134, 6768.0, 6780.69486873082, 6828.897566536605, 6900.206476255295, 6912.688928998307, 6671.566348187546, 6813.148356455443, 6827.487938404739, 6908.93091069103, 6918.896216556856, 6583.967080164569, 6599.9010014848855, 6601.0, 6603.339666033358, 6603.570767900071, 6615.834604134935, 6637.0, 6650.667466626553, 6665.433438157811, 6696.497762667722, 6456.418922296828, 6459.580127291711, 6483.513736469689, 6525.086487891794, 6568.573042752206, 6478.1578394808375, 6579.374959378852, 6627.271000189879, 6637.668116594247, 6730.226024007302, 6466.773662921775, 6517.4134327910715, 6539.836504087436, 6543.967280163569, 6557.278699342973], "value": 6240.049752797724, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [933.8412469880118, 942.1897168435145, 960.4717405427016, 991.0, 995.5818556206392, 44642.33036504451, 45494.54505454949, 45521.77239113804, 45601.0, 45630.08739825201, 45882.08235835281, 46929.76535117328, 46937.76531117348, 46963.76518117413, 46985.53014469854, 8028.718994835182, 8127.146649601796, 8139.918600814005, 8143.42995990278, 8170.632321545515, 7980.481268717544, 8085.110637829834, 8105.06791718954, 8106.310963568104, 8107.594620268992, 8124.6343914523695, 8127.349812015054, 8144.104148543655, 8147.388945829057, 8152.225538573826, 8092.797680057986, 8111.107778144399, 8122.796930076736, 8128.7561373158605, 8130.837383252331, 7992.200779922019, 8003.999500062492, 8021.037475502919, 8041.276285134366, 8043.879341809878, 41188.58811411878, 41244.38133428001, 41301.1739765206, 41363.586364136274, 41578.37632435516, 3740.4763333133383, 3741.158239396141, 3741.906452338686, 3753.3619284721663, 3765.2093060457337, 33952.83023584891, 33957.830210848784, 33973.15067123317, 34020.0, 34029.6597034029, 5500.28496295483, 5502.2296878437055, 5509.0, 5512.586556008276, 5537.363203231599, 222609.0, 222822.0, 222866.0, 223017.0, 223188.0, 52837.0, 52850.73574632102, 52959.470405296226, 53041.469585303654, 53088.203676944875, 54892.17661735077, 55114.72442637761, 55152.72423637936, 55176.44823551713, 55253.723731381084, 17761.911190444225, 17814.287428502976, 17864.0, 17871.463856084338, 17871.642567148843, 14602.926985365006, 14626.488072917396, 14639.194844283667, 14643.12141271527, 14644.12135271887, 13855.653608659864, 14269.429222831179, 14341.85658143426, 14371.13773173613, 14479.493217737328, 5091.567216786615, 5154.690718556899, 5171.844844654666, 5196.636235463481, 5346.652467589594, 1031.8134145732467, 1040.6045702633103, 1062.0335494699787, 1064.095518809006, 1075.8816530181673, 25161.874190629296, 25205.495890082097, 25206.621900671504, 25248.242552723448, 25389.0, 1144.988550114505, 1146.220570012383, 1160.3618010094415, 1162.1806626328419, 1207.02834218455, 13238.73522529544, 13250.801237981437, 13298.069135160446, 13417.322834645669, 13435.798463023062, 281431.0, 285092.0, 285363.0, 286542.0, 286989.0, 62229.688851556355, 63422.68288658527, 63620.36379636237, 63724.681376592824, 63790.68104659447, 1458.5915943535827, 1512.3950419831936, 1518.6431188670654, 1520.1715065289222, 1535.7807967486874, 30401.23996900095, 30814.229644258176, 31013.0, 31109.0, 31178.844105780234, 40670.59329406668, 40899.591004089576, 40921.79539102405, 41017.58982410138, 41062.99999999881, 235505.40225690228, 236029.0, 236244.0, 236544.0, 237157.0, 35756.74851380189, 36066.27867442689, 36123.819380902925, 36170.638293617776, 36530.26939461143, 46120.0, 46161.76919115383, 46549.767251163525, 46723.76638116788, 46841.53158468372, 34338.31323373569, 34611.48082778811, 35375.23123843746, 35443.11392215112, 35734.8213258932, 34462.655373445945, 34595.82702086474, 34646.48030279598, 34884.65115348814, 35065.47401788924, 39769.80115099406, 41126.383104254055, 41242.58757412388, 41709.374359384026, 41736.79131604323, 33330.83334583312, 33578.49632255567, 33843.323133537684, 33964.0, 34190.0, 24961.0015599374, 25141.0, 25254.116105936206, 25293.494130116927, 25498.0], "value": 18714.64750049967, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.2876604925016, 600.4565867889559, 607.1712112965802, 607.3076692570468, 623.4731651754267, 23196.188133415333, 24156.516869662595, 24214.0, 24233.0, 24244.636330455036, 24868.253952381456, 26619.334516637045, 26885.327866803338, 26901.192964211106, 26985.73014269857, 6445.742170313182, 6626.801195964129, 6628.900566491507, 6636.236832764245, 6640.435562977129, 6472.190976127984, 6494.090827284161, 6566.8686626267445, 6636.933630663704, 6669.0, 6647.169103862017, 6650.634215118166, 6653.135092437977, 6655.733770649168, 6658.30087840777, 6651.068850360954, 6663.16710411201, 6665.266820649725, 6668.833279168011, 6671.199456065255, 6193.4425901669065, 6215.595986260923, 6219.253689557237, 6234.844128896814, 6236.563440559163, 30311.393772124433, 30724.0, 30996.690033099607, 31089.84455077733, 31278.530822037686, 2262.0386335807216, 2287.2452090809993, 2287.565362581104, 2289.278877153691, 2290.484640955788, 20106.597868042558, 20547.691784623094, 20829.79170208309, 21430.464238394008, 21545.0, 2529.8229123961332, 2542.9491410171877, 2570.498752743216, 2586.2241327601832, 2591.5464793661035, 143856.0, 149754.0, 155988.22005889897, 163725.18137409355, 164564.0, 16021.43924962644, 16446.424375146813, 16615.833841661428, 16923.746143807854, 17045.40341088056, 25982.0, 25997.74002259991, 26059.73940260573, 26104.60843087355, 26121.477570448485, 10883.78232435347, 10974.902509748961, 11109.0, 11192.160587955774, 11199.160062995308, 10121.544530496145, 10168.745781355377, 10220.846687299696, 10282.691519254435, 10294.433806140734, 9687.66093186735, 9956.0, 9990.40057596532, 10002.699919002442, 10279.486025698685, 2776.319801648609, 2830.2216890355317, 2886.270752556174, 2911.315840777416, 2973.8439631267156, 1045.430240518919, 1049.58541376156, 1052.231870734353, 1054.6466933577337, 1058.5289546152042, 20932.790672093084, 21777.23779667704, 21813.0, 21913.452163696034, 22189.11243550272, 1098.357460885391, 1111.2776695148218, 1118.2898859224288, 1118.78743038824, 1121.2319561100671, 11710.590129345432, 11968.640940771791, 12090.09324300681, 12130.818037729441, 12318.322492262832, 580178.0, 600644.0, 617182.0, 625612.0, 629514.0, 132361.0, 132391.0, 134654.0, 137558.0, 137820.31089844488, 1127.813910704741, 1174.9353785541878, 1219.4878151176526, 1229.6372570091844, 1271.1800888426912, 21943.341699749035, 22497.5500489986, 22503.0, 22584.983675734304, 22630.66054009224, 62762.686186568775, 63468.0, 63638.0, 63704.68147659232, 64664.67667661631, 81097.0, 81559.59220204098, 81587.0, 81697.0, 81830.59084704539, 14719.411223551366, 15076.924615376853, 15657.982231154938, 15679.843201567839, 15767.0, 23944.88027559851, 24149.879250603633, 24175.51648967046, 24292.271231863073, 24306.75693243045, 18126.18432170582, 19006.809931900505, 19959.900200498905, 20350.28773992903, 20382.388528344174, 15930.0, 17202.225899834288, 17389.565260868578, 17441.127943603024, 17606.647867042844, 18897.811021889604, 18990.905045474683, 19461.708074378614, 19479.0, 20490.897545512176, 15341.923290383476, 15426.0, 15466.381344746535, 15531.922340388226, 15540.300686469362, 19289.8071019288, 19429.319973800848, 19621.901890490455, 19652.901735491232, 19657.705134422707], "value": 12910.901824416367, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.7050119474911, 1455.2796365798931, 1462.6343414146468, 1463.817022872141, 1464.78760579716, 16536.586585335357, 17116.74324885126, 17133.400330988417, 17148.571285717833, 17185.656286874255, 16656.83343166568, 16719.749203761952, 16754.0, 16757.0, 16802.579935501617, 2637.9340516487096, 2772.639556857606, 2779.291280723423, 2779.4163225722523, 2780.5968134620466, 2605.8566778827158, 2739.52058389781, 2771.722827717222, 2778.4304217635336, 2779.4163225722623, 2749.6562929633797, 2763.5163846326814, 2766.7233276672373, 2769.9307517312027, 2773.88904443822, 2657.0567448555776, 2677.0, 2690.730926907313, 2696.150712525568, 2701.810873238874, 2644.947101057968, 2659.188947371051, 2737.2609395463314, 2741.972580274192, 2758.8068835181543, 16403.58991025222, 16518.66962660752, 16538.83461165385, 16554.089525076117, 16559.668806623922, 8017.318527925133, 8271.048829384637, 8276.83446331076, 8280.254777070033, 8282.71010514635, 5501.944980550184, 5713.781248007512, 5737.196792449061, 5760.481556659879, 5851.0, 2013.8892360920142, 2033.8305474352308, 2041.2345370486069, 2044.47865794223, 2057.907394167266, 29954.55068173979, 30306.84846575753, 30336.696633033607, 30366.240843978856, 30431.23921901948, 6610.3720146586, 6637.933620663828, 6834.282400347991, 6847.726090956406, 7135.857282854314, 19741.802581974283, 19746.40760777179, 19750.30873919406, 19784.50538736514, 19858.0, 8219.794505137419, 8402.747917562483, 8409.789755256044, 8415.032271288757, 8417.368697347723, 7392.593407362647, 7454.40364770817, 7596.2023987481625, 7625.504342217849, 7635.503692259986, 5300.522952934254, 5456.427075157131, 5459.617826752089, 5482.506574408322, 5534.086875665551, 1617.1887486015737, 1622.3105180298326, 1624.350259896051, 1634.9100799455907, 1658.9253483593268, 928.4939707859232, 953.7472569769017, 958.6548842416724, 963.0898800633474, 972.7422233108091, 8269.503829770232, 8325.375596830261, 8364.874526882102, 8396.748097557083, 8416.663333466593, 776.5263189454429, 784.2236186175645, 784.7606480023647, 786.5477350523357, 797.2625321577517, 5002.549770520671, 5089.4147173074825, 5375.973120134374, 5528.834134975958, 5636.915446268227, 24132.51734965291, 25281.620775688378, 25597.104101356363, 25637.8718106412, 25742.35644108875, 24737.0, 25240.0, 25463.61804572933, 25477.36306592313, 25516.234512964642, 12376.381180940916, 12400.0, 12431.0, 12548.309842958543, 12622.0, 9043.593038313424, 9054.954725226331, 9062.592183351897, 9110.453372797654, 9204.723858284262, 20536.38390848277, 20732.378028659165, 21016.159353626295, 21462.03420846097, 21742.565148697253, 21696.349109526738, 21841.78158218461, 21919.342419727433, 22040.559188815812, 22156.556868862855, 12012.33932133706, 12042.277463352228, 12080.275183489019, 12138.817917731418, 12147.574834880737, 14518.637034074232, 14733.04235224707, 14741.1892345922, 14744.0, 14758.114513129247, 12256.87743122593, 12263.018958483122, 12423.31671758062, 12451.564195253122, 12527.436265368262, 11825.82261266099, 11916.880831191924, 11928.701782455508, 12155.939220303842, 12209.816852747039, 10438.373697577867, 10446.425446600206, 10596.788064238517, 10627.574897004033, 10635.627753028606, 7966.641501132347, 8022.9197708022175, 8068.749343851712, 8082.070561885458, 8150.633221504928, 8004.239597238253, 8029.759107226559, 8067.556284404414, 8184.672613095409, 8186.09952905168], "value": 7109.043127033288, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.3404547520239, 554.37078915431, 565.4430386069723, 575.234937533081, 582.798934367643, 6133.478654314383, 6190.288116866556, 6247.564229397128, 6249.187605611275, 6278.434940855322, 6136.601120927136, 6147.815565533041, 6162.815115546529, 6183.650212919085, 6216.378362163781, 5017.573506251973, 5108.8978220435565, 5113.130767769489, 5118.053160165363, 5118.257852611369, 4829.517048295177, 4900.901981960359, 4918.409790825088, 4967.627427942901, 5076.949230507685, 4819.1325561398935, 4879.487653796354, 4889.559939605435, 4892.8532144035735, 4902.142125128088, 4835.419749630032, 4855.781489832966, 4880.999395123991, 4902.632302577304, 4906.0, 4333.696641235115, 4418.911621767579, 4456.131054444385, 4482.708623939434, 4519.796609152563, 6108.480779133779, 6131.9386806131815, 6139.38606139387, 6148.647297594522, 6196.225471816023, 5741.138829175616, 5816.447437493473, 5847.7953271635715, 5851.912221316684, 5859.8535036624, 6544.901826472606, 6570.967145164292, 6590.0, 6606.8348291293105, 6612.93387066128, 4787.521247875219, 5022.522860328263, 5027.918997415573, 5044.445111037783, 5055.595552355802, 6727.226368967583, 6736.797896063126, 6843.931560684379, 6899.310068993111, 6972.825679357955, 5603.327600687943, 5616.438356164433, 5633.774649013993, 5647.858803529944, 5650.519705825051, 5710.8863771564975, 5724.141378793214, 5724.398938111438, 5791.131330300404, 5791.449812267828, 6021.6989150542295, 6045.848853778691, 6104.542159338067, 6140.846478837975, 6149.569530132848, 6661.26726060133, 6663.9004564247325, 6668.633225172565, 6690.799276021728, 6701.564398314094, 1975.7332760077493, 1979.2775636892432, 1999.2902519605332, 2003.8096380843797, 2008.4175589079002, 1436.755751522223, 1494.6338147154017, 1504.7893294938717, 1515.2953876447505, 1542.7994360733032, 6054.697265136813, 6083.148359229712, 6083.574149809471, 6103.35914728956, 6164.568480206342, 6596.637184954873, 6634.303398143222, 6666.633335166515, 6667.599944003376, 6696.0, 6073.423024812724, 6077.787277445268, 6138.710870717199, 6168.383161683796, 6192.907106393408, 3483.512308276843, 3506.316268327703, 3529.858805647745, 3532.8586856525967, 3539.8053107078845, 6934.341237582422, 7070.681819318143, 7076.540024898365, 7085.362317391459, 7105.928940710527, 6977.616231107338, 6982.755603553851, 6987.371136597731, 6991.580505169706, 7034.5427547209265, 6878.38094571491, 6958.860822783618, 7005.299470052954, 7007.6846541904715, 7053.470989675795, 6578.210614726264, 6604.669766511752, 6644.036614690746, 6651.268360480247, 6714.52998290115, 6573.934260657332, 6631.0, 6649.700763465559, 6652.567583107082, 6731.966340168267, 7048.647567621701, 7057.941308803721, 7087.468439866928, 7117.3238542338395, 7122.643867806485, 5616.5787565931905, 5648.57635677334, 5672.5745569081655, 5682.692980614399, 5699.287589051369, 6544.9672751635935, 6651.733930642914, 6658.533902626769, 6775.220849602161, 6833.521653484408, 6260.217472815898, 6404.839879002876, 6412.9358706414205, 6509.511786616117, 6564.409203171737, 6475.417212450902, 6505.544611877123, 6534.542582019213, 6537.444317232898, 6558.278589355263, 6423.197100362455, 6443.130177425987, 6450.354964503512, 6494.837629059311, 6496.123023391781, 6503.25212600557, 6527.715299645086, 6596.736130554724, 6602.953084543807, 6631.602103873783, 6159.353267906985, 6241.656708881055, 6244.65654389013, 6307.463865571478, 6332.810015699536], "value": 5228.400642886706, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [953.4946478366468, 964.2286171063149, 971.0968799016912, 973.3305438496872, 979.1298619636495, 20505.0, 20741.0, 21817.127314907426, 21822.563548729016, 21899.67150492744, 19969.900150499263, 20223.191072357124, 20326.69509957348, 21253.787462125412, 22042.33872983813, 1056.4770438632868, 1062.8724553053644, 1066.4188017530425, 1069.4011353641947, 1069.6577095329499, 1045.8797238317616, 1074.511097450658, 1078.8543546621183, 1079.3254216114929, 1079.773247618001, 1125.6904351303376, 1125.9324440533553, 1126.752114534805, 1126.8028095083368, 1135.4663308245113, 1113.6603335982481, 1114.6656003199007, 1115.9609413670523, 1117.1732917640968, 1132.4960392625285, 825.8843761873343, 826.8925039744795, 828.7555171224503, 828.8300898315831, 835.6907944060675, 18001.369952051617, 18812.905935470237, 18930.621387572308, 18942.052897355075, 18987.525311867175, 20710.89644551783, 20842.166313347447, 21254.787452125434, 21255.5748885023, 21262.78737212639, 18137.0, 18379.632407351914, 18429.815701842945, 18483.537911552183, 18564.814351856443, 3842.1931394407206, 3932.4494570760116, 3953.3872249801325, 3965.980170099131, 3970.980145099285, 157962.0, 159760.20119899441, 161293.0, 161483.0, 162390.188049059, 15449.382024718885, 15766.842331576767, 15983.520494384955, 16044.75932861008, 16136.75794863078, 28970.27574310617, 30826.383472330428, 30945.69054309473, 30957.0, 31012.379752404824, 8692.478451292942, 8782.165694259034, 8790.42862213954, 8793.164649358301, 8801.25189358899, 4313.309870420718, 4337.414449049401, 4377.058932329564, 4393.055493069006, 4404.823807047682, 5902.2327097477055, 5920.526357891358, 6033.125196846433, 6043.667598282049, 6056.4246396593135, 1040.1886528507775, 1083.0685610375072, 1083.6369816111692, 1086.1256688365784, 1095.4905968724581, 718.6263143165525, 729.5258082246582, 734.1227233455969, 742.1354122447289, 759.4418102694515, 12451.447453272058, 12975.286359250144, 13155.73688526224, 13362.799558006638, 13630.0, 733.8275505256261, 737.7602279259262, 743.4424181863602, 743.9814004649927, 748.2106377771503, 6085.847853803691, 6136.5090792737365, 6159.0, 6234.220722409699, 6258.217722784652, 147190.0, 147918.0, 149910.25044874707, 150015.0, 153304.23347883188, 128123.0, 129817.0, 132831.0, 133321.0, 137428.0, 116048.0, 118075.0, 118622.0, 119104.0, 120811.99999999824, 11673.708157296136, 11703.531858725897, 11849.407529623657, 12074.637760867188, 12076.0, 53502.73248633888, 55379.0, 56158.71920640534, 56718.432815671316, 56834.431655682914, 67488.66255668887, 67510.32489675237, 67582.66208668925, 67772.661136694, 68432.6578367105, 13893.027488075737, 14103.717925641224, 14127.15237085778, 14174.14955102697, 14224.857751422767, 16978.40575579849, 17277.913610431868, 17302.5674358137, 17377.304907803547, 17397.739033914753, 16106.0, 16312.265948032604, 16315.51053468398, 16362.0, 16443.83556164423, 15808.130552819704, 15855.20723963774, 15925.761113583074, 16012.439564615182, 16014.199290035218, 15808.52574422769, 16057.0, 16076.839231608003, 16149.111798850707, 16155.596110097342, 12763.936180319039, 12777.93611031976, 13061.21632702041, 13069.15050521713, 13107.737845243233, 12273.07951903593, 12321.93839030799, 12495.375231238584, 12544.87455125437, 12559.246445213317], "value": 9583.691774897487, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1376.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 106.0, 106.0, 108.0, 106.0, 108.0, 107.0, 107.0, 105.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 114.0, 112.0, 112.0, 114.0, 117.0, 136.0, 112.0, 112.0], "value": 115.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 164.0, 163.0, 162.0, 163.0, 163.0, 162.0, 161.0, 166.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 73.0, 74.0, 73.0, 73.0, 73.0, 76.0, 75.0, 75.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 81.0, 78.0, 76.0, 78.0, 77.0, 77.0, 77.0, 79.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 110.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 148.0, 149.0, 151.0, 151.0, 150.0, 149.0, 152.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 45.0, 46.0, 46.0, 45.0, 44.0, 46.0, 43.0, 43.0, 47.0], "value": 45.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 37.0, 36.0, 37.0, 36.0, 36.0, 37.0, 36.0, 36.0], "value": 36.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 72.0, 71.0, 71.0, 72.0, 74.0, 70.0, 72.0, 75.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 111.0, 111.0, 109.0, 112.0, 113.0, 115.0, 113.0, 110.0], "value": 111.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 163.0, 154.0, 155.0, 154.0, 152.0, 157.0, 155.0, 161.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 58.0, 59.0, 64.0, 59.0, 59.0, 57.0, 69.0, 58.0], "value": 60.5, "unit": "score"}]}]} 04:21:58 INFO - Return code: 0 04:21:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:21:58 INFO - # TBPL SUCCESS # 04:21:58 INFO - Running post-action listener: _package_coverage_data 04:21:58 INFO - Running post-action listener: _resource_record_post_action 04:21:58 INFO - [mozharness: 2017-09-09 11:21:58.290003Z] Finished run-tests step (success) 04:21:58 INFO - Running post-run listener: _resource_record_post_run 04:21:58 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 300331008; Read time: 8; Write time: 229880 04:21:58 INFO - TinderboxPrint: CPU usage
13.1% 04:21:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:21:58 INFO - TinderboxPrint: I/O write bytes / time
300,331,008 / 229,880 04:21:58 INFO - TinderboxPrint: CPU idle
8,220.9 (86.9%) 04:21:58 INFO - TinderboxPrint: CPU user
1,185.0 (12.5%) 04:21:58 INFO - TinderboxPrint: Swap in / out
0 / 0 04:21:58 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12574720; Read time: 0; Write time: 1808 04:21:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:21:58 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287756288; Read time: 8; Write time: 228072 04:21:58 INFO - Running post-run listener: _upload_blobber_files 04:21:58 INFO - Blob upload gear active. 04:21:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:21:58 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 04:21:58 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'] 04:21:58 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 04:21:59 INFO - (blobuploader) - INFO - Open directory for files ... 04:21:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:21:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:22:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:00 INFO - (blobuploader) - INFO - Done attempting. 04:22:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:22:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:22:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:01 INFO - (blobuploader) - INFO - Done attempting. 04:22:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:22:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:22:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:02 INFO - (blobuploader) - INFO - Done attempting. 04:22:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:22:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:22:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:08 INFO - (blobuploader) - INFO - Done attempting. 04:22:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:22:09 INFO - Return code: 0 04:22:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:22:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:22:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ee3b28c25edffe6ebfbb6d481166c21a78967a33d63ede1f50f4ca438ed7ea566820b33676a459ecb16ddd3177fb9101f7c8e82226054c02a22478c68365513", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e7308164c99d67e6fbbfedc5b1e35508ba8b568e356f59d8dd9e56132ee3f9ade89369726f912ed3a8280f16c4e5aeb566523c94482ade150c851903e046203", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/457818788b257a376cb6490dda1230b61fe68a2e7a6cde633aa7ccedff1eee061d08a66f6f4a9ca0e03a478e20dd4857e8166984da5224ea681306ae9b5a6fc1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e0763847f19dfe7efead0ac0daf5010ba0b06fa8d687f1414f7743abb4de595de6a3d1c8c3ea0fdff261ec7184679a443b6d00299fa0f6e3e214879269e00fc"} 04:22:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:22:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:22:09 INFO - Contents: 04:22:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ee3b28c25edffe6ebfbb6d481166c21a78967a33d63ede1f50f4ca438ed7ea566820b33676a459ecb16ddd3177fb9101f7c8e82226054c02a22478c68365513", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e7308164c99d67e6fbbfedc5b1e35508ba8b568e356f59d8dd9e56132ee3f9ade89369726f912ed3a8280f16c4e5aeb566523c94482ade150c851903e046203", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/457818788b257a376cb6490dda1230b61fe68a2e7a6cde633aa7ccedff1eee061d08a66f6f4a9ca0e03a478e20dd4857e8166984da5224ea681306ae9b5a6fc1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e0763847f19dfe7efead0ac0daf5010ba0b06fa8d687f1414f7743abb4de595de6a3d1c8c3ea0fdff261ec7184679a443b6d00299fa0f6e3e214879269e00fc"} 04:22:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:22:09 INFO - Copying logs to upload dir... 04:22:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:22:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.049695 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-09 04:22:09.141765) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 04:22:09.149238) ========= 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=781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ee3b28c25edffe6ebfbb6d481166c21a78967a33d63ede1f50f4ca438ed7ea566820b33676a459ecb16ddd3177fb9101f7c8e82226054c02a22478c68365513", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e7308164c99d67e6fbbfedc5b1e35508ba8b568e356f59d8dd9e56132ee3f9ade89369726f912ed3a8280f16c4e5aeb566523c94482ade150c851903e046203", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/457818788b257a376cb6490dda1230b61fe68a2e7a6cde633aa7ccedff1eee061d08a66f6f4a9ca0e03a478e20dd4857e8166984da5224ea681306ae9b5a6fc1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e0763847f19dfe7efead0ac0daf5010ba0b06fa8d687f1414f7743abb4de595de6a3d1c8c3ea0fdff261ec7184679a443b6d00299fa0f6e3e214879269e00fc"} build_url:https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ee3b28c25edffe6ebfbb6d481166c21a78967a33d63ede1f50f4ca438ed7ea566820b33676a459ecb16ddd3177fb9101f7c8e82226054c02a22478c68365513", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e7308164c99d67e6fbbfedc5b1e35508ba8b568e356f59d8dd9e56132ee3f9ade89369726f912ed3a8280f16c4e5aeb566523c94482ade150c851903e046203", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/457818788b257a376cb6490dda1230b61fe68a2e7a6cde633aa7ccedff1eee061d08a66f6f4a9ca0e03a478e20dd4857e8166984da5224ea681306ae9b5a6fc1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e0763847f19dfe7efead0ac0daf5010ba0b06fa8d687f1414f7743abb4de595de6a3d1c8c3ea0fdff261ec7184679a443b6d00299fa0f6e3e214879269e00fc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 04:22:09.180146) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:22:09.180506) ========= 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=781b77c4c33858b1f599d705000001c1-1504954558.978751-1783084393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:22:09.229685) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 04:22:09.233009) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 04:22:09.233296) ========= ========= Total master_lag: 0.53 =========