builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1504733034.65 results: success (0) revision: abc3387aaa6fcd05922670e0345f3b513285d8d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 14:23:54.652661) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 14:23:54.653098) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 14:23:54.653386) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 14:23:54.670568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 14:23:54.670833) ========= 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=836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-06 14:23:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.5M=0s 2017-09-06 14:23:55 (36.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.166153 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 14:23:54.856243) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 14:23:54.856567) ========= 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=836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017717 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 14:23:54.905700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 14:23:54.906025) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev abc3387aaa6fcd05922670e0345f3b513285d8d7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev abc3387aaa6fcd05922670e0345f3b513285d8d7 --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=836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-06 14:23:55,395 truncating revision to first 12 chars 2017-09-06 14:23:55,395 Setting DEBUG logging. 2017-09-06 14:23:55,395 attempt 1/10 2017-09-06 14:23:55,395 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/abc3387aaa6f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-06 14:23:55,697 unpacking tar archive at: mozilla-beta-abc3387aaa6f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613835 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 14:23:55.539480) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 14:23:55.539801) ========= script_repo_revision: abc3387aaa6fcd05922670e0345f3b513285d8d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 14:23:55.540203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 14:23:55.540470) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 14:23:55.556643) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-06 14:23:55.556907) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:23:56 INFO - MultiFileLogger online at 20170906 14:23:56 in /builds/slave/test 14:23:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 14:23:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:23:56 INFO - {'append_to_log': False, 14:23:56 INFO - 'base_work_dir': '/builds/slave/test', 14:23:56 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 14:23:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:23:56 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 14:23:56 INFO - 'buildbot_json_path': 'buildprops.json', 14:23:56 INFO - 'code_coverage': False, 14:23:56 INFO - 'config_files': ('talos/linux_config.py',), 14:23:56 INFO - 'default_actions': ('clobber', 14:23:56 INFO - 'read-buildbot-config', 14:23:56 INFO - 'download-and-extract', 14:23:56 INFO - 'populate-webroot', 14:23:56 INFO - 'create-virtualenv', 14:23:56 INFO - 'install', 14:23:56 INFO - 'setup-mitmproxy', 14:23:56 INFO - 'run-tests'), 14:23:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:23:56 INFO - 'disable_ccov_upload': False, 14:23:56 INFO - 'download_minidump_stackwalk': True, 14:23:56 INFO - 'download_symbols': 'ondemand', 14:23:56 INFO - 'enable_stylo': False, 14:23:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:23:56 INFO - 'tooltool.py': '/tools/tooltool.py', 14:23:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:23:56 INFO - '/tools/misc-python/virtualenv.py')}, 14:23:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:23:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:23:56 INFO - 'gecko_profile': False, 14:23:56 INFO - 'gecko_profile_interval': 0, 14:23:56 INFO - 'installer_path': 'installer.exe', 14:23:56 INFO - 'log_level': 'info', 14:23:56 INFO - 'log_name': 'talos', 14:23:56 INFO - 'log_to_console': True, 14:23:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:23:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:23:56 INFO - 'opt_config_files': (), 14:23:56 INFO - 'pip_index': False, 14:23:56 INFO - 'suite': 'dromaeojs-e10s', 14:23:56 INFO - 'system_bits': '32', 14:23:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:23:56 INFO - 'title': 'talos-linux64-ix-028', 14:23:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:23:56 INFO - 'use_talos_json': True, 14:23:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:23:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:23:56 INFO - 'work_dir': 'build'} 14:23:56 INFO - [mozharness: 2017-09-06 21:23:56.143890Z] Running clobber step. 14:23:56 INFO - Running pre-action listener: _resource_record_pre_action 14:23:56 INFO - Running main action method: clobber 14:23:56 INFO - rmtree: /builds/slave/test/build 14:23:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:23:57 INFO - Running post-action listener: _resource_record_post_action 14:23:57 INFO - [mozharness: 2017-09-06 21:23:57.175588Z] Finished clobber step (success) 14:23:57 INFO - [mozharness: 2017-09-06 21:23:57.175691Z] Running read-buildbot-config step. 14:23:57 INFO - Running pre-action listener: _resource_record_pre_action 14:23:57 INFO - Running main action method: read_buildbot_config 14:23:57 INFO - Using buildbot properties: 14:23:57 INFO - { 14:23:57 INFO - "project": "", 14:23:57 INFO - "product": "firefox", 14:23:57 INFO - "who": "ryanvm@gmail.com", 14:23:57 INFO - "installer_path": "public/build/target.tar.bz2", 14:23:57 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 14:23:57 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 14:23:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 14:23:57 INFO - "stage_platform": "linux64", 14:23:57 INFO - "basedir": "/builds/slave/test", 14:23:57 INFO - "buildnumber": 73, 14:23:57 INFO - "platform": "ubuntu64_hw", 14:23:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:23:57 INFO - "slavebuilddir": "test", 14:23:57 INFO - "taskId": "CQwoAyEwSJyUJ9aW_1FaaA", 14:23:57 INFO - "branch": "mozilla-beta", 14:23:57 INFO - "script_repo_revision": "production", 14:23:57 INFO - "revision": "abc3387aaa6fcd05922670e0345f3b513285d8d7", 14:23:57 INFO - "slavename": "talos-linux64-ix-028", 14:23:57 INFO - "repo_path": "releases/mozilla-beta" 14:23:57 INFO - } 14:23:57 INFO - Finding installer, test and symbols from parent task. 14:23:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CQwoAyEwSJyUJ9aW_1FaaA'}, attempt #1 14:23:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CQwoAyEwSJyUJ9aW_1FaaA'}, attempt #1 14:23:58 INFO - Task dependencies: Oqg990z_TIKTtdt8QNV5xw 14:23:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw'}, attempt #1 14:23:58 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.tar.bz2 14:23:58 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.test_packages.json 14:23:58 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.crashreporter-symbols.zip 14:23:58 INFO - Running post-action listener: _resource_record_post_action 14:23:58 INFO - [mozharness: 2017-09-06 21:23:58.526821Z] Finished read-buildbot-config step (success) 14:23:58 INFO - [mozharness: 2017-09-06 21:23:58.527044Z] Running download-and-extract step. 14:23:58 INFO - Running pre-action listener: _resource_record_pre_action 14:23:58 INFO - Running main action method: download_and_extract 14:23:58 INFO - mkdir: /builds/slave/test/build/tests 14:23: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:23:58 INFO - trying https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.test_packages.json 14:23:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:23:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:23:59 INFO - Downloaded 989 bytes. 14:23:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:23:59 INFO - Using the following test package requirements: 14:23:59 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:23:59 INFO - u'common': [u'target.common.tests.zip'], 14:23:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:23:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:23:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:23:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:23:59 INFO - u'mozbase': [u'target.common.tests.zip'], 14:23:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:23:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:23:59 INFO - u'web-platform': [u'target.common.tests.zip', 14:23:59 INFO - u'target.web-platform.tests.tar.gz'], 14:23:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:23:59 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:23:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.common.tests.zip 14:23:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:23:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.common.tests.zip into memory 14:24:00 INFO - Content-Length response header: 72862909 14:24:00 INFO - Bytes received: 72862909 14:24:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:24:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.common.tests.zip 14:24:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:24:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.common.tests.zip into memory 14:24:12 INFO - Content-Length response header: 72862909 14:24:12 INFO - Bytes received: 72862909 14:24:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.talos.tests.zip 14:24:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:24:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.talos.tests.zip into memory 14:24:25 INFO - Content-Length response header: 14496472 14:24:25 INFO - Bytes received: 14496472 14:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:26 INFO - trying https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.tar.bz2 14:24:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:24:27 INFO - Downloaded 54268743 bytes. 14:24:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.tar.bz2 14:24:27 INFO - mkdir: /builds/slave/test/properties 14:24:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:24:27 INFO - Writing to file /builds/slave/test/properties/build_url 14:24:27 INFO - Contents: 14:24:27 INFO - build_url:https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.tar.bz2 14:24:27 INFO - Running post-action listener: _resource_record_post_action 14:24:27 INFO - Running post-action listener: set_extra_try_arguments 14:24:27 INFO - [mozharness: 2017-09-06 21:24:27.928291Z] Finished download-and-extract step (success) 14:24:27 INFO - [mozharness: 2017-09-06 21:24:27.928389Z] Running populate-webroot step. 14:24:27 INFO - Running pre-action listener: _resource_record_pre_action 14:24:27 INFO - Running main action method: populate_webroot 14:24:27 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:24:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:24:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:24:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:24:27 INFO - 'tests': ['damp', 'tps']}, 14:24:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:24:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:24:27 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:24:27 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:24:27 INFO - 'other-e10s': {'tests': ['a11yr', 14:24:27 INFO - 'ts_paint', 14:24:27 INFO - 'tpaint', 14:24:27 INFO - 'sessionrestore', 14:24:27 INFO - 'sessionrestore_many_windows', 14:24:27 INFO - 'sessionrestore_no_auto_restore', 14:24:27 INFO - 'tabpaint']}, 14:24:27 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:24:27 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 14:24:27 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:24:27 INFO - 'talos_options': ['--mitmproxy', 14:24:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:24:27 INFO - '--firstNonBlankPaint'], 14:24:27 INFO - 'tests': ['quantum_pageload_google', 14:24:27 INFO - 'quantum_pageload_youtube', 14:24:27 INFO - 'quantum_pageload_amazon', 14:24:27 INFO - 'quantum_pageload_facebook']}, 14:24:27 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:24:27 INFO - 'talos_options': ['--stylo', 14:24:27 INFO - '--mitmproxy', 14:24:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:24:27 INFO - '--firstNonBlankPaint'], 14:24:27 INFO - 'tests': ['quantum_pageload_google', 14:24:27 INFO - 'quantum_pageload_youtube', 14:24:27 INFO - 'quantum_pageload_amazon', 14:24:27 INFO - 'quantum_pageload_facebook']}, 14:24:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:24:27 INFO - 'tsvgr_opacity', 14:24:27 INFO - 'tart', 14:24:27 INFO - 'tscrollx', 14:24:27 INFO - 'cart', 14:24:27 INFO - 'tsvg_static']}, 14:24:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:24:27 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:24:27 INFO - 'talos_options': ['--stylo', 14:24:27 INFO - '--stylo-threads=1', 14:24:27 INFO - '--mitmproxy', 14:24:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:24:27 INFO - '--firstNonBlankPaint'], 14:24:27 INFO - 'tests': ['tp6_google', 14:24:27 INFO - 'tp6_youtube', 14:24:27 INFO - 'tp6_amazon', 14:24:27 INFO - 'tp6_facebook']}, 14:24:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:24:27 INFO - 'talos_options': ['--xperf_path', 14:24:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:27 INFO - 'tests': ['tp5n']}}} 14:24:27 INFO - Running post-action listener: _resource_record_post_action 14:24:27 INFO - [mozharness: 2017-09-06 21:24:27.937036Z] Finished populate-webroot step (success) 14:24:27 INFO - [mozharness: 2017-09-06 21:24:27.937127Z] Running create-virtualenv step. 14:24:27 INFO - Running pre-action listener: _resource_record_pre_action 14:24:27 INFO - Running main action method: create_virtualenv 14:24:27 INFO - Creating virtualenv /builds/slave/test/build/venv 14:24:27 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:24:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:24:27 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:24:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:24:28 INFO - Using real prefix '/usr' 14:24:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:24:28 INFO - Installing distribute.............................................................................................................................................................................................done. 14:24:30 INFO - Installing pip.................done. 14:24:30 INFO - Return code: 0 14:24:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:24:30 INFO - Reading from file tmpfile_stdout 14:24:30 INFO - Output received: 14:24:30 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:24:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:24:30 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:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:30 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:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:30 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 0xc831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff0050>, '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 0xff0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff13e0>, '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': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', '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:24:30 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:24:30 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:24:30 INFO - Using env: {'DISPLAY': ':0', 14:24:30 INFO - 'HOME': '/home/cltbld', 14:24:30 INFO - 'LANG': 'en_US.UTF-8', 14:24:30 INFO - 'LANGUAGE': 'en_US:en', 14:24:30 INFO - 'LOGNAME': 'cltbld', 14:24:30 INFO - 'MAIL': '/var/mail/cltbld', 14:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:30 INFO - 'MOZ_NO_REMOTE': '1', 14:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:30 INFO - 'NO_EM_RESTART': '1', 14:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:30 INFO - 'PWD': '/builds/slave/test', 14:24:30 INFO - 'SHELL': '/bin/bash', 14:24:30 INFO - 'SHLVL': '1', 14:24:30 INFO - 'TERM': 'linux', 14:24:30 INFO - 'TMOUT': '86400', 14:24:30 INFO - 'USER': 'cltbld', 14:24:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', 14:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:30 INFO - '_': '/tools/buildbot/bin/python'} 14:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:30 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:24:30 INFO - Cleaning up... 14:24:30 INFO - Return code: 0 14:24:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:24:30 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:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:30 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:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:30 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 0xc831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff0050>, '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 0xff0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff13e0>, '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': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', '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:24:30 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:24:30 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:24:30 INFO - Using env: {'DISPLAY': ':0', 14:24:30 INFO - 'HOME': '/home/cltbld', 14:24:30 INFO - 'LANG': 'en_US.UTF-8', 14:24:30 INFO - 'LANGUAGE': 'en_US:en', 14:24:30 INFO - 'LOGNAME': 'cltbld', 14:24:30 INFO - 'MAIL': '/var/mail/cltbld', 14:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:30 INFO - 'MOZ_NO_REMOTE': '1', 14:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:30 INFO - 'NO_EM_RESTART': '1', 14:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:30 INFO - 'PWD': '/builds/slave/test', 14:24:30 INFO - 'SHELL': '/bin/bash', 14:24:30 INFO - 'SHLVL': '1', 14:24:30 INFO - 'TERM': 'linux', 14:24:30 INFO - 'TMOUT': '86400', 14:24:30 INFO - 'USER': 'cltbld', 14:24:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', 14:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:30 INFO - '_': '/tools/buildbot/bin/python'} 14:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:31 INFO - Downloading/unpacking psutil>=3.1.1 14:24:31 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:24:31 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:24:31 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:24:31 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:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:24:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:32 INFO - Installing collected packages: psutil 14:24:32 INFO - Running setup.py install for psutil 14:24:32 INFO - building 'psutil._psutil_linux' extension 14:24:32 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:24:32 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:24:32 INFO - building 'psutil._psutil_posix' extension 14:24:32 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:24:32 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:24:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:32 INFO - Successfully installed psutil 14:24:32 INFO - Cleaning up... 14:24:32 INFO - Return code: 0 14:24:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:24:32 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:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:32 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:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:32 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 0xc831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff0050>, '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 0xff0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff13e0>, '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': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', '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:24:32 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:24:32 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:24:32 INFO - Using env: {'DISPLAY': ':0', 14:24:32 INFO - 'HOME': '/home/cltbld', 14:24:32 INFO - 'LANG': 'en_US.UTF-8', 14:24:32 INFO - 'LANGUAGE': 'en_US:en', 14:24:32 INFO - 'LOGNAME': 'cltbld', 14:24:32 INFO - 'MAIL': '/var/mail/cltbld', 14:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:32 INFO - 'MOZ_NO_REMOTE': '1', 14:24:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:32 INFO - 'NO_EM_RESTART': '1', 14:24:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:32 INFO - 'PWD': '/builds/slave/test', 14:24:32 INFO - 'SHELL': '/bin/bash', 14:24:32 INFO - 'SHLVL': '1', 14:24:32 INFO - 'TERM': 'linux', 14:24:32 INFO - 'TMOUT': '86400', 14:24:32 INFO - 'USER': 'cltbld', 14:24:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', 14:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:32 INFO - '_': '/tools/buildbot/bin/python'} 14:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:24:33 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:24:33 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:24:33 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:24:33 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:24:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:24:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:24:34 INFO - Installing collected packages: mozsystemmonitor 14:24:34 INFO - Running setup.py install for mozsystemmonitor 14:24:34 INFO - Successfully installed mozsystemmonitor 14:24:34 INFO - Cleaning up... 14:24:34 INFO - Return code: 0 14:24:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:24:34 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:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:34 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:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:34 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 0xc831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff0050>, '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 0xff0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff13e0>, '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': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', '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:24:34 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:24:34 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:24:34 INFO - Using env: {'DISPLAY': ':0', 14:24:34 INFO - 'HOME': '/home/cltbld', 14:24:34 INFO - 'LANG': 'en_US.UTF-8', 14:24:34 INFO - 'LANGUAGE': 'en_US:en', 14:24:34 INFO - 'LOGNAME': 'cltbld', 14:24:34 INFO - 'MAIL': '/var/mail/cltbld', 14:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:34 INFO - 'MOZ_NO_REMOTE': '1', 14:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:34 INFO - 'NO_EM_RESTART': '1', 14:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:34 INFO - 'PWD': '/builds/slave/test', 14:24:34 INFO - 'SHELL': '/bin/bash', 14:24:34 INFO - 'SHLVL': '1', 14:24:34 INFO - 'TERM': 'linux', 14:24:34 INFO - 'TMOUT': '86400', 14:24:34 INFO - 'USER': 'cltbld', 14:24:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', 14:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:34 INFO - '_': '/tools/buildbot/bin/python'} 14:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:34 INFO - Downloading/unpacking jsonschema==2.5.1 14:24:34 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:24:34 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:24:34 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:24:34 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:24:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:24:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:24:35 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:24:35 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:24:35 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:24:35 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:24:35 INFO - Downloading functools32-3.2.3-2.tar.gz 14:24:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:24:35 INFO - warning: no files found matching '*.txt' 14:24:35 INFO - no previously-included directories found matching 'build' 14:24:35 INFO - no previously-included directories found matching 'dist' 14:24:35 INFO - no previously-included directories found matching '.git*' 14:24:35 INFO - Installing collected packages: jsonschema, functools32 14:24:35 INFO - Running setup.py install for functools32 14:24:36 INFO - warning: no files found matching '*.txt' 14:24:36 INFO - no previously-included directories found matching 'build' 14:24:36 INFO - no previously-included directories found matching 'dist' 14:24:36 INFO - no previously-included directories found matching '.git*' 14:24:36 INFO - Successfully installed jsonschema functools32 14:24:36 INFO - Cleaning up... 14:24:36 INFO - Return code: 0 14:24:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:24:36 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:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:36 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:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:36 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 0xc831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff0050>, '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 0xff0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff13e0>, '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': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', '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:24:36 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:24:36 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:24:36 INFO - Using env: {'DISPLAY': ':0', 14:24:36 INFO - 'HOME': '/home/cltbld', 14:24:36 INFO - 'LANG': 'en_US.UTF-8', 14:24:36 INFO - 'LANGUAGE': 'en_US:en', 14:24:36 INFO - 'LOGNAME': 'cltbld', 14:24:36 INFO - 'MAIL': '/var/mail/cltbld', 14:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:36 INFO - 'MOZ_NO_REMOTE': '1', 14:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:36 INFO - 'NO_EM_RESTART': '1', 14:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:36 INFO - 'PWD': '/builds/slave/test', 14:24:36 INFO - 'SHELL': '/bin/bash', 14:24:36 INFO - 'SHLVL': '1', 14:24:36 INFO - 'TERM': 'linux', 14:24:36 INFO - 'TMOUT': '86400', 14:24:36 INFO - 'USER': 'cltbld', 14:24:36 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', 14:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:36 INFO - '_': '/tools/buildbot/bin/python'} 14:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:24:36 INFO - Cleaning up... 14:24:36 INFO - Return code: 0 14:24:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:24:36 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:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:36 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:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:36 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 0xc831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff0050>, '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 0xff0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff13e0>, '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': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', '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:24:36 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:24:36 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:24:36 INFO - Using env: {'DISPLAY': ':0', 14:24:36 INFO - 'HOME': '/home/cltbld', 14:24:36 INFO - 'LANG': 'en_US.UTF-8', 14:24:36 INFO - 'LANGUAGE': 'en_US:en', 14:24:36 INFO - 'LOGNAME': 'cltbld', 14:24:36 INFO - 'MAIL': '/var/mail/cltbld', 14:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:36 INFO - 'MOZ_NO_REMOTE': '1', 14:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:36 INFO - 'NO_EM_RESTART': '1', 14:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:36 INFO - 'PWD': '/builds/slave/test', 14:24:36 INFO - 'SHELL': '/bin/bash', 14:24:36 INFO - 'SHLVL': '1', 14:24:36 INFO - 'TERM': 'linux', 14:24:36 INFO - 'TMOUT': '86400', 14:24:36 INFO - 'USER': 'cltbld', 14:24:36 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', 14:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:36 INFO - '_': '/tools/buildbot/bin/python'} 14:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:36 INFO - Downloading/unpacking blobuploader==1.2.4 14:24:36 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:24:36 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:24:36 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:24:36 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:24:37 INFO - Downloading blobuploader-1.2.4.tar.gz 14:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:24:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:24:37 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:24:37 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:24:37 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:24:37 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:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:24:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:24:38 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:24:38 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:24:38 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:24:38 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:24:38 INFO - Downloading docopt-0.6.1.tar.gz 14:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:24:38 INFO - Installing collected packages: blobuploader, requests, docopt 14:24:38 INFO - Running setup.py install for blobuploader 14:24:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:24:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:24:38 INFO - Running setup.py install for requests 14:24:38 INFO - Running setup.py install for docopt 14:24:38 INFO - Successfully installed blobuploader requests docopt 14:24:38 INFO - Cleaning up... 14:24:38 INFO - Return code: 0 14:24:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:38 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:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:38 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:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:38 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 0xc831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff0050>, '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 0xff0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff13e0>, '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': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', '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:24:38 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:24:38 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:24:38 INFO - Using env: {'DISPLAY': ':0', 14:24:38 INFO - 'HOME': '/home/cltbld', 14:24:38 INFO - 'LANG': 'en_US.UTF-8', 14:24:38 INFO - 'LANGUAGE': 'en_US:en', 14:24:38 INFO - 'LOGNAME': 'cltbld', 14:24:38 INFO - 'MAIL': '/var/mail/cltbld', 14:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:38 INFO - 'MOZ_NO_REMOTE': '1', 14:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:38 INFO - 'NO_EM_RESTART': '1', 14:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:38 INFO - 'PWD': '/builds/slave/test', 14:24:38 INFO - 'SHELL': '/bin/bash', 14:24:38 INFO - 'SHLVL': '1', 14:24:38 INFO - 'TERM': 'linux', 14:24:38 INFO - 'TMOUT': '86400', 14:24:38 INFO - 'USER': 'cltbld', 14:24:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', 14:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:38 INFO - '_': '/tools/buildbot/bin/python'} 14:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:39 INFO - Running setup.py (path:/tmp/pip-huLmCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:39 INFO - Running setup.py (path:/tmp/pip-xShtyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:39 INFO - Running setup.py (path:/tmp/pip-v_6OYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:39 INFO - Running setup.py (path:/tmp/pip-qDQRMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:39 INFO - Running setup.py (path:/tmp/pip-lEoYVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:39 INFO - Running setup.py (path:/tmp/pip-95BFbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:39 INFO - Running setup.py (path:/tmp/pip-y6AL4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:39 INFO - Running setup.py (path:/tmp/pip-CCwFgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:39 INFO - Running setup.py (path:/tmp/pip-zDLvpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:39 INFO - Running setup.py (path:/tmp/pip-D0zZg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:39 INFO - Running setup.py (path:/tmp/pip-RqVDwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:39 INFO - Running setup.py (path:/tmp/pip-yoBrVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:39 INFO - Running setup.py (path:/tmp/pip-upCXDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:40 INFO - Running setup.py (path:/tmp/pip-Sg452S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:40 INFO - Running setup.py (path:/tmp/pip-9sYDoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:40 INFO - Running setup.py (path:/tmp/pip-bKIjXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:40 INFO - Running setup.py (path:/tmp/pip-32yew1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:24:40 INFO - Running setup.py install for manifestparser 14:24:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:24:40 INFO - Running setup.py install for mozcrash 14:24:40 INFO - Running setup.py install for mozdebug 14:24:40 INFO - Running setup.py install for mozdevice 14:24:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:24:40 INFO - Running setup.py install for mozfile 14:24:40 INFO - Running setup.py install for mozhttpd 14:24:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:24:40 INFO - Running setup.py install for mozinfo 14:24:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:24:41 INFO - Running setup.py install for mozInstall 14:24:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:24:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:24:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:24:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:24:41 INFO - Running setup.py install for mozleak 14:24:41 INFO - Running setup.py install for mozlog 14:24:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:24:41 INFO - Running setup.py install for moznetwork 14:24:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:24:41 INFO - Running setup.py install for mozprocess 14:24:41 INFO - Running setup.py install for mozprofile 14:24:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:24:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:24:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:24:41 INFO - Running setup.py install for mozrunner 14:24:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:24:41 INFO - Running setup.py install for mozscreenshot 14:24:41 INFO - Running setup.py install for moztest 14:24:41 INFO - Running setup.py install for mozversion 14:24:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:24:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:24:42 INFO - Cleaning up... 14:24:42 INFO - Return code: 0 14:24:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:42 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:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:42 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:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:42 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 0xc831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff0050>, '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 0xff0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff13e0>, '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': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', '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:24:42 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:24:42 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:24:42 INFO - Using env: {'DISPLAY': ':0', 14:24:42 INFO - 'HOME': '/home/cltbld', 14:24:42 INFO - 'LANG': 'en_US.UTF-8', 14:24:42 INFO - 'LANGUAGE': 'en_US:en', 14:24:42 INFO - 'LOGNAME': 'cltbld', 14:24:42 INFO - 'MAIL': '/var/mail/cltbld', 14:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:42 INFO - 'MOZ_NO_REMOTE': '1', 14:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:42 INFO - 'NO_EM_RESTART': '1', 14:24:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:42 INFO - 'PWD': '/builds/slave/test', 14:24:42 INFO - 'SHELL': '/bin/bash', 14:24:42 INFO - 'SHLVL': '1', 14:24:42 INFO - 'TERM': 'linux', 14:24:42 INFO - 'TMOUT': '86400', 14:24:42 INFO - 'USER': 'cltbld', 14:24:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', 14:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:42 INFO - '_': '/tools/buildbot/bin/python'} 14:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:42 INFO - Running setup.py (path:/tmp/pip-btKutb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:42 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:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:42 INFO - Running setup.py (path:/tmp/pip-DDKlhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:42 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:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:42 INFO - Running setup.py (path:/tmp/pip-OBlbkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:42 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:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:42 INFO - Running setup.py (path:/tmp/pip-oy_gEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:42 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:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:42 INFO - Running setup.py (path:/tmp/pip-HGIv0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:42 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:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:42 INFO - Running setup.py (path:/tmp/pip-HXghYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:42 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:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:42 INFO - Running setup.py (path:/tmp/pip-eqqMa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:42 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:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:42 INFO - Running setup.py (path:/tmp/pip-m_1ZXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:42 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:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:42 INFO - Running setup.py (path:/tmp/pip-VPvEWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:42 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:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:42 INFO - Running setup.py (path:/tmp/pip-c_ChZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:43 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:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:43 INFO - Running setup.py (path:/tmp/pip-LP5NjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:43 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:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:43 INFO - Running setup.py (path:/tmp/pip-WtH6Qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:43 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:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:43 INFO - Running setup.py (path:/tmp/pip-qXwFlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:43 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:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:43 INFO - Running setup.py (path:/tmp/pip-ehEKSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:43 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:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:43 INFO - Running setup.py (path:/tmp/pip-kaGhSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:43 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:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:43 INFO - Running setup.py (path:/tmp/pip-MpNOrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:43 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:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:43 INFO - Running setup.py (path:/tmp/pip-YDTVRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:43 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:24:43 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:24:43 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:24:43 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:24:43 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:24:43 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:24:43 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:24:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:24:43 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:24:43 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:24:43 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:24:43 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:24:44 INFO - Downloading blessings-1.6.tar.gz 14:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:24:44 INFO - Installing collected packages: blessings 14:24:44 INFO - Running setup.py install for blessings 14:24:44 INFO - Successfully installed blessings 14:24:44 INFO - Cleaning up... 14:24:44 INFO - Return code: 0 14:24:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:24:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:45 INFO - Reading from file tmpfile_stdout 14:24:45 INFO - Current package versions: 14:24:45 INFO - argparse == 1.2.1 14:24:45 INFO - blessings == 1.6 14:24:45 INFO - blobuploader == 1.2.4 14:24:45 INFO - docopt == 0.6.1 14:24:45 INFO - functools32 == 3.2.3-2 14:24:45 INFO - jsonschema == 2.5.1 14:24:45 INFO - manifestparser == 1.1 14:24:45 INFO - mozInstall == 1.13 14:24:45 INFO - mozcrash == 1.0 14:24:45 INFO - mozdebug == 0.1 14:24:45 INFO - mozdevice == 0.51 14:24:45 INFO - mozfile == 1.2 14:24:45 INFO - mozhttpd == 0.7 14:24:45 INFO - mozinfo == 0.10 14:24:45 INFO - mozleak == 0.1 14:24:45 INFO - mozlog == 3.5 14:24:45 INFO - moznetwork == 0.27 14:24:45 INFO - mozprocess == 0.25 14:24:45 INFO - mozprofile == 0.28 14:24:45 INFO - mozrunner == 6.13 14:24:45 INFO - mozscreenshot == 0.1 14:24:45 INFO - mozsystemmonitor == 0.3 14:24:45 INFO - moztest == 0.8 14:24:45 INFO - mozversion == 1.4 14:24:45 INFO - psutil == 3.1.1 14:24:45 INFO - requests == 1.2.3 14:24:45 INFO - wsgiref == 0.1.2 14:24:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:45 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:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:45 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:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:45 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 0xc831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff0050>, '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 0xff0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff13e0>, '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': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', '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:24:45 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:24:45 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:24:45 INFO - Using env: {'DISPLAY': ':0', 14:24:45 INFO - 'HOME': '/home/cltbld', 14:24:45 INFO - 'LANG': 'en_US.UTF-8', 14:24:45 INFO - 'LANGUAGE': 'en_US:en', 14:24:45 INFO - 'LOGNAME': 'cltbld', 14:24:45 INFO - 'MAIL': '/var/mail/cltbld', 14:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:45 INFO - 'MOZ_NO_REMOTE': '1', 14:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:45 INFO - 'NO_EM_RESTART': '1', 14:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:45 INFO - 'PWD': '/builds/slave/test', 14:24:45 INFO - 'SHELL': '/bin/bash', 14:24:45 INFO - 'SHLVL': '1', 14:24:45 INFO - 'TERM': 'linux', 14:24:45 INFO - 'TMOUT': '86400', 14:24:45 INFO - 'USER': 'cltbld', 14:24:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', 14:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:45 INFO - '_': '/tools/buildbot/bin/python'} 14:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:45 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:24:45 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:24:45 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:24:45 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:24:45 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:24:45 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:24:45 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:24:45 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:24:45 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:24:45 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:24:45 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:24:45 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:24:45 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:24:45 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:24:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:24:46 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:24:46 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:24:46 INFO - Installing collected packages: simplejson 14:24:46 INFO - Running setup.py install for simplejson 14:24:46 INFO - building 'simplejson._speedups' extension 14:24:46 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:24:47 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:24:47 INFO - Successfully installed simplejson 14:24:47 INFO - Cleaning up... 14:24:47 INFO - Return code: 0 14:24:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:24:47 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:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:47 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:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:47 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 0xc831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff0050>, '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 0xff0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff13e0>, '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': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', '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:24:47 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:24:47 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:24:47 INFO - Using env: {'DISPLAY': ':0', 14:24:47 INFO - 'HOME': '/home/cltbld', 14:24:47 INFO - 'LANG': 'en_US.UTF-8', 14:24:47 INFO - 'LANGUAGE': 'en_US:en', 14:24:47 INFO - 'LOGNAME': 'cltbld', 14:24:47 INFO - 'MAIL': '/var/mail/cltbld', 14:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:47 INFO - 'MOZ_NO_REMOTE': '1', 14:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:47 INFO - 'NO_EM_RESTART': '1', 14:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:47 INFO - 'PWD': '/builds/slave/test', 14:24:47 INFO - 'SHELL': '/bin/bash', 14:24:47 INFO - 'SHLVL': '1', 14:24:47 INFO - 'TERM': 'linux', 14:24:47 INFO - 'TMOUT': '86400', 14:24:47 INFO - 'USER': 'cltbld', 14:24:47 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', 14:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:47 INFO - '_': '/tools/buildbot/bin/python'} 14:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:24:47 INFO - Cleaning up... 14:24:47 INFO - Return code: 0 14:24:47 INFO - Running post-action listener: _resource_record_post_action 14:24:47 INFO - Running post-action listener: _start_resource_monitoring 14:24:47 INFO - Starting resource monitoring. 14:24:47 INFO - [mozharness: 2017-09-06 21:24:47.812708Z] Finished create-virtualenv step (success) 14:24:47 INFO - [mozharness: 2017-09-06 21:24:47.813214Z] Running install step. 14:24:47 INFO - Running pre-action listener: _resource_record_pre_action 14:24:47 INFO - Running main action method: install 14:24:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:48 INFO - Reading from file tmpfile_stdout 14:24:48 INFO - Detecting whether we're running mozinstall >=1.0... 14:24:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:24:48 INFO - Reading from file tmpfile_stdout 14:24:48 INFO - Output received: 14:24:48 INFO - Usage: mozinstall [options] installer 14:24:48 INFO - Options: 14:24:48 INFO - -h, --help show this help message and exit 14:24:48 INFO - -d DEST, --destination=DEST 14:24:48 INFO - Directory to install application into. [default: 14:24:48 INFO - "/builds/slave/test"] 14:24:48 INFO - --app=APP Application being installed. [default: firefox] 14:24:48 INFO - mkdir: /builds/slave/test/build/application 14:24:48 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:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:25:03 INFO - Reading from file tmpfile_stdout 14:25:03 INFO - Output received: 14:25:03 INFO - /builds/slave/test/build/application/firefox/firefox 14:25:03 INFO - Running post-action listener: _resource_record_post_action 14:25:03 INFO - [mozharness: 2017-09-06 21:25:03.144581Z] Finished install step (success) 14:25:03 INFO - [mozharness: 2017-09-06 21:25:03.144708Z] Running setup-mitmproxy step. 14:25:03 INFO - Running pre-action listener: _resource_record_pre_action 14:25:03 INFO - Running main action method: setup_mitmproxy 14:25:03 INFO - Skipping: mitmproxy is not required 14:25:03 INFO - Running post-action listener: _resource_record_post_action 14:25:03 INFO - [mozharness: 2017-09-06 21:25:03.145241Z] Finished setup-mitmproxy step (success) 14:25:03 INFO - [mozharness: 2017-09-06 21:25:03.145344Z] Running run-tests step. 14:25:03 INFO - Running pre-action listener: _resource_record_pre_action 14:25:03 INFO - Running pre-action listener: _set_gcov_prefix 14:25:03 INFO - Running main action method: run_tests 14:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:25:03 INFO - Python 2.7.3 14:25:03 INFO - Return code: 0 14:25:03 INFO - grabbing minidump binary from tooltool 14:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:03 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 0xff0050>, '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 0xff0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff13e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:25:03 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:25:03 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:25:03 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:25:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:25:03 INFO - Return code: 0 14:25:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:25:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:25:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:25:03 INFO - ENV: RUST_BACKTRACE is now 1 14:25:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:25:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --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:25:03 INFO - Using env: {'DISPLAY': ':0', 14:25:03 INFO - 'HOME': '/home/cltbld', 14:25:03 INFO - 'LANG': 'en_US.UTF-8', 14:25:03 INFO - 'LANGUAGE': 'en_US:en', 14:25:03 INFO - 'LOGNAME': 'cltbld', 14:25:03 INFO - 'MAIL': '/var/mail/cltbld', 14:25:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:25:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:03 INFO - 'MOZ_NO_REMOTE': '1', 14:25:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:03 INFO - 'NO_EM_RESTART': '1', 14:25:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:03 INFO - 'PWD': '/builds/slave/test', 14:25:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:25:03 INFO - 'RUST_BACKTRACE': '1', 14:25:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:25:03 INFO - 'SHELL': '/bin/bash', 14:25:03 INFO - 'SHLVL': '1', 14:25:03 INFO - 'TERM': 'linux', 14:25:03 INFO - 'TMOUT': '86400', 14:25:03 INFO - 'USER': 'cltbld', 14:25:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137', 14:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:03 INFO - '_': '/tools/buildbot/bin/python'} 14:25:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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:25:03 INFO - mozversion application_buildid: 20170906201243 14:25:03 INFO - mozversion application_changeset: abc3387aaa6fcd05922670e0345f3b513285d8d7 14:25:03 INFO - mozversion application_display_name: Firefox 14:25:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:25:03 INFO - mozversion application_name: Firefox 14:25:03 INFO - mozversion application_remotingname: firefox 14:25:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:25:03 INFO - mozversion application_vendor: Mozilla 14:25:03 INFO - mozversion application_version: 56.0 14:25:03 INFO - mozversion platform_buildid: 20170906201243 14:25:03 INFO - mozversion platform_changeset: abc3387aaa6fcd05922670e0345f3b513285d8d7 14:25:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:25:03 INFO - mozversion platform_version: 56.0 14:25:03 INFO - using testdate: 1504733103 14:25:03 INFO - actual date: 1504733103 14:25:03 INFO - starting webserver on 'localhost:43878' 14:25:03 INFO - SUITE-START | Running 2 tests 14:25:03 INFO - TEST-START | dromaeo_css 14:25:03 INFO - Initialising browser for dromaeo_css test... 14:25:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43878/getInfo.html -profile /tmp/tmpA3hNEx/profile 14:25:03 INFO - TEST-INFO | started process 28094 (/builds/slave/test/build/application/firefox/firefox http://localhost:43878/getInfo.html) 14:25:09 INFO - TEST-INFO | 28094: exit 0 14:25:09 INFO - Browser initialized. 14:25:09 INFO - Running cycle 1/1 for dromaeo_css test... 14:25:09 INFO - TEST-INFO | started process 28256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA3hNEx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:09 INFO - PID 28256 | 1504733109951 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4395 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 14:25:20 INFO - PID 28256 | RSS: Main: 152641536 14:25:20 INFO - PID 28256 | 14:28:19 INFO - PID 28256 | Cycle 1(1): loaded http://localhost:43878/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43878/tests/dromaeo/cssquery-ext.html) 14:28:20 INFO - PID 28256 | RSS: Main: 161837056 14:28:20 INFO - PID 28256 | 14:31:21 INFO - PID 28256 | Cycle 1(1): loaded http://localhost:43878/tests/dromaeo/cssquery-ext.html (next: http://localhost:43878/tests/dromaeo/cssquery-jquery.html) 14:31:22 INFO - PID 28256 | RSS: Main: 158380032 14:31:22 INFO - PID 28256 | 14:34:23 INFO - PID 28256 | Cycle 1(1): loaded http://localhost:43878/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43878/tests/dromaeo/cssquery-mootools.html) 14:34:24 INFO - PID 28256 | RSS: Main: 160718848 14:34:24 INFO - PID 28256 | 14:37:26 INFO - PID 28256 | Cycle 1(1): loaded http://localhost:43878/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43878/tests/dromaeo/cssquery-prototype.html) 14:37:26 INFO - PID 28256 | RSS: Main: 160522240 14:37:26 INFO - PID 28256 | 14:40:29 INFO - PID 28256 | Cycle 1(1): loaded http://localhost:43878/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43878/tests/dromaeo/cssquery-yui.html) 14:40:30 INFO - PID 28256 | RSS: Main: 162324480 14:40:30 INFO - PID 28256 | 14:43:32 INFO - PID 28256 | Cycle 1(1): loaded http://localhost:43878/tests/dromaeo/cssquery-yui.html (next: http://localhost:43878/tests/dromaeo/cssquery-dojo.html) 14:43:32 INFO - PID 28256 | RSS: Main: 165986304 14:43:32 INFO - PID 28256 | 14:43:32 INFO - PID 28256 | __start_tp_report 14:43:32 INFO - PID 28256 | _x_x_mozilla_page_load 14:43:32 INFO - PID 28256 | _x_x_mozilla_page_load_details 14:43:32 INFO - PID 28256 | |i|pagename|runs| 14:43:32 INFO - PID 28256 | |0;dojo.html;3615.891523254303;3649.671529562339;3657.2502636959425;3667.0648984508953;3720.0513868963412;6453.322401147882;6490.253620833606;6519.511036672251;6550.410463058324;6554.508411869111;6490.545661803676;6496.317886621908;6549.377809108139;6570.277269500351;6587.802365929006;5634.746436410351;5640.492355687988;5685.317761868581;5718.799842005531;5735.08238681811;5662.971685141569;5673.319201695802;5714.742836572344;5728.541716662678;5736.827895163131;5590.636608620427;5623.26897503324;5686.630369026041;5689.402612725646;5771.422857714237;5637.49262566371;5682.715864206773;5704.4865962063195;5729.914051289234;5730.742116604721;5644.435556444323;5698.43015698431;5699.914501282484;5709.65742055478;5737.3688894221605;6322.209723784527;6342.873142537123;6382.234131904155;6415.294317625057;6495.05821655862;6850.417714494274;6905.17137943445;6915.273896240923;6919.584824910521;6928.826779330507;7029.543079699854;7044.049053377779;7104.040954471184;7128.0377149084725;7158.141023077212;6365.809025729235;6514.5114116441455;6525.836854078639;6588.670566471706;6622.205335359739;7083.079199704005;7084.291570842977;7086.539374940612;7091.25541818112;7097.609631470319;6710.328967103348;6764.188297404343;6772.661366931634;6780.423663988518;6799;6969.47728920333;7042.7887163385185;7051.471139664443;7060.823479413056;7064.1876184238445;6901.482388820858;6916.135483064617;6923.6192009438955;6985.196702379189;7009.053777740041;6770.424513916274;6870.690818913161;6878.518503704692;6954.965225173842;6973.755918542826;5073.1122053640465;5129.769160387791;5137.383513978347;5148.382194136652;5154.098032844237;4543.159515489645;4565.0413413183605;4567.1779079765965;4580.496145424001;4583.037562111994;6495.928171851686;6619.50353723463;6630.336966303427;6692.933070669328;6773.153355830521;7061.682224299919;7099.36105750485;7103.857922841617;7120.92879071213;7127.144742630918;6656.467482601381;6662.600243985376;6667.466602671775;6725.092112564839;6745.190577130677;5657.32112146545;5740.971295143498;5751.712414379264;5810.157527158538;5820.126980952891;7112.679929403189;7155.713771449188;7255.347018768336;7267.382272506896;7283.562986220843;7063.788086357417;7099.290070992859;7113.288671132846;7136.143662760502;7143.6428178591905;7110.822229444305;7223;7227.168875579376;7293.161286452126;7306.817329566591;6732.932670673426;6780.457563394818;6883.139607549057;6969.58182509051;6988.336108069725;7053.0830991970715;7081.575105493687;7112.431005519649;7114.075170228044;7144;6695.531312808057;6837.521373503807;6845.62349070786;6907.205671347659;6926.06498122747;6696.933030669631;6706.329367063255;6710.530262881552;6718.7312507499155;6729.360710732472;6674.299198584273;6676.232233293234;6678;6678.76624318166;6687.030380594883;6744.595324280363;6813.977903314344;6874.278200788845;6969.30306969299;6970.686319115551;6571.080048793077;6632.270450250372;6637.236717777324;6741.258461569321;6744.0558321834005 14:43:32 INFO - PID 28256 | |1;ext.html;901.8196360727852;911.5806728904704;939.6805086270668;969.6848524229628;979.2949076664808;43018.78490607547;43342.349864751974;43507.78246108769;43676.56323436765;43759.906002349955;45585;45886;45902.54097459024;46027.76986115065;46112.769436152776;7816.726414575477;7894.842103157934;7916.208379162095;7926.762197134067;7927.563983980879;7853.921460785376;7923.881141782877;7959.562224077674;7988.640511176982;7994.880076798852;8010.319122874534;8017.6392062357045;8018.358531317481;8020.518768873857;8021.117677055519;7910.129885712567;7965.800854978643;7985.401094917905;7988.400869934778;7996.680132794681;7775.766726998199;7820.139784623687;7839.333656639193;7839.6472158752995;7843.568603726792;40487.595124048676;40744.79627601873;40808.79595602003;40809;40814.79592602018;3707.3141468828085;3724.5902950675404;3736.0473079364588;3746.138388170736;3755.023693839594;31892.20269493258;32307.19232019218;32397.838010810032;32427.837860810545;32431.51352729711;4984.37695288089;5136.409312929024;5163.586913046947;5189.3772747270195;5206.24509446132;208182;209215;213857;215961;224736.99999999837;53265;53304.73347633237;53372.73313633407;53411.732941335824;53422;55931;55958.720206398706;56149;56152.43847561472;56156.71921640365;15870.127143007245;16010.279537420844;16012.519624411287;16039.198040097948;16356.918215408847;12999.09006369545;13003.804942925864;13088.28014459214;13155.868441315655;13174.60476185716;13779.448822047007;13838.515651952133;13873.722525549634;13988.72022559543;14087.15477071379;5242.5281724644965;5292.338457692788;5323.201519772065;5415.4855288748295;5483.095289277305;1086.8206745886998;1101.262154356583;1104.276698762312;1114.9609763658395;1119.1550379463454;25191;25282.367940801258;25423.23730288094;25451;25451.10921117752;1193.5046955513537;1210.8123240897676;1226.6442731607733;1226.88957993781;1227.1287385955893;13425.731485370237;13496;13510.797338039938;13512.527061552995;13515.797263041062;257010;271537;271977;272605;272638;55808.441915581134;56352.718236409375;56357.15464268039;56397.43602564004;56853.431465684815;1562.140822547617;1563.4059057558054;1569.623290410316;1588.0471716969957;1595.5452695981821;24735.752642474064;24809.33712583463;24809.97749175254;30873;31180.376392472477;55963.88072238614;56015.15977260426;56017.43982560285;56060.719696401255;56195.157072643124;228183;229797;230464;230515;231530;32746.181345466553;33273.83363083266;35492.645073548934;42153.78923105488;42741.57258427376;53897.730511347196;54276;54443.183352248954;54472;54641.453585463634;39250.411243831935;39488.80255598704;39531.80234098811;39836.601633983286;40353.596464034985;38693.419598706605;39127.2174556513;39198.804005979786;39891;39956.20087598173;44617.77691111524;45519.772401139104;45690.77154614206;45795.77102114468;46043;37623.43564846584;37652.43521347237;37888;37899.242015160096;38308.42537361886;27800.165995020183;28334.291642709097;28390.29024274327;28456.430871382872;28722.96370213297 14:43:32 INFO - PID 28256 | |2;jquery.html;599.8470390050534;599.9850003749906;608.7078202462815;613.8925688004598;628.5505863307735;23930.760692393094;24545.140920067803;25049.24852254433;25050.373740656494;25063;27740.861295693492;28194.577081343796;28409.43181136376;28458;28460.715392846116;6740.191177058759;6877.174739031323;6880.8967865482055;6884.65576721162;6885.380315771579;6437.259715132773;6684.16447944007;6686.498512611549;6700.83247918801;6710.463162946977;6617.272100068989;6642.601443913357;6642.900356494656;6656.201255849305;6656.800295991128;6614.107095542088;6653.168353955755;6654.367835055662;6669.032990216416;6677.93322066778;6177.536684748617;6188.907166392508;6189.16446279751;6189.195404597419;6196.752129914843;29892.252693682833;31281.530777038362;31407.37185256282;31529.684703152903;31867;2356.1400088967575;2383.4518060846103;2392.425817803732;2393.126508824284;2398.82008849337;19983.90008049965;20614.27850025257;20813.479663008395;20819;20819.687704684442;2366.4557151854997;2369.834111612188;2427.2354208424467;2433.2943446400523;2450.2649205238536;155308;160274;160405;160726;160851.1957440217;15572.532824015298;16024.919875400781;16429.91785041091;16656.6668666626;16895.155242237837;25456.23631291064;25464;25469.745302547108;25486.196518382963;25499.617505737428;11048.171387145996;11063.336199828036;11167.20315092856;11224.438778061065;11275;7609.277118673717;10303.124234440007;10334.328268662513;10437.791244175225;10476.214283928735;8997.235235004968;10056.34633748804;10062.899371006197;10082.143017843418;10261;2893.537034074538;2898.9275268118467;2918.1683220282116;2920.4013177298602;2920.5619157126175;1060.7666313411037;1065.8561094252177;1086.4241951765578;1089.2375337263948;1102.5314241447513;22301.99641016158;22407.43981400478;22484.887575562017;22545.549089018128;22779.202727904445;1124.6457365929707;1127.1095834290818;1146.7305183281921;1151.9366434846163;1156.3004382348727;12361.320127393079;12369.381530923418;12446.439910204062;12460.190087644274;12700.555480558136;596520;603248;606162;608484;623407;125791;129376;129734;130676;131548;1263.1158189267367;1298.6104168749525;1316.7103237287781;1330.314887832767;1334.1528129637557;19692.50768730793;19832.60334793325;20124.19503219855;20202.898985504977;20398.59202815965;58773.412265876796;58824.70587647035;59254.40745592489;59763.701181493816;60917.69541152266;76065;76200.61899690465;76303;76670.23329766632;76830.2316976823;13584.184948903097;14070.366833492313;15679.921600392381;15943.920280398524;24026;25918.611220831324;26312.34219144537;26602.866985664947;27100.1869943902;27148.592771108055;20742.58514829725;20910.16359345609;21278.78721212768;21426.250081247083;21468.57062858703;18077.548061298574;18267.54331141732;18451.538711532317;18735.156917938453;18742.250309987994;20729.585408292052;21016.159353625684;21248.575028499654;21354.89322553377;21427.67858482093;22750.203742868922;22891.88554057219;22994.540109198057;23022.194223202776;23204.3038708839;19754.209831606575;19829;20427.387178384077;20886.37340879776;21294.148234070464 14:43:32 INFO - PID 28256 | |3;mootools.html;1388.2642199634192;1432.2409123164725;1447.3197597129345;1471.4555614422666;1473.0940471609963;15952;16501.25744341506;16531.33874645013;16621.83378166218;16837.83162168381;16475.505734827944;16879.915600422013;16964.49106526803;16989.49031529053;17027.233774480148;2989.760819134464;3056.541518772185;3099.364630250793;3099.4111118887454;3101.736352410048;3045.284358175827;3054.3433161870194;3076.292452735861;3077.3691393264326;3082.7225549700524;2863.9856800715966;2901.579271005703;2915.9708402915912;2918.2996080940634;2928.8096273742244;2841.5453527435616;2898.869550870216;2899.855007249629;2912.7961042727015;2914.664813546448;2833.458480235925;2848.1170837040586;2856.1431570528757;2860.3993161436124;2948.5871977922893;15944.441944531885;16121.43574974882;16134.75797863033;16162.838371616368;16167.353305867751;8741.475511469333;9010.14403631654;9044.954775226082;9051.773705657346;9052.4568525888;5665.5467562594895;5755.68343741094;5861.589688721791;5944.405559444064;6103.938960610426;1856.6936455484963;1865.5988962373156;1917.2331067572943;1945.533072062709;1947.6396866579587;27513.17460476189;27537.586936195974;27648.861755691294;27655.30861728453;27656.308592285153;7258.927410725931;7337.486375953738;7381.446391520657;7408.888866667005;7562.357199638092;18678.34625788091;18710.158042888103;18742.344017959305;18846.151923163492;18887.244510219713;8665.653373864974;8845.469271843709;8902.510361930026;8903.51030693305;8913.821723565492;6372.2671892732005;7313.89029164563;7945.721899733481;8047.557384343801;8158.143394943564;5780.1907732917425;5940.762369505258;5991.670458124758;6011.789587364421;6046.939530604725;1652.6281586642908;1699.2778069320489;1705.4713038957964;1714.9657006860043;1738.1135620833213;935.1957316707626;947.6446332625266;950.7005293332717;956.1633570625703;964.1033838530234;8003.399745019147;8061.395395345373;8148.06297275809;8183.345332373396;8228.958855205805;775.6470805783355;784.901887264092;788.6608758234014;790.6205021589554;794.6146119132217;5220.634555581073;5241.475852414728;5369.4630536946;5537.6954267515675;5642.943570564324;22958.540829183323;23465.88267058654;23498.177563785186;23606.64590031151;23754.762452375602;21919.452013699785;23715.40711482227;23745.881270593538;23752.881235594057;23783.643245351333;11141.001901586671;12176.269423834598;12205.267683938991;12252.44863981123;12319.815202771966;9039.864402033843;9091.31815113856;9119.589618467318;9216.723498295061;9314.301427393108;19841.107150178566;20116;20413.79586204119;20514.487137821674;20950.057247423596;20696.586068278248;21341.67987480158;21472.24847130343;21480;21917.23289684917;12185.817212741638;12354.382280886099;12373.566925157576;12382.752344953231;12410.689732756753;14689.485867994568;14774.778378324549;14824.703505930036;14943.178125203218;15103.848961510244;11895.464704088165;11971.64085077449;12015.939920300343;12026.879731202926;12058.819117713418;12086.972607328476;12129.150959433107;12309.199902006341;12393;12587.181833180814;10990.230683852054;11000.284981476178;11072.224944253825;11097.722556936142;11111.38887361203;8216.63025163881;8264.586770661563;8299.709510167115;8355.707550235713;8394.076651568445;8102.068262149693;8355.623996920032;8375.32997360222;8393.24460798531;8421.705240316805 14:43:32 INFO - PID 28256 | |4;prototype.html;529.5102030621674;540.3974568356283;562.524666656675;567.5374569725673;575.9769609215632;6300.21247344082;6304.6532440715855;6330.208723909512;6340.080688300193;6388.297287298399;6065.605735627192;6199.44205021548;6225.906611400833;6253.686136129627;6268.905966410507;4890.266460030988;4911.336969509106;4921.7785199666105;4931.038447502739;4932.630052746041;4828.251620998751;4920.458749537548;4924;4931.506849315076;4933.284673722308;4819;4843.709377437347;4854.567902468781;4883.755812209393;4891.5353041461;4841.402337228741;4876.439209490918;4881.975590122062;4887.877803054935;4909.361782968227;4436.290193569046;4439.112177564468;4445.555444455561;4458.398116254297;4476.84331048415;6175.197224360849;6192.721327540226;6195.977663685487;6209.292444577732;6212.378762123797;5880.5883588148845;5888.175655408247;5891.970540147315;5907.14346419771;5939.881202375928;6504.154459920227;6569;6592.03358488682;6627.635480048595;6682.331766823328;5002.374703162105;5022;5046.899062018739;5058.949410505885;5066.620003499752;6947.861042779116;6974.267701891279;7000.439964802804;7054.823629409255;7072.752453664149;5208.661437006583;5223;5247.501487358695;5251.159814429673;5256.684598924;5311.3095297611835;5328.706921119376;5328.760205790749;5330.520253177233;5335.279737235501;5761.193432919395;5822.912656310159;5855.209546711225;5870.471657550841;5901.616394934315;6650.434713049348;6657.334266573401;6668.466522678174;6691.197056353269;6695.196576410862;1720.7590937268792;1742.7995780485408;1743.616404391032;1789.2306308287561;1823.2980302583335;1266.3727110662753;1278.8849003589721;1280.180684362009;1291.8514370847286;1293.805929110641;6160.414760597736;6203.6587987660205;6226.533010024175;6232.439080482778;6363;6643.10318107059;6783.457323414115;6831.4534837212905;6845.178578570504;6860.931390686129;6331.525135614847;6339.302676705559;6363.649999250086;6374.362563743589;6380.138681277968;3507.8952628423253;3612.3678356287546;3612.674859262679;3625.3655610268625;3629.1290090378648;6951.44388448933;7012.228654847962;7037.753678621326;7052.33002864727;7053.506254562131;6952.887537993896;6960.65196740161;6965.47758918073;6980.546264492792;6999.965000175069;6891.724331026803;6934.687939042755;6952.339527744856;6986.707459119977;7001.719931202695;6821.6465319464705;6821.658917054028;6873.381395674413;6889.036624561976;6913.619750913547;6718.454755406186;6733.2593414725325;6747.190337159573;6794.388505034571;6815.216250131299;6989.405900498515;6991.370776629924;6993.510454268152;7007.579545227302;7025.578465292099;5155.767990440514;5168.431472537943;5170.8965820684125;5196.766145523537;5252.369715634149;6542.971678779593;6731.124953755981;6826.522143449911;6870.828229294308;6875.4155896749335;6486.513511486563;6548.738050477928;6576;6576.967115164585;6587.63767992765;6483.351664833479;6574.638394888136;6575.408213260829;6598.8350291243105;6604.339566043357;6435.51733619971;6472.838179045561;6547.770828020996;6557.9344206557325;6614.966925165536;6567.82942831296;6651.800445986628;6653.868842296918;6662.6335551545135;6701.1623547056615;6452.709628066842;6536.248331441945;6539.346065393423;6591;6597.50518711089 14:43:32 INFO - PID 28256 | |5;yui.html;957.1959553974664;963.1716723617689;974.6150270643096;990.5542505872357;994.2493417469809;19609.901950490264;20164.798352016493;20190.495237619067;20422.795772042275;20492.89753551234;17817.46547603574;18327;20335.796642033576;20450.181992720274;20560.588788224264;1075.8386242063714;1086.6739978006606;1087.896649818266;1090.9018188363045;1091.2579445976733;1026.609888242467;1095.4632230207221;1098.609993452325;1108.1024370260075;1122.657589435222;1163.0114402757672;1167.2646232873278;1171.2503997441645;1172.8827117288245;1173.2256710571025;1156.0751398880861;1167.7372591166961;1168.1764356128908;1168.5909931523984;1170.9180357374987;856.4861083350003;857.939944203906;858.0175698824874;858.1932982995963;858.2790456016976;19270.614587708307;19350.612987740307;19352.70970935437;19637.80362196374;20221.78669279848;21712.937270959235;21802;21857.234996775194;22118.22586209475;22275.777242227534;17052.914735426366;17177.828221717748;17346.484759709772;17503.47489575302;17509.124543772887;3766.9811650941842;3787.6780473659774;3793.412021136728;3797.791121488317;3799.1262009737916;141923.29038354845;141984;144188;145460;146307.268463657;16327.67344653124;16756.748648770277;16794.916025419796;16867.409640662518;16920.323187072627;26947.595786063226;27647.30881727973;27676.446471070467;27817.304567385574;27826.3043423912;8642.524661143698;8645.135486451305;8755.649774009096;8761.38670293086;8796;4492.236319825637;4550.089982003613;4554.590086892129;4576.382188404589;4594.379758732595;5705.885882282414;5723.112917497794;5803.245578074823;5836;5870.589058765845;1046.539522610049;1058.957641694339;1069.5240617925103;1075.1560025380038;1083.566573370658;731.1043971135423;735.4190189750144;742.6992068212382;746.5893758432949;764.3808515102785;12261.467316585427;13280.335983200801;13503.729925401436;15186.772198417033;15562.766558501631;764.9617519124022;765.1506827421557;772.6677528662617;776.8096816279934;783.1972228465868;6167.074938759132;6245.937540624535;6359.523035772336;6504.577202481823;6616.172978377703;120768;121184.3940780308;123775;128150.35924820317;129027.35486322509;111172;112015;112343;116723.41638291754;117631;93011;98212.50893745628;99209.50395247978;99811.0075596968;101986;12435.316057616918;13692.246926419142;14289.571312860631;14314.212718300594;14536.781948270997;45332.32001520046;47028.7648561755;47135.29297060478;50374.2443863335;50482.49517504778;81354.59322703349;83039;83077.16922830936;84246.57876710578;85145;21002.94985250762;21243.575128497654;21359.25242616501;21449.142034319077;21457.46356341104;23365;23659.881700592076;23727.288181354586;23785.405364865324;23933.16233931804;21339.25312614051;21555;21556.568868622853;21559.676604850625;21573.784262157176;19982.800171998093;21503.139874405475;21652.025658845705;21774.673379899;21786.564268714854;18723.157457914152;18829.623407531497;18838.71741923845;18948.526286842938;18986.240550377832;14872.479463218735;14985.175815330262;15038.323275452412;15275.236238187825;15452.84547154514;15134.924325378302;15345.651815552494;15537.84462155364;15702.9214853925;15744.448944286894 14:43:32 INFO - PID 28256 | __end_tp_report 14:43:32 INFO - PID 28256 | __start_cc_report 14:43:32 INFO - PID 28256 | _x_x_mozilla_cycle_collect,304 14:43:32 INFO - PID 28256 | __end_cc_report 14:43:32 INFO - PID 28256 | __startTimestamp1504734212257__endTimestamp 14:43:32 INFO - PID 28256 | 14:43:32 INFO - PID 28256 | ------- Summary: start ------- 14:43:32 INFO - PID 28256 | Number of tests: 6 14:43:32 INFO - PID 28256 | 14:43:32 INFO - PID 28256 | [#0] dojo.html Cycles:165 Average:6424.25 Median:6706.33 stddev:813.14 (12.1%) stddev-sans-first:785.23 14:43:32 INFO - PID 28256 | Values: 3615.9 3649.7 3657.3 3667.1 3720.1 6453.3 6490.3 6519.5 6550.4 6554.5 6490.5 6496.3 6549.4 6570.3 6587.8 5634.7 5640.5 5685.3 5718.8 5735.1 5663.0 5673.3 5714.7 5728.5 5736.8 5590.6 5623.3 5686.6 5689.4 5771.4 5637.5 5682.7 5704.5 5729.9 5730.7 5644.4 5698.4 5699.9 5709.7 5737.4 6322.2 6342.9 6382.2 6415.3 6495.1 6850.4 6905.2 6915.3 6919.6 6928.8 7029.5 7044.0 7104.0 7128.0 7158.1 6365.8 6514.5 6525.8 6588.7 6622.2 7083.1 7084.3 7086.5 7091.3 7097.6 6710.3 6764.2 6772.7 6780.4 6799.0 6969.5 7042.8 7051.5 7060.8 7064.2 6901.5 6916.1 6923.6 6985.2 7009.1 6770.4 6870.7 6878.5 6955.0 6973.8 5073.1 5129.8 5137.4 5148.4 5154.1 4543.2 4565.0 4567.2 4580.5 4583.0 6495.9 6619.5 6630.3 6692.9 6773.2 7061.7 7099.4 7103.9 7120.9 7127.1 6656.5 6662.6 6667.5 6725.1 6745.2 5657.3 5741.0 5751.7 5810.2 5820.1 7112.7 7155.7 7255.3 7267.4 7283.6 7063.8 7099.3 7113.3 7136.1 7143.6 7110.8 7223.0 7227.2 7293.2 7306.8 6732.9 6780.5 6883.1 6969.6 6988.3 7053.1 7081.6 7112.4 7114.1 7144.0 6695.5 6837.5 6845.6 6907.2 6926.1 6696.9 6706.3 6710.5 6718.7 6729.4 6674.3 6676.2 6678.0 6678.8 6687.0 6744.6 6814.0 6874.3 6969.3 6970.7 6571.1 6632.3 6637.2 6741.3 6744.1 14:43:32 INFO - PID 28256 | 14:43:32 INFO - PID 28256 | [#1] ext.html Cycles:180 Average:43005.58 Median:39923.60 stddev:62140.71 (155.6%) stddev-sans-first:62234.61 14:43:32 INFO - PID 28256 | Values: 901.8 911.6 939.7 969.7 979.3 43018.8 43342.3 43507.8 43676.6 43759.9 45585.0 45886.0 45902.5 46027.8 46112.8 7816.7 7894.8 7916.2 7926.8 7927.6 7853.9 7923.9 7959.6 7988.6 7994.9 8010.3 8017.6 8018.4 8020.5 8021.1 7910.1 7965.8 7985.4 7988.4 7996.7 7775.8 7820.1 7839.3 7839.6 7843.6 40487.6 40744.8 40808.8 40809.0 40814.8 3707.3 3724.6 3736.0 3746.1 3755.0 31892.2 32307.2 32397.8 32427.8 32431.5 4984.4 5136.4 5163.6 5189.4 5206.2 208182.0 209215.0 213857.0 215961.0 224737.0 53265.0 53304.7 53372.7 53411.7 53422.0 55931.0 55958.7 56149.0 56152.4 56156.7 15870.1 16010.3 16012.5 16039.2 16356.9 12999.1 13003.8 13088.3 13155.9 13174.6 13779.4 13838.5 13873.7 13988.7 14087.2 5242.5 5292.3 5323.2 5415.5 5483.1 1086.8 1101.3 1104.3 1115.0 1119.2 25191.0 25282.4 25423.2 25451.0 25451.1 1193.5 1210.8 1226.6 1226.9 1227.1 13425.7 13496.0 13510.8 13512.5 13515.8 257010.0 271537.0 271977.0 272605.0 272638.0 55808.4 56352.7 56357.2 56397.4 56853.4 1562.1 1563.4 1569.6 1588.0 1595.5 24735.8 24809.3 24810.0 30873.0 31180.4 55963.9 56015.2 56017.4 56060.7 56195.2 228183.0 229797.0 230464.0 230515.0 231530.0 32746.2 33273.8 35492.6 42153.8 42741.6 53897.7 54276.0 54443.2 54472.0 54641.5 39250.4 39488.8 39531.8 39836.6 40353.6 38693.4 39127.2 39198.8 39891.0 39956.2 44617.8 45519.8 45690.8 45795.8 46043.0 37623.4 37652.4 37888.0 37899.2 38308.4 27800.2 28334.3 28390.3 28456.4 28723.0 14:43:32 INFO - PID 28256 | 14:43:32 INFO - PID 28256 | [#2] jquery.html Cycles:180 Average:40477.58 Median:23113.25 stddev:101709.86 (440.1%) stddev-sans-first:101951.11 14:43:32 INFO - PID 28256 | Values: 599.8 600.0 608.7 613.9 628.6 23930.8 24545.1 25049.2 25050.4 25063.0 27740.9 28194.6 28409.4 28458.0 28460.7 6740.2 6877.2 6880.9 6884.7 6885.4 6437.3 6684.2 6686.5 6700.8 6710.5 6617.3 6642.6 6642.9 6656.2 6656.8 6614.1 6653.2 6654.4 6669.0 6677.9 6177.5 6188.9 6189.2 6189.2 6196.8 29892.3 31281.5 31407.4 31529.7 31867.0 2356.1 2383.5 2392.4 2393.1 2398.8 19983.9 20614.3 20813.5 20819.0 20819.7 2366.5 2369.8 2427.2 2433.3 2450.3 155308.0 160274.0 160405.0 160726.0 160851.2 15572.5 16024.9 16429.9 16656.7 16895.2 25456.2 25464.0 25469.7 25486.2 25499.6 11048.2 11063.3 11167.2 11224.4 11275.0 7609.3 10303.1 10334.3 10437.8 10476.2 8997.2 10056.3 10062.9 10082.1 10261.0 2893.5 2898.9 2918.2 2920.4 2920.6 1060.8 1065.9 1086.4 1089.2 1102.5 22302.0 22407.4 22484.9 22545.5 22779.2 1124.6 1127.1 1146.7 1151.9 1156.3 12361.3 12369.4 12446.4 12460.2 12700.6 596520.0 603248.0 606162.0 608484.0 623407.0 125791.0 129376.0 129734.0 130676.0 131548.0 1263.1 1298.6 1316.7 1330.3 1334.2 19692.5 19832.6 20124.2 20202.9 20398.6 58773.4 58824.7 59254.4 59763.7 60917.7 76065.0 76200.6 76303.0 76670.2 76830.2 13584.2 14070.4 15679.9 15943.9 24026.0 25918.6 26312.3 26602.9 27100.2 27148.6 20742.6 20910.2 21278.8 21426.3 21468.6 18077.5 18267.5 18451.5 18735.2 18742.3 20729.6 21016.2 21248.6 21354.9 21427.7 22750.2 22891.9 22994.5 23022.2 23204.3 19754.2 19829.0 20427.4 20886.4 21294.1 14:43:32 INFO - PID 28256 | 14:43:32 INFO - PID 28256 | [#3] mootools.html Cycles:180 Average:10125.58 Median:2837.50 stddev:7202.65 (253.8%) stddev-sans-first:7192.93 14:43:32 INFO - PID 28256 | Values: 1388.3 1432.2 1447.3 1471.5 1473.1 15952.0 16501.3 16531.3 16621.8 16837.8 16475.5 16879.9 16964.5 16989.5 17027.2 2989.8 3056.5 3099.4 3099.4 3101.7 3045.3 3054.3 3076.3 3077.4 3082.7 2864.0 2901.6 2916.0 2918.3 2928.8 2841.5 2898.9 2899.9 2912.8 2914.7 2833.5 2848.1 2856.1 2860.4 2948.6 15944.4 16121.4 16134.8 16162.8 16167.4 8741.5 9010.1 9045.0 9051.8 9052.5 5665.5 5755.7 5861.6 5944.4 6103.9 1856.7 1865.6 1917.2 1945.5 1947.6 27513.2 27537.6 27648.9 27655.3 27656.3 7258.9 7337.5 7381.4 7408.9 7562.4 18678.3 18710.2 18742.3 18846.2 18887.2 8665.7 8845.5 8902.5 8903.5 8913.8 6372.3 7313.9 7945.7 8047.6 8158.1 5780.2 5940.8 5991.7 6011.8 6046.9 1652.6 1699.3 1705.5 1715.0 1738.1 935.2 947.6 950.7 956.2 964.1 8003.4 8061.4 8148.1 8183.3 8229.0 775.6 784.9 788.7 790.6 794.6 5220.6 5241.5 5369.5 5537.7 5642.9 22958.5 23465.9 23498.2 23606.6 23754.8 21919.5 23715.4 23745.9 23752.9 23783.6 11141.0 12176.3 12205.3 12252.4 12319.8 9039.9 9091.3 9119.6 9216.7 9314.3 19841.1 20116.0 20413.8 20514.5 20950.1 20696.6 21341.7 21472.2 21480.0 21917.2 12185.8 12354.4 12373.6 12382.8 12410.7 14689.5 14774.8 14824.7 14943.2 15103.8 11895.5 11971.6 12015.9 12026.9 12058.8 12087.0 12129.2 12309.2 12393.0 12587.2 10990.2 11000.3 11072.2 11097.7 11111.4 8216.6 8264.6 8299.7 8355.7 8394.1 8102.1 8355.6 8375.3 8393.2 8421.7 14:43:32 INFO - PID 28256 | 14:43:32 INFO - PID 28256 | [#4] prototype.html Cycles:180 Average:5648.04 Median:6317.43 stddev:1598.46 (25.3%) stddev-sans-first:1556.09 14:43:32 INFO - PID 28256 | Values: 529.5 540.4 562.5 567.5 576.0 6300.2 6304.7 6330.2 6340.1 6388.3 6065.6 6199.4 6225.9 6253.7 6268.9 4890.3 4911.3 4921.8 4931.0 4932.6 4828.3 4920.5 4924.0 4931.5 4933.3 4819.0 4843.7 4854.6 4883.8 4891.5 4841.4 4876.4 4882.0 4887.9 4909.4 4436.3 4439.1 4445.6 4458.4 4476.8 6175.2 6192.7 6196.0 6209.3 6212.4 5880.6 5888.2 5892.0 5907.1 5939.9 6504.2 6569.0 6592.0 6627.6 6682.3 5002.4 5022.0 5046.9 5058.9 5066.6 6947.9 6974.3 7000.4 7054.8 7072.8 5208.7 5223.0 5247.5 5251.2 5256.7 5311.3 5328.7 5328.8 5330.5 5335.3 5761.2 5822.9 5855.2 5870.5 5901.6 6650.4 6657.3 6668.5 6691.2 6695.2 1720.8 1742.8 1743.6 1789.2 1823.3 1266.4 1278.9 1280.2 1291.9 1293.8 6160.4 6203.7 6226.5 6232.4 6363.0 6643.1 6783.5 6831.5 6845.2 6860.9 6331.5 6339.3 6363.6 6374.4 6380.1 3507.9 3612.4 3612.7 3625.4 3629.1 6951.4 7012.2 7037.8 7052.3 7053.5 6952.9 6960.7 6965.5 6980.5 7000.0 6891.7 6934.7 6952.3 6986.7 7001.7 6821.6 6821.7 6873.4 6889.0 6913.6 6718.5 6733.3 6747.2 6794.4 6815.2 6989.4 6991.4 6993.5 7007.6 7025.6 5155.8 5168.4 5170.9 5196.8 5252.4 6543.0 6731.1 6826.5 6870.8 6875.4 6486.5 6548.7 6576.0 6577.0 6587.6 6483.4 6574.6 6575.4 6598.8 6604.3 6435.5 6472.8 6547.8 6557.9 6615.0 6567.8 6651.8 6653.9 6662.6 6701.2 6452.7 6536.2 6539.3 6591.0 6597.5 14:43:32 INFO - PID 28256 | 14:43:32 INFO - PID 28256 | [#5] yui.html Cycles:180 Average:26626.56 Median:20526.74 stddev:37012.44 (180.3%) stddev-sans-first:37066.08 14:43:32 INFO - PID 28256 | Values: 957.2 963.2 974.6 990.6 994.2 19609.9 20164.8 20190.5 20422.8 20492.9 17817.5 18327.0 20335.8 20450.2 20560.6 1075.8 1086.7 1087.9 1090.9 1091.3 1026.6 1095.5 1098.6 1108.1 1122.7 1163.0 1167.3 1171.3 1172.9 1173.2 1156.1 1167.7 1168.2 1168.6 1170.9 856.5 857.9 858.0 858.2 858.3 19270.6 19350.6 19352.7 19637.8 20221.8 21712.9 21802.0 21857.2 22118.2 22275.8 17052.9 17177.8 17346.5 17503.5 17509.1 3767.0 3787.7 3793.4 3797.8 3799.1 141923.3 141984.0 144188.0 145460.0 146307.3 16327.7 16756.7 16794.9 16867.4 16920.3 26947.6 27647.3 27676.4 27817.3 27826.3 8642.5 8645.1 8755.6 8761.4 8796.0 4492.2 4550.1 4554.6 4576.4 4594.4 5705.9 5723.1 5803.2 5836.0 5870.6 1046.5 1059.0 1069.5 1075.2 1083.6 731.1 735.4 742.7 746.6 764.4 12261.5 13280.3 13503.7 15186.8 15562.8 765.0 765.2 772.7 776.8 783.2 6167.1 6245.9 6359.5 6504.6 6616.2 120768.0 121184.4 123775.0 128150.4 129027.4 111172.0 112015.0 112343.0 116723.4 117631.0 93011.0 98212.5 99209.5 99811.0 101986.0 12435.3 13692.2 14289.6 14314.2 14536.8 45332.3 47028.8 47135.3 50374.2 50482.5 81354.6 83039.0 83077.2 84246.6 85145.0 21002.9 21243.6 21359.3 21449.1 21457.5 23365.0 23659.9 23727.3 23785.4 23933.2 21339.3 21555.0 21556.6 21559.7 21573.8 19982.8 21503.1 21652.0 21774.7 21786.6 18723.2 18829.6 18838.7 18948.5 18986.2 14872.5 14985.2 15038.3 15275.2 15452.8 15134.9 15345.7 15537.8 15702.9 15744.4 14:43:32 INFO - PID 28256 | -------- Summary: end -------- 14:43:32 INFO - PID 28256 | 14:43:32 INFO - TEST-INFO | 28256: exit 0 14:43:32 INFO - TEST-OK | dromaeo_css | took 1109426ms 14:43:32 INFO - TEST-START | kraken 14:43:32 INFO - Initialising browser for kraken test... 14:43:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43878/getInfo.html -profile /tmp/tmpcTeQET/profile 14:43:32 INFO - TEST-INFO | started process 28609 (/builds/slave/test/build/application/firefox/firefox http://localhost:43878/getInfo.html) 14:43:38 INFO - TEST-INFO | 28609: exit 0 14:43:39 INFO - Browser initialized. 14:43:39 INFO - Running cycle 1/1 for kraken test... 14:43:39 INFO - TEST-INFO | started process 28774 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcTeQET/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:43:39 INFO - PID 28774 | 1504734219325 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4395 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 14:43:50 INFO - PID 28774 | RSS: Main: 152465408 14:43:50 INFO - PID 28774 | 14:43:52 INFO - PID 28774 | Cycle 1(1): loaded http://localhost:43878/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43878/tests/kraken/driver.html?testName=audio-beat-detection) 14:43:53 INFO - PID 28774 | RSS: Main: 159100928 14:43:53 INFO - PID 28774 | 14:43:56 INFO - PID 28774 | Cycle 1(1): loaded http://localhost:43878/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43878/tests/kraken/driver.html?testName=audio-dft) 14:43:56 INFO - PID 28774 | RSS: Main: 159219712 14:43:56 INFO - PID 28774 | 14:43:59 INFO - PID 28774 | Cycle 1(1): loaded http://localhost:43878/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43878/tests/kraken/driver.html?testName=audio-fft) 14:44:00 INFO - PID 28774 | RSS: Main: 159277056 14:44:00 INFO - PID 28774 | 14:44:02 INFO - PID 28774 | Cycle 1(1): loaded http://localhost:43878/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43878/tests/kraken/driver.html?testName=audio-oscillator) 14:44:02 INFO - PID 28774 | RSS: Main: 159232000 14:44:02 INFO - PID 28774 | 14:44:04 INFO - PID 28774 | Cycle 1(1): loaded http://localhost:43878/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43878/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:44:05 INFO - PID 28774 | RSS: Main: 158568448 14:44:05 INFO - PID 28774 | 14:44:08 INFO - PID 28774 | Cycle 1(1): loaded http://localhost:43878/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43878/tests/kraken/driver.html?testName=imaging-darkroom) 14:44:09 INFO - PID 28774 | RSS: Main: 159002624 14:44:09 INFO - PID 28774 | 14:44:12 INFO - PID 28774 | Cycle 1(1): loaded http://localhost:43878/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43878/tests/kraken/driver.html?testName=imaging-desaturate) 14:44:13 INFO - PID 28774 | RSS: Main: 161906688 14:44:13 INFO - PID 28774 | 14:44:15 INFO - PID 28774 | Cycle 1(1): loaded http://localhost:43878/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43878/tests/kraken/driver.html?testName=json-parse-financial) 14:44:16 INFO - PID 28774 | RSS: Main: 162635776 14:44:16 INFO - PID 28774 | 14:44:18 INFO - PID 28774 | Cycle 1(1): loaded http://localhost:43878/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43878/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:44:18 INFO - PID 28774 | RSS: Main: 162631680 14:44:18 INFO - PID 28774 | 14:44:20 INFO - PID 28774 | Cycle 1(1): loaded http://localhost:43878/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43878/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:44:21 INFO - PID 28774 | RSS: Main: 162582528 14:44:21 INFO - PID 28774 | 14:44:23 INFO - PID 28774 | Cycle 1(1): loaded http://localhost:43878/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43878/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:44:23 INFO - PID 28774 | RSS: Main: 162312192 14:44:23 INFO - PID 28774 | 14:44:26 INFO - PID 28774 | Cycle 1(1): loaded http://localhost:43878/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43878/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:44:26 INFO - PID 28774 | RSS: Main: 162594816 14:44:26 INFO - PID 28774 | 14:44:29 INFO - PID 28774 | Cycle 1(1): loaded http://localhost:43878/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43878/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:44:30 INFO - PID 28774 | RSS: Main: 162447360 14:44:30 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | Cycle 1(1): loaded http://localhost:43878/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43878/tests/kraken/driver.html?testName=ai-astar) 14:44:32 INFO - PID 28774 | RSS: Main: 164122624 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | __start_tp_report 14:44:32 INFO - PID 28774 | _x_x_mozilla_page_load 14:44:32 INFO - PID 28774 | _x_x_mozilla_page_load_details 14:44:32 INFO - PID 28774 | |i|pagename|runs| 14:44:32 INFO - PID 28774 | |0;ai-astar;95;106;98;105;107;107;111;99;105;107 14:44:32 INFO - PID 28774 | |1;audio-beat-detection;144;110;146;158;115;144;137;116;162;113 14:44:32 INFO - PID 28774 | |2;audio-dft;161;162;162;163;162;162;161;161;162;161 14:44:32 INFO - PID 28774 | |3;audio-fft;74;74;75;191;74;74;73;75;175;77 14:44:32 INFO - PID 28774 | |4;audio-oscillator;77;77;128;77;77;77;135;78;78;121 14:44:32 INFO - PID 28774 | |5;imaging-gaussian-blur;114;114;115;114;114;114;114;114;113;116 14:44:32 INFO - PID 28774 | |6;imaging-darkroom;148;149;148;149;149;148;150;151;149;147 14:44:32 INFO - PID 28774 | |7;imaging-desaturate;94;95;94;94;94;94;94;94;94;94 14:44:32 INFO - PID 28774 | |8;json-parse-financial;47;47;49;48;49;51;48;46;46;46 14:44:32 INFO - PID 28774 | |9;json-stringify-tinderbox;52;51;51;52;52;51;52;52;51;51 14:44:32 INFO - PID 28774 | |10;stanford-crypto-aes;74;74;74;73;74;73;73;80;81;86 14:44:32 INFO - PID 28774 | |11;stanford-crypto-ccm;121;126;113;117;114;115;114;117;113;138 14:44:32 INFO - PID 28774 | |12;stanford-crypto-pbkdf2;176;176;159;166;170;157;172;157;178;158 14:44:32 INFO - PID 28774 | |13;stanford-crypto-sha256-iterative;61;60;59;59;67;58;61;58;60;62 14:44:32 INFO - PID 28774 | __end_tp_report 14:44:32 INFO - PID 28774 | __start_cc_report 14:44:32 INFO - PID 28774 | _x_x_mozilla_cycle_collect,788 14:44:32 INFO - PID 28774 | __end_cc_report 14:44:32 INFO - PID 28774 | __startTimestamp1504734272270__endTimestamp 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | ------- Summary: start ------- 14:44:32 INFO - PID 28774 | Number of tests: 14 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | [#0] ai-astar Cycles:10 Average:104.00 Median:109.00 stddev:4.99 (4.6%) stddev-sans-first:4.09 14:44:32 INFO - PID 28774 | Values: 95.0 106.0 98.0 105.0 107.0 107.0 111.0 99.0 105.0 107.0 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:144.00 stddev:19.47 (13.5%) stddev-sans-first:20.35 14:44:32 INFO - PID 28774 | Values: 144.0 110.0 146.0 158.0 115.0 144.0 137.0 116.0 162.0 113.0 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 14:44:32 INFO - PID 28774 | Values: 161.0 162.0 162.0 163.0 162.0 162.0 161.0 161.0 162.0 161.0 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | [#3] audio-fft Cycles:10 Average:96.20 Median:74.00 stddev:45.91 (62.0%) stddev-sans-first:47.99 14:44:32 INFO - PID 28774 | Values: 74.0 74.0 75.0 191.0 74.0 74.0 73.0 75.0 175.0 77.0 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:77.00 stddev:24.72 (32.1%) stddev-sans-first:25.58 14:44:32 INFO - PID 28774 | Values: 77.0 77.0 128.0 77.0 77.0 77.0 135.0 78.0 78.0 121.0 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 14:44:32 INFO - PID 28774 | Values: 114.0 114.0 115.0 114.0 114.0 114.0 114.0 114.0 113.0 116.0 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.14 (0.8%) stddev-sans-first:1.17 14:44:32 INFO - PID 28774 | Values: 148.0 149.0 148.0 149.0 149.0 148.0 150.0 151.0 149.0 147.0 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:44:32 INFO - PID 28774 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | [#8] json-parse-financial Cycles:10 Average:47.70 Median:48.00 stddev:1.64 (3.4%) stddev-sans-first:1.72 14:44:32 INFO - PID 28774 | Values: 47.0 47.0 49.0 48.0 49.0 51.0 48.0 46.0 46.0 46.0 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | [#9] json-stringify-tinderbox Cycles:10 Average:51.50 Median:52.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 14:44:32 INFO - PID 28774 | Values: 52.0 51.0 51.0 52.0 52.0 51.0 52.0 52.0 51.0 51.0 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:74.00 stddev:4.52 (6.1%) stddev-sans-first:4.72 14:44:32 INFO - PID 28774 | Values: 74.0 74.0 74.0 73.0 74.0 73.0 73.0 80.0 81.0 86.0 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:117.00 stddev:7.89 (6.7%) stddev-sans-first:8.32 14:44:32 INFO - PID 28774 | Values: 121.0 126.0 113.0 117.0 114.0 115.0 114.0 117.0 113.0 138.0 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:171.00 stddev:8.58 (5.0%) stddev-sans-first:8.45 14:44:32 INFO - PID 28774 | Values: 176.0 176.0 159.0 166.0 170.0 157.0 172.0 157.0 178.0 158.0 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:60.50 stddev:2.64 (4.4%) stddev-sans-first:2.79 14:44:32 INFO - PID 28774 | Values: 61.0 60.0 59.0 59.0 67.0 58.0 61.0 58.0 60.0 62.0 14:44:32 INFO - PID 28774 | -------- Summary: end -------- 14:44:32 INFO - PID 28774 | 14:44:32 INFO - PID 28774 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:44:33 INFO - TEST-INFO | 28774: exit 0 14:44:33 INFO - TEST-OK | kraken | took 60123ms 14:44:33 INFO - SUITE-END | took 1169s 14:44:33 INFO - Completed test suite (00:19:29) 14:44:33 INFO - javascript benchmark 14:44:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9164.503489308529, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3615.891523254303, 3649.671529562339, 3657.2502636959425, 3667.0648984508953, 3720.0513868963412, 6453.322401147882, 6490.253620833606, 6519.511036672251, 6550.410463058324, 6554.508411869111, 6490.545661803676, 6496.317886621908, 6549.377809108139, 6570.277269500351, 6587.802365929006, 5634.746436410351, 5640.492355687988, 5685.317761868581, 5718.799842005531, 5735.08238681811, 5662.971685141569, 5673.319201695802, 5714.742836572344, 5728.541716662678, 5736.827895163131, 5590.636608620427, 5623.26897503324, 5686.630369026041, 5689.402612725646, 5771.422857714237, 5637.49262566371, 5682.715864206773, 5704.4865962063195, 5729.914051289234, 5730.742116604721, 5644.435556444323, 5698.43015698431, 5699.914501282484, 5709.65742055478, 5737.3688894221605, 6322.209723784527, 6342.873142537123, 6382.234131904155, 6415.294317625057, 6495.05821655862, 6850.417714494274, 6905.17137943445, 6915.273896240923, 6919.584824910521, 6928.826779330507, 7029.543079699854, 7044.049053377779, 7104.040954471184, 7128.0377149084725, 7158.141023077212, 6365.809025729235, 6514.5114116441455, 6525.836854078639, 6588.670566471706, 6622.205335359739, 7083.079199704005, 7084.291570842977, 7086.539374940612, 7091.25541818112, 7097.609631470319, 6710.328967103348, 6764.188297404343, 6772.661366931634, 6780.423663988518, 6799.0, 6969.47728920333, 7042.7887163385185, 7051.471139664443, 7060.823479413056, 7064.1876184238445, 6901.482388820858, 6916.135483064617, 6923.6192009438955, 6985.196702379189, 7009.053777740041, 6770.424513916274, 6870.690818913161, 6878.518503704692, 6954.965225173842, 6973.755918542826, 5073.1122053640465, 5129.769160387791, 5137.383513978347, 5148.382194136652, 5154.098032844237, 4543.159515489645, 4565.0413413183605, 4567.1779079765965, 4580.496145424001, 4583.037562111994, 6495.928171851686, 6619.50353723463, 6630.336966303427, 6692.933070669328, 6773.153355830521, 7061.682224299919, 7099.36105750485, 7103.857922841617, 7120.92879071213, 7127.144742630918, 6656.467482601381, 6662.600243985376, 6667.466602671775, 6725.092112564839, 6745.190577130677, 5657.32112146545, 5740.971295143498, 5751.712414379264, 5810.157527158538, 5820.126980952891, 7112.679929403189, 7155.713771449188, 7255.347018768336, 7267.382272506896, 7283.562986220843, 7063.788086357417, 7099.290070992859, 7113.288671132846, 7136.143662760502, 7143.6428178591905, 7110.822229444305, 7223.0, 7227.168875579376, 7293.161286452126, 7306.817329566591, 6732.932670673426, 6780.457563394818, 6883.139607549057, 6969.58182509051, 6988.336108069725, 7053.0830991970715, 7081.575105493687, 7112.431005519649, 7114.075170228044, 7144.0, 6695.531312808057, 6837.521373503807, 6845.62349070786, 6907.205671347659, 6926.06498122747, 6696.933030669631, 6706.329367063255, 6710.530262881552, 6718.7312507499155, 6729.360710732472, 6674.299198584273, 6676.232233293234, 6678.0, 6678.76624318166, 6687.030380594883, 6744.595324280363, 6813.977903314344, 6874.278200788845, 6969.30306969299, 6970.686319115551, 6571.080048793077, 6632.270450250372, 6637.236717777324, 6741.258461569321, 6744.0558321834005], "value": 6363.452541830803, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.8196360727852, 911.5806728904704, 939.6805086270668, 969.6848524229628, 979.2949076664808, 43018.78490607547, 43342.349864751974, 43507.78246108769, 43676.56323436765, 43759.906002349955, 45585.0, 45886.0, 45902.54097459024, 46027.76986115065, 46112.769436152776, 7816.726414575477, 7894.842103157934, 7916.208379162095, 7926.762197134067, 7927.563983980879, 7853.921460785376, 7923.881141782877, 7959.562224077674, 7988.640511176982, 7994.880076798852, 8010.319122874534, 8017.6392062357045, 8018.358531317481, 8020.518768873857, 8021.117677055519, 7910.129885712567, 7965.800854978643, 7985.401094917905, 7988.400869934778, 7996.680132794681, 7775.766726998199, 7820.139784623687, 7839.333656639193, 7839.6472158752995, 7843.568603726792, 40487.595124048676, 40744.79627601873, 40808.79595602003, 40809.0, 40814.79592602018, 3707.3141468828085, 3724.5902950675404, 3736.0473079364588, 3746.138388170736, 3755.023693839594, 31892.20269493258, 32307.19232019218, 32397.838010810032, 32427.837860810545, 32431.51352729711, 4984.37695288089, 5136.409312929024, 5163.586913046947, 5189.3772747270195, 5206.24509446132, 208182.0, 209215.0, 213857.0, 215961.0, 224736.99999999837, 53265.0, 53304.73347633237, 53372.73313633407, 53411.732941335824, 53422.0, 55931.0, 55958.720206398706, 56149.0, 56152.43847561472, 56156.71921640365, 15870.127143007245, 16010.279537420844, 16012.519624411287, 16039.198040097948, 16356.918215408847, 12999.09006369545, 13003.804942925864, 13088.28014459214, 13155.868441315655, 13174.60476185716, 13779.448822047007, 13838.515651952133, 13873.722525549634, 13988.72022559543, 14087.15477071379, 5242.5281724644965, 5292.338457692788, 5323.201519772065, 5415.4855288748295, 5483.095289277305, 1086.8206745886998, 1101.262154356583, 1104.276698762312, 1114.9609763658395, 1119.1550379463454, 25191.0, 25282.367940801258, 25423.23730288094, 25451.0, 25451.10921117752, 1193.5046955513537, 1210.8123240897676, 1226.6442731607733, 1226.88957993781, 1227.1287385955893, 13425.731485370237, 13496.0, 13510.797338039938, 13512.527061552995, 13515.797263041062, 257010.0, 271537.0, 271977.0, 272605.0, 272638.0, 55808.441915581134, 56352.718236409375, 56357.15464268039, 56397.43602564004, 56853.431465684815, 1562.140822547617, 1563.4059057558054, 1569.623290410316, 1588.0471716969957, 1595.5452695981821, 24735.752642474064, 24809.33712583463, 24809.97749175254, 30873.0, 31180.376392472477, 55963.88072238614, 56015.15977260426, 56017.43982560285, 56060.719696401255, 56195.157072643124, 228183.0, 229797.0, 230464.0, 230515.0, 231530.0, 32746.181345466553, 33273.83363083266, 35492.645073548934, 42153.78923105488, 42741.57258427376, 53897.730511347196, 54276.0, 54443.183352248954, 54472.0, 54641.453585463634, 39250.411243831935, 39488.80255598704, 39531.80234098811, 39836.601633983286, 40353.596464034985, 38693.419598706605, 39127.2174556513, 39198.804005979786, 39891.0, 39956.20087598173, 44617.77691111524, 45519.772401139104, 45690.77154614206, 45795.77102114468, 46043.0, 37623.43564846584, 37652.43521347237, 37888.0, 37899.242015160096, 38308.42537361886, 27800.165995020183, 28334.291642709097, 28390.29024274327, 28456.430871382872, 28722.96370213297], "value": 18899.03336971343, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.8470390050534, 599.9850003749906, 608.7078202462815, 613.8925688004598, 628.5505863307735, 23930.760692393094, 24545.140920067803, 25049.24852254433, 25050.373740656494, 25063.0, 27740.861295693492, 28194.577081343796, 28409.43181136376, 28458.0, 28460.715392846116, 6740.191177058759, 6877.174739031323, 6880.8967865482055, 6884.65576721162, 6885.380315771579, 6437.259715132773, 6684.16447944007, 6686.498512611549, 6700.83247918801, 6710.463162946977, 6617.272100068989, 6642.601443913357, 6642.900356494656, 6656.201255849305, 6656.800295991128, 6614.107095542088, 6653.168353955755, 6654.367835055662, 6669.032990216416, 6677.93322066778, 6177.536684748617, 6188.907166392508, 6189.16446279751, 6189.195404597419, 6196.752129914843, 29892.252693682833, 31281.530777038362, 31407.37185256282, 31529.684703152903, 31867.0, 2356.1400088967575, 2383.4518060846103, 2392.425817803732, 2393.126508824284, 2398.82008849337, 19983.90008049965, 20614.27850025257, 20813.479663008395, 20819.0, 20819.687704684442, 2366.4557151854997, 2369.834111612188, 2427.2354208424467, 2433.2943446400523, 2450.2649205238536, 155308.0, 160274.0, 160405.0, 160726.0, 160851.1957440217, 15572.532824015298, 16024.919875400781, 16429.91785041091, 16656.6668666626, 16895.155242237837, 25456.23631291064, 25464.0, 25469.745302547108, 25486.196518382963, 25499.617505737428, 11048.171387145996, 11063.336199828036, 11167.20315092856, 11224.438778061065, 11275.0, 7609.277118673717, 10303.124234440007, 10334.328268662513, 10437.791244175225, 10476.214283928735, 8997.235235004968, 10056.34633748804, 10062.899371006197, 10082.143017843418, 10261.0, 2893.537034074538, 2898.9275268118467, 2918.1683220282116, 2920.4013177298602, 2920.5619157126175, 1060.7666313411037, 1065.8561094252177, 1086.4241951765578, 1089.2375337263948, 1102.5314241447513, 22301.99641016158, 22407.43981400478, 22484.887575562017, 22545.549089018128, 22779.202727904445, 1124.6457365929707, 1127.1095834290818, 1146.7305183281921, 1151.9366434846163, 1156.3004382348727, 12361.320127393079, 12369.381530923418, 12446.439910204062, 12460.190087644274, 12700.555480558136, 596520.0, 603248.0, 606162.0, 608484.0, 623407.0, 125791.0, 129376.0, 129734.0, 130676.0, 131548.0, 1263.1158189267367, 1298.6104168749525, 1316.7103237287781, 1330.314887832767, 1334.1528129637557, 19692.50768730793, 19832.60334793325, 20124.19503219855, 20202.898985504977, 20398.59202815965, 58773.412265876796, 58824.70587647035, 59254.40745592489, 59763.701181493816, 60917.69541152266, 76065.0, 76200.61899690465, 76303.0, 76670.23329766632, 76830.2316976823, 13584.184948903097, 14070.366833492313, 15679.921600392381, 15943.920280398524, 24026.0, 25918.611220831324, 26312.34219144537, 26602.866985664947, 27100.1869943902, 27148.592771108055, 20742.58514829725, 20910.16359345609, 21278.78721212768, 21426.250081247083, 21468.57062858703, 18077.548061298574, 18267.54331141732, 18451.538711532317, 18735.156917938453, 18742.250309987994, 20729.585408292052, 21016.159353625684, 21248.575028499654, 21354.89322553377, 21427.67858482093, 22750.203742868922, 22891.88554057219, 22994.540109198057, 23022.194223202776, 23204.3038708839, 19754.209831606575, 19829.0, 20427.387178384077, 20886.37340879776, 21294.148234070464], "value": 13218.57098035684, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.2642199634192, 1432.2409123164725, 1447.3197597129345, 1471.4555614422666, 1473.0940471609963, 15952.0, 16501.25744341506, 16531.33874645013, 16621.83378166218, 16837.83162168381, 16475.505734827944, 16879.915600422013, 16964.49106526803, 16989.49031529053, 17027.233774480148, 2989.760819134464, 3056.541518772185, 3099.364630250793, 3099.4111118887454, 3101.736352410048, 3045.284358175827, 3054.3433161870194, 3076.292452735861, 3077.3691393264326, 3082.7225549700524, 2863.9856800715966, 2901.579271005703, 2915.9708402915912, 2918.2996080940634, 2928.8096273742244, 2841.5453527435616, 2898.869550870216, 2899.855007249629, 2912.7961042727015, 2914.664813546448, 2833.458480235925, 2848.1170837040586, 2856.1431570528757, 2860.3993161436124, 2948.5871977922893, 15944.441944531885, 16121.43574974882, 16134.75797863033, 16162.838371616368, 16167.353305867751, 8741.475511469333, 9010.14403631654, 9044.954775226082, 9051.773705657346, 9052.4568525888, 5665.5467562594895, 5755.68343741094, 5861.589688721791, 5944.405559444064, 6103.938960610426, 1856.6936455484963, 1865.5988962373156, 1917.2331067572943, 1945.533072062709, 1947.6396866579587, 27513.17460476189, 27537.586936195974, 27648.861755691294, 27655.30861728453, 27656.308592285153, 7258.927410725931, 7337.486375953738, 7381.446391520657, 7408.888866667005, 7562.357199638092, 18678.34625788091, 18710.158042888103, 18742.344017959305, 18846.151923163492, 18887.244510219713, 8665.653373864974, 8845.469271843709, 8902.510361930026, 8903.51030693305, 8913.821723565492, 6372.2671892732005, 7313.89029164563, 7945.721899733481, 8047.557384343801, 8158.143394943564, 5780.1907732917425, 5940.762369505258, 5991.670458124758, 6011.789587364421, 6046.939530604725, 1652.6281586642908, 1699.2778069320489, 1705.4713038957964, 1714.9657006860043, 1738.1135620833213, 935.1957316707626, 947.6446332625266, 950.7005293332717, 956.1633570625703, 964.1033838530234, 8003.399745019147, 8061.395395345373, 8148.06297275809, 8183.345332373396, 8228.958855205805, 775.6470805783355, 784.901887264092, 788.6608758234014, 790.6205021589554, 794.6146119132217, 5220.634555581073, 5241.475852414728, 5369.4630536946, 5537.6954267515675, 5642.943570564324, 22958.540829183323, 23465.88267058654, 23498.177563785186, 23606.64590031151, 23754.762452375602, 21919.452013699785, 23715.40711482227, 23745.881270593538, 23752.881235594057, 23783.643245351333, 11141.001901586671, 12176.269423834598, 12205.267683938991, 12252.44863981123, 12319.815202771966, 9039.864402033843, 9091.31815113856, 9119.589618467318, 9216.723498295061, 9314.301427393108, 19841.107150178566, 20116.0, 20413.79586204119, 20514.487137821674, 20950.057247423596, 20696.586068278248, 21341.67987480158, 21472.24847130343, 21480.0, 21917.23289684917, 12185.817212741638, 12354.382280886099, 12373.566925157576, 12382.752344953231, 12410.689732756753, 14689.485867994568, 14774.778378324549, 14824.703505930036, 14943.178125203218, 15103.848961510244, 11895.464704088165, 11971.64085077449, 12015.939920300343, 12026.879731202926, 12058.819117713418, 12086.972607328476, 12129.150959433107, 12309.199902006341, 12393.0, 12587.181833180814, 10990.230683852054, 11000.284981476178, 11072.224944253825, 11097.722556936142, 11111.38887361203, 8216.63025163881, 8264.586770661563, 8299.709510167115, 8355.707550235713, 8394.076651568445, 8102.068262149693, 8355.623996920032, 8375.32997360222, 8393.24460798531, 8421.705240316805], "value": 7187.455570602307, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.5102030621674, 540.3974568356283, 562.524666656675, 567.5374569725673, 575.9769609215632, 6300.21247344082, 6304.6532440715855, 6330.208723909512, 6340.080688300193, 6388.297287298399, 6065.605735627192, 6199.44205021548, 6225.906611400833, 6253.686136129627, 6268.905966410507, 4890.266460030988, 4911.336969509106, 4921.7785199666105, 4931.038447502739, 4932.630052746041, 4828.251620998751, 4920.458749537548, 4924.0, 4931.506849315076, 4933.284673722308, 4819.0, 4843.709377437347, 4854.567902468781, 4883.755812209393, 4891.5353041461, 4841.402337228741, 4876.439209490918, 4881.975590122062, 4887.877803054935, 4909.361782968227, 4436.290193569046, 4439.112177564468, 4445.555444455561, 4458.398116254297, 4476.84331048415, 6175.197224360849, 6192.721327540226, 6195.977663685487, 6209.292444577732, 6212.378762123797, 5880.5883588148845, 5888.175655408247, 5891.970540147315, 5907.14346419771, 5939.881202375928, 6504.154459920227, 6569.0, 6592.03358488682, 6627.635480048595, 6682.331766823328, 5002.374703162105, 5022.0, 5046.899062018739, 5058.949410505885, 5066.620003499752, 6947.861042779116, 6974.267701891279, 7000.439964802804, 7054.823629409255, 7072.752453664149, 5208.661437006583, 5223.0, 5247.501487358695, 5251.159814429673, 5256.684598924, 5311.3095297611835, 5328.706921119376, 5328.760205790749, 5330.520253177233, 5335.279737235501, 5761.193432919395, 5822.912656310159, 5855.209546711225, 5870.471657550841, 5901.616394934315, 6650.434713049348, 6657.334266573401, 6668.466522678174, 6691.197056353269, 6695.196576410862, 1720.7590937268792, 1742.7995780485408, 1743.616404391032, 1789.2306308287561, 1823.2980302583335, 1266.3727110662753, 1278.8849003589721, 1280.180684362009, 1291.8514370847286, 1293.805929110641, 6160.414760597736, 6203.6587987660205, 6226.533010024175, 6232.439080482778, 6363.0, 6643.10318107059, 6783.457323414115, 6831.4534837212905, 6845.178578570504, 6860.931390686129, 6331.525135614847, 6339.302676705559, 6363.649999250086, 6374.362563743589, 6380.138681277968, 3507.8952628423253, 3612.3678356287546, 3612.674859262679, 3625.3655610268625, 3629.1290090378648, 6951.44388448933, 7012.228654847962, 7037.753678621326, 7052.33002864727, 7053.506254562131, 6952.887537993896, 6960.65196740161, 6965.47758918073, 6980.546264492792, 6999.965000175069, 6891.724331026803, 6934.687939042755, 6952.339527744856, 6986.707459119977, 7001.719931202695, 6821.6465319464705, 6821.658917054028, 6873.381395674413, 6889.036624561976, 6913.619750913547, 6718.454755406186, 6733.2593414725325, 6747.190337159573, 6794.388505034571, 6815.216250131299, 6989.405900498515, 6991.370776629924, 6993.510454268152, 7007.579545227302, 7025.578465292099, 5155.767990440514, 5168.431472537943, 5170.8965820684125, 5196.766145523537, 5252.369715634149, 6542.971678779593, 6731.124953755981, 6826.522143449911, 6870.828229294308, 6875.4155896749335, 6486.513511486563, 6548.738050477928, 6576.0, 6576.967115164585, 6587.63767992765, 6483.351664833479, 6574.638394888136, 6575.408213260829, 6598.8350291243105, 6604.339566043357, 6435.51733619971, 6472.838179045561, 6547.770828020996, 6557.9344206557325, 6614.966925165536, 6567.82942831296, 6651.800445986628, 6653.868842296918, 6662.6335551545135, 6701.1623547056615, 6452.709628066842, 6536.248331441945, 6539.346065393423, 6591.0, 6597.50518711089], "value": 5184.53093066137, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [957.1959553974664, 963.1716723617689, 974.6150270643096, 990.5542505872357, 994.2493417469809, 19609.901950490264, 20164.798352016493, 20190.495237619067, 20422.795772042275, 20492.89753551234, 17817.46547603574, 18327.0, 20335.796642033576, 20450.181992720274, 20560.588788224264, 1075.8386242063714, 1086.6739978006606, 1087.896649818266, 1090.9018188363045, 1091.2579445976733, 1026.609888242467, 1095.4632230207221, 1098.609993452325, 1108.1024370260075, 1122.657589435222, 1163.0114402757672, 1167.2646232873278, 1171.2503997441645, 1172.8827117288245, 1173.2256710571025, 1156.0751398880861, 1167.7372591166961, 1168.1764356128908, 1168.5909931523984, 1170.9180357374987, 856.4861083350003, 857.939944203906, 858.0175698824874, 858.1932982995963, 858.2790456016976, 19270.614587708307, 19350.612987740307, 19352.70970935437, 19637.80362196374, 20221.78669279848, 21712.937270959235, 21802.0, 21857.234996775194, 22118.22586209475, 22275.777242227534, 17052.914735426366, 17177.828221717748, 17346.484759709772, 17503.47489575302, 17509.124543772887, 3766.9811650941842, 3787.6780473659774, 3793.412021136728, 3797.791121488317, 3799.1262009737916, 141923.29038354845, 141984.0, 144188.0, 145460.0, 146307.268463657, 16327.67344653124, 16756.748648770277, 16794.916025419796, 16867.409640662518, 16920.323187072627, 26947.595786063226, 27647.30881727973, 27676.446471070467, 27817.304567385574, 27826.3043423912, 8642.524661143698, 8645.135486451305, 8755.649774009096, 8761.38670293086, 8796.0, 4492.236319825637, 4550.089982003613, 4554.590086892129, 4576.382188404589, 4594.379758732595, 5705.885882282414, 5723.112917497794, 5803.245578074823, 5836.0, 5870.589058765845, 1046.539522610049, 1058.957641694339, 1069.5240617925103, 1075.1560025380038, 1083.566573370658, 731.1043971135423, 735.4190189750144, 742.6992068212382, 746.5893758432949, 764.3808515102785, 12261.467316585427, 13280.335983200801, 13503.729925401436, 15186.772198417033, 15562.766558501631, 764.9617519124022, 765.1506827421557, 772.6677528662617, 776.8096816279934, 783.1972228465868, 6167.074938759132, 6245.937540624535, 6359.523035772336, 6504.577202481823, 6616.172978377703, 120768.0, 121184.3940780308, 123775.0, 128150.35924820317, 129027.35486322509, 111172.0, 112015.0, 112343.0, 116723.41638291754, 117631.0, 93011.0, 98212.50893745628, 99209.50395247978, 99811.0075596968, 101986.0, 12435.316057616918, 13692.246926419142, 14289.571312860631, 14314.212718300594, 14536.781948270997, 45332.32001520046, 47028.7648561755, 47135.29297060478, 50374.2443863335, 50482.49517504778, 81354.59322703349, 83039.0, 83077.16922830936, 84246.57876710578, 85145.0, 21002.94985250762, 21243.575128497654, 21359.25242616501, 21449.142034319077, 21457.46356341104, 23365.0, 23659.881700592076, 23727.288181354586, 23785.405364865324, 23933.16233931804, 21339.25312614051, 21555.0, 21556.568868622853, 21559.676604850625, 21573.784262157176, 19982.800171998093, 21503.139874405475, 21652.025658845705, 21774.673379899, 21786.564268714854, 18723.157457914152, 18829.623407531497, 18838.71741923845, 18948.526286842938, 18986.240550377832, 14872.479463218735, 14985.175815330262, 15038.323275452412, 15275.236238187825, 15452.84547154514, 15134.924325378302, 15345.651815552494, 15537.84462155364, 15702.9214853925, 15744.448944286894], "value": 10000.569476427845, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1467.6000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 106.0, 98.0, 105.0, 107.0, 107.0, 111.0, 99.0, 105.0, 107.0], "value": 104.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 146.0, 158.0, 115.0, 144.0, 137.0, 116.0, 162.0, 113.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 162.0, 162.0, 161.0, 161.0, 162.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 191.0, 74.0, 74.0, 73.0, 75.0, 175.0, 77.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 128.0, 77.0, 77.0, 77.0, 135.0, 78.0, 78.0, 121.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 116.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 149.0, 149.0, 148.0, 150.0, 151.0, 149.0, 147.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 49.0, 48.0, 49.0, 51.0, 48.0, 46.0, 46.0, 46.0], "value": 47.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 52.0, 52.0, 51.0, 52.0, 52.0, 51.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 73.0, 74.0, 73.0, 73.0, 80.0, 81.0, 86.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 126.0, 113.0, 117.0, 114.0, 115.0, 114.0, 117.0, 113.0, 138.0], "value": 118.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 159.0, 166.0, 170.0, 157.0, 172.0, 157.0, 178.0, 158.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 59.0, 67.0, 58.0, 61.0, 58.0, 60.0, 62.0], "value": 60.5, "unit": "score"}]}]} 14:44:33 INFO - Return code: 0 14:44:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:44:33 INFO - # TBPL SUCCESS # 14:44:33 INFO - Running post-action listener: _package_coverage_data 14:44:33 INFO - Running post-action listener: _resource_record_post_action 14:44:33 INFO - [mozharness: 2017-09-06 21:44:33.539944Z] Finished run-tests step (success) 14:44:33 INFO - Running post-run listener: _resource_record_post_run 14:44:33 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 499712; Write bytes: 380219392; Read time: 36; Write time: 438396 14:44:33 INFO - TinderboxPrint: CPU usage
13.1% 14:44:33 INFO - TinderboxPrint: I/O read bytes / time
499,712 / 36 14:44:33 INFO - TinderboxPrint: I/O write bytes / time
380,219,392 / 438,396 14:44:33 INFO - TinderboxPrint: CPU idle
8,213.1 (86.9%) 14:44:33 INFO - TinderboxPrint: CPU user
1,182.1 (12.5%) 14:44:33 INFO - TinderboxPrint: Swap in / out
0 / 0 14:44:33 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 100835328; Read time: 0; Write time: 188508 14:44:33 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:44:33 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 495616; Write bytes: 279384064; Read time: 24; Write time: 249888 14:44:34 INFO - Running post-run listener: _upload_blobber_files 14:44:34 INFO - Blob upload gear active. 14:44:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:44:34 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:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:44:34 INFO - (blobuploader) - INFO - Open directory for files ... 14:44:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:44:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:44:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:35 INFO - (blobuploader) - INFO - Done attempting. 14:44:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:44:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:44:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:36 INFO - (blobuploader) - INFO - Done attempting. 14:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:44:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:43 INFO - (blobuploader) - INFO - Done attempting. 14:44:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:44:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:44:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:44 INFO - (blobuploader) - INFO - Done attempting. 14:44:44 INFO - (blobuploader) - INFO - Iteration through files over. 14:44:44 INFO - Return code: 0 14:44:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:44:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:44:44 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/50a07c1798bec1e0e26c323fbecb3ee8fd61e8106adfcecfb9df6c178acb04e06f657b148adb2fbe816c3371f11e45c552544449bf87a84d8ca7ad399ef9d002", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/654aa519116679443abbfa2cdaff7dc2f2c87827e90521167563b58754920f9fdce123bc476bd814b1e9e3f8e4026567c7bd0f3ff33d5661ff0315a70af537b4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/893ba8f48ffda8bb3318580940073f924985282d359b154edc04eb1fb527be40aa8bcc19481f03157f7a69dad988f46c924f8d5249ee14c50ef08eb3da47e778", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06e8150dbc4a45e493c89d9a5de29bc99c8c0afa07c1807204698e2e39be1c594a6cd26c5bd4879922daa12398a39a7b0182d2211908de95d65c80ee57e66e30"} 14:44:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:44:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:44:44 INFO - Contents: 14:44:44 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/50a07c1798bec1e0e26c323fbecb3ee8fd61e8106adfcecfb9df6c178acb04e06f657b148adb2fbe816c3371f11e45c552544449bf87a84d8ca7ad399ef9d002", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/654aa519116679443abbfa2cdaff7dc2f2c87827e90521167563b58754920f9fdce123bc476bd814b1e9e3f8e4026567c7bd0f3ff33d5661ff0315a70af537b4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/893ba8f48ffda8bb3318580940073f924985282d359b154edc04eb1fb527be40aa8bcc19481f03157f7a69dad988f46c924f8d5249ee14c50ef08eb3da47e778", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06e8150dbc4a45e493c89d9a5de29bc99c8c0afa07c1807204698e2e39be1c594a6cd26c5bd4879922daa12398a39a7b0182d2211908de95d65c80ee57e66e30"} 14:44:44 INFO - Running post-run listener: copy_logs_to_upload_dir 14:44:44 INFO - Copying logs to upload dir... 14:44:44 INFO - mkdir: /builds/slave/test/build/upload/logs 14:44:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.629545 ========= master_lag: -0.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-06 14:44:43.595939) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 14:44:43.599625) ========= 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=836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/50a07c1798bec1e0e26c323fbecb3ee8fd61e8106adfcecfb9df6c178acb04e06f657b148adb2fbe816c3371f11e45c552544449bf87a84d8ca7ad399ef9d002", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/654aa519116679443abbfa2cdaff7dc2f2c87827e90521167563b58754920f9fdce123bc476bd814b1e9e3f8e4026567c7bd0f3ff33d5661ff0315a70af537b4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/893ba8f48ffda8bb3318580940073f924985282d359b154edc04eb1fb527be40aa8bcc19481f03157f7a69dad988f46c924f8d5249ee14c50ef08eb3da47e778", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06e8150dbc4a45e493c89d9a5de29bc99c8c0afa07c1807204698e2e39be1c594a6cd26c5bd4879922daa12398a39a7b0182d2211908de95d65c80ee57e66e30"} build_url:https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011472 build_url: 'https://queue.taskcluster.net/v1/task/Oqg990z_TIKTtdt8QNV5xw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/50a07c1798bec1e0e26c323fbecb3ee8fd61e8106adfcecfb9df6c178acb04e06f657b148adb2fbe816c3371f11e45c552544449bf87a84d8ca7ad399ef9d002", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/654aa519116679443abbfa2cdaff7dc2f2c87827e90521167563b58754920f9fdce123bc476bd814b1e9e3f8e4026567c7bd0f3ff33d5661ff0315a70af537b4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/893ba8f48ffda8bb3318580940073f924985282d359b154edc04eb1fb527be40aa8bcc19481f03157f7a69dad988f46c924f8d5249ee14c50ef08eb3da47e778", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06e8150dbc4a45e493c89d9a5de29bc99c8c0afa07c1807204698e2e39be1c594a6cd26c5bd4879922daa12398a39a7b0182d2211908de95d65c80ee57e66e30"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 14:44:43.630985) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 14:44:43.631397) ========= 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=836cfdc75598d54cb747368e000001a9-1504733034.40691-1113409137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 14:44:43.714535) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 14:44:43.718276) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 14:44:43.718667) ========= ========= Total master_lag: -0.42 =========