builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1503090621.32 results: success (0) revision: 8febdfacc7160c9ba90ba480e8bf5cd174e4fcab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 14:10:21.323145) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 14:10:21.323564) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 14:10:21.323835) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 14:10:21.333257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 14:10:21.333517) ========= 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=9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-18 14:10:21-- 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% 224M=0s 2017-08-18 14:10:21 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102050 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 14:10:21.450489) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 14:10:21.450787) ========= 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=9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018493 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 14:10:21.502795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-18 14:10:21.503121) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8febdfacc7160c9ba90ba480e8bf5cd174e4fcab --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 8febdfacc7160c9ba90ba480e8bf5cd174e4fcab --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=9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-18 14:10:21,768 truncating revision to first 12 chars 2017-08-18 14:10:21,768 Setting DEBUG logging. 2017-08-18 14:10:21,768 attempt 1/10 2017-08-18 14:10:21,768 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8febdfacc716?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-18 14:10:23,083 unpacking tar archive at: mozilla-central-8febdfacc716/testing/mozharness/ program finished with exit code 0 elapsedTime=1.599967 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-18 14:10:23.120526) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 14:10:23.120843) ========= script_repo_revision: 8febdfacc7160c9ba90ba480e8bf5cd174e4fcab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 14:10:23.124240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 14:10:23.124513) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 14:10:23.135956) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-18 14:10:23.136231) ========= /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=9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:10:23 INFO - MultiFileLogger online at 20170818 14:10:23 in /builds/slave/test 14:10:23 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 14:10:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:10:23 INFO - {'append_to_log': False, 14:10:23 INFO - 'base_work_dir': '/builds/slave/test', 14:10:23 INFO - 'blob_upload_branch': 'Firefox', 14:10:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:10:23 INFO - 'branch': 'Firefox', 14:10:23 INFO - 'buildbot_json_path': 'buildprops.json', 14:10:23 INFO - 'code_coverage': False, 14:10:23 INFO - 'config_files': ('talos/linux_config.py',), 14:10:23 INFO - 'default_actions': ('clobber', 14:10:23 INFO - 'read-buildbot-config', 14:10:23 INFO - 'download-and-extract', 14:10:23 INFO - 'populate-webroot', 14:10:23 INFO - 'create-virtualenv', 14:10:23 INFO - 'install', 14:10:23 INFO - 'setup-mitmproxy', 14:10:23 INFO - 'run-tests'), 14:10:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:10:23 INFO - 'disable_ccov_upload': False, 14:10:23 INFO - 'download_minidump_stackwalk': True, 14:10:23 INFO - 'download_symbols': 'ondemand', 14:10:23 INFO - 'enable_stylo': False, 14:10:23 INFO - 'enable_webrender': False, 14:10:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:10:23 INFO - 'tooltool.py': '/tools/tooltool.py', 14:10:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:10:23 INFO - '/tools/misc-python/virtualenv.py')}, 14:10:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:10:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:10:23 INFO - 'gecko_profile': False, 14:10:23 INFO - 'gecko_profile_interval': 0, 14:10:23 INFO - 'installer_path': 'installer.exe', 14:10:23 INFO - 'log_level': 'info', 14:10:23 INFO - 'log_name': 'talos', 14:10:23 INFO - 'log_to_console': True, 14:10:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:10:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:10:23 INFO - 'opt_config_files': (), 14:10:23 INFO - 'pip_index': False, 14:10:23 INFO - 'suite': 'dromaeojs-e10s', 14:10:23 INFO - 'system_bits': '32', 14:10:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:10:23 INFO - 'title': 'talos-linux64-ix-088', 14:10:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:10:23 INFO - 'use_talos_json': True, 14:10:23 INFO - 'verify': 'False', 14:10:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:10:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:10:23 INFO - 'work_dir': 'build'} 14:10:23 INFO - [mozharness: 2017-08-18 21:10:23.542287Z] Running clobber step. 14:10:23 INFO - Running pre-action listener: _resource_record_pre_action 14:10:23 INFO - Running main action method: clobber 14:10:23 INFO - rmtree: /builds/slave/test/build 14:10:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:10:24 INFO - Running post-action listener: _resource_record_post_action 14:10:24 INFO - [mozharness: 2017-08-18 21:10:24.583098Z] Finished clobber step (success) 14:10:24 INFO - [mozharness: 2017-08-18 21:10:24.583194Z] Running read-buildbot-config step. 14:10:24 INFO - Running pre-action listener: _resource_record_pre_action 14:10:24 INFO - Running main action method: read_buildbot_config 14:10:24 INFO - Using buildbot properties: 14:10:24 INFO - { 14:10:24 INFO - "project": "", 14:10:24 INFO - "product": "firefox", 14:10:24 INFO - "who": "kwierso@gmail.com", 14:10:24 INFO - "installer_path": "public/build/target.tar.bz2", 14:10:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 14:10:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:10:24 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 14:10:24 INFO - "stage_platform": "linux64-qr", 14:10:24 INFO - "basedir": "/builds/slave/test", 14:10:24 INFO - "buildnumber": 9, 14:10:24 INFO - "platform": "ubuntu64_hw_qr", 14:10:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:10:24 INFO - "slavebuilddir": "test", 14:10:24 INFO - "taskId": "LbcZEWefTja9FJAEn0eLDQ", 14:10:24 INFO - "branch": "mozilla-central", 14:10:24 INFO - "script_repo_revision": "production", 14:10:24 INFO - "revision": "8febdfacc7160c9ba90ba480e8bf5cd174e4fcab", 14:10:24 INFO - "slavename": "talos-linux64-ix-088", 14:10:24 INFO - "repo_path": "mozilla-central" 14:10:24 INFO - } 14:10:24 INFO - Finding installer, test and symbols from parent task. 14:10:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LbcZEWefTja9FJAEn0eLDQ'}, attempt #1 14:10:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LbcZEWefTja9FJAEn0eLDQ'}, attempt #1 14:10:25 INFO - Task dependencies: QiZA7ovKSU-f1yV-_iZS9A 14:10:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A'}, attempt #1 14:10:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.tar.bz2 14:10:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.test_packages.json 14:10:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.crashreporter-symbols.zip 14:10:25 INFO - Running post-action listener: _resource_record_post_action 14:10:25 INFO - [mozharness: 2017-08-18 21:10:25.921344Z] Finished read-buildbot-config step (success) 14:10:25 INFO - [mozharness: 2017-08-18 21:10:25.921603Z] Running download-and-extract step. 14:10:25 INFO - Running pre-action listener: _resource_record_pre_action 14:10:25 INFO - Running main action method: download_and_extract 14:10:25 INFO - mkdir: /builds/slave/test/build/tests 14:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:25 INFO - trying https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.test_packages.json 14:10:25 INFO - Downloading https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:10:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:10:26 INFO - Downloaded 989 bytes. 14:10:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:10:26 INFO - Using the following test package requirements: 14:10:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:10:26 INFO - u'common': [u'target.common.tests.zip'], 14:10:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:10:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:10:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:10:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:10:26 INFO - u'mozbase': [u'target.common.tests.zip'], 14:10:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:10:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:10:26 INFO - u'web-platform': [u'target.common.tests.zip', 14:10:26 INFO - u'target.web-platform.tests.tar.gz'], 14:10:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:10:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:10:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.common.tests.zip 14:10:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:10:26 INFO - Fetch https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.common.tests.zip into memory 14:10:27 INFO - Content-Length response header: 54002232 14:10:27 INFO - Bytes received: 54002232 14:10:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:10:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.common.tests.zip 14:10:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:10:38 INFO - Fetch https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.common.tests.zip into memory 14:10:39 INFO - Content-Length response header: 54002232 14:10:39 INFO - Bytes received: 54002232 14:10:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.talos.tests.zip 14:10:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:10:51 INFO - Fetch https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.talos.tests.zip into memory 14:10:52 INFO - Content-Length response header: 14496256 14:10:52 INFO - Bytes received: 14496256 14:10: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')]} 14:10:52 INFO - trying https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.tar.bz2 14:10:52 INFO - Downloading https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:10:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:10:53 INFO - Downloaded 62357354 bytes. 14:10:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.tar.bz2 14:10:53 INFO - mkdir: /builds/slave/test/properties 14:10:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:10:53 INFO - Writing to file /builds/slave/test/properties/build_url 14:10:53 INFO - Contents: 14:10:53 INFO - build_url:https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.tar.bz2 14:10:53 INFO - Running post-action listener: _resource_record_post_action 14:10:53 INFO - Running post-action listener: find_tests_for_verification 14:10:53 INFO - Running post-action listener: set_extra_try_arguments 14:10:53 INFO - [mozharness: 2017-08-18 21:10:53.397839Z] Finished download-and-extract step (success) 14:10:53 INFO - [mozharness: 2017-08-18 21:10:53.397935Z] Running populate-webroot step. 14:10:53 INFO - Running pre-action listener: _resource_record_pre_action 14:10:53 INFO - Running main action method: populate_webroot 14:10:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:10:53 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 14:10:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:10:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:10:53 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 14:10:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:10:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:10:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:53 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 14:10:53 INFO - 'talos_options': ['--stylo'], 14:10:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:10:53 INFO - 'tests': ['damp', 'tps']}, 14:10:53 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 14:10:53 INFO - 'talos_options': ['--stylo'], 14:10:53 INFO - 'tests': ['damp', 'tps']}, 14:10:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:10:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:10:53 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 14:10:53 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:10:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:10:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:10:53 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 14:10:53 INFO - 'talos_options': ['--stylo'], 14:10:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:10:53 INFO - 'other-e10s': {'tests': ['a11yr', 14:10:53 INFO - 'ts_paint', 14:10:53 INFO - 'tpaint', 14:10:53 INFO - 'sessionrestore', 14:10:53 INFO - 'sessionrestore_many_windows', 14:10:53 INFO - 'sessionrestore_no_auto_restore', 14:10:53 INFO - 'tabpaint']}, 14:10:53 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 14:10:53 INFO - 'tests': ['a11yr', 14:10:53 INFO - 'ts_paint', 14:10:53 INFO - 'tpaint', 14:10:53 INFO - 'sessionrestore', 14:10:53 INFO - 'sessionrestore_many_windows', 14:10:53 INFO - 'sessionrestore_no_auto_restore', 14:10:53 INFO - 'tabpaint']}, 14:10:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:10:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 14:10:53 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 14:10:53 INFO - 'tests': ['bloom_basic_singleton']}, 14:10:53 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 14:10:53 INFO - 'tests': ['bloom_basic']}, 14:10:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:10:53 INFO - 'tsvgr_opacity', 14:10:53 INFO - 'tart', 14:10:53 INFO - 'tscrollx', 14:10:53 INFO - 'tsvg_static']}, 14:10:53 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 14:10:53 INFO - 'tests': ['tsvgx', 14:10:53 INFO - 'tsvgr_opacity', 14:10:53 INFO - 'tart', 14:10:53 INFO - 'tscrollx', 14:10:53 INFO - 'tsvg_static']}, 14:10:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:10:53 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 14:10:53 INFO - 'talos_options': ['--stylo'], 14:10:53 INFO - 'tests': ['tp5o']}, 14:10:53 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:10:53 INFO - 'talos_options': ['--mitmproxy', 14:10:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:10:53 INFO - '--firstNonBlankPaint'], 14:10:53 INFO - 'tests': ['tp6_google', 14:10:53 INFO - 'tp6_youtube', 14:10:53 INFO - 'tp6_amazon', 14:10:53 INFO - 'tp6_facebook']}, 14:10:53 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:10:53 INFO - 'talos_options': ['--stylo', 14:10:53 INFO - '--mitmproxy', 14:10:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:10:53 INFO - '--firstNonBlankPaint'], 14:10:53 INFO - 'tests': ['tp6_google', 14:10:53 INFO - 'tp6_youtube', 14:10:53 INFO - 'tp6_amazon', 14:10:53 INFO - 'tp6_facebook']}, 14:10:53 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:10:53 INFO - 'talos_options': ['--stylo', 14:10:53 INFO - '--stylo-threads=1', 14:10:53 INFO - '--mitmproxy', 14:10:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:10:53 INFO - '--firstNonBlankPaint'], 14:10:53 INFO - 'tests': ['tp6_google', 14:10:53 INFO - 'tp6_youtube', 14:10:53 INFO - 'tp6_amazon', 14:10:53 INFO - 'tp6_facebook']}, 14:10:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:10:53 INFO - 'talos_options': ['--xperf_path', 14:10:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:53 INFO - 'tests': ['tp5n']}, 14:10:53 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 14:10:53 INFO - 'talos_options': ['--stylo', 14:10:53 INFO - '--xperf_path', 14:10:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:53 INFO - 'tests': ['tp5n']}}} 14:10:53 INFO - Running post-action listener: _resource_record_post_action 14:10:53 INFO - [mozharness: 2017-08-18 21:10:53.412090Z] Finished populate-webroot step (success) 14:10:53 INFO - [mozharness: 2017-08-18 21:10:53.412179Z] Running create-virtualenv step. 14:10:53 INFO - Running pre-action listener: _resource_record_pre_action 14:10:53 INFO - Running main action method: create_virtualenv 14:10:53 INFO - Creating virtualenv /builds/slave/test/build/venv 14:10:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:10:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:10:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:10:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:10:53 INFO - Using real prefix '/usr' 14:10:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:10:54 INFO - Installing distribute.............................................................................................................................................................................................done. 14:10:56 INFO - Installing pip.................done. 14:10:56 INFO - Return code: 0 14:10:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:10:56 INFO - Reading from file tmpfile_stdout 14:10:56 INFO - Output received: 14:10:56 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:10:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d130>, '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 0x2a1e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e4c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', '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 14:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:10:56 INFO - Using env: {'DISPLAY': ':0', 14:10:56 INFO - 'HOME': '/home/cltbld', 14:10:56 INFO - 'LANG': 'en_US.UTF-8', 14:10:56 INFO - 'LANGUAGE': 'en_US:en', 14:10:56 INFO - 'LOGNAME': 'cltbld', 14:10:56 INFO - 'MAIL': '/var/mail/cltbld', 14:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:56 INFO - 'MOZ_NO_REMOTE': '1', 14:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:56 INFO - 'NO_EM_RESTART': '1', 14:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:56 INFO - 'PWD': '/builds/slave/test', 14:10:56 INFO - 'SHELL': '/bin/bash', 14:10:56 INFO - 'SHLVL': '1', 14:10:56 INFO - 'TERM': 'linux', 14:10:56 INFO - 'TMOUT': '86400', 14:10:56 INFO - 'USER': 'cltbld', 14:10:56 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', 14:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:56 INFO - '_': '/tools/buildbot/bin/python'} 14:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:10:56 INFO - Cleaning up... 14:10:56 INFO - Return code: 0 14:10:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d130>, '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 0x2a1e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e4c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', '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 14:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:10:56 INFO - Using env: {'DISPLAY': ':0', 14:10:56 INFO - 'HOME': '/home/cltbld', 14:10:56 INFO - 'LANG': 'en_US.UTF-8', 14:10:56 INFO - 'LANGUAGE': 'en_US:en', 14:10:56 INFO - 'LOGNAME': 'cltbld', 14:10:56 INFO - 'MAIL': '/var/mail/cltbld', 14:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:56 INFO - 'MOZ_NO_REMOTE': '1', 14:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:56 INFO - 'NO_EM_RESTART': '1', 14:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:56 INFO - 'PWD': '/builds/slave/test', 14:10:56 INFO - 'SHELL': '/bin/bash', 14:10:56 INFO - 'SHLVL': '1', 14:10:56 INFO - 'TERM': 'linux', 14:10:56 INFO - 'TMOUT': '86400', 14:10:56 INFO - 'USER': 'cltbld', 14:10:56 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', 14:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:56 INFO - '_': '/tools/buildbot/bin/python'} 14:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:56 INFO - Downloading/unpacking psutil>=3.1.1 14:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:10:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:57 INFO - Installing collected packages: psutil 14:10:57 INFO - Running setup.py install for psutil 14:10:57 INFO - building 'psutil._psutil_linux' extension 14:10:57 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 14:10:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:10:58 INFO - building 'psutil._psutil_posix' extension 14:10:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:10:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:10:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:58 INFO - Successfully installed psutil 14:10:58 INFO - Cleaning up... 14:10:58 INFO - Return code: 0 14:10:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d130>, '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 0x2a1e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e4c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', '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 14:10:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:10:58 INFO - Using env: {'DISPLAY': ':0', 14:10:58 INFO - 'HOME': '/home/cltbld', 14:10:58 INFO - 'LANG': 'en_US.UTF-8', 14:10:58 INFO - 'LANGUAGE': 'en_US:en', 14:10:58 INFO - 'LOGNAME': 'cltbld', 14:10:58 INFO - 'MAIL': '/var/mail/cltbld', 14:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:58 INFO - 'MOZ_NO_REMOTE': '1', 14:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:58 INFO - 'NO_EM_RESTART': '1', 14:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:58 INFO - 'PWD': '/builds/slave/test', 14:10:58 INFO - 'SHELL': '/bin/bash', 14:10:58 INFO - 'SHLVL': '1', 14:10:58 INFO - 'TERM': 'linux', 14:10:58 INFO - 'TMOUT': '86400', 14:10:58 INFO - 'USER': 'cltbld', 14:10:58 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', 14:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:58 INFO - '_': '/tools/buildbot/bin/python'} 14:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:10:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:10:59 INFO - Installing collected packages: mozsystemmonitor 14:10:59 INFO - Running setup.py install for mozsystemmonitor 14:10:59 INFO - Successfully installed mozsystemmonitor 14:10:59 INFO - Cleaning up... 14:10:59 INFO - Return code: 0 14:10:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10: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')]} 14:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d130>, '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 0x2a1e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e4c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', '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 14:10:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:10:59 INFO - Using env: {'DISPLAY': ':0', 14:10:59 INFO - 'HOME': '/home/cltbld', 14:10:59 INFO - 'LANG': 'en_US.UTF-8', 14:10:59 INFO - 'LANGUAGE': 'en_US:en', 14:10:59 INFO - 'LOGNAME': 'cltbld', 14:10:59 INFO - 'MAIL': '/var/mail/cltbld', 14:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:59 INFO - 'MOZ_NO_REMOTE': '1', 14:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:59 INFO - 'NO_EM_RESTART': '1', 14:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:59 INFO - 'PWD': '/builds/slave/test', 14:10:59 INFO - 'SHELL': '/bin/bash', 14:10:59 INFO - 'SHLVL': '1', 14:10:59 INFO - 'TERM': 'linux', 14:10:59 INFO - 'TMOUT': '86400', 14:10:59 INFO - 'USER': 'cltbld', 14:10:59 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', 14:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:59 INFO - '_': '/tools/buildbot/bin/python'} 14:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:00 INFO - Downloading/unpacking jsonschema==2.5.1 14:11: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 14:11: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 14:11: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 14:11: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 14:11:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:11: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 14:11: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 14:11: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 14:11: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 14:11:01 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:01 INFO - warning: no files found matching '*.txt' 14:11:01 INFO - no previously-included directories found matching 'build' 14:11:01 INFO - no previously-included directories found matching 'dist' 14:11:01 INFO - no previously-included directories found matching '.git*' 14:11:01 INFO - Installing collected packages: jsonschema, functools32 14:11:01 INFO - Running setup.py install for functools32 14:11:01 INFO - warning: no files found matching '*.txt' 14:11:01 INFO - no previously-included directories found matching 'build' 14:11:01 INFO - no previously-included directories found matching 'dist' 14:11:01 INFO - no previously-included directories found matching '.git*' 14:11:01 INFO - Successfully installed jsonschema functools32 14:11:01 INFO - Cleaning up... 14:11:01 INFO - Return code: 0 14:11:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d130>, '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 0x2a1e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e4c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', '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 14:11:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:11:01 INFO - Using env: {'DISPLAY': ':0', 14:11:01 INFO - 'HOME': '/home/cltbld', 14:11:01 INFO - 'LANG': 'en_US.UTF-8', 14:11:01 INFO - 'LANGUAGE': 'en_US:en', 14:11:01 INFO - 'LOGNAME': 'cltbld', 14:11:01 INFO - 'MAIL': '/var/mail/cltbld', 14:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:01 INFO - 'MOZ_NO_REMOTE': '1', 14:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:01 INFO - 'NO_EM_RESTART': '1', 14:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:01 INFO - 'PWD': '/builds/slave/test', 14:11:01 INFO - 'SHELL': '/bin/bash', 14:11:01 INFO - 'SHLVL': '1', 14:11:01 INFO - 'TERM': 'linux', 14:11:01 INFO - 'TMOUT': '86400', 14:11:01 INFO - 'USER': 'cltbld', 14:11:01 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', 14:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:01 INFO - '_': '/tools/buildbot/bin/python'} 14:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:11:01 INFO - Cleaning up... 14:11:01 INFO - Return code: 0 14:11:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d130>, '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 0x2a1e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e4c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', '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 14:11:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:11:01 INFO - Using env: {'DISPLAY': ':0', 14:11:01 INFO - 'HOME': '/home/cltbld', 14:11:01 INFO - 'LANG': 'en_US.UTF-8', 14:11:01 INFO - 'LANGUAGE': 'en_US:en', 14:11:01 INFO - 'LOGNAME': 'cltbld', 14:11:01 INFO - 'MAIL': '/var/mail/cltbld', 14:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:01 INFO - 'MOZ_NO_REMOTE': '1', 14:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:01 INFO - 'NO_EM_RESTART': '1', 14:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:01 INFO - 'PWD': '/builds/slave/test', 14:11:01 INFO - 'SHELL': '/bin/bash', 14:11:01 INFO - 'SHLVL': '1', 14:11:01 INFO - 'TERM': 'linux', 14:11:01 INFO - 'TMOUT': '86400', 14:11:01 INFO - 'USER': 'cltbld', 14:11:01 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', 14:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:01 INFO - '_': '/tools/buildbot/bin/python'} 14:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:02 INFO - Downloading/unpacking blobuploader==1.2.4 14:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:03 INFO - Downloading blobuploader-1.2.4.tar.gz 14:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:11:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:11:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:03 INFO - Downloading docopt-0.6.1.tar.gz 14:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:11:03 INFO - Installing collected packages: blobuploader, requests, docopt 14:11:03 INFO - Running setup.py install for blobuploader 14:11:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:11:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:11:03 INFO - Running setup.py install for requests 14:11:04 INFO - Running setup.py install for docopt 14:11:04 INFO - Successfully installed blobuploader requests docopt 14:11:04 INFO - Cleaning up... 14:11:04 INFO - Return code: 0 14:11:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:04 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')]} 14:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:04 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')]} 14:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:04 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 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d130>, '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 0x2a1e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e4c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', '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 14:11:04 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 14:11:04 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 14:11:04 INFO - Using env: {'DISPLAY': ':0', 14:11:04 INFO - 'HOME': '/home/cltbld', 14:11:04 INFO - 'LANG': 'en_US.UTF-8', 14:11:04 INFO - 'LANGUAGE': 'en_US:en', 14:11:04 INFO - 'LOGNAME': 'cltbld', 14:11:04 INFO - 'MAIL': '/var/mail/cltbld', 14:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:04 INFO - 'MOZ_NO_REMOTE': '1', 14:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:04 INFO - 'NO_EM_RESTART': '1', 14:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:04 INFO - 'PWD': '/builds/slave/test', 14:11:04 INFO - 'SHELL': '/bin/bash', 14:11:04 INFO - 'SHLVL': '1', 14:11:04 INFO - 'TERM': 'linux', 14:11:04 INFO - 'TMOUT': '86400', 14:11:04 INFO - 'USER': 'cltbld', 14:11:04 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', 14:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:04 INFO - '_': '/tools/buildbot/bin/python'} 14:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:04 INFO - Running setup.py (path:/tmp/pip-nPPmYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:04 INFO - Running setup.py (path:/tmp/pip-_VX8Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:04 INFO - Running setup.py (path:/tmp/pip-Hlat1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:04 INFO - Running setup.py (path:/tmp/pip-zAzu5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:04 INFO - Running setup.py (path:/tmp/pip-zvcZDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:04 INFO - Running setup.py (path:/tmp/pip-NMDYDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:05 INFO - Running setup.py (path:/tmp/pip-Npv7aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:05 INFO - Running setup.py (path:/tmp/pip-m7rY8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:05 INFO - Running setup.py (path:/tmp/pip-Tb_Ehp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:05 INFO - Running setup.py (path:/tmp/pip-HdHnDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:05 INFO - Running setup.py (path:/tmp/pip-vz3jhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:05 INFO - Running setup.py (path:/tmp/pip-uQg8BW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:05 INFO - Running setup.py (path:/tmp/pip-VgRMMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:05 INFO - Running setup.py (path:/tmp/pip-6D1Nh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:05 INFO - Running setup.py (path:/tmp/pip-0uzDvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:05 INFO - Running setup.py (path:/tmp/pip-eERcZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:05 INFO - Running setup.py (path:/tmp/pip-Em_jAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:05 INFO - Running setup.py install for manifestparser 14:11:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:11:05 INFO - Running setup.py install for mozcrash 14:11:06 INFO - Running setup.py install for mozdebug 14:11:06 INFO - Running setup.py install for mozdevice 14:11:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:06 INFO - Running setup.py install for mozfile 14:11:06 INFO - Running setup.py install for mozhttpd 14:11:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:06 INFO - Running setup.py install for mozinfo 14:11:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:11:06 INFO - Running setup.py install for mozInstall 14:11:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:11:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:11:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:11:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:11:06 INFO - Running setup.py install for mozleak 14:11:06 INFO - Running setup.py install for mozlog 14:11:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:11:06 INFO - Running setup.py install for moznetwork 14:11:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:11:06 INFO - Running setup.py install for mozprocess 14:11:07 INFO - Running setup.py install for mozprofile 14:11:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:11:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:11:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:11:07 INFO - Running setup.py install for mozrunner 14:11:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:11:07 INFO - Running setup.py install for mozscreenshot 14:11:07 INFO - Running setup.py install for moztest 14:11:07 INFO - Running setup.py install for mozversion 14:11:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:11:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:07 INFO - Cleaning up... 14:11:07 INFO - Return code: 0 14:11:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:07 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')]} 14:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:07 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')]} 14:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:07 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 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d130>, '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 0x2a1e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e4c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', '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 14:11:07 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 14:11:07 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 14:11:07 INFO - Using env: {'DISPLAY': ':0', 14:11:07 INFO - 'HOME': '/home/cltbld', 14:11:07 INFO - 'LANG': 'en_US.UTF-8', 14:11:07 INFO - 'LANGUAGE': 'en_US:en', 14:11:07 INFO - 'LOGNAME': 'cltbld', 14:11:07 INFO - 'MAIL': '/var/mail/cltbld', 14:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:07 INFO - 'MOZ_NO_REMOTE': '1', 14:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:07 INFO - 'NO_EM_RESTART': '1', 14:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:07 INFO - 'PWD': '/builds/slave/test', 14:11:07 INFO - 'SHELL': '/bin/bash', 14:11:07 INFO - 'SHLVL': '1', 14:11:07 INFO - 'TERM': 'linux', 14:11:07 INFO - 'TMOUT': '86400', 14:11:07 INFO - 'USER': 'cltbld', 14:11:07 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', 14:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:07 INFO - '_': '/tools/buildbot/bin/python'} 14:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:07 INFO - Running setup.py (path:/tmp/pip-EhCcGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:07 INFO - Running setup.py (path:/tmp/pip-9FFSVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:07 INFO - Running setup.py (path:/tmp/pip-QClb_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:08 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)) 14:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:08 INFO - Running setup.py (path:/tmp/pip-kSbuBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:08 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)) 14:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:08 INFO - Running setup.py (path:/tmp/pip-nC_5FD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:08 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)) 14:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:08 INFO - Running setup.py (path:/tmp/pip-zn0ZUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:08 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)) 14:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:08 INFO - Running setup.py (path:/tmp/pip-JfnTTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:08 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)) 14:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:08 INFO - Running setup.py (path:/tmp/pip-KwDz85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:08 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)) 14:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:08 INFO - Running setup.py (path:/tmp/pip-RswXP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:08 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)) 14:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:08 INFO - Running setup.py (path:/tmp/pip-W7szxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:08 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)) 14:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:08 INFO - Running setup.py (path:/tmp/pip-8_1VaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:08 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)) 14:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:08 INFO - Running setup.py (path:/tmp/pip-3oSCJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:08 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)) 14:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:08 INFO - Running setup.py (path:/tmp/pip-zSx1Hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:08 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)) 14:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:08 INFO - Running setup.py (path:/tmp/pip-7xyz49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:08 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)) 14:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:08 INFO - Running setup.py (path:/tmp/pip-sgszVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:08 INFO - Running setup.py (path:/tmp/pip-bUkRNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:08 INFO - Running setup.py (path:/tmp/pip-M8U6x_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:09 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)) 14:11:09 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)) 14:11:09 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)) 14:11:09 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)) 14:11:09 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)) 14:11:09 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)) 14:11:09 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)) 14:11:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11: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 14:11: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 14:11: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 14:11: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 14:11:10 INFO - Downloading blessings-1.6.tar.gz 14:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:11:10 INFO - Installing collected packages: blessings 14:11:10 INFO - Running setup.py install for blessings 14:11:10 INFO - Successfully installed blessings 14:11:10 INFO - Cleaning up... 14:11:10 INFO - Return code: 0 14:11:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:11:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:10 INFO - Reading from file tmpfile_stdout 14:11:10 INFO - Current package versions: 14:11:10 INFO - argparse == 1.2.1 14:11:10 INFO - blessings == 1.6 14:11:10 INFO - blobuploader == 1.2.4 14:11:10 INFO - docopt == 0.6.1 14:11:10 INFO - functools32 == 3.2.3-2 14:11:10 INFO - jsonschema == 2.5.1 14:11:10 INFO - manifestparser == 1.1 14:11:10 INFO - mozInstall == 1.13 14:11:10 INFO - mozcrash == 1.0 14:11:10 INFO - mozdebug == 0.1 14:11:10 INFO - mozdevice == 0.51 14:11:10 INFO - mozfile == 1.2 14:11:10 INFO - mozhttpd == 0.7 14:11:10 INFO - mozinfo == 0.10 14:11:10 INFO - mozleak == 0.1 14:11:10 INFO - mozlog == 3.5 14:11:10 INFO - moznetwork == 0.27 14:11:10 INFO - mozprocess == 0.25 14:11:10 INFO - mozprofile == 0.28 14:11:10 INFO - mozrunner == 6.13 14:11:10 INFO - mozscreenshot == 0.1 14:11:10 INFO - mozsystemmonitor == 0.3 14:11:10 INFO - moztest == 0.8 14:11:10 INFO - mozversion == 1.4 14:11:10 INFO - psutil == 3.1.1 14:11:10 INFO - requests == 1.2.3 14:11:10 INFO - wsgiref == 0.1.2 14:11:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:10 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')]} 14:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:10 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')]} 14:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:10 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 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d130>, '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 0x2a1e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e4c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', '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 14:11:10 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 14:11:10 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 14:11:10 INFO - Using env: {'DISPLAY': ':0', 14:11:10 INFO - 'HOME': '/home/cltbld', 14:11:10 INFO - 'LANG': 'en_US.UTF-8', 14:11:10 INFO - 'LANGUAGE': 'en_US:en', 14:11:10 INFO - 'LOGNAME': 'cltbld', 14:11:10 INFO - 'MAIL': '/var/mail/cltbld', 14:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:10 INFO - 'MOZ_NO_REMOTE': '1', 14:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:10 INFO - 'NO_EM_RESTART': '1', 14:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:10 INFO - 'PWD': '/builds/slave/test', 14:11:10 INFO - 'SHELL': '/bin/bash', 14:11:10 INFO - 'SHLVL': '1', 14:11:10 INFO - 'TERM': 'linux', 14:11:10 INFO - 'TMOUT': '86400', 14:11:10 INFO - 'USER': 'cltbld', 14:11:10 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', 14:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:10 INFO - '_': '/tools/buildbot/bin/python'} 14:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:10 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)) 14:11:10 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)) 14:11:10 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)) 14:11:10 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)) 14:11:10 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)) 14:11:10 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)) 14:11:10 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)) 14:11:10 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)) 14:11:10 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)) 14:11:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:11:12 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)) 14:11:12 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)) 14:11:12 INFO - Installing collected packages: simplejson 14:11:12 INFO - Running setup.py install for simplejson 14:11:12 INFO - building 'simplejson._speedups' extension 14:11:12 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 14:11:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 14:11:12 INFO - Successfully installed simplejson 14:11:12 INFO - Cleaning up... 14:11:13 INFO - Return code: 0 14:11:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:11:13 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')]} 14:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:13 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')]} 14:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:13 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 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d130>, '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 0x2a1e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e4c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', '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 14:11:13 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 14:11:13 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 14:11:13 INFO - Using env: {'DISPLAY': ':0', 14:11:13 INFO - 'HOME': '/home/cltbld', 14:11:13 INFO - 'LANG': 'en_US.UTF-8', 14:11:13 INFO - 'LANGUAGE': 'en_US:en', 14:11:13 INFO - 'LOGNAME': 'cltbld', 14:11:13 INFO - 'MAIL': '/var/mail/cltbld', 14:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:13 INFO - 'MOZ_NO_REMOTE': '1', 14:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:13 INFO - 'NO_EM_RESTART': '1', 14:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:13 INFO - 'PWD': '/builds/slave/test', 14:11:13 INFO - 'SHELL': '/bin/bash', 14:11:13 INFO - 'SHLVL': '1', 14:11:13 INFO - 'TERM': 'linux', 14:11:13 INFO - 'TMOUT': '86400', 14:11:13 INFO - 'USER': 'cltbld', 14:11:13 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', 14:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:13 INFO - '_': '/tools/buildbot/bin/python'} 14:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:11:13 INFO - Cleaning up... 14:11:13 INFO - Return code: 0 14:11:13 INFO - Running post-action listener: _resource_record_post_action 14:11:13 INFO - Running post-action listener: _start_resource_monitoring 14:11:13 INFO - Starting resource monitoring. 14:11:13 INFO - [mozharness: 2017-08-18 21:11:13.302989Z] Finished create-virtualenv step (success) 14:11:13 INFO - [mozharness: 2017-08-18 21:11:13.303498Z] Running install step. 14:11:13 INFO - Running pre-action listener: _resource_record_pre_action 14:11:13 INFO - Running main action method: install 14:11:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:13 INFO - Reading from file tmpfile_stdout 14:11:13 INFO - Detecting whether we're running mozinstall >=1.0... 14:11:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:11:13 INFO - Reading from file tmpfile_stdout 14:11:13 INFO - Output received: 14:11:13 INFO - Usage: mozinstall [options] installer 14:11:13 INFO - Options: 14:11:13 INFO - -h, --help show this help message and exit 14:11:13 INFO - -d DEST, --destination=DEST 14:11:13 INFO - Directory to install application into. [default: 14:11:13 INFO - "/builds/slave/test"] 14:11:13 INFO - --app=APP Application being installed. [default: firefox] 14:11:13 INFO - mkdir: /builds/slave/test/build/application 14:11:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:11:31 INFO - Reading from file tmpfile_stdout 14:11:31 INFO - Output received: 14:11:31 INFO - /builds/slave/test/build/application/firefox/firefox 14:11:31 INFO - Running post-action listener: _resource_record_post_action 14:11:31 INFO - [mozharness: 2017-08-18 21:11:31.764160Z] Finished install step (success) 14:11:31 INFO - [mozharness: 2017-08-18 21:11:31.764443Z] Running setup-mitmproxy step. 14:11:31 INFO - Running pre-action listener: _resource_record_pre_action 14:11:31 INFO - Running main action method: setup_mitmproxy 14:11:31 INFO - Skipping: mitmproxy is not required 14:11:31 INFO - Running post-action listener: _resource_record_post_action 14:11:31 INFO - [mozharness: 2017-08-18 21:11:31.765766Z] Finished setup-mitmproxy step (success) 14:11:31 INFO - [mozharness: 2017-08-18 21:11:31.765991Z] Running run-tests step. 14:11:31 INFO - Running pre-action listener: _resource_record_pre_action 14:11:31 INFO - Running pre-action listener: _set_gcov_prefix 14:11:31 INFO - Running main action method: run_tests 14:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:11:31 INFO - Python 2.7.3 14:11:31 INFO - Return code: 0 14:11:31 INFO - grabbing minidump binary from tooltool 14:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x2a1d130>, '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 0x2a1e030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:11:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 14:11:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:11:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 14:11:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:11:31 INFO - Return code: 0 14:11:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:11:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:11:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:11:31 INFO - ENV: RUST_BACKTRACE is now full 14:11:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:11:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 14:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --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 14:11:31 INFO - Using env: {'DISPLAY': ':0', 14:11:31 INFO - 'HOME': '/home/cltbld', 14:11:31 INFO - 'LANG': 'en_US.UTF-8', 14:11:31 INFO - 'LANGUAGE': 'en_US:en', 14:11:31 INFO - 'LOGNAME': 'cltbld', 14:11:31 INFO - 'MAIL': '/var/mail/cltbld', 14:11:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:11:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:11:31 INFO - 'MOZ_ACCELERATED': '1', 14:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:31 INFO - 'MOZ_NO_REMOTE': '1', 14:11:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:11:31 INFO - 'MOZ_WEBRENDER': '1', 14:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:31 INFO - 'NO_EM_RESTART': '1', 14:11:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:31 INFO - 'PWD': '/builds/slave/test', 14:11:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:11:31 INFO - 'RUST_BACKTRACE': 'full', 14:11:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:11:31 INFO - 'SHELL': '/bin/bash', 14:11:31 INFO - 'SHLVL': '1', 14:11:31 INFO - 'TERM': 'linux', 14:11:31 INFO - 'TMOUT': '86400', 14:11:31 INFO - 'USER': 'cltbld', 14:11:31 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963', 14:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:31 INFO - '_': '/tools/buildbot/bin/python'} 14:11:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 14:11:32 INFO - mozversion application_buildid: 20170818201121 14:11:32 INFO - mozversion application_changeset: 8febdfacc7160c9ba90ba480e8bf5cd174e4fcab 14:11:32 INFO - mozversion application_display_name: Nightly 14:11:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:11:32 INFO - mozversion application_name: Firefox 14:11:32 INFO - mozversion application_remotingname: firefox 14:11:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:11:32 INFO - mozversion application_vendor: Mozilla 14:11:32 INFO - mozversion application_version: 57.0a1 14:11:32 INFO - mozversion platform_buildid: 20170818201121 14:11:32 INFO - mozversion platform_changeset: 8febdfacc7160c9ba90ba480e8bf5cd174e4fcab 14:11:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:11:32 INFO - mozversion platform_version: 57.0a1 14:11:32 INFO - using testdate: 1503090692 14:11:32 INFO - actual date: 1503090692 14:11:32 INFO - starting webserver on 'localhost:37569' 14:11:32 INFO - SUITE-START | Running 2 tests 14:11:32 INFO - TEST-START | dromaeo_css 14:11:32 INFO - Initialising browser for dromaeo_css test... 14:11:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37569/getInfo.html -profile /tmp/tmpKIlwtM/profile 14:11:32 INFO - TEST-INFO | started process 5194 (/builds/slave/test/build/application/firefox/firefox http://localhost:37569/getInfo.html) 14:11:37 INFO - TEST-INFO | 5194: exit 0 14:11:38 INFO - Browser initialized. 14:11:38 INFO - Running cycle 1/1 for dromaeo_css test... 14:11:38 INFO - TEST-INFO | started process 5378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKIlwtM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:38 INFO - PID 5378 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 14:11:39 INFO - PID 5378 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 14:11:39 INFO - PID 5378 | 14:11:39 INFO - PID 5378 | (/builds/slave/test/build/application/firefox/firefox:5437): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:11:39 INFO - PID 5378 | 14:11:39 INFO - PID 5378 | 14:11:39 INFO - PID 5378 | (/builds/slave/test/build/application/firefox/firefox:5494): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:11:39 INFO - PID 5378 | 14:11:40 INFO - PID 5378 | __metrics Screen width/height:1600/1200 14:11:40 INFO - PID 5378 | colorDepth:24 14:11:40 INFO - PID 5378 | Browser inner width/height: 1024/768 14:11:40 INFO - PID 5378 | __metrics 14:11:49 INFO - PID 5378 | RSS: Main: 204558336 14:11:49 INFO - PID 5378 | 14:11:54 INFO - PID 5378 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 14:14:48 INFO - PID 5378 | Cycle 1(1): loaded http://localhost:37569/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37569/tests/dromaeo/cssquery-ext.html) 14:14:50 INFO - PID 5378 | RSS: Main: 224997376 14:14:50 INFO - PID 5378 | 14:17:52 INFO - PID 5378 | Cycle 1(1): loaded http://localhost:37569/tests/dromaeo/cssquery-ext.html (next: http://localhost:37569/tests/dromaeo/cssquery-jquery.html) 14:17:52 INFO - PID 5378 | RSS: Main: 271994880 14:17:52 INFO - PID 5378 | 14:20:55 INFO - PID 5378 | Cycle 1(1): loaded http://localhost:37569/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37569/tests/dromaeo/cssquery-mootools.html) 14:20:55 INFO - PID 5378 | RSS: Main: 276258816 14:20:55 INFO - PID 5378 | 14:23:57 INFO - PID 5378 | Cycle 1(1): loaded http://localhost:37569/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37569/tests/dromaeo/cssquery-prototype.html) 14:23:58 INFO - PID 5378 | RSS: Main: 275316736 14:23:58 INFO - PID 5378 | 14:27:02 INFO - PID 5378 | Cycle 1(1): loaded http://localhost:37569/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37569/tests/dromaeo/cssquery-yui.html) 14:27:03 INFO - PID 5378 | RSS: Main: 276299776 14:27:03 INFO - PID 5378 | 14:30:05 INFO - PID 5378 | Cycle 1(1): loaded http://localhost:37569/tests/dromaeo/cssquery-yui.html (next: http://localhost:37569/tests/dromaeo/cssquery-dojo.html) 14:30:05 INFO - PID 5378 | RSS: Main: 278396928 14:30:05 INFO - PID 5378 | 14:30:05 INFO - PID 5378 | __start_tp_report 14:30:05 INFO - PID 5378 | _x_x_mozilla_page_load 14:30:05 INFO - PID 5378 | _x_x_mozilla_page_load_details 14:30:05 INFO - PID 5378 | |i|pagename|runs| 14:30:05 INFO - PID 5378 | |0;dojo.html;3015.20097174249;3067.6472205696336;3095.504719244921;3119.9844000779995;3127.9530807037886;6043.365446628107;6081.54388420868;6188.226471691039;6199.194104766385;6202.379762023796;6142.969285153568;6177.135201071854;6200.193974783272;6226.875462490748;6267.780627678021;5589.189567512708;5599.63602365847;5686.31764188297;5694;5729.28383952006;5506.339239291291;5537.861553461155;5569.275994120759;5573.4147914469;5631.493165615094;5564.10974244121;5593.909187708398;5612.270404847364;5617.578681598856;5644.181593668915;5585.190147428641;5595.944040559583;5601.411851755548;5603.915941260884;5622.690752008638;5506.1190209566275;5589.80435684749;5598.048331783607;5629.746661400247;5663.716814159276;6058.575899687024;6090.33006369299;6112.205413296288;6122.938770612282;6158.599691020114;6375.585586936834;6587.242467116295;6599.868002639968;6650.667466626698;6694.43097336727;6481.74073037078;6569.178852643419;6569.408753212234;6592.736290548372;6603.108580341641;6104.816855494298;6198.907016394758;6207.224096987877;6214.161088253073;6238.407351301619;6609.272979972199;6792.252852186256;6881.793546193622;6889.069975553336;6889.138857642794;6349.619022858643;6359.141515895295;6386.936130638727;6390;6404.263509696351;6490.448311893448;6521.771737989147;6525.184351956005;6528.608283503005;6544.770933017321;6392.872142557123;6423.357664233539;6473.838154046187;6484.221893372731;6530.575512591667;6453.967730161319;6463.838404039842;6482.384173503509;6501.739930402826;6538.967305163444;5345.278387417648;5355.946440535545;5385.165299378603;5389.892202155935;5481.917771233435;4561.110583436198;4617.746023968647;4628.907421851612;4628.930566041512;4643.117807616542;5661.1508273758445;5694.430556944355;5739.598228123991;5768.711564421846;5782.884342313214;6476;6563.704633291513;6565.080888675589;6575.967120164369;6581.177352830896;5672.631278966854;5710.2576665033275;5711.543076553866;5716.485516303553;5735.827925162252;5802.622829516153;5831.329397119301;5868.559858010581;5936.673482958478;5939.316978547522;6348.587341822767;6373.490120790326;6428.292887782433;6442.48460123189;6474.223093228843;6280.9685951569945;6464.935350646621;6512.772052978313;6576.572522786004;6582.243042050225;6382.393672601095;6455.3221911700475;6459.709313081016;6488.383603557654;6497.610143391412;6487.0593763903025;6591.96704016496;6606.141201643948;6613.702383392662;6617.106690596708;6589.341065893564;6592.90110648331;6683.699233534599;6688.799336019927;6691;6291.622502649856;6428.582142160744;6430.646314452563;6534.248561415498;6536.640484773383;6346.111544383883;6363.268224154096;6367.140436041075;6393.360663933569;6397.040443933447;6257.342978987141;6322.36776322364;6333.936660633335;6342.270638876588;6344.238691357066;6327.810165695037;6386.584871983307;6420.165378500765;6422.967885160731;6455.548111632328;6205.565610407409;6221.5333849962335;6223.937760622336;6267.435930766253;6314.463270622048 14:30:05 INFO - PID 5378 | |1;ext.html;786.6420778545762;837.8994520657515;850.527956983874;878.79348353137;879.6833140069574;41065;41625;41755.79122104389;41906.58093419065;41938.370924436116;37944.43083353745;38211.617883821156;38286.23427531448;38320.808395958054;38353.23293534128;6807.795766127012;6862.965685171567;6898.1377327834025;6902.930970690304;6906.067680863094;6842.828929276783;6894.586324820501;6916.6541672916155;6926.792196234096;6932.861342773142;6899.6550172491425;7482.289182527678;7728;7753.379729621617;7773.9222607774045;7598.582077985709;7660;7662.540247585107;7669.156392796788;7718.884216736754;7427.405807535384;7561.319481246659;7608.695652173907;7617.238276172394;7684.385249180053;38748.80625596882;38834.417483737765;38932.416013759816;38997.805010974764;39045.21909561821;3569.464580312948;3601.225736466672;3605.5312809334882;3628.238070005276;3630.5824830144606;30365.089047328616;30412.695873041208;30536.931207407855;30564.388712225853;30598.92903748358;4951.950480495185;4974.651774375795;4986.5761410280165;4991.201407774739;5006.549410553068;224552;226574;228445;230482;230819.8459007711;50272.49727502751;50376.496235037914;50766;50823.745881270355;50884;52846;52993.470065299625;53209.467905321224;56092.15861762077;56574.43425565774;16377.181140942905;16718.41485548;16722.498325050266;16724.581885452717;16729.247183876756;13661.248631325372;13701.45194192241;13718.451261949609;13775.104618199784;13783.724325513434;14601.831853451698;14639.194844283667;14678.779818302733;14694.55916322512;14793.11241325524;5680.6591604503865;5766.452187042224;5815.534757219497;5817.534597232211;5929.080992446177;993.64228877604;1002.1081237698454;1002.9699109026741;1018.6231094495084;1019.6940917724653;23068.769312307;23209;23276.534469310518;23390;23442.531149377257;1093.3877028863863;1101.5593762494907;1123.455124264731;1125.2741981421937;1133.8696049954196;12124.332132129193;12285.38573071343;12325.260484370967;12391.380430978415;16509;234255;236044;237103;237257;237787;49391.25913111306;49845.25232121521;58038;58119.418805812245;58671;1484.6585285384422;1513.712394645014;1517.6281810956386;1532.3181184372847;1534.7237497250603;28558.714412855606;28648.14055578336;28677.85661071681;28683.569746453402;29486.410271794874;37739;37753.62246377501;37962.62037379591;38079.619203807604;38155.2368952625;214405;216268;217069;217347;217953;37388;37535.81232093822;37583;37624.811875940446;37733.4339984906;44563.77718111389;47391.763041184575;48764;48794.26808597803;48947;33870.491942621375;34677;34891.77878774231;35530.822345888104;35876.461853072746;33498.66501334956;34310.313793723486;34713.82643086869;35470.64529354673;35602.46596301006;36937.81531092327;37413.43879841859;38282.61717382791;38530.6146938527;38545.6145438542;33567.328653427285;33808;34070.65929340774;34160.82919585386;34170.658293416745;23783;24536.570270621258;24598.877005614857;24599.631005534575;25079.74920250774 14:30:05 INFO - PID 5378 | |2;jquery.html;563.4253061876889;572.4819038769912;573.3435216676905;574.9195112684222;581.8894410062088;21914;22739.54520909581;22761.999999999978;22793.202237921676;22851.77148228517;19394.806051939475;23511;24261.636075458882;25754;25927.481450370982;6181;6327.082573026908;6338.809835704937;6373.7131829067575;6383.042543618448;6271.310155882849;6361.968190159043;6366.904496432558;6394.488440924715;6399.776007839727;6129.846753831168;6721.630310332954;6750.662466876661;6761.966190169067;6779.593224406527;6650.966745166292;6671;6727.764528241512;6736.191657001191;6741.426978706816;6517.543771935966;6535.607863528204;6590.143281373391;6605.636689982049;6614.040964060232;28857.278568035756;30086.398272034436;30263.184208947532;30783.538246926313;30855.84572077148;1947.6299503094367;1990.5521257716898;1991.332903477337;1992.7608686957512;1997.4507010572063;18802.435926922215;19123.71314430285;19146.04269786519;19291.51771205717;19442.805571944384;2391.366287933699;2419.020296779807;2465.6178292364534;2482.8013758899247;2508.949821003588;141845;148867;149061;149104.2544787269;149354;19856.808591484267;21018.2643607473;21054.47363815917;21225.15099396038;21680.783192168194;43030.56969430328;43245;43336.3499547507;43337.56662433398;43418.34872476915;11146.832797508045;11266.605668801552;11353.943230283796;11386.430678466044;11412.144089193343;9186.908130918606;9278.953605232065;9412.15290623847;9454;9555.140037396528;8367.912171417676;11130.610428634958;11329.734053189395;11502.884971150348;11595.362255075883;2621.200533837198;2701.540738074532;2714.3763076292976;2757.4071574611553;2760.627315312447;955.3217215776876;963.8987906269881;981.8772653418323;984.7931934293736;1006.3609607898891;19346.129424175946;19636.803631963783;20010.799892001185;20051.799482004993;20385.49036274105;1034.3535290443472;1036.7200855769051;1052.6841947415744;1054.593981317183;1059.1050562274866;10604.575816967235;10760;10942.398168100832;10966.725831854108;11128.38793866345;458929;460093;460843;529247.3537632287;533421;120751;124147;124807;127167;128399;1224.2593231095236;1246.8379110715548;1290.3290289049642;1290.4580076367947;1290.677330667352;19449.708254375913;20203.69694454555;20238.494037649176;20296.289629862884;20304.289349872684;56925;59411;60089.39910600838;60912;60984.39015609787;71618.64190679013;72720.27279727135;73329.6333518329;74395.62802185955;75200.62399687967;13860.237686927316;14271.785923211368;14341.713165736835;14366.856331436551;14396.568102956928;16886.831131688527;21194.364169074954;22947.93732299029;23130.76869231286;23282.76717232874;15760.92119539395;15904.76142857835;16021.198940052718;16061.196940152711;16152.434664786677;15090.24548772535;16471.67056658836;16691.332346705996;16940.57648558796;17055.06197159168;15906.727461802797;16394.180290985165;16403.58991025234;16407.917960410123;16431.917840410722;13863.168209907439;13864.653383665489;13923.58229253124;13996.65008374758;14009.08940918837;15467.381304747683;15815.920920395325;16109.516714498584;16257.918710406373;16502.25739841734 14:30:05 INFO - PID 5378 | |3;mootools.html;1365.5698454986677;1419.6379923119603;1445.7903603977425;1452.230317931496;1452.4335509151426;13683.24742139182;13959.232242226699;14408.711825763492;14451.349689263981;14472.782908256384;14184.574462766108;14401.135931844097;14496.130232186077;14516.346764395601;14529.128252304869;2625.8949642014295;2688.086050742747;2688.126358933345;2700.5544085225915;2702.7837772978214;2559.104313490273;2650.4036591766794;2715.9321016974636;2727.9181624551197;2735.37086470112;2615.3069436599317;2651.0721247563392;2652.3501742073217;2655.7477039681294;2676.397810492633;2589.676290463692;2620.882060307291;2650.2446802661248;2651.814372993891;2659.7739192168688;2625.474905019004;2629.382095207625;2634.855082970436;2638.2480992917117;2644.6429731986127;13947.372368243352;14008.22954737489;14189.78715319271;14193.219372934485;14216;7498.550086994798;7631.12242092161;7660.310572048543;7743.8838417423785;7764.805879853049;4750.786214620351;4823.276508523714;4858.878528036792;4974.90050198994;4977.079240340512;1841;1882.802305757903;1902.7145928110756;1909.9140538675654;1928.2094341320133;22914.427139321484;23010.42473938148;23026.884865575732;23090.65364019541;23093.19173828908;6217.626942383471;6387.425131738073;6427.678616069178;6593.769218077345;6625.734970601218;15700.607484812972;15803.577678009035;15883.682326353639;15893.682126357407;15919.124448155231;7096.7516136934955;7366.815829604303;7399.519031262951;7451.813704657318;7464.514806537558;6059.6364218147055;6393.296737358887;7019.613921234381;7206.891896621555;7293.1248250209255;4912.508749125059;4967.652264341534;5032.572231360376;5047.268146118792;5065.290859279704;1425.2659880161725;1438.604383794444;1445.4146070841116;1454.1129910754432;1465.5749832548443;907.4509921497531;922.8292765838341;928.4475736936512;929.3262384770987;937.1659223291276;7277.19950805411;7338.926610733824;7409.296116868889;7426.554406735613;7435.219301973323;711.1253158614933;713.7501874343938;716.3130826902569;721.4480922094601;722.6639612580176;4524.932126018112;5143.408508021551;5188.507091826271;5278.9472105278455;5362.27609272751;18593;19514.70727939082;19634.214631414583;19675.40973770789;19719;17789.7331540027;19258.518537036405;19263.22947082101;19269.710954335696;19467.51331216731;10512.526936288039;10620.256582039337;10888.510017049251;10911.290766100177;10974.945125274322;8226.095129535626;8238.134995825352;8265.132161122996;8285.337173026022;8394.790130246793;16917.577060573585;17014;17287.65424691474;17463.912680436515;17490.03804790749;17098;17182.140892955053;17305.913470432566;17515.0366729826;17817.10914454298;11292.548298067984;11654.650360489199;11677.357745324089;11759.823602646138;11774.058075354122;13005.349732513147;13120.671983200496;13156.40796164194;13159.342032898508;13167;10556.208284378548;10720.785584288427;10753.516091775733;10972.890271097187;10984.231103822656;10315.17478601695;10371.896281037092;10386.169106471616;10555.736106597396;10743.194260430655;9134.040925702706;9163.587638556148;9206.861897071683;9237.769055773659;9306.860397093913;6637.203535575762;6690.431313338226;6701.296363881722;6744.7976560703255;6867.278935711878;6919.411849992807;7081.433485321265;7350.558966462029;7351.522151060164;7447 14:30:05 INFO - PID 5378 | |4;prototype.html;499.93250911127;508.38739319120464;511.1081163369919;524.2634099090776;528.8254875890954;6047.697615119243;6108.205933228674;6166.4450199482035;6186.969065154673;6240.095186198004;6023.126646636235;6045.818625441244;6062.484688801446;6085.786997455079;6124.479419249358;4962.15643340633;4996.425411077718;5028.899422011557;5041.924371134436;5091.618128640348;4817.940053188293;4888.731119788428;4947.060058588857;4984.501549845005;5003.374578177728;4878.853634390974;4885.389326334208;4915.844776477525;4930.605551555867;4952.925706114411;4758.619310455155;4902.803887844482;4949.67365338294;4959.809645685045;4963.131451995904;4314.525402205786;4370.628496577795;4423.540231723524;4440.578145076212;4452.243118669834;5980.325508857527;6061.939380606225;6067.180930574405;6083.330833608299;6095.481884039862;5611.719414029282;5637.8590535236535;5645.8588535286535;5654.46282603152;5674.042455352938;6460.321666225026;6478.190226221723;6479.157709497782;6533.314002029813;6566.179227596551;4825.276208568707;4841.434039958827;4877.658563900528;4902.583280421169;4911.705297682151;6621.106150669694;6629.73481060757;6715.630640314781;6717.261101278904;6961.164660240804;4799.232122860326;4865.318855360252;4886.877828054256;4900.4854490278;4950.2822090796635;4859.392575928009;4942.184539551005;4954.752262386866;4966.528179822911;5008.574271186917;5554.472325129106;5570.3315602128005;5571.637843540157;5598.300212473441;5611.438856114438;6444.903326450107;6457.644829534421;6525.412712855866;6532.346765323429;6590.901136482957;1745.6159644878107;1749.7287920372107;1760.9207585658676;1766.3464518128376;1769.9646007080044;1155.3183621663259;1200.3578085724096;1224.8591411987557;1236.771197328497;1243.2726854790048;5639.013172694844;5707.600467967285;5711;5741.65550066989;5756.366799652035;6602.636854973022;6639.306976720905;6655.900161497581;6690.866182676319;6747.730090796314;5742.13867919807;5752.015554633728;5762.74067666956;5784.82645520635;5801;3469.61834198238;3506.1935754776546;3523.8195204606745;3548.3919319300294;3558.2705545363137;6362.395572420705;6372.5661726112185;6417.486601071903;6457.580257283262;6464.709088091047;6727.562708423937;6783.660816959133;6830.146231721035;6861.245263021064;6870.175578930561;6342.587731797418;6415.967920160276;6439.967800160969;6453.677316134174;6459.289478157305;6523.510736694861;6528.314526974599;6570.310117437601;6601.570897891814;6651.135352404156;5958.672273025025;6458.677066146768;6477.8704425912165;6625.304343043911;6629;6340.875806604839;6366.427021568081;6393.6483493408305;6398.328175541501;6444.935550644621;4865.9270110947655;4881.414230292387;4898.771059168142;4919.729414882073;4950.975245123751;6435.195600549931;6686.197656281277;6709.563878347892;6712.194536655633;6717.798466046026;6398.264199617103;6403.3276505966205;6489;6503.122078519339;6547;6301.779437719658;6431.324710905475;6454;6490.338961025956;6573.671316434255;6290.370962903673;6356.2054743157105;6403.6798160090875;6485.156929599122;6519.728652912826;6461.870762584816;6545.836354091186;6560.573562718408;6567.704453299709;6623.503237257129;6281.466075383643;6293.276273228455;6294.748210071546;6307.747690092345;6340.461060809883 14:30:05 INFO - PID 5378 | |5;yui.html;890.8396488632044;896.8834051573295;913.6208473483505;915.8443064679004;919.6045700348848;18816.4355069348;19728.309509167182;19739.901300493497;19791.406257812254;19803.504912377197;16507.66984660309;16953.745693814602;19046.714299285522;19100.80899191008;19839.404817855488;1030.9226807989412;1048.6591857646258;1049.4385503755493;1050.2595670052633;1051.3218973761918;1045.5451878432907;1052.200327750911;1052.9578816847318;1052.9842052369183;1058.4125810175349;1049.0610903241595;1084.4577711144427;1105.5964572930864;1125.3304283951036;1132.6092498088187;1085.3813326403954;1087.1791797193148;1094.8740894797081;1095.05277934586;1101.2126329674322;797.453744185235;797.4975765267902;798.4371018432049;801.9398545109082;804.5454318310136;19745.605087898304;20217.595648087103;20371.79628203714;20515.48711282215;20937.476563085893;21633.783662163336;21735.891320543455;21857.562848743095;22308.888455557782;22374;16510;16636.168191590372;16676;16861.915690421592;17327.22027508765;3327.5175099610665;3351.882684106069;3377.392069427502;3381.8309084545676;3389.8983030508875;124364;125136.37431812874;127318;131629.3418532911;133919;17118.743218851727;17144;17483.65032699339;17624.735628965576;17696.469105926844;31857.52213716796;32536.837315813744;32601;32762.508562371582;33197.50203746946;8708.695195668248;8795.824083518293;8800.075992020873;8806.691765788166;8819.779505512413;4198.790060496963;4257.787110644455;4339.240632889232;4428;4429.357743127293;5269.288646032813;5393;5398.64908780928;5399.379071406838;5418.620696551282;1006.1648831469862;1023.9846402303972;1025.661531694539;1033.9534720937577;1045.9633912813015;678.6606696651675;688.7727050073464;693.414065114977;695.5583204664973;700.7792545348199;11911.821322680167;12103.939480302719;12283.201591896677;13089.934550327378;13310.600681979557;664.9700763465655;673.6766352150995;679;685.4961603221628;704.2605264472284;5858.619189752652;5877.647341159544;5879.764809407661;6032.125341825411;6086.573939824169;110678;111487;114209;119917.40041299738;120325;90466.54766726124;97401.51299243601;100131.49934250282;101000;103395;87827.56086219655;88312.55843720741;88701.55649221713;90405;90531;12669.303188324731;12822.422990965242;13078.803817942548;13289.867101328862;13328.666783330495;39275;39996;40222;40854.1829163421;41484;72186;72982.63508682635;75835;76356.61821691078;77868.22131778837;17755.644887101927;17906.820931790517;18265.908670456563;18342;18646.347377842252;19336.419907402236;19353.903230483756;19393.90303048476;19500.1224944875;19573;19156;19647;19676.90161549183;19723.11245993905;19730.60538789245;19400.12699428501;19977.500562486053;20082.69875951891;20675.17299308011;20687.379378618665;18951.526211844815;19636.9018154914;20008.49978750543;20084.799152008294;20292.695609566163;14063.789043164155;14071.437142514185;14086.929565352517;14125.434982600991;14383.568492945229;14974;15092.245387730789;15187.544373668808;15722.21388930526;15742.449014284903 14:30:05 INFO - PID 5378 | __end_tp_report 14:30:05 INFO - PID 5378 | __start_cc_report 14:30:05 INFO - PID 5378 | _x_x_mozilla_cycle_collect,373 14:30:05 INFO - PID 5378 | __end_cc_report 14:30:05 INFO - PID 5378 | __startTimestamp1503091805715__endTimestamp 14:30:05 INFO - PID 5378 | 14:30:05 INFO - PID 5378 | ------- Summary: start ------- 14:30:05 INFO - PID 5378 | Number of tests: 6 14:30:05 INFO - PID 5378 | 14:30:05 INFO - PID 5378 | [#0] dojo.html Cycles:165 Average:6055.01 Median:6314.46 stddev:706.32 (11.2%) stddev-sans-first:667.01 14:30:05 INFO - PID 5378 | Values: 3015.2 3067.6 3095.5 3120.0 3128.0 6043.4 6081.5 6188.2 6199.2 6202.4 6143.0 6177.1 6200.2 6226.9 6267.8 5589.2 5599.6 5686.3 5694.0 5729.3 5506.3 5537.9 5569.3 5573.4 5631.5 5564.1 5593.9 5612.3 5617.6 5644.2 5585.2 5595.9 5601.4 5603.9 5622.7 5506.1 5589.8 5598.0 5629.7 5663.7 6058.6 6090.3 6112.2 6122.9 6158.6 6375.6 6587.2 6599.9 6650.7 6694.4 6481.7 6569.2 6569.4 6592.7 6603.1 6104.8 6198.9 6207.2 6214.2 6238.4 6609.3 6792.3 6881.8 6889.1 6889.1 6349.6 6359.1 6386.9 6390.0 6404.3 6490.4 6521.8 6525.2 6528.6 6544.8 6392.9 6423.4 6473.8 6484.2 6530.6 6454.0 6463.8 6482.4 6501.7 6539.0 5345.3 5355.9 5385.2 5389.9 5481.9 4561.1 4617.7 4628.9 4628.9 4643.1 5661.2 5694.4 5739.6 5768.7 5782.9 6476.0 6563.7 6565.1 6576.0 6581.2 5672.6 5710.3 5711.5 5716.5 5735.8 5802.6 5831.3 5868.6 5936.7 5939.3 6348.6 6373.5 6428.3 6442.5 6474.2 6281.0 6464.9 6512.8 6576.6 6582.2 6382.4 6455.3 6459.7 6488.4 6497.6 6487.1 6592.0 6606.1 6613.7 6617.1 6589.3 6592.9 6683.7 6688.8 6691.0 6291.6 6428.6 6430.6 6534.2 6536.6 6346.1 6363.3 6367.1 6393.4 6397.0 6257.3 6322.4 6333.9 6342.3 6344.2 6327.8 6386.6 6420.2 6423.0 6455.5 6205.6 6221.5 6223.9 6267.4 6314.5 14:30:05 INFO - PID 5378 | 14:30:05 INFO - PID 5378 | [#1] ext.html Cycles:180 Average:40148.73 Median:37400.72 stddev:58947.21 (157.6%) stddev-sans-first:59038.48 14:30:05 INFO - PID 5378 | Values: 786.6 837.9 850.5 878.8 879.7 41065.0 41625.0 41755.8 41906.6 41938.4 37944.4 38211.6 38286.2 38320.8 38353.2 6807.8 6863.0 6898.1 6902.9 6906.1 6842.8 6894.6 6916.7 6926.8 6932.9 6899.7 7482.3 7728.0 7753.4 7773.9 7598.6 7660.0 7662.5 7669.2 7718.9 7427.4 7561.3 7608.7 7617.2 7684.4 38748.8 38834.4 38932.4 38997.8 39045.2 3569.5 3601.2 3605.5 3628.2 3630.6 30365.1 30412.7 30536.9 30564.4 30598.9 4952.0 4974.7 4986.6 4991.2 5006.5 224552.0 226574.0 228445.0 230482.0 230819.8 50272.5 50376.5 50766.0 50823.7 50884.0 52846.0 52993.5 53209.5 56092.2 56574.4 16377.2 16718.4 16722.5 16724.6 16729.2 13661.2 13701.5 13718.5 13775.1 13783.7 14601.8 14639.2 14678.8 14694.6 14793.1 5680.7 5766.5 5815.5 5817.5 5929.1 993.6 1002.1 1003.0 1018.6 1019.7 23068.8 23209.0 23276.5 23390.0 23442.5 1093.4 1101.6 1123.5 1125.3 1133.9 12124.3 12285.4 12325.3 12391.4 16509.0 234255.0 236044.0 237103.0 237257.0 237787.0 49391.3 49845.3 58038.0 58119.4 58671.0 1484.7 1513.7 1517.6 1532.3 1534.7 28558.7 28648.1 28677.9 28683.6 29486.4 37739.0 37753.6 37962.6 38079.6 38155.2 214405.0 216268.0 217069.0 217347.0 217953.0 37388.0 37535.8 37583.0 37624.8 37733.4 44563.8 47391.8 48764.0 48794.3 48947.0 33870.5 34677.0 34891.8 35530.8 35876.5 33498.7 34310.3 34713.8 35470.6 35602.5 36937.8 37413.4 38282.6 38530.6 38545.6 33567.3 33808.0 34070.7 34160.8 34170.7 23783.0 24536.6 24598.9 24599.6 25079.7 14:30:05 INFO - PID 5378 | 14:30:05 INFO - PID 5378 | [#2] jquery.html Cycles:180 Average:35962.72 Median:21209.76 stddev:83195.47 (392.3%) stddev-sans-first:83386.40 14:30:05 INFO - PID 5378 | Values: 563.4 572.5 573.3 574.9 581.9 21914.0 22739.5 22762.0 22793.2 22851.8 19394.8 23511.0 24261.6 25754.0 25927.5 6181.0 6327.1 6338.8 6373.7 6383.0 6271.3 6362.0 6366.9 6394.5 6399.8 6129.8 6721.6 6750.7 6762.0 6779.6 6651.0 6671.0 6727.8 6736.2 6741.4 6517.5 6535.6 6590.1 6605.6 6614.0 28857.3 30086.4 30263.2 30783.5 30855.8 1947.6 1990.6 1991.3 1992.8 1997.5 18802.4 19123.7 19146.0 19291.5 19442.8 2391.4 2419.0 2465.6 2482.8 2508.9 141845.0 148867.0 149061.0 149104.3 149354.0 19856.8 21018.3 21054.5 21225.2 21680.8 43030.6 43245.0 43336.3 43337.6 43418.3 11146.8 11266.6 11353.9 11386.4 11412.1 9186.9 9279.0 9412.2 9454.0 9555.1 8367.9 11130.6 11329.7 11502.9 11595.4 2621.2 2701.5 2714.4 2757.4 2760.6 955.3 963.9 981.9 984.8 1006.4 19346.1 19636.8 20010.8 20051.8 20385.5 1034.4 1036.7 1052.7 1054.6 1059.1 10604.6 10760.0 10942.4 10966.7 11128.4 458929.0 460093.0 460843.0 529247.4 533421.0 120751.0 124147.0 124807.0 127167.0 128399.0 1224.3 1246.8 1290.3 1290.5 1290.7 19449.7 20203.7 20238.5 20296.3 20304.3 56925.0 59411.0 60089.4 60912.0 60984.4 71618.6 72720.3 73329.6 74395.6 75200.6 13860.2 14271.8 14341.7 14366.9 14396.6 16886.8 21194.4 22947.9 23130.8 23282.8 15760.9 15904.8 16021.2 16061.2 16152.4 15090.2 16471.7 16691.3 16940.6 17055.1 15906.7 16394.2 16403.6 16407.9 16431.9 13863.2 13864.7 13923.6 13996.7 14009.1 15467.4 15815.9 16109.5 16257.9 16502.3 14:30:05 INFO - PID 5378 | 14:30:05 INFO - PID 5378 | [#3] mootools.html Cycles:180 Average:8700.46 Median:2627.64 stddev:5977.79 (227.5%) stddev-sans-first:5969.15 14:30:05 INFO - PID 5378 | Values: 1365.6 1419.6 1445.8 1452.2 1452.4 13683.2 13959.2 14408.7 14451.3 14472.8 14184.6 14401.1 14496.1 14516.3 14529.1 2625.9 2688.1 2688.1 2700.6 2702.8 2559.1 2650.4 2715.9 2727.9 2735.4 2615.3 2651.1 2652.4 2655.7 2676.4 2589.7 2620.9 2650.2 2651.8 2659.8 2625.5 2629.4 2634.9 2638.2 2644.6 13947.4 14008.2 14189.8 14193.2 14216.0 7498.6 7631.1 7660.3 7743.9 7764.8 4750.8 4823.3 4858.9 4974.9 4977.1 1841.0 1882.8 1902.7 1909.9 1928.2 22914.4 23010.4 23026.9 23090.7 23093.2 6217.6 6387.4 6427.7 6593.8 6625.7 15700.6 15803.6 15883.7 15893.7 15919.1 7096.8 7366.8 7399.5 7451.8 7464.5 6059.6 6393.3 7019.6 7206.9 7293.1 4912.5 4967.7 5032.6 5047.3 5065.3 1425.3 1438.6 1445.4 1454.1 1465.6 907.5 922.8 928.4 929.3 937.2 7277.2 7338.9 7409.3 7426.6 7435.2 711.1 713.8 716.3 721.4 722.7 4524.9 5143.4 5188.5 5278.9 5362.3 18593.0 19514.7 19634.2 19675.4 19719.0 17789.7 19258.5 19263.2 19269.7 19467.5 10512.5 10620.3 10888.5 10911.3 10974.9 8226.1 8238.1 8265.1 8285.3 8394.8 16917.6 17014.0 17287.7 17463.9 17490.0 17098.0 17182.1 17305.9 17515.0 17817.1 11292.5 11654.7 11677.4 11759.8 11774.1 13005.3 13120.7 13156.4 13159.3 13167.0 10556.2 10720.8 10753.5 10972.9 10984.2 10315.2 10371.9 10386.2 10555.7 10743.2 9134.0 9163.6 9206.9 9237.8 9306.9 6637.2 6690.4 6701.3 6744.8 6867.3 6919.4 7081.4 7350.6 7351.5 7447.0 14:30:05 INFO - PID 5378 | 14:30:05 INFO - PID 5378 | [#4] prototype.html Cycles:180 Average:5445.96 Median:6062.21 stddev:1524.37 (25.1%) stddev-sans-first:1482.75 14:30:05 INFO - PID 5378 | Values: 499.9 508.4 511.1 524.3 528.8 6047.7 6108.2 6166.4 6187.0 6240.1 6023.1 6045.8 6062.5 6085.8 6124.5 4962.2 4996.4 5028.9 5041.9 5091.6 4817.9 4888.7 4947.1 4984.5 5003.4 4878.9 4885.4 4915.8 4930.6 4952.9 4758.6 4902.8 4949.7 4959.8 4963.1 4314.5 4370.6 4423.5 4440.6 4452.2 5980.3 6061.9 6067.2 6083.3 6095.5 5611.7 5637.9 5645.9 5654.5 5674.0 6460.3 6478.2 6479.2 6533.3 6566.2 4825.3 4841.4 4877.7 4902.6 4911.7 6621.1 6629.7 6715.6 6717.3 6961.2 4799.2 4865.3 4886.9 4900.5 4950.3 4859.4 4942.2 4954.8 4966.5 5008.6 5554.5 5570.3 5571.6 5598.3 5611.4 6444.9 6457.6 6525.4 6532.3 6590.9 1745.6 1749.7 1760.9 1766.3 1770.0 1155.3 1200.4 1224.9 1236.8 1243.3 5639.0 5707.6 5711.0 5741.7 5756.4 6602.6 6639.3 6655.9 6690.9 6747.7 5742.1 5752.0 5762.7 5784.8 5801.0 3469.6 3506.2 3523.8 3548.4 3558.3 6362.4 6372.6 6417.5 6457.6 6464.7 6727.6 6783.7 6830.1 6861.2 6870.2 6342.6 6416.0 6440.0 6453.7 6459.3 6523.5 6528.3 6570.3 6601.6 6651.1 5958.7 6458.7 6477.9 6625.3 6629.0 6340.9 6366.4 6393.6 6398.3 6444.9 4865.9 4881.4 4898.8 4919.7 4951.0 6435.2 6686.2 6709.6 6712.2 6717.8 6398.3 6403.3 6489.0 6503.1 6547.0 6301.8 6431.3 6454.0 6490.3 6573.7 6290.4 6356.2 6403.7 6485.2 6519.7 6461.9 6545.8 6560.6 6567.7 6623.5 6281.5 6293.3 6294.7 6307.7 6340.5 14:30:05 INFO - PID 5378 | 14:30:05 INFO - PID 5378 | [#5] yui.html Cycles:180 Average:24507.97 Median:19729.46 stddev:33109.70 (167.8%) stddev-sans-first:33155.09 14:30:05 INFO - PID 5378 | Values: 890.8 896.9 913.6 915.8 919.6 18816.4 19728.3 19739.9 19791.4 19803.5 16507.7 16953.7 19046.7 19100.8 19839.4 1030.9 1048.7 1049.4 1050.3 1051.3 1045.5 1052.2 1053.0 1053.0 1058.4 1049.1 1084.5 1105.6 1125.3 1132.6 1085.4 1087.2 1094.9 1095.1 1101.2 797.5 797.5 798.4 801.9 804.5 19745.6 20217.6 20371.8 20515.5 20937.5 21633.8 21735.9 21857.6 22308.9 22374.0 16510.0 16636.2 16676.0 16861.9 17327.2 3327.5 3351.9 3377.4 3381.8 3389.9 124364.0 125136.4 127318.0 131629.3 133919.0 17118.7 17144.0 17483.7 17624.7 17696.5 31857.5 32536.8 32601.0 32762.5 33197.5 8708.7 8795.8 8800.1 8806.7 8819.8 4198.8 4257.8 4339.2 4428.0 4429.4 5269.3 5393.0 5398.6 5399.4 5418.6 1006.2 1024.0 1025.7 1034.0 1046.0 678.7 688.8 693.4 695.6 700.8 11911.8 12103.9 12283.2 13089.9 13310.6 665.0 673.7 679.0 685.5 704.3 5858.6 5877.6 5879.8 6032.1 6086.6 110678.0 111487.0 114209.0 119917.4 120325.0 90466.5 97401.5 100131.5 101000.0 103395.0 87827.6 88312.6 88701.6 90405.0 90531.0 12669.3 12822.4 13078.8 13289.9 13328.7 39275.0 39996.0 40222.0 40854.2 41484.0 72186.0 72982.6 75835.0 76356.6 77868.2 17755.6 17906.8 18265.9 18342.0 18646.3 19336.4 19353.9 19393.9 19500.1 19573.0 19156.0 19647.0 19676.9 19723.1 19730.6 19400.1 19977.5 20082.7 20675.2 20687.4 18951.5 19636.9 20008.5 20084.8 20292.7 14063.8 14071.4 14086.9 14125.4 14383.6 14974.0 15092.2 15187.5 15722.2 15742.4 14:30:05 INFO - PID 5378 | -------- Summary: end -------- 14:30:05 INFO - PID 5378 | 14:30:06 INFO - TEST-INFO | 5378: exit 0 14:30:06 INFO - TEST-OK | dromaeo_css | took 1114522ms 14:30:06 INFO - TEST-START | kraken 14:30:06 INFO - Initialising browser for kraken test... 14:30:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37569/getInfo.html -profile /tmp/tmpAzLXXr/profile 14:30:06 INFO - TEST-INFO | started process 5804 (/builds/slave/test/build/application/firefox/firefox http://localhost:37569/getInfo.html) 14:30:12 INFO - TEST-INFO | 5804: exit 0 14:30:12 INFO - Browser initialized. 14:30:12 INFO - Running cycle 1/1 for kraken test... 14:30:12 INFO - TEST-INFO | started process 5990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAzLXXr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:13 INFO - PID 5990 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 14:30:13 INFO - PID 5990 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 14:30:13 INFO - PID 5990 | 14:30:13 INFO - PID 5990 | (/builds/slave/test/build/application/firefox/firefox:6049): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:30:13 INFO - PID 5990 | 14:30:14 INFO - PID 5990 | 14:30:14 INFO - PID 5990 | (/builds/slave/test/build/application/firefox/firefox:6106): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:30:14 INFO - PID 5990 | 14:30:14 INFO - PID 5990 | __metrics Screen width/height:1600/1200 14:30:14 INFO - PID 5990 | colorDepth:24 14:30:14 INFO - PID 5990 | Browser inner width/height: 1024/768 14:30:14 INFO - PID 5990 | __metrics 14:30:23 INFO - PID 5990 | RSS: Main: 201539584 14:30:23 INFO - PID 5990 | 14:30:26 INFO - PID 5990 | Cycle 1(1): loaded http://localhost:37569/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37569/tests/kraken/driver.html?testName=audio-beat-detection) 14:30:27 INFO - PID 5990 | RSS: Main: 211582976 14:30:27 INFO - PID 5990 | 14:30:27 INFO - PID 5990 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 14:30:30 INFO - PID 5990 | Cycle 1(1): loaded http://localhost:37569/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37569/tests/kraken/driver.html?testName=audio-dft) 14:30:30 INFO - PID 5990 | RSS: Main: 226828288 14:30:30 INFO - PID 5990 | 14:30:33 INFO - PID 5990 | Cycle 1(1): loaded http://localhost:37569/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37569/tests/kraken/driver.html?testName=audio-fft) 14:30:34 INFO - PID 5990 | RSS: Main: 219226112 14:30:34 INFO - PID 5990 | 14:30:36 INFO - PID 5990 | Cycle 1(1): loaded http://localhost:37569/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37569/tests/kraken/driver.html?testName=audio-oscillator) 14:30:37 INFO - PID 5990 | RSS: Main: 220704768 14:30:37 INFO - PID 5990 | 14:30:39 INFO - PID 5990 | Cycle 1(1): loaded http://localhost:37569/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37569/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:30:40 INFO - PID 5990 | RSS: Main: 221130752 14:30:40 INFO - PID 5990 | 14:30:43 INFO - PID 5990 | Cycle 1(1): loaded http://localhost:37569/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37569/tests/kraken/driver.html?testName=imaging-darkroom) 14:30:43 INFO - PID 5990 | RSS: Main: 221700096 14:30:43 INFO - PID 5990 | 14:30:47 INFO - PID 5990 | Cycle 1(1): loaded http://localhost:37569/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37569/tests/kraken/driver.html?testName=imaging-desaturate) 14:30:48 INFO - PID 5990 | RSS: Main: 220950528 14:30:48 INFO - PID 5990 | 14:30:50 INFO - PID 5990 | Cycle 1(1): loaded http://localhost:37569/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37569/tests/kraken/driver.html?testName=json-parse-financial) 14:30:51 INFO - PID 5990 | RSS: Main: 221556736 14:30:51 INFO - PID 5990 | 14:30:53 INFO - PID 5990 | Cycle 1(1): loaded http://localhost:37569/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37569/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:30:53 INFO - PID 5990 | RSS: Main: 222478336 14:30:53 INFO - PID 5990 | 14:30:55 INFO - PID 5990 | Cycle 1(1): loaded http://localhost:37569/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37569/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:30:56 INFO - PID 5990 | RSS: Main: 223207424 14:30:56 INFO - PID 5990 | 14:30:58 INFO - PID 5990 | Cycle 1(1): loaded http://localhost:37569/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37569/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:30:59 INFO - PID 5990 | RSS: Main: 223424512 14:30:59 INFO - PID 5990 | 14:31:02 INFO - PID 5990 | Cycle 1(1): loaded http://localhost:37569/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:02 INFO - PID 5990 | RSS: Main: 221536256 14:31:02 INFO - PID 5990 | 14:31:05 INFO - PID 5990 | Cycle 1(1): loaded http://localhost:37569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:06 INFO - PID 5990 | RSS: Main: 223760384 14:31:06 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | Cycle 1(1): loaded http://localhost:37569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37569/tests/kraken/driver.html?testName=ai-astar) 14:31:08 INFO - PID 5990 | RSS: Main: 224657408 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | __start_tp_report 14:31:08 INFO - PID 5990 | _x_x_mozilla_page_load 14:31:08 INFO - PID 5990 | _x_x_mozilla_page_load_details 14:31:08 INFO - PID 5990 | |i|pagename|runs| 14:31:08 INFO - PID 5990 | |0;ai-astar;99;113;109;109;108;108;113;100;109;110 14:31:08 INFO - PID 5990 | |1;audio-beat-detection;162;124;151;179;122;145;143;123;175;117 14:31:08 INFO - PID 5990 | |2;audio-dft;164;167;164;166;169;169;163;168;164;165 14:31:08 INFO - PID 5990 | |3;audio-fft;76;82;84;171;83;81;86;85;160;79 14:31:08 INFO - PID 5990 | |4;audio-oscillator;85;80;145;88;86;79;134;89;81;139 14:31:08 INFO - PID 5990 | |5;imaging-gaussian-blur;114;115;115;115;116;115;118;115;116;119 14:31:08 INFO - PID 5990 | |6;imaging-darkroom;152;153;155;155;152;151;159;157;154;150 14:31:08 INFO - PID 5990 | |7;imaging-desaturate;101;104;97;94;102;99;95;100;102;94 14:31:08 INFO - PID 5990 | |8;json-parse-financial;55;58;56;66;59;55;66;55;55;56 14:31:08 INFO - PID 5990 | |9;json-stringify-tinderbox;62;65;60;55;60;64;65;63;60;55 14:31:08 INFO - PID 5990 | |10;stanford-crypto-aes;83;80;78;78;77;83;80;76;80;81 14:31:08 INFO - PID 5990 | |11;stanford-crypto-ccm;123;139;121;129;127;130;131;125;133;170 14:31:08 INFO - PID 5990 | |12;stanford-crypto-pbkdf2;172;183;193;177;174;173;175;178;178;173 14:31:08 INFO - PID 5990 | |13;stanford-crypto-sha256-iterative;68;71;67;71;66;69;66;69;69;66 14:31:08 INFO - PID 5990 | __end_tp_report 14:31:08 INFO - PID 5990 | __start_cc_report 14:31:08 INFO - PID 5990 | _x_x_mozilla_cycle_collect,971 14:31:08 INFO - PID 5990 | __end_cc_report 14:31:08 INFO - PID 5990 | __startTimestamp1503091868526__endTimestamp 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | ------- Summary: start ------- 14:31:08 INFO - PID 5990 | Number of tests: 14 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | [#0] ai-astar Cycles:10 Average:107.80 Median:109.50 stddev:4.73 (4.3%) stddev-sans-first:3.80 14:31:08 INFO - PID 5990 | Values: 99.0 113.0 109.0 109.0 108.0 108.0 113.0 100.0 109.0 110.0 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:148.00 stddev:22.64 (15.3%) stddev-sans-first:23.07 14:31:08 INFO - PID 5990 | Values: 162.0 124.0 151.0 179.0 122.0 145.0 143.0 123.0 175.0 117.0 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.50 stddev:2.23 (1.3%) stddev-sans-first:2.26 14:31:08 INFO - PID 5990 | Values: 164.0 167.0 164.0 166.0 169.0 169.0 163.0 168.0 164.0 165.0 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | [#3] audio-fft Cycles:10 Average:98.70 Median:82.50 stddev:35.42 (42.9%) stddev-sans-first:36.61 14:31:08 INFO - PID 5990 | Values: 76.0 82.0 84.0 171.0 83.0 81.0 86.0 85.0 160.0 79.0 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | [#4] audio-oscillator Cycles:10 Average:100.60 Median:83.00 stddev:27.05 (32.6%) stddev-sans-first:28.10 14:31:08 INFO - PID 5990 | Values: 85.0 80.0 145.0 88.0 86.0 79.0 134.0 89.0 81.0 139.0 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:115.50 stddev:1.55 (1.3%) stddev-sans-first:1.50 14:31:08 INFO - PID 5990 | Values: 114.0 115.0 115.0 115.0 116.0 115.0 118.0 115.0 116.0 119.0 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | [#6] imaging-darkroom Cycles:10 Average:153.80 Median:154.50 stddev:2.78 (1.8%) stddev-sans-first:2.87 14:31:08 INFO - PID 5990 | Values: 152.0 153.0 155.0 155.0 152.0 151.0 159.0 157.0 154.0 150.0 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | [#7] imaging-desaturate Cycles:10 Average:98.80 Median:94.00 stddev:3.61 (3.8%) stddev-sans-first:3.75 14:31:08 INFO - PID 5990 | Values: 101.0 104.0 97.0 94.0 102.0 99.0 95.0 100.0 102.0 94.0 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:57.00 stddev:4.38 (7.7%) stddev-sans-first:4.50 14:31:08 INFO - PID 5990 | Values: 55.0 58.0 56.0 66.0 59.0 55.0 66.0 55.0 55.0 56.0 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:62.50 stddev:3.67 (5.9%) stddev-sans-first:3.87 14:31:08 INFO - PID 5990 | Values: 62.0 65.0 60.0 55.0 60.0 64.0 65.0 63.0 60.0 55.0 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:80.00 stddev:2.37 (3.0%) stddev-sans-first:2.17 14:31:08 INFO - PID 5990 | Values: 83.0 80.0 78.0 78.0 77.0 83.0 80.0 76.0 80.0 81.0 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:130.50 stddev:14.05 (10.8%) stddev-sans-first:14.45 14:31:08 INFO - PID 5990 | Values: 123.0 139.0 121.0 129.0 127.0 130.0 131.0 125.0 133.0 170.0 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.60 Median:177.50 stddev:6.33 (3.6%) stddev-sans-first:6.38 14:31:08 INFO - PID 5990 | Values: 172.0 183.0 193.0 177.0 174.0 173.0 175.0 178.0 178.0 173.0 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.93 (2.8%) stddev-sans-first:2.05 14:31:08 INFO - PID 5990 | Values: 68.0 71.0 67.0 71.0 66.0 69.0 66.0 69.0 69.0 66.0 14:31:08 INFO - PID 5990 | -------- Summary: end -------- 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | 14:31:08 INFO - PID 5990 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 14:31:08 INFO - PID 5990 | 14:31:09 INFO - PID 5990 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:31:09 INFO - TEST-INFO | 5990: exit 0 14:31:09 INFO - TEST-OK | kraken | took 63024ms 14:31:09 INFO - SUITE-END | took 1177s 14:31:09 INFO - Completed test suite (00:19:37) 14:31:09 INFO - javascript benchmark 14:31:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8541.811936776006, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3015.20097174249, 3067.6472205696336, 3095.504719244921, 3119.9844000779995, 3127.9530807037886, 6043.365446628107, 6081.54388420868, 6188.226471691039, 6199.194104766385, 6202.379762023796, 6142.969285153568, 6177.135201071854, 6200.193974783272, 6226.875462490748, 6267.780627678021, 5589.189567512708, 5599.63602365847, 5686.31764188297, 5694.0, 5729.28383952006, 5506.339239291291, 5537.861553461155, 5569.275994120759, 5573.4147914469, 5631.493165615094, 5564.10974244121, 5593.909187708398, 5612.270404847364, 5617.578681598856, 5644.181593668915, 5585.190147428641, 5595.944040559583, 5601.411851755548, 5603.915941260884, 5622.690752008638, 5506.1190209566275, 5589.80435684749, 5598.048331783607, 5629.746661400247, 5663.716814159276, 6058.575899687024, 6090.33006369299, 6112.205413296288, 6122.938770612282, 6158.599691020114, 6375.585586936834, 6587.242467116295, 6599.868002639968, 6650.667466626698, 6694.43097336727, 6481.74073037078, 6569.178852643419, 6569.408753212234, 6592.736290548372, 6603.108580341641, 6104.816855494298, 6198.907016394758, 6207.224096987877, 6214.161088253073, 6238.407351301619, 6609.272979972199, 6792.252852186256, 6881.793546193622, 6889.069975553336, 6889.138857642794, 6349.619022858643, 6359.141515895295, 6386.936130638727, 6390.0, 6404.263509696351, 6490.448311893448, 6521.771737989147, 6525.184351956005, 6528.608283503005, 6544.770933017321, 6392.872142557123, 6423.357664233539, 6473.838154046187, 6484.221893372731, 6530.575512591667, 6453.967730161319, 6463.838404039842, 6482.384173503509, 6501.739930402826, 6538.967305163444, 5345.278387417648, 5355.946440535545, 5385.165299378603, 5389.892202155935, 5481.917771233435, 4561.110583436198, 4617.746023968647, 4628.907421851612, 4628.930566041512, 4643.117807616542, 5661.1508273758445, 5694.430556944355, 5739.598228123991, 5768.711564421846, 5782.884342313214, 6476.0, 6563.704633291513, 6565.080888675589, 6575.967120164369, 6581.177352830896, 5672.631278966854, 5710.2576665033275, 5711.543076553866, 5716.485516303553, 5735.827925162252, 5802.622829516153, 5831.329397119301, 5868.559858010581, 5936.673482958478, 5939.316978547522, 6348.587341822767, 6373.490120790326, 6428.292887782433, 6442.48460123189, 6474.223093228843, 6280.9685951569945, 6464.935350646621, 6512.772052978313, 6576.572522786004, 6582.243042050225, 6382.393672601095, 6455.3221911700475, 6459.709313081016, 6488.383603557654, 6497.610143391412, 6487.0593763903025, 6591.96704016496, 6606.141201643948, 6613.702383392662, 6617.106690596708, 6589.341065893564, 6592.90110648331, 6683.699233534599, 6688.799336019927, 6691.0, 6291.622502649856, 6428.582142160744, 6430.646314452563, 6534.248561415498, 6536.640484773383, 6346.111544383883, 6363.268224154096, 6367.140436041075, 6393.360663933569, 6397.040443933447, 6257.342978987141, 6322.36776322364, 6333.936660633335, 6342.270638876588, 6344.238691357066, 6327.810165695037, 6386.584871983307, 6420.165378500765, 6422.967885160731, 6455.548111632328, 6205.565610407409, 6221.5333849962335, 6223.937760622336, 6267.435930766253, 6314.463270622048], "value": 6002.108907120429, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.6420778545762, 837.8994520657515, 850.527956983874, 878.79348353137, 879.6833140069574, 41065.0, 41625.0, 41755.79122104389, 41906.58093419065, 41938.370924436116, 37944.43083353745, 38211.617883821156, 38286.23427531448, 38320.808395958054, 38353.23293534128, 6807.795766127012, 6862.965685171567, 6898.1377327834025, 6902.930970690304, 6906.067680863094, 6842.828929276783, 6894.586324820501, 6916.6541672916155, 6926.792196234096, 6932.861342773142, 6899.6550172491425, 7482.289182527678, 7728.0, 7753.379729621617, 7773.9222607774045, 7598.582077985709, 7660.0, 7662.540247585107, 7669.156392796788, 7718.884216736754, 7427.405807535384, 7561.319481246659, 7608.695652173907, 7617.238276172394, 7684.385249180053, 38748.80625596882, 38834.417483737765, 38932.416013759816, 38997.805010974764, 39045.21909561821, 3569.464580312948, 3601.225736466672, 3605.5312809334882, 3628.238070005276, 3630.5824830144606, 30365.089047328616, 30412.695873041208, 30536.931207407855, 30564.388712225853, 30598.92903748358, 4951.950480495185, 4974.651774375795, 4986.5761410280165, 4991.201407774739, 5006.549410553068, 224552.0, 226574.0, 228445.0, 230482.0, 230819.8459007711, 50272.49727502751, 50376.496235037914, 50766.0, 50823.745881270355, 50884.0, 52846.0, 52993.470065299625, 53209.467905321224, 56092.15861762077, 56574.43425565774, 16377.181140942905, 16718.41485548, 16722.498325050266, 16724.581885452717, 16729.247183876756, 13661.248631325372, 13701.45194192241, 13718.451261949609, 13775.104618199784, 13783.724325513434, 14601.831853451698, 14639.194844283667, 14678.779818302733, 14694.55916322512, 14793.11241325524, 5680.6591604503865, 5766.452187042224, 5815.534757219497, 5817.534597232211, 5929.080992446177, 993.64228877604, 1002.1081237698454, 1002.9699109026741, 1018.6231094495084, 1019.6940917724653, 23068.769312307, 23209.0, 23276.534469310518, 23390.0, 23442.531149377257, 1093.3877028863863, 1101.5593762494907, 1123.455124264731, 1125.2741981421937, 1133.8696049954196, 12124.332132129193, 12285.38573071343, 12325.260484370967, 12391.380430978415, 16509.0, 234255.0, 236044.0, 237103.0, 237257.0, 237787.0, 49391.25913111306, 49845.25232121521, 58038.0, 58119.418805812245, 58671.0, 1484.6585285384422, 1513.712394645014, 1517.6281810956386, 1532.3181184372847, 1534.7237497250603, 28558.714412855606, 28648.14055578336, 28677.85661071681, 28683.569746453402, 29486.410271794874, 37739.0, 37753.62246377501, 37962.62037379591, 38079.619203807604, 38155.2368952625, 214405.0, 216268.0, 217069.0, 217347.0, 217953.0, 37388.0, 37535.81232093822, 37583.0, 37624.811875940446, 37733.4339984906, 44563.77718111389, 47391.763041184575, 48764.0, 48794.26808597803, 48947.0, 33870.491942621375, 34677.0, 34891.77878774231, 35530.822345888104, 35876.461853072746, 33498.66501334956, 34310.313793723486, 34713.82643086869, 35470.64529354673, 35602.46596301006, 36937.81531092327, 37413.43879841859, 38282.61717382791, 38530.6146938527, 38545.6145438542, 33567.328653427285, 33808.0, 34070.65929340774, 34160.82919585386, 34170.658293416745, 23783.0, 24536.570270621258, 24598.877005614857, 24599.631005534575, 25079.74920250774], "value": 17675.391969068092, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.4253061876889, 572.4819038769912, 573.3435216676905, 574.9195112684222, 581.8894410062088, 21914.0, 22739.54520909581, 22761.999999999978, 22793.202237921676, 22851.77148228517, 19394.806051939475, 23511.0, 24261.636075458882, 25754.0, 25927.481450370982, 6181.0, 6327.082573026908, 6338.809835704937, 6373.7131829067575, 6383.042543618448, 6271.310155882849, 6361.968190159043, 6366.904496432558, 6394.488440924715, 6399.776007839727, 6129.846753831168, 6721.630310332954, 6750.662466876661, 6761.966190169067, 6779.593224406527, 6650.966745166292, 6671.0, 6727.764528241512, 6736.191657001191, 6741.426978706816, 6517.543771935966, 6535.607863528204, 6590.143281373391, 6605.636689982049, 6614.040964060232, 28857.278568035756, 30086.398272034436, 30263.184208947532, 30783.538246926313, 30855.84572077148, 1947.6299503094367, 1990.5521257716898, 1991.332903477337, 1992.7608686957512, 1997.4507010572063, 18802.435926922215, 19123.71314430285, 19146.04269786519, 19291.51771205717, 19442.805571944384, 2391.366287933699, 2419.020296779807, 2465.6178292364534, 2482.8013758899247, 2508.949821003588, 141845.0, 148867.0, 149061.0, 149104.2544787269, 149354.0, 19856.808591484267, 21018.2643607473, 21054.47363815917, 21225.15099396038, 21680.783192168194, 43030.56969430328, 43245.0, 43336.3499547507, 43337.56662433398, 43418.34872476915, 11146.832797508045, 11266.605668801552, 11353.943230283796, 11386.430678466044, 11412.144089193343, 9186.908130918606, 9278.953605232065, 9412.15290623847, 9454.0, 9555.140037396528, 8367.912171417676, 11130.610428634958, 11329.734053189395, 11502.884971150348, 11595.362255075883, 2621.200533837198, 2701.540738074532, 2714.3763076292976, 2757.4071574611553, 2760.627315312447, 955.3217215776876, 963.8987906269881, 981.8772653418323, 984.7931934293736, 1006.3609607898891, 19346.129424175946, 19636.803631963783, 20010.799892001185, 20051.799482004993, 20385.49036274105, 1034.3535290443472, 1036.7200855769051, 1052.6841947415744, 1054.593981317183, 1059.1050562274866, 10604.575816967235, 10760.0, 10942.398168100832, 10966.725831854108, 11128.38793866345, 458929.0, 460093.0, 460843.0, 529247.3537632287, 533421.0, 120751.0, 124147.0, 124807.0, 127167.0, 128399.0, 1224.2593231095236, 1246.8379110715548, 1290.3290289049642, 1290.4580076367947, 1290.677330667352, 19449.708254375913, 20203.69694454555, 20238.494037649176, 20296.289629862884, 20304.289349872684, 56925.0, 59411.0, 60089.39910600838, 60912.0, 60984.39015609787, 71618.64190679013, 72720.27279727135, 73329.6333518329, 74395.62802185955, 75200.62399687967, 13860.237686927316, 14271.785923211368, 14341.713165736835, 14366.856331436551, 14396.568102956928, 16886.831131688527, 21194.364169074954, 22947.93732299029, 23130.76869231286, 23282.76717232874, 15760.92119539395, 15904.76142857835, 16021.198940052718, 16061.196940152711, 16152.434664786677, 15090.24548772535, 16471.67056658836, 16691.332346705996, 16940.57648558796, 17055.06197159168, 15906.727461802797, 16394.180290985165, 16403.58991025234, 16407.917960410123, 16431.917840410722, 13863.168209907439, 13864.653383665489, 13923.58229253124, 13996.65008374758, 14009.08940918837, 15467.381304747683, 15815.920920395325, 16109.516714498584, 16257.918710406373, 16502.25739841734], "value": 12330.695404624343, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.5698454986677, 1419.6379923119603, 1445.7903603977425, 1452.230317931496, 1452.4335509151426, 13683.24742139182, 13959.232242226699, 14408.711825763492, 14451.349689263981, 14472.782908256384, 14184.574462766108, 14401.135931844097, 14496.130232186077, 14516.346764395601, 14529.128252304869, 2625.8949642014295, 2688.086050742747, 2688.126358933345, 2700.5544085225915, 2702.7837772978214, 2559.104313490273, 2650.4036591766794, 2715.9321016974636, 2727.9181624551197, 2735.37086470112, 2615.3069436599317, 2651.0721247563392, 2652.3501742073217, 2655.7477039681294, 2676.397810492633, 2589.676290463692, 2620.882060307291, 2650.2446802661248, 2651.814372993891, 2659.7739192168688, 2625.474905019004, 2629.382095207625, 2634.855082970436, 2638.2480992917117, 2644.6429731986127, 13947.372368243352, 14008.22954737489, 14189.78715319271, 14193.219372934485, 14216.0, 7498.550086994798, 7631.12242092161, 7660.310572048543, 7743.8838417423785, 7764.805879853049, 4750.786214620351, 4823.276508523714, 4858.878528036792, 4974.90050198994, 4977.079240340512, 1841.0, 1882.802305757903, 1902.7145928110756, 1909.9140538675654, 1928.2094341320133, 22914.427139321484, 23010.42473938148, 23026.884865575732, 23090.65364019541, 23093.19173828908, 6217.626942383471, 6387.425131738073, 6427.678616069178, 6593.769218077345, 6625.734970601218, 15700.607484812972, 15803.577678009035, 15883.682326353639, 15893.682126357407, 15919.124448155231, 7096.7516136934955, 7366.815829604303, 7399.519031262951, 7451.813704657318, 7464.514806537558, 6059.6364218147055, 6393.296737358887, 7019.613921234381, 7206.891896621555, 7293.1248250209255, 4912.508749125059, 4967.652264341534, 5032.572231360376, 5047.268146118792, 5065.290859279704, 1425.2659880161725, 1438.604383794444, 1445.4146070841116, 1454.1129910754432, 1465.5749832548443, 907.4509921497531, 922.8292765838341, 928.4475736936512, 929.3262384770987, 937.1659223291276, 7277.19950805411, 7338.926610733824, 7409.296116868889, 7426.554406735613, 7435.219301973323, 711.1253158614933, 713.7501874343938, 716.3130826902569, 721.4480922094601, 722.6639612580176, 4524.932126018112, 5143.408508021551, 5188.507091826271, 5278.9472105278455, 5362.27609272751, 18593.0, 19514.70727939082, 19634.214631414583, 19675.40973770789, 19719.0, 17789.7331540027, 19258.518537036405, 19263.22947082101, 19269.710954335696, 19467.51331216731, 10512.526936288039, 10620.256582039337, 10888.510017049251, 10911.290766100177, 10974.945125274322, 8226.095129535626, 8238.134995825352, 8265.132161122996, 8285.337173026022, 8394.790130246793, 16917.577060573585, 17014.0, 17287.65424691474, 17463.912680436515, 17490.03804790749, 17098.0, 17182.140892955053, 17305.913470432566, 17515.0366729826, 17817.10914454298, 11292.548298067984, 11654.650360489199, 11677.357745324089, 11759.823602646138, 11774.058075354122, 13005.349732513147, 13120.671983200496, 13156.40796164194, 13159.342032898508, 13167.0, 10556.208284378548, 10720.785584288427, 10753.516091775733, 10972.890271097187, 10984.231103822656, 10315.17478601695, 10371.896281037092, 10386.169106471616, 10555.736106597396, 10743.194260430655, 9134.040925702706, 9163.587638556148, 9206.861897071683, 9237.769055773659, 9306.860397093913, 6637.203535575762, 6690.431313338226, 6701.296363881722, 6744.7976560703255, 6867.278935711878, 6919.411849992807, 7081.433485321265, 7350.558966462029, 7351.522151060164, 7447.0], "value": 6308.434241467646, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.93250911127, 508.38739319120464, 511.1081163369919, 524.2634099090776, 528.8254875890954, 6047.697615119243, 6108.205933228674, 6166.4450199482035, 6186.969065154673, 6240.095186198004, 6023.126646636235, 6045.818625441244, 6062.484688801446, 6085.786997455079, 6124.479419249358, 4962.15643340633, 4996.425411077718, 5028.899422011557, 5041.924371134436, 5091.618128640348, 4817.940053188293, 4888.731119788428, 4947.060058588857, 4984.501549845005, 5003.374578177728, 4878.853634390974, 4885.389326334208, 4915.844776477525, 4930.605551555867, 4952.925706114411, 4758.619310455155, 4902.803887844482, 4949.67365338294, 4959.809645685045, 4963.131451995904, 4314.525402205786, 4370.628496577795, 4423.540231723524, 4440.578145076212, 4452.243118669834, 5980.325508857527, 6061.939380606225, 6067.180930574405, 6083.330833608299, 6095.481884039862, 5611.719414029282, 5637.8590535236535, 5645.8588535286535, 5654.46282603152, 5674.042455352938, 6460.321666225026, 6478.190226221723, 6479.157709497782, 6533.314002029813, 6566.179227596551, 4825.276208568707, 4841.434039958827, 4877.658563900528, 4902.583280421169, 4911.705297682151, 6621.106150669694, 6629.73481060757, 6715.630640314781, 6717.261101278904, 6961.164660240804, 4799.232122860326, 4865.318855360252, 4886.877828054256, 4900.4854490278, 4950.2822090796635, 4859.392575928009, 4942.184539551005, 4954.752262386866, 4966.528179822911, 5008.574271186917, 5554.472325129106, 5570.3315602128005, 5571.637843540157, 5598.300212473441, 5611.438856114438, 6444.903326450107, 6457.644829534421, 6525.412712855866, 6532.346765323429, 6590.901136482957, 1745.6159644878107, 1749.7287920372107, 1760.9207585658676, 1766.3464518128376, 1769.9646007080044, 1155.3183621663259, 1200.3578085724096, 1224.8591411987557, 1236.771197328497, 1243.2726854790048, 5639.013172694844, 5707.600467967285, 5711.0, 5741.65550066989, 5756.366799652035, 6602.636854973022, 6639.306976720905, 6655.900161497581, 6690.866182676319, 6747.730090796314, 5742.13867919807, 5752.015554633728, 5762.74067666956, 5784.82645520635, 5801.0, 3469.61834198238, 3506.1935754776546, 3523.8195204606745, 3548.3919319300294, 3558.2705545363137, 6362.395572420705, 6372.5661726112185, 6417.486601071903, 6457.580257283262, 6464.709088091047, 6727.562708423937, 6783.660816959133, 6830.146231721035, 6861.245263021064, 6870.175578930561, 6342.587731797418, 6415.967920160276, 6439.967800160969, 6453.677316134174, 6459.289478157305, 6523.510736694861, 6528.314526974599, 6570.310117437601, 6601.570897891814, 6651.135352404156, 5958.672273025025, 6458.677066146768, 6477.8704425912165, 6625.304343043911, 6629.0, 6340.875806604839, 6366.427021568081, 6393.6483493408305, 6398.328175541501, 6444.935550644621, 4865.9270110947655, 4881.414230292387, 4898.771059168142, 4919.729414882073, 4950.975245123751, 6435.195600549931, 6686.197656281277, 6709.563878347892, 6712.194536655633, 6717.798466046026, 6398.264199617103, 6403.3276505966205, 6489.0, 6503.122078519339, 6547.0, 6301.779437719658, 6431.324710905475, 6454.0, 6490.338961025956, 6573.671316434255, 6290.370962903673, 6356.2054743157105, 6403.6798160090875, 6485.156929599122, 6519.728652912826, 6461.870762584816, 6545.836354091186, 6560.573562718408, 6567.704453299709, 6623.503237257129, 6281.466075383643, 6293.276273228455, 6294.748210071546, 6307.747690092345, 6340.461060809883], "value": 5000.020286989495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.8396488632044, 896.8834051573295, 913.6208473483505, 915.8443064679004, 919.6045700348848, 18816.4355069348, 19728.309509167182, 19739.901300493497, 19791.406257812254, 19803.504912377197, 16507.66984660309, 16953.745693814602, 19046.714299285522, 19100.80899191008, 19839.404817855488, 1030.9226807989412, 1048.6591857646258, 1049.4385503755493, 1050.2595670052633, 1051.3218973761918, 1045.5451878432907, 1052.200327750911, 1052.9578816847318, 1052.9842052369183, 1058.4125810175349, 1049.0610903241595, 1084.4577711144427, 1105.5964572930864, 1125.3304283951036, 1132.6092498088187, 1085.3813326403954, 1087.1791797193148, 1094.8740894797081, 1095.05277934586, 1101.2126329674322, 797.453744185235, 797.4975765267902, 798.4371018432049, 801.9398545109082, 804.5454318310136, 19745.605087898304, 20217.595648087103, 20371.79628203714, 20515.48711282215, 20937.476563085893, 21633.783662163336, 21735.891320543455, 21857.562848743095, 22308.888455557782, 22374.0, 16510.0, 16636.168191590372, 16676.0, 16861.915690421592, 17327.22027508765, 3327.5175099610665, 3351.882684106069, 3377.392069427502, 3381.8309084545676, 3389.8983030508875, 124364.0, 125136.37431812874, 127318.0, 131629.3418532911, 133919.0, 17118.743218851727, 17144.0, 17483.65032699339, 17624.735628965576, 17696.469105926844, 31857.52213716796, 32536.837315813744, 32601.0, 32762.508562371582, 33197.50203746946, 8708.695195668248, 8795.824083518293, 8800.075992020873, 8806.691765788166, 8819.779505512413, 4198.790060496963, 4257.787110644455, 4339.240632889232, 4428.0, 4429.357743127293, 5269.288646032813, 5393.0, 5398.64908780928, 5399.379071406838, 5418.620696551282, 1006.1648831469862, 1023.9846402303972, 1025.661531694539, 1033.9534720937577, 1045.9633912813015, 678.6606696651675, 688.7727050073464, 693.414065114977, 695.5583204664973, 700.7792545348199, 11911.821322680167, 12103.939480302719, 12283.201591896677, 13089.934550327378, 13310.600681979557, 664.9700763465655, 673.6766352150995, 679.0, 685.4961603221628, 704.2605264472284, 5858.619189752652, 5877.647341159544, 5879.764809407661, 6032.125341825411, 6086.573939824169, 110678.0, 111487.0, 114209.0, 119917.40041299738, 120325.0, 90466.54766726124, 97401.51299243601, 100131.49934250282, 101000.0, 103395.0, 87827.56086219655, 88312.55843720741, 88701.55649221713, 90405.0, 90531.0, 12669.303188324731, 12822.422990965242, 13078.803817942548, 13289.867101328862, 13328.666783330495, 39275.0, 39996.0, 40222.0, 40854.1829163421, 41484.0, 72186.0, 72982.63508682635, 75835.0, 76356.61821691078, 77868.22131778837, 17755.644887101927, 17906.820931790517, 18265.908670456563, 18342.0, 18646.347377842252, 19336.419907402236, 19353.903230483756, 19393.90303048476, 19500.1224944875, 19573.0, 19156.0, 19647.0, 19676.90161549183, 19723.11245993905, 19730.60538789245, 19400.12699428501, 19977.500562486053, 20082.69875951891, 20675.17299308011, 20687.379378618665, 18951.526211844815, 19636.9018154914, 20008.49978750543, 20084.799152008294, 20292.695609566163, 14063.789043164155, 14071.437142514185, 14086.929565352517, 14125.434982600991, 14383.568492945229, 14974.0, 15092.245387730789, 15187.544373668808, 15722.21388930526, 15742.449014284903], "value": 9412.766147339858, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 113.0, 109.0, 109.0, 108.0, 108.0, 113.0, 100.0, 109.0, 110.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 124.0, 151.0, 179.0, 122.0, 145.0, 143.0, 123.0, 175.0, 117.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 164.0, 166.0, 169.0, 169.0, 163.0, 168.0, 164.0, 165.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 84.0, 171.0, 83.0, 81.0, 86.0, 85.0, 160.0, 79.0], "value": 98.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 145.0, 88.0, 86.0, 79.0, 134.0, 89.0, 81.0, 139.0], "value": 100.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 115.0, 116.0, 115.0, 118.0, 115.0, 116.0, 119.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 155.0, 155.0, 152.0, 151.0, 159.0, 157.0, 154.0, 150.0], "value": 153.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 104.0, 97.0, 94.0, 102.0, 99.0, 95.0, 100.0, 102.0, 94.0], "value": 98.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 56.0, 66.0, 59.0, 55.0, 66.0, 55.0, 55.0, 56.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 60.0, 55.0, 60.0, 64.0, 65.0, 63.0, 60.0, 55.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 78.0, 78.0, 77.0, 83.0, 80.0, 76.0, 80.0, 81.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 139.0, 121.0, 129.0, 127.0, 130.0, 131.0, 125.0, 133.0, 170.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 183.0, 193.0, 177.0, 174.0, 173.0, 175.0, 178.0, 178.0, 173.0], "value": 177.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 67.0, 71.0, 66.0, 69.0, 66.0, 69.0, 69.0, 66.0], "value": 68.2, "unit": "score"}]}]} 14:31:09 INFO - Return code: 0 14:31:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:31:09 INFO - # TBPL SUCCESS # 14:31:09 INFO - Running post-action listener: _package_coverage_data 14:31:09 INFO - Running post-action listener: _resource_record_post_action 14:31:09 INFO - [mozharness: 2017-08-18 21:31:09.804109Z] Finished run-tests step (success) 14:31:09 INFO - Running post-run listener: _resource_record_post_run 14:31:09 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 270336; Write bytes: 434499584; Read time: 296; Write time: 354560 14:31:09 INFO - TinderboxPrint: CPU usage
13.3% 14:31:09 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 296 14:31:09 INFO - TinderboxPrint: I/O write bytes / time
434,499,584 / 354,560 14:31:09 INFO - TinderboxPrint: CPU idle
8,263.4 (86.7%) 14:31:09 INFO - TinderboxPrint: CPU user
1,209.2 (12.7%) 14:31:09 INFO - TinderboxPrint: Swap in / out
0 / 0 14:31:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107450368; Read time: 0; Write time: 103980 14:31:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:31:09 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 266240; Write bytes: 325926912; Read time: 276; Write time: 250540 14:31:10 INFO - Running post-run listener: _upload_blobber_files 14:31:10 INFO - Blob upload gear active. 14:31:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:31:10 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 14:31:10 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'] 14:31:10 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 14:31:10 INFO - (blobuploader) - INFO - Open directory for files ... 14:31:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:31:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:31:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:11 INFO - (blobuploader) - INFO - Done attempting. 14:31:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:31:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:31:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:18 INFO - (blobuploader) - INFO - Done attempting. 14:31:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:31:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:31:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:19 INFO - (blobuploader) - INFO - Done attempting. 14:31:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:31:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:31:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:20 INFO - (blobuploader) - INFO - Done attempting. 14:31:20 INFO - (blobuploader) - INFO - Iteration through files over. 14:31:20 INFO - Return code: 0 14:31:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:31:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:31:20 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/daffded2785ada9d11b689ab02b252e393f718a14ef311ab917f29fdd44d5f7f3a579be1631ab655baf8b0de47ebca79ec84594a59832ce81fc0110a1028558c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8004a64b78f784381de7d5060cbc6fa652bf1361c23f7941826eb00de62508b7bbda38b8e544ca907ba7f35e3c65dab6c6b624a404b0f6e35d9b67765c8f16c5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6549ea5729b05dfc6e1c5015a34c30de1700b8e02152e1af23e74db1be5cc4a48d54b0f5852717dbe352f01601038a7a5448890d2a490a73fb3e5076d6bee226", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4499c43fb0b19a998e81ff67f4ac450521a5876ee674f75bb2ef2ad5e1796cb657891aa4ba45db3c562f24f306276a2098647c6c6c49434d34f7071a39bc7629"} 14:31:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:31:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:31:20 INFO - Contents: 14:31:20 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/daffded2785ada9d11b689ab02b252e393f718a14ef311ab917f29fdd44d5f7f3a579be1631ab655baf8b0de47ebca79ec84594a59832ce81fc0110a1028558c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8004a64b78f784381de7d5060cbc6fa652bf1361c23f7941826eb00de62508b7bbda38b8e544ca907ba7f35e3c65dab6c6b624a404b0f6e35d9b67765c8f16c5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6549ea5729b05dfc6e1c5015a34c30de1700b8e02152e1af23e74db1be5cc4a48d54b0f5852717dbe352f01601038a7a5448890d2a490a73fb3e5076d6bee226", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4499c43fb0b19a998e81ff67f4ac450521a5876ee674f75bb2ef2ad5e1796cb657891aa4ba45db3c562f24f306276a2098647c6c6c49434d34f7071a39bc7629"} 14:31:20 INFO - Running post-run listener: copy_logs_to_upload_dir 14:31:20 INFO - Copying logs to upload dir... 14:31:20 INFO - mkdir: /builds/slave/test/build/upload/logs 14:31:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.949464 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-18 14:31:20.327051) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 14:31:20.332170) ========= 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=9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/daffded2785ada9d11b689ab02b252e393f718a14ef311ab917f29fdd44d5f7f3a579be1631ab655baf8b0de47ebca79ec84594a59832ce81fc0110a1028558c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8004a64b78f784381de7d5060cbc6fa652bf1361c23f7941826eb00de62508b7bbda38b8e544ca907ba7f35e3c65dab6c6b624a404b0f6e35d9b67765c8f16c5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6549ea5729b05dfc6e1c5015a34c30de1700b8e02152e1af23e74db1be5cc4a48d54b0f5852717dbe352f01601038a7a5448890d2a490a73fb3e5076d6bee226", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4499c43fb0b19a998e81ff67f4ac450521a5876ee674f75bb2ef2ad5e1796cb657891aa4ba45db3c562f24f306276a2098647c6c6c49434d34f7071a39bc7629"} build_url:https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/QiZA7ovKSU-f1yV-_iZS9A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/daffded2785ada9d11b689ab02b252e393f718a14ef311ab917f29fdd44d5f7f3a579be1631ab655baf8b0de47ebca79ec84594a59832ce81fc0110a1028558c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8004a64b78f784381de7d5060cbc6fa652bf1361c23f7941826eb00de62508b7bbda38b8e544ca907ba7f35e3c65dab6c6b624a404b0f6e35d9b67765c8f16c5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6549ea5729b05dfc6e1c5015a34c30de1700b8e02152e1af23e74db1be5cc4a48d54b0f5852717dbe352f01601038a7a5448890d2a490a73fb3e5076d6bee226", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4499c43fb0b19a998e81ff67f4ac450521a5876ee674f75bb2ef2ad5e1796cb657891aa4ba45db3c562f24f306276a2098647c6c6c49434d34f7071a39bc7629"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 14:31:20.362069) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 14:31:20.362389) ========= 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=9f7544b6a75ada7b6b576032000001a7-1503090620.657215-1298277963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 14:31:20.441634) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 14:31:20.444959) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 14:31:20.445244) ========= ========= Total master_lag: 0.40 =========