builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-077 starttime: 1503850132.01 results: success (0) revision: bceb296ce64fbb9c788aa681de84a618a8ca5af4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-27 09:08:52.007172) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-27 09:08:52.007563) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-27 09:08:52.007825) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-27 09:08:52.024096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-27 09:08:52.024409) ========= 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=20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-27 09:08:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-08-27 09:08:52 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080601 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-27 09:08:52.123315) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-27 09:08:52.123643) ========= 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=20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017357 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-27 09:08:52.173057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-27 09:08:52.173401) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bceb296ce64fbb9c788aa681de84a618a8ca5af4 --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 bceb296ce64fbb9c788aa681de84a618a8ca5af4 --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=20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-27 09:08:52,660 truncating revision to first 12 chars 2017-08-27 09:08:52,660 Setting DEBUG logging. 2017-08-27 09:08:52,660 attempt 1/10 2017-08-27 09:08:52,660 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bceb296ce64f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-27 09:08:53,518 unpacking tar archive at: mozilla-beta-bceb296ce64f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.187495 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-27 09:08:53.378775) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-27 09:08:53.382182) ========= script_repo_revision: bceb296ce64fbb9c788aa681de84a618a8ca5af4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-27 09:08:53.382626) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-27 09:08:53.382911) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-27 09:08:53.395103) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-08-27 09:08:53.395518) ========= /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=20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:08:53 INFO - MultiFileLogger online at 20170827 09:08:53 in /builds/slave/test 09:08:53 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 09:08:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:08:53 INFO - {'append_to_log': False, 09:08:53 INFO - 'base_work_dir': '/builds/slave/test', 09:08:53 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 09:08:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:08:53 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 09:08:53 INFO - 'buildbot_json_path': 'buildprops.json', 09:08:53 INFO - 'code_coverage': False, 09:08:53 INFO - 'config_files': ('talos/linux_config.py',), 09:08:53 INFO - 'default_actions': ('clobber', 09:08:53 INFO - 'read-buildbot-config', 09:08:53 INFO - 'download-and-extract', 09:08:53 INFO - 'populate-webroot', 09:08:53 INFO - 'create-virtualenv', 09:08:53 INFO - 'install', 09:08:53 INFO - 'setup-mitmproxy', 09:08:53 INFO - 'run-tests'), 09:08:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:08:53 INFO - 'disable_ccov_upload': False, 09:08:53 INFO - 'download_minidump_stackwalk': True, 09:08:53 INFO - 'download_symbols': 'ondemand', 09:08:53 INFO - 'enable_stylo': False, 09:08:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:08:53 INFO - 'tooltool.py': '/tools/tooltool.py', 09:08:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:08:53 INFO - '/tools/misc-python/virtualenv.py')}, 09:08:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:08:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:08:53 INFO - 'gecko_profile': False, 09:08:53 INFO - 'gecko_profile_interval': 0, 09:08:53 INFO - 'installer_path': 'installer.exe', 09:08:53 INFO - 'log_level': 'info', 09:08:53 INFO - 'log_name': 'talos', 09:08:53 INFO - 'log_to_console': True, 09:08:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:08:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:08:53 INFO - 'opt_config_files': (), 09:08:53 INFO - 'pip_index': False, 09:08:53 INFO - 'suite': 'dromaeojs-e10s', 09:08:53 INFO - 'system_bits': '32', 09:08:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:08:53 INFO - 'title': 'talos-linux64-ix-077', 09:08:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:08:53 INFO - 'use_talos_json': True, 09:08:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:08:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:08:53 INFO - 'work_dir': 'build'} 09:08:53 INFO - [mozharness: 2017-08-27 16:08:53.986159Z] Running clobber step. 09:08:53 INFO - Running pre-action listener: _resource_record_pre_action 09:08:53 INFO - Running main action method: clobber 09:08:53 INFO - rmtree: /builds/slave/test/build 09:08:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:08:55 INFO - Running post-action listener: _resource_record_post_action 09:08:55 INFO - [mozharness: 2017-08-27 16:08:55.017711Z] Finished clobber step (success) 09:08:55 INFO - [mozharness: 2017-08-27 16:08:55.017813Z] Running read-buildbot-config step. 09:08:55 INFO - Running pre-action listener: _resource_record_pre_action 09:08:55 INFO - Running main action method: read_buildbot_config 09:08:55 INFO - Using buildbot properties: 09:08:55 INFO - { 09:08:55 INFO - "project": "", 09:08:55 INFO - "product": "firefox", 09:08:55 INFO - "who": "ffxbld@noreply.mozilla.org", 09:08:55 INFO - "installer_path": "public/build/target.tar.bz2", 09:08:55 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:08:55 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 09:08:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 09:08:55 INFO - "stage_platform": "linux64", 09:08:55 INFO - "basedir": "/builds/slave/test", 09:08:55 INFO - "buildnumber": 65, 09:08:55 INFO - "platform": "ubuntu64_hw", 09:08:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:08:55 INFO - "slavebuilddir": "test", 09:08:55 INFO - "taskId": "HrY539-tS5OLCI-yfFWC9w", 09:08:55 INFO - "branch": "mozilla-beta", 09:08:55 INFO - "script_repo_revision": "production", 09:08:55 INFO - "revision": "bceb296ce64fbb9c788aa681de84a618a8ca5af4", 09:08:55 INFO - "slavename": "talos-linux64-ix-077", 09:08:55 INFO - "repo_path": "releases/mozilla-beta" 09:08:55 INFO - } 09:08:55 INFO - Finding installer, test and symbols from parent task. 09:08:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HrY539-tS5OLCI-yfFWC9w'}, attempt #1 09:08:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HrY539-tS5OLCI-yfFWC9w'}, attempt #1 09:08:55 INFO - Task dependencies: FOu2YV7tSUW7TLmCMflFCg 09:08:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg'}, attempt #1 09:08:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.tar.bz2 09:08:56 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.test_packages.json 09:08:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.crashreporter-symbols.zip 09:08:56 INFO - Running post-action listener: _resource_record_post_action 09:08:56 INFO - [mozharness: 2017-08-27 16:08:56.395254Z] Finished read-buildbot-config step (success) 09:08:56 INFO - [mozharness: 2017-08-27 16:08:56.395475Z] Running download-and-extract step. 09:08:56 INFO - Running pre-action listener: _resource_record_pre_action 09:08:56 INFO - Running main action method: download_and_extract 09:08:56 INFO - mkdir: /builds/slave/test/build/tests 09:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:56 INFO - trying https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.test_packages.json 09:08:56 INFO - Downloading https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:08:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:08:56 INFO - Downloaded 989 bytes. 09:08:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:08:56 INFO - Using the following test package requirements: 09:08:56 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:08:56 INFO - u'common': [u'target.common.tests.zip'], 09:08:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:08:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:08:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:08:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:08:56 INFO - u'mozbase': [u'target.common.tests.zip'], 09:08:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:08:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:08:56 INFO - u'web-platform': [u'target.common.tests.zip', 09:08:56 INFO - u'target.web-platform.tests.tar.gz'], 09:08:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:08:56 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:08:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.common.tests.zip 09:08:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:08:56 INFO - Fetch https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.common.tests.zip into memory 09:08:59 INFO - Content-Length response header: 72855634 09:08:59 INFO - Bytes received: 72855634 09:09:10 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:09:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.common.tests.zip 09:09:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:09:10 INFO - Fetch https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.common.tests.zip into memory 09:09:11 INFO - Content-Length response header: 72855634 09:09:11 INFO - Bytes received: 72855634 09:09:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.talos.tests.zip 09:09:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:09:23 INFO - Fetch https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.talos.tests.zip into memory 09:09:24 INFO - Content-Length response header: 14496472 09:09:24 INFO - Bytes received: 14496472 09:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:25 INFO - trying https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.tar.bz2 09:09:25 INFO - Downloading https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:09:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:09:26 INFO - Downloaded 54221270 bytes. 09:09:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.tar.bz2 09:09:26 INFO - mkdir: /builds/slave/test/properties 09:09:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:09:26 INFO - Writing to file /builds/slave/test/properties/build_url 09:09:26 INFO - Contents: 09:09:26 INFO - build_url:https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.tar.bz2 09:09:26 INFO - Running post-action listener: _resource_record_post_action 09:09:26 INFO - Running post-action listener: set_extra_try_arguments 09:09:26 INFO - [mozharness: 2017-08-27 16:09:26.558107Z] Finished download-and-extract step (success) 09:09:26 INFO - [mozharness: 2017-08-27 16:09:26.558273Z] Running populate-webroot step. 09:09:26 INFO - Running pre-action listener: _resource_record_pre_action 09:09:26 INFO - Running main action method: populate_webroot 09:09:26 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:09:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:09:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:09:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:09:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:09:26 INFO - 'tests': ['damp', 'tps']}, 09:09:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:09:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:09:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:09:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:09:26 INFO - 'other-e10s': {'tests': ['a11yr', 09:09:26 INFO - 'ts_paint', 09:09:26 INFO - 'tpaint', 09:09:26 INFO - 'sessionrestore', 09:09:26 INFO - 'sessionrestore_many_windows', 09:09:26 INFO - 'sessionrestore_no_auto_restore', 09:09:26 INFO - 'tabpaint']}, 09:09:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:09:26 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 09:09:26 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:09:26 INFO - 'talos_options': ['--mitmproxy', 09:09:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:09:26 INFO - '--firstNonBlankPaint'], 09:09:26 INFO - 'tests': ['quantum_pageload_google', 09:09:26 INFO - 'quantum_pageload_youtube', 09:09:26 INFO - 'quantum_pageload_amazon', 09:09:26 INFO - 'quantum_pageload_facebook']}, 09:09:26 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:09:26 INFO - 'talos_options': ['--stylo', 09:09:26 INFO - '--mitmproxy', 09:09:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:09:26 INFO - '--firstNonBlankPaint'], 09:09:26 INFO - 'tests': ['quantum_pageload_google', 09:09:26 INFO - 'quantum_pageload_youtube', 09:09:26 INFO - 'quantum_pageload_amazon', 09:09:26 INFO - 'quantum_pageload_facebook']}, 09:09:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:09:26 INFO - 'tsvgr_opacity', 09:09:26 INFO - 'tart', 09:09:26 INFO - 'tscrollx', 09:09:26 INFO - 'cart', 09:09:26 INFO - 'tsvg_static']}, 09:09:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:09:26 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:09:26 INFO - 'talos_options': ['--stylo', 09:09:26 INFO - '--stylo-threads=1', 09:09:26 INFO - '--mitmproxy', 09:09:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:09:26 INFO - '--firstNonBlankPaint'], 09:09:26 INFO - 'tests': ['tp6_google', 09:09:26 INFO - 'tp6_youtube', 09:09:26 INFO - 'tp6_amazon', 09:09:26 INFO - 'tp6_facebook']}, 09:09:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:09:26 INFO - 'talos_options': ['--xperf_path', 09:09:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:09:26 INFO - 'tests': ['tp5n']}}} 09:09:26 INFO - Running post-action listener: _resource_record_post_action 09:09:26 INFO - [mozharness: 2017-08-27 16:09:26.566947Z] Finished populate-webroot step (success) 09:09:26 INFO - [mozharness: 2017-08-27 16:09:26.567038Z] Running create-virtualenv step. 09:09:26 INFO - Running pre-action listener: _resource_record_pre_action 09:09:26 INFO - Running main action method: create_virtualenv 09:09:26 INFO - Creating virtualenv /builds/slave/test/build/venv 09:09:26 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 09:09:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:09:26 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:09:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:09:26 INFO - Using real prefix '/usr' 09:09:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:09:27 INFO - Installing distribute.............................................................................................................................................................................................done. 09:09:29 INFO - Installing pip.................done. 09:09:29 INFO - Return code: 0 09:09:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:09:29 INFO - Reading from file tmpfile_stdout 09:09:29 INFO - Output received: 09:09:29 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) 09:09:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:29 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 0x111e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b050>, '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 0x148bf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c3e0>, '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': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', '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 09:09:29 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 09:09:29 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 09:09:29 INFO - Using env: {'DISPLAY': ':0', 09:09:29 INFO - 'HOME': '/home/cltbld', 09:09:29 INFO - 'LANG': 'en_US.UTF-8', 09:09:29 INFO - 'LANGUAGE': 'en_US:en', 09:09:29 INFO - 'LOGNAME': 'cltbld', 09:09:29 INFO - 'MAIL': '/var/mail/cltbld', 09:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:29 INFO - 'MOZ_NO_REMOTE': '1', 09:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:29 INFO - 'NO_EM_RESTART': '1', 09:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:29 INFO - 'PWD': '/builds/slave/test', 09:09:29 INFO - 'SHELL': '/bin/bash', 09:09:29 INFO - 'SHLVL': '1', 09:09:29 INFO - 'TERM': 'linux', 09:09:29 INFO - 'TMOUT': '86400', 09:09:29 INFO - 'USER': 'cltbld', 09:09:29 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', 09:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:29 INFO - '_': '/tools/buildbot/bin/python'} 09:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:29 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 09:09:29 INFO - Cleaning up... 09:09:29 INFO - Return code: 0 09:09:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:29 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 0x111e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b050>, '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 0x148bf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c3e0>, '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': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', '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 09:09:29 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 09:09:29 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 09:09:29 INFO - Using env: {'DISPLAY': ':0', 09:09:29 INFO - 'HOME': '/home/cltbld', 09:09:29 INFO - 'LANG': 'en_US.UTF-8', 09:09:29 INFO - 'LANGUAGE': 'en_US:en', 09:09:29 INFO - 'LOGNAME': 'cltbld', 09:09:29 INFO - 'MAIL': '/var/mail/cltbld', 09:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:29 INFO - 'MOZ_NO_REMOTE': '1', 09:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:29 INFO - 'NO_EM_RESTART': '1', 09:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:29 INFO - 'PWD': '/builds/slave/test', 09:09:29 INFO - 'SHELL': '/bin/bash', 09:09:29 INFO - 'SHLVL': '1', 09:09:29 INFO - 'TERM': 'linux', 09:09:29 INFO - 'TMOUT': '86400', 09:09:29 INFO - 'USER': 'cltbld', 09:09:29 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', 09:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:29 INFO - '_': '/tools/buildbot/bin/python'} 09:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:29 INFO - Downloading/unpacking psutil>=3.1.1 09:09:29 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 09:09:29 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 09:09:29 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 09:09:29 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 09:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:09:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:31 INFO - Installing collected packages: psutil 09:09:31 INFO - Running setup.py install for psutil 09:09:31 INFO - building 'psutil._psutil_linux' extension 09:09:31 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 09:09:31 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 09:09:31 INFO - building 'psutil._psutil_posix' extension 09:09:31 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 09:09:31 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 09:09:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:31 INFO - Successfully installed psutil 09:09:31 INFO - Cleaning up... 09:09:31 INFO - Return code: 0 09:09:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:31 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 0x111e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b050>, '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 0x148bf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c3e0>, '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': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', '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 09:09:31 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 09:09:31 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 09:09:31 INFO - Using env: {'DISPLAY': ':0', 09:09:31 INFO - 'HOME': '/home/cltbld', 09:09:31 INFO - 'LANG': 'en_US.UTF-8', 09:09:31 INFO - 'LANGUAGE': 'en_US:en', 09:09:31 INFO - 'LOGNAME': 'cltbld', 09:09:31 INFO - 'MAIL': '/var/mail/cltbld', 09:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:31 INFO - 'MOZ_NO_REMOTE': '1', 09:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:31 INFO - 'NO_EM_RESTART': '1', 09:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:31 INFO - 'PWD': '/builds/slave/test', 09:09:31 INFO - 'SHELL': '/bin/bash', 09:09:31 INFO - 'SHLVL': '1', 09:09:31 INFO - 'TERM': 'linux', 09:09:31 INFO - 'TMOUT': '86400', 09:09:31 INFO - 'USER': 'cltbld', 09:09:31 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', 09:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:31 INFO - '_': '/tools/buildbot/bin/python'} 09:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:09: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 09:09: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 09:09: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 09:09: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 09:09:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:09:32 INFO - Installing collected packages: mozsystemmonitor 09:09:32 INFO - Running setup.py install for mozsystemmonitor 09:09:33 INFO - Successfully installed mozsystemmonitor 09:09:33 INFO - Cleaning up... 09:09:33 INFO - Return code: 0 09:09:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:33 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 0x111e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b050>, '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 0x148bf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c3e0>, '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': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', '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 09:09:33 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 09:09:33 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 09:09:33 INFO - Using env: {'DISPLAY': ':0', 09:09:33 INFO - 'HOME': '/home/cltbld', 09:09:33 INFO - 'LANG': 'en_US.UTF-8', 09:09:33 INFO - 'LANGUAGE': 'en_US:en', 09:09:33 INFO - 'LOGNAME': 'cltbld', 09:09:33 INFO - 'MAIL': '/var/mail/cltbld', 09:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:33 INFO - 'MOZ_NO_REMOTE': '1', 09:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:33 INFO - 'NO_EM_RESTART': '1', 09:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:33 INFO - 'PWD': '/builds/slave/test', 09:09:33 INFO - 'SHELL': '/bin/bash', 09:09:33 INFO - 'SHLVL': '1', 09:09:33 INFO - 'TERM': 'linux', 09:09:33 INFO - 'TMOUT': '86400', 09:09:33 INFO - 'USER': 'cltbld', 09:09:33 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', 09:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:33 INFO - '_': '/tools/buildbot/bin/python'} 09:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:33 INFO - Downloading/unpacking jsonschema==2.5.1 09:09: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 09:09: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 09:09: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 09:09: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 09:09:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:09:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:09: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 09:09: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 09:09: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 09:09: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 09:09:34 INFO - Downloading functools32-3.2.3-2.tar.gz 09:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:09:34 INFO - warning: no files found matching '*.txt' 09:09:34 INFO - no previously-included directories found matching 'build' 09:09:34 INFO - no previously-included directories found matching 'dist' 09:09:34 INFO - no previously-included directories found matching '.git*' 09:09:34 INFO - Installing collected packages: jsonschema, functools32 09:09:34 INFO - Running setup.py install for functools32 09:09:34 INFO - warning: no files found matching '*.txt' 09:09:34 INFO - no previously-included directories found matching 'build' 09:09:34 INFO - no previously-included directories found matching 'dist' 09:09:34 INFO - no previously-included directories found matching '.git*' 09:09:34 INFO - Successfully installed jsonschema functools32 09:09:34 INFO - Cleaning up... 09:09:34 INFO - Return code: 0 09:09:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09: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')]} 09:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09: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', '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 0x111e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b050>, '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 0x148bf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c3e0>, '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': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', '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 09:09: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:09: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 functools32==3.2.3-2 09:09:34 INFO - Using env: {'DISPLAY': ':0', 09:09:34 INFO - 'HOME': '/home/cltbld', 09:09:34 INFO - 'LANG': 'en_US.UTF-8', 09:09:34 INFO - 'LANGUAGE': 'en_US:en', 09:09:34 INFO - 'LOGNAME': 'cltbld', 09:09:34 INFO - 'MAIL': '/var/mail/cltbld', 09:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:34 INFO - 'MOZ_NO_REMOTE': '1', 09:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:34 INFO - 'NO_EM_RESTART': '1', 09:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:34 INFO - 'PWD': '/builds/slave/test', 09:09:34 INFO - 'SHELL': '/bin/bash', 09:09:34 INFO - 'SHLVL': '1', 09:09:34 INFO - 'TERM': 'linux', 09:09:34 INFO - 'TMOUT': '86400', 09:09:34 INFO - 'USER': 'cltbld', 09:09:34 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', 09:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:34 INFO - '_': '/tools/buildbot/bin/python'} 09:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:09:34 INFO - Cleaning up... 09:09:34 INFO - Return code: 0 09:09:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09: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')]} 09:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09: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', '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 0x111e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b050>, '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 0x148bf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c3e0>, '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': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', '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 09:09: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:09: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 blobuploader==1.2.4 09:09:34 INFO - Using env: {'DISPLAY': ':0', 09:09:34 INFO - 'HOME': '/home/cltbld', 09:09:34 INFO - 'LANG': 'en_US.UTF-8', 09:09:34 INFO - 'LANGUAGE': 'en_US:en', 09:09:34 INFO - 'LOGNAME': 'cltbld', 09:09:34 INFO - 'MAIL': '/var/mail/cltbld', 09:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:34 INFO - 'MOZ_NO_REMOTE': '1', 09:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:34 INFO - 'NO_EM_RESTART': '1', 09:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:34 INFO - 'PWD': '/builds/slave/test', 09:09:34 INFO - 'SHELL': '/bin/bash', 09:09:34 INFO - 'SHLVL': '1', 09:09:34 INFO - 'TERM': 'linux', 09:09:34 INFO - 'TMOUT': '86400', 09:09:34 INFO - 'USER': 'cltbld', 09:09:34 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', 09:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:34 INFO - '_': '/tools/buildbot/bin/python'} 09:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:35 INFO - Downloading/unpacking blobuploader==1.2.4 09:09: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 09:09: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 09:09: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 09:09: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 09:09:36 INFO - Downloading blobuploader-1.2.4.tar.gz 09:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:09:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:09: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 09:09: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 09:09: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 09:09: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 09:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:09:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:09: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 09:09: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 09:09: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 09:09: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 09:09:36 INFO - Downloading docopt-0.6.1.tar.gz 09:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:09:36 INFO - Installing collected packages: blobuploader, requests, docopt 09:09:36 INFO - Running setup.py install for blobuploader 09:09:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:09:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:09:37 INFO - Running setup.py install for requests 09:09:37 INFO - Running setup.py install for docopt 09:09:37 INFO - Successfully installed blobuploader requests docopt 09:09:37 INFO - Cleaning up... 09:09:37 INFO - Return code: 0 09:09:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:37 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')]} 09:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:37 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')]} 09:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:37 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 0x111e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b050>, '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 0x148bf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c3e0>, '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': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', '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 09:09:37 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 09:09:37 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 09:09:37 INFO - Using env: {'DISPLAY': ':0', 09:09:37 INFO - 'HOME': '/home/cltbld', 09:09:37 INFO - 'LANG': 'en_US.UTF-8', 09:09:37 INFO - 'LANGUAGE': 'en_US:en', 09:09:37 INFO - 'LOGNAME': 'cltbld', 09:09:37 INFO - 'MAIL': '/var/mail/cltbld', 09:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:37 INFO - 'MOZ_NO_REMOTE': '1', 09:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:37 INFO - 'NO_EM_RESTART': '1', 09:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:37 INFO - 'PWD': '/builds/slave/test', 09:09:37 INFO - 'SHELL': '/bin/bash', 09:09:37 INFO - 'SHLVL': '1', 09:09:37 INFO - 'TERM': 'linux', 09:09:37 INFO - 'TMOUT': '86400', 09:09:37 INFO - 'USER': 'cltbld', 09:09:37 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', 09:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:37 INFO - '_': '/tools/buildbot/bin/python'} 09:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:37 INFO - Running setup.py (path:/tmp/pip-2_1YdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:37 INFO - Running setup.py (path:/tmp/pip-9WF1IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:37 INFO - Running setup.py (path:/tmp/pip-URzFSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:37 INFO - Running setup.py (path:/tmp/pip-0Uu2f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:38 INFO - Running setup.py (path:/tmp/pip-qMqz4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:38 INFO - Running setup.py (path:/tmp/pip-OW3ZNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:38 INFO - Running setup.py (path:/tmp/pip-WXOFHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:38 INFO - Running setup.py (path:/tmp/pip-_vCxEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:38 INFO - Running setup.py (path:/tmp/pip-tuk0kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:38 INFO - Running setup.py (path:/tmp/pip-5AdvD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:38 INFO - Running setup.py (path:/tmp/pip-JhJGwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:38 INFO - Running setup.py (path:/tmp/pip-BmPK7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:38 INFO - Running setup.py (path:/tmp/pip-XkxIAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:38 INFO - Running setup.py (path:/tmp/pip-QJ3t9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:38 INFO - Running setup.py (path:/tmp/pip-bcc3Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:38 INFO - Running setup.py (path:/tmp/pip-LSkqnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:38 INFO - Running setup.py (path:/tmp/pip-QBdsAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:09:38 INFO - Running setup.py install for manifestparser 09:09:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:09:39 INFO - Running setup.py install for mozcrash 09:09:39 INFO - Running setup.py install for mozdebug 09:09:39 INFO - Running setup.py install for mozdevice 09:09:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:09:39 INFO - Running setup.py install for mozfile 09:09:39 INFO - Running setup.py install for mozhttpd 09:09:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:09:39 INFO - Running setup.py install for mozinfo 09:09:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:09:39 INFO - Running setup.py install for mozInstall 09:09:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:09:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:09:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:09:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:09:39 INFO - Running setup.py install for mozleak 09:09:39 INFO - Running setup.py install for mozlog 09:09:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:09:39 INFO - Running setup.py install for moznetwork 09:09:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:09:40 INFO - Running setup.py install for mozprocess 09:09:40 INFO - Running setup.py install for mozprofile 09:09:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:09:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:09:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:09:40 INFO - Running setup.py install for mozrunner 09:09:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:09:40 INFO - Running setup.py install for mozscreenshot 09:09:40 INFO - Running setup.py install for moztest 09:09:40 INFO - Running setup.py install for mozversion 09:09:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:09:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:09:40 INFO - Cleaning up... 09:09:40 INFO - Return code: 0 09:09:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:40 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')]} 09:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:40 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')]} 09:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:40 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 0x111e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b050>, '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 0x148bf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c3e0>, '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': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', '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 09:09:40 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 09:09:40 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 09:09:40 INFO - Using env: {'DISPLAY': ':0', 09:09:40 INFO - 'HOME': '/home/cltbld', 09:09:40 INFO - 'LANG': 'en_US.UTF-8', 09:09:40 INFO - 'LANGUAGE': 'en_US:en', 09:09:40 INFO - 'LOGNAME': 'cltbld', 09:09:40 INFO - 'MAIL': '/var/mail/cltbld', 09:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:40 INFO - 'MOZ_NO_REMOTE': '1', 09:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:40 INFO - 'NO_EM_RESTART': '1', 09:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:40 INFO - 'PWD': '/builds/slave/test', 09:09:40 INFO - 'SHELL': '/bin/bash', 09:09:40 INFO - 'SHLVL': '1', 09:09:40 INFO - 'TERM': 'linux', 09:09:40 INFO - 'TMOUT': '86400', 09:09:40 INFO - 'USER': 'cltbld', 09:09:40 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', 09:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:40 INFO - '_': '/tools/buildbot/bin/python'} 09:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:40 INFO - Running setup.py (path:/tmp/pip-s6N9Kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:40 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)) 09:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:41 INFO - Running setup.py (path:/tmp/pip-8AlJ5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:41 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)) 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:41 INFO - Running setup.py (path:/tmp/pip-y8XFkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:41 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)) 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:41 INFO - Running setup.py (path:/tmp/pip-lYQgCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:41 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)) 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:41 INFO - Running setup.py (path:/tmp/pip-f7j1Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:41 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)) 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:41 INFO - Running setup.py (path:/tmp/pip-CKU_tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:41 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)) 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:41 INFO - Running setup.py (path:/tmp/pip-07Dv1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:41 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)) 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:41 INFO - Running setup.py (path:/tmp/pip-X0Dx3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:41 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)) 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:41 INFO - Running setup.py (path:/tmp/pip-tHuiVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:41 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)) 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:41 INFO - Running setup.py (path:/tmp/pip-1giwsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:41 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)) 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:41 INFO - Running setup.py (path:/tmp/pip-XRfVUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:41 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)) 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:41 INFO - Running setup.py (path:/tmp/pip-atZOFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:41 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)) 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:41 INFO - Running setup.py (path:/tmp/pip-KL6cjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:41 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)) 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:41 INFO - Running setup.py (path:/tmp/pip-bxVQkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:41 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)) 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:41 INFO - Running setup.py (path:/tmp/pip-XhBYmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:42 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)) 09:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:42 INFO - Running setup.py (path:/tmp/pip-0IgJBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:42 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)) 09:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:42 INFO - Running setup.py (path:/tmp/pip-PZoILQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:42 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)) 09:09:42 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)) 09:09:42 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)) 09:09:42 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)) 09:09:42 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)) 09:09:42 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)) 09:09:42 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)) 09:09:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:09:42 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 09:09:42 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 09:09:42 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 09:09:42 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 09:09:43 INFO - Downloading blessings-1.6.tar.gz 09:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:09:43 INFO - Installing collected packages: blessings 09:09:43 INFO - Running setup.py install for blessings 09:09:43 INFO - Successfully installed blessings 09:09:43 INFO - Cleaning up... 09:09:43 INFO - Return code: 0 09:09:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:43 INFO - Reading from file tmpfile_stdout 09:09:43 INFO - Current package versions: 09:09:43 INFO - argparse == 1.2.1 09:09:43 INFO - blessings == 1.6 09:09:43 INFO - blobuploader == 1.2.4 09:09:43 INFO - docopt == 0.6.1 09:09:43 INFO - functools32 == 3.2.3-2 09:09:43 INFO - jsonschema == 2.5.1 09:09:43 INFO - manifestparser == 1.1 09:09:43 INFO - mozInstall == 1.13 09:09:43 INFO - mozcrash == 1.0 09:09:43 INFO - mozdebug == 0.1 09:09:43 INFO - mozdevice == 0.51 09:09:43 INFO - mozfile == 1.2 09:09:43 INFO - mozhttpd == 0.7 09:09:43 INFO - mozinfo == 0.10 09:09:43 INFO - mozleak == 0.1 09:09:43 INFO - mozlog == 3.5 09:09:43 INFO - moznetwork == 0.27 09:09:43 INFO - mozprocess == 0.25 09:09:43 INFO - mozprofile == 0.28 09:09:43 INFO - mozrunner == 6.13 09:09:43 INFO - mozscreenshot == 0.1 09:09:43 INFO - mozsystemmonitor == 0.3 09:09:43 INFO - moztest == 0.8 09:09:43 INFO - mozversion == 1.4 09:09:43 INFO - psutil == 3.1.1 09:09:43 INFO - requests == 1.2.3 09:09:43 INFO - wsgiref == 0.1.2 09:09:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:43 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')]} 09:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:43 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')]} 09:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:43 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 0x111e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b050>, '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 0x148bf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c3e0>, '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': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', '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 09:09:43 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 09:09:43 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 09:09:43 INFO - Using env: {'DISPLAY': ':0', 09:09:43 INFO - 'HOME': '/home/cltbld', 09:09:43 INFO - 'LANG': 'en_US.UTF-8', 09:09:43 INFO - 'LANGUAGE': 'en_US:en', 09:09:43 INFO - 'LOGNAME': 'cltbld', 09:09:43 INFO - 'MAIL': '/var/mail/cltbld', 09:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:43 INFO - 'MOZ_NO_REMOTE': '1', 09:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:43 INFO - 'NO_EM_RESTART': '1', 09:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:43 INFO - 'PWD': '/builds/slave/test', 09:09:43 INFO - 'SHELL': '/bin/bash', 09:09:43 INFO - 'SHLVL': '1', 09:09:43 INFO - 'TERM': 'linux', 09:09:43 INFO - 'TMOUT': '86400', 09:09:43 INFO - 'USER': 'cltbld', 09:09:43 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', 09:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:43 INFO - '_': '/tools/buildbot/bin/python'} 09:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:43 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)) 09:09:43 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)) 09:09:43 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)) 09:09:43 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)) 09:09:43 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)) 09:09:43 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)) 09:09:43 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)) 09:09:43 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)) 09:09:43 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)) 09:09:43 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:09: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 09:09: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 09:09: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 09:09: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 09:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:09:45 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)) 09:09:45 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)) 09:09:45 INFO - Installing collected packages: simplejson 09:09:45 INFO - Running setup.py install for simplejson 09:09:45 INFO - building 'simplejson._speedups' extension 09:09:45 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 09:09:46 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 09:09:46 INFO - Successfully installed simplejson 09:09:46 INFO - Cleaning up... 09:09:46 INFO - Return code: 0 09:09:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:09:46 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')]} 09:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:46 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')]} 09:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:46 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 0x111e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b050>, '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 0x148bf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c3e0>, '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': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', '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 09:09:46 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 09:09:46 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 09:09:46 INFO - Using env: {'DISPLAY': ':0', 09:09:46 INFO - 'HOME': '/home/cltbld', 09:09:46 INFO - 'LANG': 'en_US.UTF-8', 09:09:46 INFO - 'LANGUAGE': 'en_US:en', 09:09:46 INFO - 'LOGNAME': 'cltbld', 09:09:46 INFO - 'MAIL': '/var/mail/cltbld', 09:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:46 INFO - 'MOZ_NO_REMOTE': '1', 09:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:46 INFO - 'NO_EM_RESTART': '1', 09:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:46 INFO - 'PWD': '/builds/slave/test', 09:09:46 INFO - 'SHELL': '/bin/bash', 09:09:46 INFO - 'SHLVL': '1', 09:09:46 INFO - 'TERM': 'linux', 09:09:46 INFO - 'TMOUT': '86400', 09:09:46 INFO - 'USER': 'cltbld', 09:09:46 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', 09:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:46 INFO - '_': '/tools/buildbot/bin/python'} 09:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:09:46 INFO - Cleaning up... 09:09:46 INFO - Return code: 0 09:09:46 INFO - Running post-action listener: _resource_record_post_action 09:09:46 INFO - Running post-action listener: _start_resource_monitoring 09:09:46 INFO - Starting resource monitoring. 09:09:46 INFO - [mozharness: 2017-08-27 16:09:46.452934Z] Finished create-virtualenv step (success) 09:09:46 INFO - [mozharness: 2017-08-27 16:09:46.453442Z] Running install step. 09:09:46 INFO - Running pre-action listener: _resource_record_pre_action 09:09:46 INFO - Running main action method: install 09:09:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:46 INFO - Reading from file tmpfile_stdout 09:09:46 INFO - Detecting whether we're running mozinstall >=1.0... 09:09:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:09:46 INFO - Reading from file tmpfile_stdout 09:09:46 INFO - Output received: 09:09:46 INFO - Usage: mozinstall [options] installer 09:09:46 INFO - Options: 09:09:46 INFO - -h, --help show this help message and exit 09:09:46 INFO - -d DEST, --destination=DEST 09:09:46 INFO - Directory to install application into. [default: 09:09:46 INFO - "/builds/slave/test"] 09:09:46 INFO - --app=APP Application being installed. [default: firefox] 09:09:46 INFO - mkdir: /builds/slave/test/build/application 09:09:46 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'] 09:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:10:01 INFO - Reading from file tmpfile_stdout 09:10:01 INFO - Output received: 09:10:01 INFO - /builds/slave/test/build/application/firefox/firefox 09:10:01 INFO - Running post-action listener: _resource_record_post_action 09:10:01 INFO - [mozharness: 2017-08-27 16:10:01.547756Z] Finished install step (success) 09:10:01 INFO - [mozharness: 2017-08-27 16:10:01.548098Z] Running setup-mitmproxy step. 09:10:01 INFO - Running pre-action listener: _resource_record_pre_action 09:10:01 INFO - Running main action method: setup_mitmproxy 09:10:01 INFO - Skipping: mitmproxy is not required 09:10:01 INFO - Running post-action listener: _resource_record_post_action 09:10:01 INFO - [mozharness: 2017-08-27 16:10:01.549713Z] Finished setup-mitmproxy step (success) 09:10:01 INFO - [mozharness: 2017-08-27 16:10:01.550023Z] Running run-tests step. 09:10:01 INFO - Running pre-action listener: _resource_record_pre_action 09:10:01 INFO - Running pre-action listener: _set_gcov_prefix 09:10:01 INFO - Running main action method: run_tests 09:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:10:01 INFO - Python 2.7.3 09:10:01 INFO - Return code: 0 09:10:01 INFO - grabbing minidump binary from tooltool 09:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:01 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 0x148b050>, '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 0x148bf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c3e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:10:01 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 09:10:01 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 09:10:01 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 09:10:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:10:01 INFO - Return code: 0 09:10:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:10:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:10:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:10:01 INFO - ENV: RUST_BACKTRACE is now 1 09:10:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:10:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:10:01 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/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--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 09:10:01 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/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-077 --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 09:10:01 INFO - Using env: {'DISPLAY': ':0', 09:10:01 INFO - 'HOME': '/home/cltbld', 09:10:01 INFO - 'LANG': 'en_US.UTF-8', 09:10:01 INFO - 'LANGUAGE': 'en_US:en', 09:10:01 INFO - 'LOGNAME': 'cltbld', 09:10:01 INFO - 'MAIL': '/var/mail/cltbld', 09:10:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:10:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:01 INFO - 'MOZ_NO_REMOTE': '1', 09:10:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:01 INFO - 'NO_EM_RESTART': '1', 09:10:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:01 INFO - 'PWD': '/builds/slave/test', 09:10:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:10:01 INFO - 'RUST_BACKTRACE': '1', 09:10:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:10:01 INFO - 'SHELL': '/bin/bash', 09:10:01 INFO - 'SHLVL': '1', 09:10:01 INFO - 'TERM': 'linux', 09:10:01 INFO - 'TMOUT': '86400', 09:10:01 INFO - 'USER': 'cltbld', 09:10:01 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157', 09:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:01 INFO - '_': '/tools/buildbot/bin/python'} 09:10:01 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/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--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 09:10:01 INFO - mozversion application_buildid: 20170827150022 09:10:01 INFO - mozversion application_changeset: bceb296ce64fbb9c788aa681de84a618a8ca5af4 09:10:01 INFO - mozversion application_display_name: Firefox 09:10:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:10:01 INFO - mozversion application_name: Firefox 09:10:01 INFO - mozversion application_remotingname: firefox 09:10:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:10:01 INFO - mozversion application_vendor: Mozilla 09:10:01 INFO - mozversion application_version: 56.0 09:10:01 INFO - mozversion platform_buildid: 20170827150022 09:10:01 INFO - mozversion platform_changeset: bceb296ce64fbb9c788aa681de84a618a8ca5af4 09:10:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:10:01 INFO - mozversion platform_version: 56.0 09:10:01 INFO - using testdate: 1503850201 09:10:01 INFO - actual date: 1503850201 09:10:01 INFO - starting webserver on 'localhost:33939' 09:10:01 INFO - SUITE-START | Running 2 tests 09:10:01 INFO - TEST-START | dromaeo_css 09:10:01 INFO - Initialising browser for dromaeo_css test... 09:10:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33939/getInfo.html -profile /tmp/tmpC_jj0v/profile 09:10:01 INFO - TEST-INFO | started process 5541 (/builds/slave/test/build/application/firefox/firefox http://localhost:33939/getInfo.html) 09:10:06 INFO - TEST-INFO | 5541: exit 0 09:10:07 INFO - Browser initialized. 09:10:07 INFO - Running cycle 1/1 for dromaeo_css test... 09:10:07 INFO - TEST-INFO | started process 5703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC_jj0v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:07 INFO - PID 5703 | 1503850207332 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 09:10:18 INFO - PID 5703 | RSS: Main: 157253632 09:10:18 INFO - PID 5703 | 09:13:16 INFO - PID 5703 | Cycle 1(1): loaded http://localhost:33939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33939/tests/dromaeo/cssquery-ext.html) 09:13:17 INFO - PID 5703 | RSS: Main: 162484224 09:13:17 INFO - PID 5703 | 09:16:19 INFO - PID 5703 | Cycle 1(1): loaded http://localhost:33939/tests/dromaeo/cssquery-ext.html (next: http://localhost:33939/tests/dromaeo/cssquery-jquery.html) 09:16:19 INFO - PID 5703 | RSS: Main: 158576640 09:16:19 INFO - PID 5703 | 09:19:21 INFO - PID 5703 | Cycle 1(1): loaded http://localhost:33939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33939/tests/dromaeo/cssquery-mootools.html) 09:19:22 INFO - PID 5703 | RSS: Main: 160854016 09:19:22 INFO - PID 5703 | 09:22:23 INFO - PID 5703 | Cycle 1(1): loaded http://localhost:33939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33939/tests/dromaeo/cssquery-prototype.html) 09:22:24 INFO - PID 5703 | RSS: Main: 161263616 09:22:24 INFO - PID 5703 | 09:25:27 INFO - PID 5703 | Cycle 1(1): loaded http://localhost:33939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33939/tests/dromaeo/cssquery-yui.html) 09:25:28 INFO - PID 5703 | RSS: Main: 162779136 09:25:28 INFO - PID 5703 | 09:28:29 INFO - PID 5703 | Cycle 1(1): loaded http://localhost:33939/tests/dromaeo/cssquery-yui.html (next: http://localhost:33939/tests/dromaeo/cssquery-dojo.html) 09:28:29 INFO - PID 5703 | RSS: Main: 165957632 09:28:29 INFO - PID 5703 | 09:28:29 INFO - PID 5703 | __start_tp_report 09:28:29 INFO - PID 5703 | _x_x_mozilla_page_load 09:28:29 INFO - PID 5703 | _x_x_mozilla_page_load_details 09:28:29 INFO - PID 5703 | |i|pagename|runs| 09:28:29 INFO - PID 5703 | |0;dojo.html;3617.113807117255;3622.981885090574;3624.3294990426775;3635.381985062539;3695.8336874840647;6418.9679051604735;6419.807405777822;6434.806955791322;6513.218413790346;6518;6464.612123272607;6486.675666216694;6498.577592456487;6556;6597.769078082268;5507.201455788908;5587.636803607753;5611.719414029302;5630.802921897734;5682.289713785777;5666.858328541799;5691.857703557403;5715.828525144252;5743.13852922063;5749.971250143743;5618.887622247532;5684.346300175492;5689.118186681071;5748.45389687979;5780.942190578083;5516.448355164452;5600.0759874620635;5618.775248990036;5649.830505084854;5679;5529.060059789846;5589.189567512688;5597.328320601513;5598.216249725042;5605.327360716699;6296.240975852626;6318.368163183691;6336.524760642924;6361.236651601837;6390.616563006234;6755.7973260802255;6877.759278425231;6927.099477067949;7012.7545535906;7033.437325013987;7108.537945033556;7126.2161162272105;7144.214136444987;7160.462965277573;7160.749373771945;6320.336364681734;6523.151990241286;6531.444827189647;6531.93468065318;6598.571092878948;7019.543729657556;7184.533005354635;7192;7249.275072492708;7287.380572651278;6899.827504312432;6941.652917354213;6956.269591692901;6973.930260697328;6985;6968.965155174293;6975.79072627822;7013.298670133048;7036.612986285803;7046.577205367695;6949.617771022642;6966.1988871280455;6989.650517474106;7025.402840758593;7032.08582884232;6908.378245957788;6923.273056329113;7001.159860816734;7008.299170083053;7028.789136325919;5044.621653376012;5140.897182056338;5158.92261616076;5171;5176.818811341585;4525.796339164745;4568.291914753218;4581;4607.124646317189;4641.976790116096;6672.86654266912;6710.328967103348;6716.496262780311;6749.460043196631;6754.6284954327;7009.264027277164;7012.894806577905;7021.543599666005;7083.220845706968;7097.645117744092;6507.804765857032;6657.23441804189;6677.53257271996;6754.290799466084;6756.223034351015;5855.677937713466;5908.379620139909;5927.585069045125;5947.702614869239;5951.702414879239;7199.856002879913;7248.275172482815;7249.130104387507;7258.818529536804;7261.8547629047125;6895.34494223038;6985.615791131537;6996.965015174892;7073.151221853411;7073.3987611053635;7060.188078371053;7137.393321567725;7140.6786694599905;7145.678444469907;7287.672054757655;6829.863402732017;6914.654267286515;6952.478564107813;6965.547239429421;6998.230194678479;6922.653867306715;6982.511224214256;6986.790396287916;7065.964670176616;7118.60847653384;6732.3267673232285;6740.325967403221;6750.966245168743;6753.088333074972;6760.526763126534;6700.631465269457;6706.295838937037;6709.295523969913;6720.193576770819;6728.461723062045;6798.490113241428;6805.727770889109;6811.2167100784045;6825.317468253135;6832.692528836314;6810.523263371715;6893.655317234018;6935.479839011993;6951.826204344932;6991.895121573282;6491.675416229075;6653.567518111307;6656.334366563305;6737.898931515933;6756.155480564929 09:28:29 INFO - PID 5703 | |1;ext.html;870.2476629479144;915.3729695158817;946.2950102173877;953.4565297780264;978.9265805064613;43076.138477230474;43836;43858.342124868155;43871.56128438715;43887.341689874636;41352.37971430431;41354.172916541655;41455.792721036356;41621.375679364835;41674.7916260419;7090.50366474347;7119.394851437634;7144.964275178617;7158.319959603829;7164.104486939133;6995.265497122805;7061.435085193198;7061.788146355618;7083.291670832901;7087.9291207088045;7703.229677032308;7791;7841.451098423113;7844.764657060297;7846.843063138734;7800.258975397356;7840.960795196044;7846.607669616496;7853.842923141505;7856.292933635943;7796.103448103484;7875.527468351917;7875.566843823587;7877.487963282369;7877.7636670899965;40838.38742418866;41141.38287925684;41260.38109428331;41313.38029929553;41379;3713.628637136265;3723.5345581802276;3752.5872154063304;3753.887383378503;3753.924921501582;32468.675313247037;32484.70061197549;32520.674793252;32603.347933041205;32639.673603263902;5083.6441449098575;5163.8192663256605;5188.792448302063;5204.635675502716;5224.895502089975;209543;216240;217158;218205;228231.99999999834;52051.219231711555;52070.73964630228;52091.218631720556;52118.739406302724;52131.73934130305;54730.45269547333;55170.17244741332;55197;55217.723911380184;55260.72369638126;18019.369322073664;18083.27666893336;18139.365122220657;18151.546211344823;18288.451346459362;15066.924665376602;15131.848681513044;15252.161131137673;15260.694786104215;15267.770983435257;14979.325930333162;15096.54710358691;15170.544883653509;15437.15095669749;15552.444755524582;5740.264281967394;5854.531637468992;5933.614315069507;6013.4888534474185;6101.328853826076;1093.8632670916136;1100.6037826382496;1127.7913585986619;1140.988590114105;1144.5822274869613;25535;25535.36161595975;25622;25718.6142207867;25788.74211257901;1218.9085818563642;1242.0808601634906;1242.9689257768628;1245.64499117751;1247.2641141726244;13370.863476604403;13586.456541738418;13590.38843252056;13642.2496762679;13815.654608634664;297690;298923;300491;300621;301583;57589.13616295759;57792.42207577955;57830;57982.7100864493;57988.420115798304;1554.595805090662;1561.625209949604;1598.1609654931021;1606.5421354913794;1616.7655689924895;25157.496850063264;25367.6194857081;25643.743562564134;25734.227973160836;25784.742152578234;42005.15989680251;42050.57949420466;42101;42129.78935105305;42145.578544214164;223300;224387;227086;227749;227828;36542.8172859134;41944.79027604842;42227.155456890076;42336.576634233264;42643.36034959416;50805;51759.22361164661;51868.481315186364;51928.48071519387;52418.213726793365;37802.243955121296;38054.80972595119;38278.808605956794;38305.2338953225;38468.6153138465;38005.239895202496;38011.80994095122;38030;38060.42909356306;38089;43235;44588.33117503175;44803;44884.326735098344;45488;36789.81605091957;36933.81533092317;37097.814510927274;37610;37752.24495510129;26792.720302688394;27622.447551048466;27781.16656500308;27944;28048.29879253035 09:28:29 INFO - PID 5703 | |2;jquery.html;574.7557288152534;591.2107336705501;594.1355327997763;602.8944934636437;620.7175735040557;23735.169269075584;24317.392065198357;24501.264962051122;24501.632475512837;24503.63244551331;23407.88296058517;23477;25950.221493355184;28493.43013139741;28519.287017824565;6441.452476539488;6618.3050779668165;6619.238787539422;6622.2715501294815;6623.768168114117;6097.146399504073;6656;6674.16572928384;6691.197056353244;6730.831729206784;6292.244930608334;6326;6331.176946996884;6355.8411039723915;6357.904631430532;6328.873422531569;6329.493640508771;6333.968330158343;6337.176167098294;6342.048692696087;5923.526117910556;5932.228810254683;5935.347111817697;5942.286925568917;5942.3760505146765;30670.079897602885;31647.367052658818;31962.680373196203;32443;32583;2253.7971582557648;2325.732540757818;2332;2332.6734257204007;2333.0201315447553;20228.49428764278;20644.896775516176;20734;20756.273530426362;20792.688109678365;2415.758424157588;2419.3830573203895;2457.176845756656;2466.5683505386664;2487.825852190347;140835;150542.24728876285;151531;161196;161405.19297403438;15565.844341556665;16241.457061579367;16536.834631653528;16696.332146714238;16906;25147.87426062858;25232.873835630704;25252;25268;25335.36661583475;11434;11552.595659152057;11595.652130436101;11774.764504709858;11966.461509232106;10917.672469825919;10974.945125274322;11049.723756906142;11067.557297708001;11126.666200014013;9922.950385248028;10003.599856005823;10045.940582180636;10120.342177758423;10266.845997310047;2865.126136528379;2866.8423236721765;2894.088362165911;2914.373409716921;2921.5008886315263;1080.3895798873612;1081.7674200047027;1096.31480324797;1104.7017305327518;1108.944552772358;21560.56878862414;21935.890320548297;22059.66910496344;22076.2273320433;22258.554828903332;1143.451143451148;1151.8329842172839;1156.7570810129798;1157.438642258504;1165.825126231072;12097.455614497369;12237.449314780857;12425.565105221274;12461.875381246253;12512.74974500523;599671;666157;681472;715412;721859;146665;149994;151276;155910;161117;1327.1373607155233;1367.8974076944469;1405.0445696926188;1412;1415.9150450972768;24164.39589010289;24594.754052459248;24612.876935615208;24877.751222487543;25099.247022589352;66128.66935665291;67921.66039169772;68520;69563;73784.63107684428;88400.5579972096;88499;88884;88976;89695.10304896868;22294.331170064925;22503.437414064778;23606.70163140975;23856.28431146999;24134.637980429958;26041.218763437126;26101.955921762918;26148.477030459664;26167.345816354744;26340.20979370622;20558.691619625417;20717.171313147304;20767.480812979797;21120.26079087286;21140.682889756972;18579.349722759638;18837.24651013944;18864.24543018264;18924;19013.33453329127;21708.565828683655;21873.671894921907;21932.780672193076;22093.44766380789;22172.1131154752;22743.203987860346;23335.18326858552;23570;23574.88212558926;23591.29226123219;20630.071646776232;21012;21062.2628208012;21065.473363166042;21137.6829347563 09:28:29 INFO - PID 5703 | |3;mootools.html;1425.1164278147548;1452.6368407898026;1478.9630259243525;1492.940282388705;1493.9103653780774;15857.841421585781;16223.51329460118;16513.33946642133;16537.338506459728;16555.25501352439;16808.495745127635;17069.317227310894;17071.658566828657;17073.951125864915;17081.060541670202;3066.75465962723;3070.6468756093;3109.6423911250267;3115.704008119225;3117.06488053583;3014.2464383904025;3031.6362036555533;3040.5135178371465;3048.6189226346705;3057.250973511482;2913.4027524357457;2922.0941508132546;2968.9257768555744;2975.1372102090477;2983.4033193361306;2877.683454819989;2896.145637037058;2915.9125226243245;2926.1221633509863;2933.383989362247;2721.2516557946524;2735.9179224623294;2736.1244401791437;2738.602902579135;2747.107190163205;15637.452689155825;15968.361265549363;16040.35838566456;16046.1174635395;16047.277872495766;8617.741467755977;8969.955150224272;8974.551272436353;8976.237019853255;8979.551022448917;5739.426057394269;5809.128630705386;5864.442877926633;6014.158017877457;6016.548758843061;1949.3567122849568;2018.6467368210504;2020.444377796103;2046.8157865792002;2054.7226124473154;28651.856740716372;28774.568381474295;28961.855190723913;29003.12990610264;29021.709782902322;7270.309320614533;7451.3293803557945;7462.96268518654;7560.546367217875;7609.277118673717;19432;19437.708434373497;19468.805311946984;19477.707834382494;19484.220631174878;8542.701005464778;8587.871181932276;8604.268637165911;8674;8676.91323086761;6894.896576551356;7070.71717131309;7369;8447.704330348408;8473.915260847312;5901.760630267606;6096.908546371808;6120.938790612036;6132.202813634288;6139.079138129227;1621.6837716645377;1647.0694057857272;1665.7418100194488;1672.4480921295942;1685.4943516944868;987.2250283527396;1012.3217444312328;1019.3730855523947;1024.257413375312;1032.607609108534;8508.149185081566;8691.261242794308;8698.434601750865;8717;8789.956050219836;725.8548290341953;733.4755649710482;741.4661443760484;752.5371896283746;753.8190834199862;5254.448282930237;5340.759665815048;5629.746661400247;5941.673207973517;5965.9629685082255;22844.885775571016;22875;23507.294781156594;24007.399815004414;24075.638865417033;23170.304890853302;23330.300090997298;23357.2992810216;23462.061517539107;23587.702676352965;12426.502939882484;12527.43626536808;12755.234685918875;12876.227426354637;12880.80678789819;9148.359614827164;9434.528273586431;9553.379030363005;9588.232941364813;9642.276829237975;20310.492237694176;20503.17987280552;21149;21257.68113478268;21263.468413289793;20831;21117.788822111583;21251.893740531817;21399.67900481463;21448.14207431748;13580.388882500509;13821;13821.930890345484;13917.512887048904;13925.512607058705;15241.923790380977;15485.458008969632;15485.612859678598;15491.922540387226;15515.301811418287;11734.29594224315;11988.280703157838;12017.459214335551;12030.518779248732;12290.508379664714;11921.701957451132;12005.39973001364;12086.758264834478;12157.452914618687;12157.939210303892;10549.630762923261;10888.836667450152;10907.127429805756;10938.398388088732;10968.890311096788;8256.463329883538;8329.37529685288;8341.290990265896;8610.182032706884;8700.825983480168;8650.956745216234;8752.956235218782;8753;8755.649774009224;8888.333374996771 09:28:29 INFO - PID 5703 | |4;prototype.html;529.1427886823346;538.625655169657;553.1166378481267;558.6089737183971;562.5471495446167;6120.785772497963;6127.969360153199;6214.285357183925;6235.688215589219;6239.594426362283;6010.188624535686;6019.578629495937;6061.45446909778;6084.604500707451;6133.877322453548;4773.6897101688455;4832.420109586837;4841.709497430148;4852.611791056707;4897.485763994782;4769.5468930451725;4794.688345257565;4828.71027738335;4830.372051633282;4836.443808961979;4753.382060332152;4797.304390863323;4798.328234047236;4864.927026094611;4872.561469467747;4765.737884416356;4770.379850619397;4783.736894470802;4809.855704328858;4875.07373599015;4303.784810759481;4359.651227901761;4378.190034843532;4435.203742484299;4451.844185453526;6043.697815109271;6072.453479186895;6083.543734219951;6150.292716337589;6169.167162433104;5761;5821.62159459638;5843.590948633598;5867.207926929853;5877.970610146965;6557.573757705782;6609.438197753197;6621.5304669348;6624.403803657646;6628.602283862983;4978.515039472348;5000.1249781288125;5015.974920125376;5028.4971502849785;5073.923891141636;6847.1783385994;6932.584044957319;6934.237233904267;7013;7054.435645148375;5143.174173168546;5168.328117344721;5175.689458632494;5177.8446646599905;5178.766955487012;5248.448912864171;5254.395744489356;5255.240998475831;5264.815101732815;5278.788848446019;5747.166660834156;5787.71061446926;5789.536837053026;5799.797007104731;5828.6502809831545;6557.475401967927;6558.278589355167;6558.917778566483;6567.605943643397;6589.835254118685;1747.519432156167;1778.1198306838198;1780.4302623160722;1802.4769070135715;1810.5021119192327;1265.6519457149357;1276.144982861485;1277.2400421749044;1277.9297138657278;1287.414226526928;6162.938370616326;6217.29024518252;6273.215848018997;6294.9685251574365;6368.617882926947;6622.8344291393105;6664.8000559983275;6704.296048914891;6771.221309549366;6786.898196527056;6233.937660623426;6350.7459701611415;6373.558278529635;6375.330590288046;6467.805965821033;3522.1898963238086;3559.6974257187912;3579.4093974493917;3593.7304702147444;3594.928101438009;6929.3070692931315;6959.7124531960735;7052.964735176394;7087.291270872975;7113.857722845514;6855.794326170123;6891.310868913169;6915.377616014583;6919.962005699185;6965.164180298295;6881.41507971828;6883.242843287235;6970.651467426608;7039.964800175966;7096.587160365604;6685.732570697118;6744.156980377453;6776.6950487227205;6786.830329241611;6802.3537763912345;6590.70341834609;6651.636414534912;6698.196216454056;6724.697388617622;6763.188417389944;7091.716331346688;7097.467689923174;7120.750773722895;7136.607486588287;7137.357637812622;5183.377994640668;5194.3247377840635;5223.686578805284;5224.138017227115;5258.1849813279005;6600.8349791255605;6700.698468569024;6797.5581587196675;6804.55770374924;6892.793216203522;6468;6473.741050358121;6602.537822352581;6634.237062737654;6675.165604299463;6505.8698826024165;6522.21733391977;6563.967180164069;6574.27682954865;6590.462671871268;6385.7126429309865;6470.870582588416;6516.185476815398;6553.901691474536;6635.8009259722285;6597.934020659732;6624.205095388585;6632.701528431136;6662.167229096363;6724.529282950147;6356.4279214870885;6448.193975753031;6463.64449955257;6504.934950650433;6509.251436084911 09:28:29 INFO - PID 5703 | |5;yui.html;969.1229437359189;975.3513913247689;986.1322036607784;986.8963758805321;1003.9849402258967;18364.44906652801;19577;20035.499112522157;20050.99999999998;22844.314670559866;21750;21840.890795546038;22050.779492205074;22097.779022209772;22123.778762212372;1060.7401186709267;1075.5213929801241;1077.962271320504;1078.8166011777978;1080.3517889266457;1042.7862288230895;1079.7246702090956;1093.7429704019548;1095.6986828622114;1102.0247081333039;1159.0264178090401;1161.2742036227357;1162.0877611075307;1162.3548930343657;1163.1741463560882;1129.9661010169707;1142.063507923503;1145.1354227558224;1145.3643228008452;1146.6101525481336;835.173178553234;845.5222799118478;846.9364797640202;846.9534175620338;847.0555330806168;20416.672916260395;20593.8970305149;20771.58456830855;20788.5842283155;20814;21234.256801012045;21461.892690536602;21859.890700546555;21940;22107.557848843095;17101.74347384778;17307.740383894252;17403.216855241546;17431.12844357777;17551.122443877754;3762.811859407046;3781.3760729479604;3783.2622638585485;3784.9432258516144;3787.16682329887;148215.25892370468;148877;149168.2541587296;149478;149657;14492.855071449361;14608.415663373558;15101.169435680924;15165;15166.848331516765;30887.073387798402;31581.210469738442;31611;31675.20811979719;31834;9055.547222638841;9215.354925155174;9219.078092190728;9219.354645174773;9224.446533208029;4448.4439445069365;4510.075434535912;4511.548845115528;4512.503624601291;4526.637868970474;5615.943840561624;5982.521398288127;6094.421030002142;6114.2357205349335;6119.663418512025;1174.7121955120879;1206.9818952715716;1210.5520957245699;1215.1251099208555;1234.1422711215619;738.9150247721474;756.6330329790047;770.3028758973138;772.3705180278167;778.9376849851998;13024.54414095502;13299.601011969657;13618.387172577257;13748;13793.24137172445;748.3863232149585;752.7816933089342;756.8032311599023;760.1334478694293;760.3612965109335;6177.320494745574;6389.9680501597195;6394.104825324458;6510.934890651128;6873.15016891396;127429;129363;130962.34518827345;131224.3438782819;131378.34310828385;114596.42701786605;118374;118992;119572;120436;100447;101504;105322.47338763103;106287.4685626567;106807.34888224483;13549.458021679022;13765.793513097111;13966.79049814274;14008.159510429407;14040.578782636538;46551.53448465472;46668.53331466778;46679.766601166775;46909.29636055393;46993.2951005742;61597.753346081874;61832.69083654553;61835.38164618476;62067.689661551405;62280;19939;19979;20024.49938751543;20232;20243.493912652302;22352.77647223507;22640.094396223965;22671;22696.432589185402;22785;20863;21252.681209781556;21308.893455532623;21417.57164856663;21478.463038424165;20903.059362328426;21060.684089738974;21167.047482863618;21300;21304.254351097636;20583.69124463104;20703;20926.058327375;20992.160313587287;20993;15322.846771532142;15619.297131629331;15650.13924234178;15711.921440392725;15819.209039548206;13935.425829668215;14254.717075463259;15455.381784728484;15711.842881571038;16201.270942807838 09:28:29 INFO - PID 5703 | __end_tp_report 09:28:29 INFO - PID 5703 | __start_cc_report 09:28:29 INFO - PID 5703 | _x_x_mozilla_cycle_collect,289 09:28:29 INFO - PID 5703 | __end_cc_report 09:28:29 INFO - PID 5703 | __startTimestamp1503851309805__endTimestamp 09:28:29 INFO - PID 5703 | 09:28:29 INFO - PID 5703 | ------- Summary: start ------- 09:28:29 INFO - PID 5703 | Number of tests: 6 09:28:29 INFO - PID 5703 | 09:28:29 INFO - PID 5703 | [#0] dojo.html Cycles:165 Average:6428.30 Median:6749.46 stddev:821.52 (12.2%) stddev-sans-first:793.88 09:28:29 INFO - PID 5703 | Values: 3617.1 3623.0 3624.3 3635.4 3695.8 6419.0 6419.8 6434.8 6513.2 6518.0 6464.6 6486.7 6498.6 6556.0 6597.8 5507.2 5587.6 5611.7 5630.8 5682.3 5666.9 5691.9 5715.8 5743.1 5750.0 5618.9 5684.3 5689.1 5748.5 5780.9 5516.4 5600.1 5618.8 5649.8 5679.0 5529.1 5589.2 5597.3 5598.2 5605.3 6296.2 6318.4 6336.5 6361.2 6390.6 6755.8 6877.8 6927.1 7012.8 7033.4 7108.5 7126.2 7144.2 7160.5 7160.7 6320.3 6523.2 6531.4 6531.9 6598.6 7019.5 7184.5 7192.0 7249.3 7287.4 6899.8 6941.7 6956.3 6973.9 6985.0 6969.0 6975.8 7013.3 7036.6 7046.6 6949.6 6966.2 6989.7 7025.4 7032.1 6908.4 6923.3 7001.2 7008.3 7028.8 5044.6 5140.9 5158.9 5171.0 5176.8 4525.8 4568.3 4581.0 4607.1 4642.0 6672.9 6710.3 6716.5 6749.5 6754.6 7009.3 7012.9 7021.5 7083.2 7097.6 6507.8 6657.2 6677.5 6754.3 6756.2 5855.7 5908.4 5927.6 5947.7 5951.7 7199.9 7248.3 7249.1 7258.8 7261.9 6895.3 6985.6 6997.0 7073.2 7073.4 7060.2 7137.4 7140.7 7145.7 7287.7 6829.9 6914.7 6952.5 6965.5 6998.2 6922.7 6982.5 6986.8 7066.0 7118.6 6732.3 6740.3 6751.0 6753.1 6760.5 6700.6 6706.3 6709.3 6720.2 6728.5 6798.5 6805.7 6811.2 6825.3 6832.7 6810.5 6893.7 6935.5 6951.8 6991.9 6491.7 6653.6 6656.3 6737.9 6756.2 09:28:29 INFO - PID 5703 | 09:28:29 INFO - PID 5703 | [#1] ext.html Cycles:180 Average:43312.10 Median:39653.50 stddev:65231.26 (164.5%) stddev-sans-first:65336.40 09:28:29 INFO - PID 5703 | Values: 870.2 915.4 946.3 953.5 978.9 43076.1 43836.0 43858.3 43871.6 43887.3 41352.4 41354.2 41455.8 41621.4 41674.8 7090.5 7119.4 7145.0 7158.3 7164.1 6995.3 7061.4 7061.8 7083.3 7087.9 7703.2 7791.0 7841.5 7844.8 7846.8 7800.3 7841.0 7846.6 7853.8 7856.3 7796.1 7875.5 7875.6 7877.5 7877.8 40838.4 41141.4 41260.4 41313.4 41379.0 3713.6 3723.5 3752.6 3753.9 3753.9 32468.7 32484.7 32520.7 32603.3 32639.7 5083.6 5163.8 5188.8 5204.6 5224.9 209543.0 216240.0 217158.0 218205.0 228232.0 52051.2 52070.7 52091.2 52118.7 52131.7 54730.5 55170.2 55197.0 55217.7 55260.7 18019.4 18083.3 18139.4 18151.5 18288.5 15066.9 15131.8 15252.2 15260.7 15267.8 14979.3 15096.5 15170.5 15437.2 15552.4 5740.3 5854.5 5933.6 6013.5 6101.3 1093.9 1100.6 1127.8 1141.0 1144.6 25535.0 25535.4 25622.0 25718.6 25788.7 1218.9 1242.1 1243.0 1245.6 1247.3 13370.9 13586.5 13590.4 13642.2 13815.7 297690.0 298923.0 300491.0 300621.0 301583.0 57589.1 57792.4 57830.0 57982.7 57988.4 1554.6 1561.6 1598.2 1606.5 1616.8 25157.5 25367.6 25643.7 25734.2 25784.7 42005.2 42050.6 42101.0 42129.8 42145.6 223300.0 224387.0 227086.0 227749.0 227828.0 36542.8 41944.8 42227.2 42336.6 42643.4 50805.0 51759.2 51868.5 51928.5 52418.2 37802.2 38054.8 38278.8 38305.2 38468.6 38005.2 38011.8 38030.0 38060.4 38089.0 43235.0 44588.3 44803.0 44884.3 45488.0 36789.8 36933.8 37097.8 37610.0 37752.2 26792.7 27622.4 27781.2 27944.0 28048.3 09:28:29 INFO - PID 5703 | 09:28:29 INFO - PID 5703 | [#2] jquery.html Cycles:180 Average:43787.29 Median:23572.44 stddev:113313.41 (480.7%) stddev-sans-first:113584.83 09:28:29 INFO - PID 5703 | Values: 574.8 591.2 594.1 602.9 620.7 23735.2 24317.4 24501.3 24501.6 24503.6 23407.9 23477.0 25950.2 28493.4 28519.3 6441.5 6618.3 6619.2 6622.3 6623.8 6097.1 6656.0 6674.2 6691.2 6730.8 6292.2 6326.0 6331.2 6355.8 6357.9 6328.9 6329.5 6334.0 6337.2 6342.0 5923.5 5932.2 5935.3 5942.3 5942.4 30670.1 31647.4 31962.7 32443.0 32583.0 2253.8 2325.7 2332.0 2332.7 2333.0 20228.5 20644.9 20734.0 20756.3 20792.7 2415.8 2419.4 2457.2 2466.6 2487.8 140835.0 150542.2 151531.0 161196.0 161405.2 15565.8 16241.5 16536.8 16696.3 16906.0 25147.9 25232.9 25252.0 25268.0 25335.4 11434.0 11552.6 11595.7 11774.8 11966.5 10917.7 10974.9 11049.7 11067.6 11126.7 9923.0 10003.6 10045.9 10120.3 10266.8 2865.1 2866.8 2894.1 2914.4 2921.5 1080.4 1081.8 1096.3 1104.7 1108.9 21560.6 21935.9 22059.7 22076.2 22258.6 1143.5 1151.8 1156.8 1157.4 1165.8 12097.5 12237.4 12425.6 12461.9 12512.7 599671.0 666157.0 681472.0 715412.0 721859.0 146665.0 149994.0 151276.0 155910.0 161117.0 1327.1 1367.9 1405.0 1412.0 1415.9 24164.4 24594.8 24612.9 24877.8 25099.2 66128.7 67921.7 68520.0 69563.0 73784.6 88400.6 88499.0 88884.0 88976.0 89695.1 22294.3 22503.4 23606.7 23856.3 24134.6 26041.2 26102.0 26148.5 26167.3 26340.2 20558.7 20717.2 20767.5 21120.3 21140.7 18579.3 18837.2 18864.2 18924.0 19013.3 21708.6 21873.7 21932.8 22093.4 22172.1 22743.2 23335.2 23570.0 23574.9 23591.3 20630.1 21012.0 21062.3 21065.5 21137.7 09:28:29 INFO - PID 5703 | 09:28:29 INFO - PID 5703 | [#3] mootools.html Cycles:180 Average:10297.53 Median:2736.02 stddev:7338.71 (268.2%) stddev-sans-first:7329.02 09:28:29 INFO - PID 5703 | Values: 1425.1 1452.6 1479.0 1492.9 1493.9 15857.8 16223.5 16513.3 16537.3 16555.3 16808.5 17069.3 17071.7 17074.0 17081.1 3066.8 3070.6 3109.6 3115.7 3117.1 3014.2 3031.6 3040.5 3048.6 3057.3 2913.4 2922.1 2968.9 2975.1 2983.4 2877.7 2896.1 2915.9 2926.1 2933.4 2721.3 2735.9 2736.1 2738.6 2747.1 15637.5 15968.4 16040.4 16046.1 16047.3 8617.7 8970.0 8974.6 8976.2 8979.6 5739.4 5809.1 5864.4 6014.2 6016.5 1949.4 2018.6 2020.4 2046.8 2054.7 28651.9 28774.6 28961.9 29003.1 29021.7 7270.3 7451.3 7463.0 7560.5 7609.3 19432.0 19437.7 19468.8 19477.7 19484.2 8542.7 8587.9 8604.3 8674.0 8676.9 6894.9 7070.7 7369.0 8447.7 8473.9 5901.8 6096.9 6120.9 6132.2 6139.1 1621.7 1647.1 1665.7 1672.4 1685.5 987.2 1012.3 1019.4 1024.3 1032.6 8508.1 8691.3 8698.4 8717.0 8790.0 725.9 733.5 741.5 752.5 753.8 5254.4 5340.8 5629.7 5941.7 5966.0 22844.9 22875.0 23507.3 24007.4 24075.6 23170.3 23330.3 23357.3 23462.1 23587.7 12426.5 12527.4 12755.2 12876.2 12880.8 9148.4 9434.5 9553.4 9588.2 9642.3 20310.5 20503.2 21149.0 21257.7 21263.5 20831.0 21117.8 21251.9 21399.7 21448.1 13580.4 13821.0 13821.9 13917.5 13925.5 15241.9 15485.5 15485.6 15491.9 15515.3 11734.3 11988.3 12017.5 12030.5 12290.5 11921.7 12005.4 12086.8 12157.5 12157.9 10549.6 10888.8 10907.1 10938.4 10968.9 8256.5 8329.4 8341.3 8610.2 8700.8 8651.0 8753.0 8753.0 8755.6 8888.3 09:28:29 INFO - PID 5703 | 09:28:29 INFO - PID 5703 | [#4] prototype.html Cycles:180 Average:5608.77 Median:6234.81 stddev:1593.98 (25.6%) stddev-sans-first:1552.18 09:28:29 INFO - PID 5703 | Values: 529.1 538.6 553.1 558.6 562.5 6120.8 6128.0 6214.3 6235.7 6239.6 6010.2 6019.6 6061.5 6084.6 6133.9 4773.7 4832.4 4841.7 4852.6 4897.5 4769.5 4794.7 4828.7 4830.4 4836.4 4753.4 4797.3 4798.3 4864.9 4872.6 4765.7 4770.4 4783.7 4809.9 4875.1 4303.8 4359.7 4378.2 4435.2 4451.8 6043.7 6072.5 6083.5 6150.3 6169.2 5761.0 5821.6 5843.6 5867.2 5878.0 6557.6 6609.4 6621.5 6624.4 6628.6 4978.5 5000.1 5016.0 5028.5 5073.9 6847.2 6932.6 6934.2 7013.0 7054.4 5143.2 5168.3 5175.7 5177.8 5178.8 5248.4 5254.4 5255.2 5264.8 5278.8 5747.2 5787.7 5789.5 5799.8 5828.7 6557.5 6558.3 6558.9 6567.6 6589.8 1747.5 1778.1 1780.4 1802.5 1810.5 1265.7 1276.1 1277.2 1277.9 1287.4 6162.9 6217.3 6273.2 6295.0 6368.6 6622.8 6664.8 6704.3 6771.2 6786.9 6233.9 6350.7 6373.6 6375.3 6467.8 3522.2 3559.7 3579.4 3593.7 3594.9 6929.3 6959.7 7053.0 7087.3 7113.9 6855.8 6891.3 6915.4 6920.0 6965.2 6881.4 6883.2 6970.7 7040.0 7096.6 6685.7 6744.2 6776.7 6786.8 6802.4 6590.7 6651.6 6698.2 6724.7 6763.2 7091.7 7097.5 7120.8 7136.6 7137.4 5183.4 5194.3 5223.7 5224.1 5258.2 6600.8 6700.7 6797.6 6804.6 6892.8 6468.0 6473.7 6602.5 6634.2 6675.2 6505.9 6522.2 6564.0 6574.3 6590.5 6385.7 6470.9 6516.2 6553.9 6635.8 6597.9 6624.2 6632.7 6662.2 6724.5 6356.4 6448.2 6463.6 6504.9 6509.3 09:28:29 INFO - PID 5703 | 09:28:29 INFO - PID 5703 | [#5] yui.html Cycles:180 Average:26712.01 Median:20801.29 stddev:37725.29 (181.4%) stddev-sans-first:37781.60 09:28:29 INFO - PID 5703 | Values: 969.1 975.4 986.1 986.9 1004.0 18364.4 19577.0 20035.5 20051.0 22844.3 21750.0 21840.9 22050.8 22097.8 22123.8 1060.7 1075.5 1078.0 1078.8 1080.4 1042.8 1079.7 1093.7 1095.7 1102.0 1159.0 1161.3 1162.1 1162.4 1163.2 1130.0 1142.1 1145.1 1145.4 1146.6 835.2 845.5 846.9 847.0 847.1 20416.7 20593.9 20771.6 20788.6 20814.0 21234.3 21461.9 21859.9 21940.0 22107.6 17101.7 17307.7 17403.2 17431.1 17551.1 3762.8 3781.4 3783.3 3784.9 3787.2 148215.3 148877.0 149168.3 149478.0 149657.0 14492.9 14608.4 15101.2 15165.0 15166.8 30887.1 31581.2 31611.0 31675.2 31834.0 9055.5 9215.4 9219.1 9219.4 9224.4 4448.4 4510.1 4511.5 4512.5 4526.6 5615.9 5982.5 6094.4 6114.2 6119.7 1174.7 1207.0 1210.6 1215.1 1234.1 738.9 756.6 770.3 772.4 778.9 13024.5 13299.6 13618.4 13748.0 13793.2 748.4 752.8 756.8 760.1 760.4 6177.3 6390.0 6394.1 6510.9 6873.2 127429.0 129363.0 130962.3 131224.3 131378.3 114596.4 118374.0 118992.0 119572.0 120436.0 100447.0 101504.0 105322.5 106287.5 106807.3 13549.5 13765.8 13966.8 14008.2 14040.6 46551.5 46668.5 46679.8 46909.3 46993.3 61597.8 61832.7 61835.4 62067.7 62280.0 19939.0 19979.0 20024.5 20232.0 20243.5 22352.8 22640.1 22671.0 22696.4 22785.0 20863.0 21252.7 21308.9 21417.6 21478.5 20903.1 21060.7 21167.0 21300.0 21304.3 20583.7 20703.0 20926.1 20992.2 20993.0 15322.8 15619.3 15650.1 15711.9 15819.2 13935.4 14254.7 15455.4 15711.8 16201.3 09:28:29 INFO - PID 5703 | -------- Summary: end -------- 09:28:29 INFO - PID 5703 | 09:28:30 INFO - TEST-INFO | 5703: exit 0 09:28:30 INFO - TEST-OK | dromaeo_css | took 1108595ms 09:28:30 INFO - TEST-START | kraken 09:28:30 INFO - Initialising browser for kraken test... 09:28:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33939/getInfo.html -profile /tmp/tmpgvELXq/profile 09:28:30 INFO - TEST-INFO | started process 6064 (/builds/slave/test/build/application/firefox/firefox http://localhost:33939/getInfo.html) 09:28:35 INFO - TEST-INFO | 6064: exit 0 09:28:35 INFO - Browser initialized. 09:28:35 INFO - Running cycle 1/1 for kraken test... 09:28:35 INFO - TEST-INFO | started process 6228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgvELXq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:28:36 INFO - PID 6228 | 1503851316109 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 09:28:47 INFO - PID 6228 | RSS: Main: 151994368 09:28:47 INFO - PID 6228 | 09:28:49 INFO - PID 6228 | Cycle 1(1): loaded http://localhost:33939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33939/tests/kraken/driver.html?testName=audio-beat-detection) 09:28:50 INFO - PID 6228 | RSS: Main: 158752768 09:28:50 INFO - PID 6228 | 09:28:52 INFO - PID 6228 | Cycle 1(1): loaded http://localhost:33939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33939/tests/kraken/driver.html?testName=audio-dft) 09:28:53 INFO - PID 6228 | RSS: Main: 159330304 09:28:53 INFO - PID 6228 | 09:28:56 INFO - PID 6228 | Cycle 1(1): loaded http://localhost:33939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33939/tests/kraken/driver.html?testName=audio-fft) 09:28:57 INFO - PID 6228 | RSS: Main: 159371264 09:28:57 INFO - PID 6228 | 09:28:59 INFO - PID 6228 | Cycle 1(1): loaded http://localhost:33939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33939/tests/kraken/driver.html?testName=audio-oscillator) 09:28:59 INFO - PID 6228 | RSS: Main: 159670272 09:28:59 INFO - PID 6228 | 09:29:01 INFO - PID 6228 | Cycle 1(1): loaded http://localhost:33939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:29:02 INFO - PID 6228 | RSS: Main: 159264768 09:29:02 INFO - PID 6228 | 09:29:05 INFO - PID 6228 | Cycle 1(1): loaded http://localhost:33939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33939/tests/kraken/driver.html?testName=imaging-darkroom) 09:29:06 INFO - PID 6228 | RSS: Main: 159326208 09:29:06 INFO - PID 6228 | 09:29:09 INFO - PID 6228 | Cycle 1(1): loaded http://localhost:33939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33939/tests/kraken/driver.html?testName=imaging-desaturate) 09:29:09 INFO - PID 6228 | RSS: Main: 161894400 09:29:09 INFO - PID 6228 | 09:29:12 INFO - PID 6228 | Cycle 1(1): loaded http://localhost:33939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33939/tests/kraken/driver.html?testName=json-parse-financial) 09:29:13 INFO - PID 6228 | RSS: Main: 162443264 09:29:13 INFO - PID 6228 | 09:29:14 INFO - PID 6228 | Cycle 1(1): loaded http://localhost:33939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:29:15 INFO - PID 6228 | RSS: Main: 162344960 09:29:15 INFO - PID 6228 | 09:29:17 INFO - PID 6228 | Cycle 1(1): loaded http://localhost:33939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33939/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:29:17 INFO - PID 6228 | RSS: Main: 162369536 09:29:17 INFO - PID 6228 | 09:29:19 INFO - PID 6228 | Cycle 1(1): loaded http://localhost:33939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:29:20 INFO - PID 6228 | RSS: Main: 162668544 09:29:20 INFO - PID 6228 | 09:29:22 INFO - PID 6228 | Cycle 1(1): loaded http://localhost:33939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:29:23 INFO - PID 6228 | RSS: Main: 162549760 09:29:23 INFO - PID 6228 | 09:29:26 INFO - PID 6228 | Cycle 1(1): loaded http://localhost:33939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:29:27 INFO - PID 6228 | RSS: Main: 163053568 09:29:27 INFO - PID 6228 | 09:29:28 INFO - PID 6228 | Cycle 1(1): loaded http://localhost:33939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33939/tests/kraken/driver.html?testName=ai-astar) 09:29:29 INFO - PID 6228 | RSS: Main: 164397056 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | __start_tp_report 09:29:29 INFO - PID 6228 | _x_x_mozilla_page_load 09:29:29 INFO - PID 6228 | _x_x_mozilla_page_load_details 09:29:29 INFO - PID 6228 | |i|pagename|runs| 09:29:29 INFO - PID 6228 | |0;ai-astar;95;106;100;105;105;107;107;97;106;107 09:29:29 INFO - PID 6228 | |1;audio-beat-detection;140;112;155;167;114;144;155;112;184;113 09:29:29 INFO - PID 6228 | |2;audio-dft;162;163;161;160;162;161;161;162;161;163 09:29:29 INFO - PID 6228 | |3;audio-fft;74;74;75;184;75;73;76;73;153;75 09:29:29 INFO - PID 6228 | |4;audio-oscillator;77;77;126;78;78;78;124;77;78;123 09:29:29 INFO - PID 6228 | |5;imaging-gaussian-blur;114;114;115;114;114;113;114;113;114;113 09:29:29 INFO - PID 6228 | |6;imaging-darkroom;146;147;147;148;149;148;147;148;146;147 09:29:29 INFO - PID 6228 | |7;imaging-desaturate;94;94;94;94;93;93;94;94;94;95 09:29:29 INFO - PID 6228 | |8;json-parse-financial;49;47;46;47;47;46;49;47;46;45 09:29:29 INFO - PID 6228 | |9;json-stringify-tinderbox;53;53;53;53;53;53;54;53;53;53 09:29:29 INFO - PID 6228 | |10;stanford-crypto-aes;72;73;81;72;73;73;73;75;75;72 09:29:29 INFO - PID 6228 | |11;stanford-crypto-ccm;120;116;128;114;124;120;116;112;112;143 09:29:29 INFO - PID 6228 | |12;stanford-crypto-pbkdf2;170;160;158;159;165;163;165;165;159;159 09:29:29 INFO - PID 6228 | |13;stanford-crypto-sha256-iterative;61;58;66;59;58;60;58;60;69;59 09:29:29 INFO - PID 6228 | __end_tp_report 09:29:29 INFO - PID 6228 | __start_cc_report 09:29:29 INFO - PID 6228 | _x_x_mozilla_cycle_collect,831 09:29:29 INFO - PID 6228 | __end_cc_report 09:29:29 INFO - PID 6228 | __startTimestamp1503851369030__endTimestamp 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | ------- Summary: start ------- 09:29:29 INFO - PID 6228 | Number of tests: 14 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | [#0] ai-astar Cycles:10 Average:103.50 Median:107.00 stddev:4.48 (4.2%) stddev-sans-first:3.54 09:29:29 INFO - PID 6228 | Values: 95.0 106.0 100.0 105.0 105.0 107.0 107.0 97.0 106.0 107.0 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:149.50 stddev:26.04 (17.4%) stddev-sans-first:27.62 09:29:29 INFO - PID 6228 | Values: 140.0 112.0 155.0 167.0 114.0 144.0 155.0 112.0 184.0 113.0 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 09:29:29 INFO - PID 6228 | Values: 162.0 163.0 161.0 160.0 162.0 161.0 161.0 162.0 161.0 163.0 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | [#3] audio-fft Cycles:10 Average:93.20 Median:74.50 stddev:40.36 (54.2%) stddev-sans-first:42.21 09:29:29 INFO - PID 6228 | Values: 74.0 74.0 75.0 184.0 75.0 73.0 76.0 73.0 153.0 75.0 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:77.50 stddev:22.60 (29.2%) stddev-sans-first:23.35 09:29:29 INFO - PID 6228 | Values: 77.0 77.0 126.0 78.0 78.0 78.0 124.0 77.0 78.0 123.0 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 09:29:29 INFO - PID 6228 | Values: 114.0 114.0 115.0 114.0 114.0 113.0 114.0 113.0 114.0 113.0 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 09:29:29 INFO - PID 6228 | Values: 146.0 147.0 147.0 148.0 149.0 148.0 147.0 148.0 146.0 147.0 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:29:29 INFO - PID 6228 | Values: 94.0 94.0 94.0 94.0 93.0 93.0 94.0 94.0 94.0 95.0 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | [#8] json-parse-financial Cycles:10 Average:46.90 Median:47.00 stddev:1.29 (2.7%) stddev-sans-first:1.12 09:29:29 INFO - PID 6228 | Values: 49.0 47.0 46.0 47.0 47.0 46.0 49.0 47.0 46.0 45.0 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | [#9] json-stringify-tinderbox Cycles:10 Average:53.10 Median:53.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 09:29:29 INFO - PID 6228 | Values: 53.0 53.0 53.0 53.0 53.0 53.0 54.0 53.0 53.0 53.0 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:73.00 stddev:2.73 (3.7%) stddev-sans-first:2.80 09:29:29 INFO - PID 6228 | Values: 72.0 73.0 81.0 72.0 73.0 73.0 73.0 75.0 75.0 72.0 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:120.00 stddev:9.44 (7.9%) stddev-sans-first:10.01 09:29:29 INFO - PID 6228 | Values: 120.0 116.0 128.0 114.0 124.0 120.0 116.0 112.0 112.0 143.0 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:164.00 stddev:3.92 (2.4%) stddev-sans-first:3.00 09:29:29 INFO - PID 6228 | Values: 170.0 160.0 158.0 159.0 165.0 163.0 165.0 165.0 159.0 159.0 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.80 Median:60.00 stddev:3.74 (6.2%) stddev-sans-first:3.96 09:29:29 INFO - PID 6228 | Values: 61.0 58.0 66.0 59.0 58.0 60.0 58.0 60.0 69.0 59.0 09:29:29 INFO - PID 6228 | -------- Summary: end -------- 09:29:29 INFO - PID 6228 | 09:29:29 INFO - PID 6228 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:29:29 INFO - TEST-INFO | 6228: exit 0 09:29:29 INFO - TEST-OK | kraken | took 59187ms 09:29:29 INFO - SUITE-END | took 1167s 09:29:30 INFO - Completed test suite (00:19:28) 09:29:30 INFO - javascript benchmark 09:29:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9220.111095264247, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3617.113807117255, 3622.981885090574, 3624.3294990426775, 3635.381985062539, 3695.8336874840647, 6418.9679051604735, 6419.807405777822, 6434.806955791322, 6513.218413790346, 6518.0, 6464.612123272607, 6486.675666216694, 6498.577592456487, 6556.0, 6597.769078082268, 5507.201455788908, 5587.636803607753, 5611.719414029302, 5630.802921897734, 5682.289713785777, 5666.858328541799, 5691.857703557403, 5715.828525144252, 5743.13852922063, 5749.971250143743, 5618.887622247532, 5684.346300175492, 5689.118186681071, 5748.45389687979, 5780.942190578083, 5516.448355164452, 5600.0759874620635, 5618.775248990036, 5649.830505084854, 5679.0, 5529.060059789846, 5589.189567512688, 5597.328320601513, 5598.216249725042, 5605.327360716699, 6296.240975852626, 6318.368163183691, 6336.524760642924, 6361.236651601837, 6390.616563006234, 6755.7973260802255, 6877.759278425231, 6927.099477067949, 7012.7545535906, 7033.437325013987, 7108.537945033556, 7126.2161162272105, 7144.214136444987, 7160.462965277573, 7160.749373771945, 6320.336364681734, 6523.151990241286, 6531.444827189647, 6531.93468065318, 6598.571092878948, 7019.543729657556, 7184.533005354635, 7192.0, 7249.275072492708, 7287.380572651278, 6899.827504312432, 6941.652917354213, 6956.269591692901, 6973.930260697328, 6985.0, 6968.965155174293, 6975.79072627822, 7013.298670133048, 7036.612986285803, 7046.577205367695, 6949.617771022642, 6966.1988871280455, 6989.650517474106, 7025.402840758593, 7032.08582884232, 6908.378245957788, 6923.273056329113, 7001.159860816734, 7008.299170083053, 7028.789136325919, 5044.621653376012, 5140.897182056338, 5158.92261616076, 5171.0, 5176.818811341585, 4525.796339164745, 4568.291914753218, 4581.0, 4607.124646317189, 4641.976790116096, 6672.86654266912, 6710.328967103348, 6716.496262780311, 6749.460043196631, 6754.6284954327, 7009.264027277164, 7012.894806577905, 7021.543599666005, 7083.220845706968, 7097.645117744092, 6507.804765857032, 6657.23441804189, 6677.53257271996, 6754.290799466084, 6756.223034351015, 5855.677937713466, 5908.379620139909, 5927.585069045125, 5947.702614869239, 5951.702414879239, 7199.856002879913, 7248.275172482815, 7249.130104387507, 7258.818529536804, 7261.8547629047125, 6895.34494223038, 6985.615791131537, 6996.965015174892, 7073.151221853411, 7073.3987611053635, 7060.188078371053, 7137.393321567725, 7140.6786694599905, 7145.678444469907, 7287.672054757655, 6829.863402732017, 6914.654267286515, 6952.478564107813, 6965.547239429421, 6998.230194678479, 6922.653867306715, 6982.511224214256, 6986.790396287916, 7065.964670176616, 7118.60847653384, 6732.3267673232285, 6740.325967403221, 6750.966245168743, 6753.088333074972, 6760.526763126534, 6700.631465269457, 6706.295838937037, 6709.295523969913, 6720.193576770819, 6728.461723062045, 6798.490113241428, 6805.727770889109, 6811.2167100784045, 6825.317468253135, 6832.692528836314, 6810.523263371715, 6893.655317234018, 6935.479839011993, 6951.826204344932, 6991.895121573282, 6491.675416229075, 6653.567518111307, 6656.334366563305, 6737.898931515933, 6756.155480564929], "value": 6366.23143447479, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [870.2476629479144, 915.3729695158817, 946.2950102173877, 953.4565297780264, 978.9265805064613, 43076.138477230474, 43836.0, 43858.342124868155, 43871.56128438715, 43887.341689874636, 41352.37971430431, 41354.172916541655, 41455.792721036356, 41621.375679364835, 41674.7916260419, 7090.50366474347, 7119.394851437634, 7144.964275178617, 7158.319959603829, 7164.104486939133, 6995.265497122805, 7061.435085193198, 7061.788146355618, 7083.291670832901, 7087.9291207088045, 7703.229677032308, 7791.0, 7841.451098423113, 7844.764657060297, 7846.843063138734, 7800.258975397356, 7840.960795196044, 7846.607669616496, 7853.842923141505, 7856.292933635943, 7796.103448103484, 7875.527468351917, 7875.566843823587, 7877.487963282369, 7877.7636670899965, 40838.38742418866, 41141.38287925684, 41260.38109428331, 41313.38029929553, 41379.0, 3713.628637136265, 3723.5345581802276, 3752.5872154063304, 3753.887383378503, 3753.924921501582, 32468.675313247037, 32484.70061197549, 32520.674793252, 32603.347933041205, 32639.673603263902, 5083.6441449098575, 5163.8192663256605, 5188.792448302063, 5204.635675502716, 5224.895502089975, 209543.0, 216240.0, 217158.0, 218205.0, 228231.99999999834, 52051.219231711555, 52070.73964630228, 52091.218631720556, 52118.739406302724, 52131.73934130305, 54730.45269547333, 55170.17244741332, 55197.0, 55217.723911380184, 55260.72369638126, 18019.369322073664, 18083.27666893336, 18139.365122220657, 18151.546211344823, 18288.451346459362, 15066.924665376602, 15131.848681513044, 15252.161131137673, 15260.694786104215, 15267.770983435257, 14979.325930333162, 15096.54710358691, 15170.544883653509, 15437.15095669749, 15552.444755524582, 5740.264281967394, 5854.531637468992, 5933.614315069507, 6013.4888534474185, 6101.328853826076, 1093.8632670916136, 1100.6037826382496, 1127.7913585986619, 1140.988590114105, 1144.5822274869613, 25535.0, 25535.36161595975, 25622.0, 25718.6142207867, 25788.74211257901, 1218.9085818563642, 1242.0808601634906, 1242.9689257768628, 1245.64499117751, 1247.2641141726244, 13370.863476604403, 13586.456541738418, 13590.38843252056, 13642.2496762679, 13815.654608634664, 297690.0, 298923.0, 300491.0, 300621.0, 301583.0, 57589.13616295759, 57792.42207577955, 57830.0, 57982.7100864493, 57988.420115798304, 1554.595805090662, 1561.625209949604, 1598.1609654931021, 1606.5421354913794, 1616.7655689924895, 25157.496850063264, 25367.6194857081, 25643.743562564134, 25734.227973160836, 25784.742152578234, 42005.15989680251, 42050.57949420466, 42101.0, 42129.78935105305, 42145.578544214164, 223300.0, 224387.0, 227086.0, 227749.0, 227828.0, 36542.8172859134, 41944.79027604842, 42227.155456890076, 42336.576634233264, 42643.36034959416, 50805.0, 51759.22361164661, 51868.481315186364, 51928.48071519387, 52418.213726793365, 37802.243955121296, 38054.80972595119, 38278.808605956794, 38305.2338953225, 38468.6153138465, 38005.239895202496, 38011.80994095122, 38030.0, 38060.42909356306, 38089.0, 43235.0, 44588.33117503175, 44803.0, 44884.326735098344, 45488.0, 36789.81605091957, 36933.81533092317, 37097.814510927274, 37610.0, 37752.24495510129, 26792.720302688394, 27622.447551048466, 27781.16656500308, 27944.0, 28048.29879253035], "value": 18816.723444990846, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.7557288152534, 591.2107336705501, 594.1355327997763, 602.8944934636437, 620.7175735040557, 23735.169269075584, 24317.392065198357, 24501.264962051122, 24501.632475512837, 24503.63244551331, 23407.88296058517, 23477.0, 25950.221493355184, 28493.43013139741, 28519.287017824565, 6441.452476539488, 6618.3050779668165, 6619.238787539422, 6622.2715501294815, 6623.768168114117, 6097.146399504073, 6656.0, 6674.16572928384, 6691.197056353244, 6730.831729206784, 6292.244930608334, 6326.0, 6331.176946996884, 6355.8411039723915, 6357.904631430532, 6328.873422531569, 6329.493640508771, 6333.968330158343, 6337.176167098294, 6342.048692696087, 5923.526117910556, 5932.228810254683, 5935.347111817697, 5942.286925568917, 5942.3760505146765, 30670.079897602885, 31647.367052658818, 31962.680373196203, 32443.0, 32583.0, 2253.7971582557648, 2325.732540757818, 2332.0, 2332.6734257204007, 2333.0201315447553, 20228.49428764278, 20644.896775516176, 20734.0, 20756.273530426362, 20792.688109678365, 2415.758424157588, 2419.3830573203895, 2457.176845756656, 2466.5683505386664, 2487.825852190347, 140835.0, 150542.24728876285, 151531.0, 161196.0, 161405.19297403438, 15565.844341556665, 16241.457061579367, 16536.834631653528, 16696.332146714238, 16906.0, 25147.87426062858, 25232.873835630704, 25252.0, 25268.0, 25335.36661583475, 11434.0, 11552.595659152057, 11595.652130436101, 11774.764504709858, 11966.461509232106, 10917.672469825919, 10974.945125274322, 11049.723756906142, 11067.557297708001, 11126.666200014013, 9922.950385248028, 10003.599856005823, 10045.940582180636, 10120.342177758423, 10266.845997310047, 2865.126136528379, 2866.8423236721765, 2894.088362165911, 2914.373409716921, 2921.5008886315263, 1080.3895798873612, 1081.7674200047027, 1096.31480324797, 1104.7017305327518, 1108.944552772358, 21560.56878862414, 21935.890320548297, 22059.66910496344, 22076.2273320433, 22258.554828903332, 1143.451143451148, 1151.8329842172839, 1156.7570810129798, 1157.438642258504, 1165.825126231072, 12097.455614497369, 12237.449314780857, 12425.565105221274, 12461.875381246253, 12512.74974500523, 599671.0, 666157.0, 681472.0, 715412.0, 721859.0, 146665.0, 149994.0, 151276.0, 155910.0, 161117.0, 1327.1373607155233, 1367.8974076944469, 1405.0445696926188, 1412.0, 1415.9150450972768, 24164.39589010289, 24594.754052459248, 24612.876935615208, 24877.751222487543, 25099.247022589352, 66128.66935665291, 67921.66039169772, 68520.0, 69563.0, 73784.63107684428, 88400.5579972096, 88499.0, 88884.0, 88976.0, 89695.10304896868, 22294.331170064925, 22503.437414064778, 23606.70163140975, 23856.28431146999, 24134.637980429958, 26041.218763437126, 26101.955921762918, 26148.477030459664, 26167.345816354744, 26340.20979370622, 20558.691619625417, 20717.171313147304, 20767.480812979797, 21120.26079087286, 21140.682889756972, 18579.349722759638, 18837.24651013944, 18864.24543018264, 18924.0, 19013.33453329127, 21708.565828683655, 21873.671894921907, 21932.780672193076, 22093.44766380789, 22172.1131154752, 22743.203987860346, 23335.18326858552, 23570.0, 23574.88212558926, 23591.29226123219, 20630.071646776232, 21012.0, 21062.2628208012, 21065.473363166042, 21137.6829347563], "value": 13612.747100452885, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1425.1164278147548, 1452.6368407898026, 1478.9630259243525, 1492.940282388705, 1493.9103653780774, 15857.841421585781, 16223.51329460118, 16513.33946642133, 16537.338506459728, 16555.25501352439, 16808.495745127635, 17069.317227310894, 17071.658566828657, 17073.951125864915, 17081.060541670202, 3066.75465962723, 3070.6468756093, 3109.6423911250267, 3115.704008119225, 3117.06488053583, 3014.2464383904025, 3031.6362036555533, 3040.5135178371465, 3048.6189226346705, 3057.250973511482, 2913.4027524357457, 2922.0941508132546, 2968.9257768555744, 2975.1372102090477, 2983.4033193361306, 2877.683454819989, 2896.145637037058, 2915.9125226243245, 2926.1221633509863, 2933.383989362247, 2721.2516557946524, 2735.9179224623294, 2736.1244401791437, 2738.602902579135, 2747.107190163205, 15637.452689155825, 15968.361265549363, 16040.35838566456, 16046.1174635395, 16047.277872495766, 8617.741467755977, 8969.955150224272, 8974.551272436353, 8976.237019853255, 8979.551022448917, 5739.426057394269, 5809.128630705386, 5864.442877926633, 6014.158017877457, 6016.548758843061, 1949.3567122849568, 2018.6467368210504, 2020.444377796103, 2046.8157865792002, 2054.7226124473154, 28651.856740716372, 28774.568381474295, 28961.855190723913, 29003.12990610264, 29021.709782902322, 7270.309320614533, 7451.3293803557945, 7462.96268518654, 7560.546367217875, 7609.277118673717, 19432.0, 19437.708434373497, 19468.805311946984, 19477.707834382494, 19484.220631174878, 8542.701005464778, 8587.871181932276, 8604.268637165911, 8674.0, 8676.91323086761, 6894.896576551356, 7070.71717131309, 7369.0, 8447.704330348408, 8473.915260847312, 5901.760630267606, 6096.908546371808, 6120.938790612036, 6132.202813634288, 6139.079138129227, 1621.6837716645377, 1647.0694057857272, 1665.7418100194488, 1672.4480921295942, 1685.4943516944868, 987.2250283527396, 1012.3217444312328, 1019.3730855523947, 1024.257413375312, 1032.607609108534, 8508.149185081566, 8691.261242794308, 8698.434601750865, 8717.0, 8789.956050219836, 725.8548290341953, 733.4755649710482, 741.4661443760484, 752.5371896283746, 753.8190834199862, 5254.448282930237, 5340.759665815048, 5629.746661400247, 5941.673207973517, 5965.9629685082255, 22844.885775571016, 22875.0, 23507.294781156594, 24007.399815004414, 24075.638865417033, 23170.304890853302, 23330.300090997298, 23357.2992810216, 23462.061517539107, 23587.702676352965, 12426.502939882484, 12527.43626536808, 12755.234685918875, 12876.227426354637, 12880.80678789819, 9148.359614827164, 9434.528273586431, 9553.379030363005, 9588.232941364813, 9642.276829237975, 20310.492237694176, 20503.17987280552, 21149.0, 21257.68113478268, 21263.468413289793, 20831.0, 21117.788822111583, 21251.893740531817, 21399.67900481463, 21448.14207431748, 13580.388882500509, 13821.0, 13821.930890345484, 13917.512887048904, 13925.512607058705, 15241.923790380977, 15485.458008969632, 15485.612859678598, 15491.922540387226, 15515.301811418287, 11734.29594224315, 11988.280703157838, 12017.459214335551, 12030.518779248732, 12290.508379664714, 11921.701957451132, 12005.39973001364, 12086.758264834478, 12157.452914618687, 12157.939210303892, 10549.630762923261, 10888.836667450152, 10907.127429805756, 10938.398388088732, 10968.890311096788, 8256.463329883538, 8329.37529685288, 8341.290990265896, 8610.182032706884, 8700.825983480168, 8650.956745216234, 8752.956235218782, 8753.0, 8755.649774009224, 8888.333374996771], "value": 7289.141989419945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.1427886823346, 538.625655169657, 553.1166378481267, 558.6089737183971, 562.5471495446167, 6120.785772497963, 6127.969360153199, 6214.285357183925, 6235.688215589219, 6239.594426362283, 6010.188624535686, 6019.578629495937, 6061.45446909778, 6084.604500707451, 6133.877322453548, 4773.6897101688455, 4832.420109586837, 4841.709497430148, 4852.611791056707, 4897.485763994782, 4769.5468930451725, 4794.688345257565, 4828.71027738335, 4830.372051633282, 4836.443808961979, 4753.382060332152, 4797.304390863323, 4798.328234047236, 4864.927026094611, 4872.561469467747, 4765.737884416356, 4770.379850619397, 4783.736894470802, 4809.855704328858, 4875.07373599015, 4303.784810759481, 4359.651227901761, 4378.190034843532, 4435.203742484299, 4451.844185453526, 6043.697815109271, 6072.453479186895, 6083.543734219951, 6150.292716337589, 6169.167162433104, 5761.0, 5821.62159459638, 5843.590948633598, 5867.207926929853, 5877.970610146965, 6557.573757705782, 6609.438197753197, 6621.5304669348, 6624.403803657646, 6628.602283862983, 4978.515039472348, 5000.1249781288125, 5015.974920125376, 5028.4971502849785, 5073.923891141636, 6847.1783385994, 6932.584044957319, 6934.237233904267, 7013.0, 7054.435645148375, 5143.174173168546, 5168.328117344721, 5175.689458632494, 5177.8446646599905, 5178.766955487012, 5248.448912864171, 5254.395744489356, 5255.240998475831, 5264.815101732815, 5278.788848446019, 5747.166660834156, 5787.71061446926, 5789.536837053026, 5799.797007104731, 5828.6502809831545, 6557.475401967927, 6558.278589355167, 6558.917778566483, 6567.605943643397, 6589.835254118685, 1747.519432156167, 1778.1198306838198, 1780.4302623160722, 1802.4769070135715, 1810.5021119192327, 1265.6519457149357, 1276.144982861485, 1277.2400421749044, 1277.9297138657278, 1287.414226526928, 6162.938370616326, 6217.29024518252, 6273.215848018997, 6294.9685251574365, 6368.617882926947, 6622.8344291393105, 6664.8000559983275, 6704.296048914891, 6771.221309549366, 6786.898196527056, 6233.937660623426, 6350.7459701611415, 6373.558278529635, 6375.330590288046, 6467.805965821033, 3522.1898963238086, 3559.6974257187912, 3579.4093974493917, 3593.7304702147444, 3594.928101438009, 6929.3070692931315, 6959.7124531960735, 7052.964735176394, 7087.291270872975, 7113.857722845514, 6855.794326170123, 6891.310868913169, 6915.377616014583, 6919.962005699185, 6965.164180298295, 6881.41507971828, 6883.242843287235, 6970.651467426608, 7039.964800175966, 7096.587160365604, 6685.732570697118, 6744.156980377453, 6776.6950487227205, 6786.830329241611, 6802.3537763912345, 6590.70341834609, 6651.636414534912, 6698.196216454056, 6724.697388617622, 6763.188417389944, 7091.716331346688, 7097.467689923174, 7120.750773722895, 7136.607486588287, 7137.357637812622, 5183.377994640668, 5194.3247377840635, 5223.686578805284, 5224.138017227115, 5258.1849813279005, 6600.8349791255605, 6700.698468569024, 6797.5581587196675, 6804.55770374924, 6892.793216203522, 6468.0, 6473.741050358121, 6602.537822352581, 6634.237062737654, 6675.165604299463, 6505.8698826024165, 6522.21733391977, 6563.967180164069, 6574.27682954865, 6590.462671871268, 6385.7126429309865, 6470.870582588416, 6516.185476815398, 6553.901691474536, 6635.8009259722285, 6597.934020659732, 6624.205095388585, 6632.701528431136, 6662.167229096363, 6724.529282950147, 6356.4279214870885, 6448.193975753031, 6463.64449955257, 6504.934950650433, 6509.251436084911], "value": 5147.843961265806, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [969.1229437359189, 975.3513913247689, 986.1322036607784, 986.8963758805321, 1003.9849402258967, 18364.44906652801, 19577.0, 20035.499112522157, 20050.99999999998, 22844.314670559866, 21750.0, 21840.890795546038, 22050.779492205074, 22097.779022209772, 22123.778762212372, 1060.7401186709267, 1075.5213929801241, 1077.962271320504, 1078.8166011777978, 1080.3517889266457, 1042.7862288230895, 1079.7246702090956, 1093.7429704019548, 1095.6986828622114, 1102.0247081333039, 1159.0264178090401, 1161.2742036227357, 1162.0877611075307, 1162.3548930343657, 1163.1741463560882, 1129.9661010169707, 1142.063507923503, 1145.1354227558224, 1145.3643228008452, 1146.6101525481336, 835.173178553234, 845.5222799118478, 846.9364797640202, 846.9534175620338, 847.0555330806168, 20416.672916260395, 20593.8970305149, 20771.58456830855, 20788.5842283155, 20814.0, 21234.256801012045, 21461.892690536602, 21859.890700546555, 21940.0, 22107.557848843095, 17101.74347384778, 17307.740383894252, 17403.216855241546, 17431.12844357777, 17551.122443877754, 3762.811859407046, 3781.3760729479604, 3783.2622638585485, 3784.9432258516144, 3787.16682329887, 148215.25892370468, 148877.0, 149168.2541587296, 149478.0, 149657.0, 14492.855071449361, 14608.415663373558, 15101.169435680924, 15165.0, 15166.848331516765, 30887.073387798402, 31581.210469738442, 31611.0, 31675.20811979719, 31834.0, 9055.547222638841, 9215.354925155174, 9219.078092190728, 9219.354645174773, 9224.446533208029, 4448.4439445069365, 4510.075434535912, 4511.548845115528, 4512.503624601291, 4526.637868970474, 5615.943840561624, 5982.521398288127, 6094.421030002142, 6114.2357205349335, 6119.663418512025, 1174.7121955120879, 1206.9818952715716, 1210.5520957245699, 1215.1251099208555, 1234.1422711215619, 738.9150247721474, 756.6330329790047, 770.3028758973138, 772.3705180278167, 778.9376849851998, 13024.54414095502, 13299.601011969657, 13618.387172577257, 13748.0, 13793.24137172445, 748.3863232149585, 752.7816933089342, 756.8032311599023, 760.1334478694293, 760.3612965109335, 6177.320494745574, 6389.9680501597195, 6394.104825324458, 6510.934890651128, 6873.15016891396, 127429.0, 129363.0, 130962.34518827345, 131224.3438782819, 131378.34310828385, 114596.42701786605, 118374.0, 118992.0, 119572.0, 120436.0, 100447.0, 101504.0, 105322.47338763103, 106287.4685626567, 106807.34888224483, 13549.458021679022, 13765.793513097111, 13966.79049814274, 14008.159510429407, 14040.578782636538, 46551.53448465472, 46668.53331466778, 46679.766601166775, 46909.29636055393, 46993.2951005742, 61597.753346081874, 61832.69083654553, 61835.38164618476, 62067.689661551405, 62280.0, 19939.0, 19979.0, 20024.49938751543, 20232.0, 20243.493912652302, 22352.77647223507, 22640.094396223965, 22671.0, 22696.432589185402, 22785.0, 20863.0, 21252.681209781556, 21308.893455532623, 21417.57164856663, 21478.463038424165, 20903.059362328426, 21060.684089738974, 21167.047482863618, 21300.0, 21304.254351097636, 20583.69124463104, 20703.0, 20926.058327375, 20992.160313587287, 20993.0, 15322.846771532142, 15619.297131629331, 15650.13924234178, 15711.921440392725, 15819.209039548206, 13935.425829668215, 14254.717075463259, 15455.381784728484, 15711.842881571038, 16201.270942807838], "value": 10039.571031035379, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 106.0, 100.0, 105.0, 105.0, 107.0, 107.0, 97.0, 106.0, 107.0], "value": 103.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 112.0, 155.0, 167.0, 114.0, 144.0, 155.0, 112.0, 184.0, 113.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 160.0, 162.0, 161.0, 161.0, 162.0, 161.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 184.0, 75.0, 73.0, 76.0, 73.0, 153.0, 75.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 126.0, 78.0, 78.0, 78.0, 124.0, 77.0, 78.0, 123.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 149.0, 148.0, 147.0, 148.0, 146.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 95.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 47.0, 46.0, 47.0, 47.0, 46.0, 49.0, 47.0, 46.0, 45.0], "value": 46.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 54.0, 53.0, 53.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 81.0, 72.0, 73.0, 73.0, 73.0, 75.0, 75.0, 72.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 116.0, 128.0, 114.0, 124.0, 120.0, 116.0, 112.0, 112.0, 143.0], "value": 120.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 160.0, 158.0, 159.0, 165.0, 163.0, 165.0, 165.0, 159.0, 159.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 66.0, 59.0, 58.0, 60.0, 58.0, 60.0, 69.0, 59.0], "value": 60.8, "unit": "score"}]}]} 09:29:30 INFO - Return code: 0 09:29:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:29:30 INFO - # TBPL SUCCESS # 09:29:30 INFO - Running post-action listener: _package_coverage_data 09:29:30 INFO - Running post-action listener: _resource_record_post_action 09:29:30 INFO - [mozharness: 2017-08-27 16:29:30.323288Z] Finished run-tests step (success) 09:29:30 INFO - Running post-run listener: _resource_record_post_run 09:29:30 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 503808; Write bytes: 377708544; Read time: 252; Write time: 200920 09:29:30 INFO - TinderboxPrint: CPU usage
13.0% 09:29:30 INFO - TinderboxPrint: I/O read bytes / time
503,808 / 252 09:29:30 INFO - TinderboxPrint: I/O write bytes / time
377,708,544 / 200,920 09:29:30 INFO - TinderboxPrint: CPU idle
8,209.5 (86.9%) 09:29:30 INFO - TinderboxPrint: CPU user
1,182.8 (12.5%) 09:29:30 INFO - TinderboxPrint: Swap in / out
0 / 0 09:29:30 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 94842880; Read time: 60; Write time: 70708 09:29:30 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:29:30 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 499712; Write bytes: 282451968; Read time: 192; Write time: 130172 09:29:30 INFO - Running post-run listener: _upload_blobber_files 09:29:30 INFO - Blob upload gear active. 09:29:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:29:30 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 09:29:30 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'] 09:29:30 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 09:29:31 INFO - (blobuploader) - INFO - Open directory for files ... 09:29:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:29:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:29:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:32 INFO - (blobuploader) - INFO - Done attempting. 09:29:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:29:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:29:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:38 INFO - (blobuploader) - INFO - Done attempting. 09:29:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:29:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:29:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:39 INFO - (blobuploader) - INFO - Done attempting. 09:29:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:29:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:29:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:40 INFO - (blobuploader) - INFO - Done attempting. 09:29:40 INFO - (blobuploader) - INFO - Iteration through files over. 09:29:40 INFO - Return code: 0 09:29:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:29:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:29:40 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1329c534be4505ee25d69f5d6bd030318c7db8e5b532c100161a2306fa90ae06586c37b995fc197c865cfb411a153e97b394b04f919f0f5d540e8fc3ac8c3d56", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fa1179966a7200681e2ac9272d5b767f65a5734ad659b795b92cae75bc1948a09a698764ce7127694064249583c710aedeb2a25882b6471919e45c775a113540", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/350cb7784fbdd1bcf0c909743c48d29b55c2df16f1a7cb1ce80a165aed72b0dc867e53d2e4872fc9e703214a6e2198dddbb79653268696e77e89fabf45e3eeba", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ad938c6b9f7eb2bc2206495d145773876954fb128c97be3afb791ee9ba8e5b2f4b50b47dcde216ec6774366e9a4c9d1fdbbaef2367bf472c3cfd503f9674082b"} 09:29:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:29:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:29:40 INFO - Contents: 09:29:40 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1329c534be4505ee25d69f5d6bd030318c7db8e5b532c100161a2306fa90ae06586c37b995fc197c865cfb411a153e97b394b04f919f0f5d540e8fc3ac8c3d56", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fa1179966a7200681e2ac9272d5b767f65a5734ad659b795b92cae75bc1948a09a698764ce7127694064249583c710aedeb2a25882b6471919e45c775a113540", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/350cb7784fbdd1bcf0c909743c48d29b55c2df16f1a7cb1ce80a165aed72b0dc867e53d2e4872fc9e703214a6e2198dddbb79653268696e77e89fabf45e3eeba", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ad938c6b9f7eb2bc2206495d145773876954fb128c97be3afb791ee9ba8e5b2f4b50b47dcde216ec6774366e9a4c9d1fdbbaef2367bf472c3cfd503f9674082b"} 09:29:40 INFO - Running post-run listener: copy_logs_to_upload_dir 09:29:40 INFO - Copying logs to upload dir... 09:29:40 INFO - mkdir: /builds/slave/test/build/upload/logs 09:29:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.609173 ========= master_lag: 0.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-08-27 09:29:40.473828) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-27 09:29:40.480776) ========= 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=20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157 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/1329c534be4505ee25d69f5d6bd030318c7db8e5b532c100161a2306fa90ae06586c37b995fc197c865cfb411a153e97b394b04f919f0f5d540e8fc3ac8c3d56", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fa1179966a7200681e2ac9272d5b767f65a5734ad659b795b92cae75bc1948a09a698764ce7127694064249583c710aedeb2a25882b6471919e45c775a113540", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/350cb7784fbdd1bcf0c909743c48d29b55c2df16f1a7cb1ce80a165aed72b0dc867e53d2e4872fc9e703214a6e2198dddbb79653268696e77e89fabf45e3eeba", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ad938c6b9f7eb2bc2206495d145773876954fb128c97be3afb791ee9ba8e5b2f4b50b47dcde216ec6774366e9a4c9d1fdbbaef2367bf472c3cfd503f9674082b"} build_url:https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/FOu2YV7tSUW7TLmCMflFCg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1329c534be4505ee25d69f5d6bd030318c7db8e5b532c100161a2306fa90ae06586c37b995fc197c865cfb411a153e97b394b04f919f0f5d540e8fc3ac8c3d56", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fa1179966a7200681e2ac9272d5b767f65a5734ad659b795b92cae75bc1948a09a698764ce7127694064249583c710aedeb2a25882b6471919e45c775a113540", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/350cb7784fbdd1bcf0c909743c48d29b55c2df16f1a7cb1ce80a165aed72b0dc867e53d2e4872fc9e703214a6e2198dddbb79653268696e77e89fabf45e3eeba", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ad938c6b9f7eb2bc2206495d145773876954fb128c97be3afb791ee9ba8e5b2f4b50b47dcde216ec6774366e9a4c9d1fdbbaef2367bf472c3cfd503f9674082b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-27 09:29:40.516550) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-27 09:29:40.516882) ========= 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=20e20d796406ba5117c4a6f1000001ba-1503850131.401048-1906996157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-27 09:29:40.593441) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-27 09:29:40.593769) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-27 09:29:40.594080) ========= ========= Total master_lag: 0.63 =========