builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1501409187.03 results: success (0) revision: 8b577b152383f5560ab57fdc307fa872cd268ea7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-30 03:06:27.025281) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-30 03:06:27.025707) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-30 03:06:27.025985) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-30 03:06:27.066460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:06:27.066792) ========= 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=1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-30 03:06:27-- 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% 226M=0s 2017-07-30 03:06:27 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.193758 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:06:27.302020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:06:27.302334) ========= 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=1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018648 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:06:27.362150) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-30 03:06:27.362456) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8b577b152383f5560ab57fdc307fa872cd268ea7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 8b577b152383f5560ab57fdc307fa872cd268ea7 --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=1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-30 03:06:27,664 truncating revision to first 12 chars 2017-07-30 03:06:27,664 Setting DEBUG logging. 2017-07-30 03:06:27,664 attempt 1/10 2017-07-30 03:06:27,664 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8b577b152383?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-30 03:06:29,178 unpacking tar archive at: mozilla-central-8b577b152383/testing/mozharness/ program finished with exit code 0 elapsedTime=1.832682 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-30 03:06:29.207948) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-30 03:06:29.211356) ========= script_repo_revision: 8b577b152383f5560ab57fdc307fa872cd268ea7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-30 03:06:29.211800) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-30 03:06:29.212072) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-30 03:06:29.220818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-07-30 03:06:29.221223) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:06:29 INFO - MultiFileLogger online at 20170730 03:06:29 in /builds/slave/test 03:06:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:06:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:06:29 INFO - {'append_to_log': False, 03:06:29 INFO - 'base_work_dir': '/builds/slave/test', 03:06:29 INFO - 'blob_upload_branch': 'Firefox', 03:06:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:06:29 INFO - 'branch': 'Firefox', 03:06:29 INFO - 'buildbot_json_path': 'buildprops.json', 03:06:29 INFO - 'code_coverage': False, 03:06:29 INFO - 'config_files': ('talos/linux_config.py',), 03:06:29 INFO - 'default_actions': ('clobber', 03:06:29 INFO - 'read-buildbot-config', 03:06:29 INFO - 'download-and-extract', 03:06:29 INFO - 'populate-webroot', 03:06:29 INFO - 'create-virtualenv', 03:06:29 INFO - 'install', 03:06:29 INFO - 'setup-mitmproxy', 03:06:29 INFO - 'run-tests'), 03:06:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:06:29 INFO - 'disable_ccov_upload': False, 03:06:29 INFO - 'download_minidump_stackwalk': True, 03:06:29 INFO - 'download_symbols': 'ondemand', 03:06:29 INFO - 'enable_stylo': False, 03:06:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:06:29 INFO - 'tooltool.py': '/tools/tooltool.py', 03:06:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:06:29 INFO - '/tools/misc-python/virtualenv.py')}, 03:06:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:06:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:06:29 INFO - 'gecko_profile': False, 03:06:29 INFO - 'gecko_profile_interval': 0, 03:06:29 INFO - 'installer_path': 'installer.exe', 03:06:29 INFO - 'log_level': 'info', 03:06:29 INFO - 'log_name': 'talos', 03:06:29 INFO - 'log_to_console': True, 03:06:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:06:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:06:29 INFO - 'opt_config_files': (), 03:06:29 INFO - 'pip_index': False, 03:06:29 INFO - 'suite': 'dromaeojs-e10s', 03:06:29 INFO - 'system_bits': '32', 03:06:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:06:29 INFO - 'title': 'talos-linux64-ix-027', 03:06:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:06:29 INFO - 'use_talos_json': True, 03:06:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:06:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:06:29 INFO - 'work_dir': 'build'} 03:06:29 INFO - [mozharness: 2017-07-30 10:06:29.731362Z] Running clobber step. 03:06:29 INFO - Running pre-action listener: _resource_record_pre_action 03:06:29 INFO - Running main action method: clobber 03:06:29 INFO - rmtree: /builds/slave/test/build 03:06:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:06:30 INFO - Running post-action listener: _resource_record_post_action 03:06:30 INFO - [mozharness: 2017-07-30 10:06:30.740981Z] Finished clobber step (success) 03:06:30 INFO - [mozharness: 2017-07-30 10:06:30.741083Z] Running read-buildbot-config step. 03:06:30 INFO - Running pre-action listener: _resource_record_pre_action 03:06:30 INFO - Running main action method: read_buildbot_config 03:06:30 INFO - Using buildbot properties: 03:06:30 INFO - { 03:06:30 INFO - "project": "", 03:06:30 INFO - "product": "firefox", 03:06:30 INFO - "who": "archaeopteryx@coole-files.de", 03:06:30 INFO - "installer_path": "public/build/target.tar.bz2", 03:06:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 03:06:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:06:30 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 03:06:30 INFO - "stage_platform": "linux64-stylo", 03:06:30 INFO - "basedir": "/builds/slave/test", 03:06:30 INFO - "buildnumber": 55, 03:06:30 INFO - "platform": "ubuntu64_hw_stylo", 03:06:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:06:30 INFO - "slavebuilddir": "test", 03:06:30 INFO - "taskId": "K8Xop56eRpOmygPGlwURVw", 03:06:30 INFO - "branch": "mozilla-central", 03:06:30 INFO - "script_repo_revision": "production", 03:06:30 INFO - "revision": "8b577b152383f5560ab57fdc307fa872cd268ea7", 03:06:30 INFO - "slavename": "talos-linux64-ix-027", 03:06:30 INFO - "repo_path": "mozilla-central" 03:06:30 INFO - } 03:06:30 INFO - Finding installer, test and symbols from parent task. 03:06:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K8Xop56eRpOmygPGlwURVw'}, attempt #1 03:06:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K8Xop56eRpOmygPGlwURVw'}, attempt #1 03:06:31 INFO - Task dependencies: BhLq2Mq1QfOaTK4I1eOx5w 03:06:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w'}, attempt #1 03:06:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.tar.bz2 03:06:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.test_packages.json 03:06:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.crashreporter-symbols.zip 03:06:32 INFO - Running post-action listener: _resource_record_post_action 03:06:32 INFO - [mozharness: 2017-07-30 10:06:32.105606Z] Finished read-buildbot-config step (success) 03:06:32 INFO - [mozharness: 2017-07-30 10:06:32.105830Z] Running download-and-extract step. 03:06:32 INFO - Running pre-action listener: _resource_record_pre_action 03:06:32 INFO - Running main action method: download_and_extract 03:06:32 INFO - mkdir: /builds/slave/test/build/tests 03:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:32 INFO - trying https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.test_packages.json 03:06:32 INFO - Downloading https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:06:32 INFO - Downloaded 989 bytes. 03:06:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:06:32 INFO - Using the following test package requirements: 03:06:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:06:32 INFO - u'common': [u'target.common.tests.zip'], 03:06:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:06:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:06:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:06:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:06:32 INFO - u'mozbase': [u'target.common.tests.zip'], 03:06:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:06:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:06:32 INFO - u'web-platform': [u'target.common.tests.zip', 03:06:32 INFO - u'target.web-platform.tests.tar.gz'], 03:06:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:06:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:06:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.common.tests.zip 03:06:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:06:32 INFO - Fetch https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.common.tests.zip into memory 03:06:34 INFO - Content-Length response header: 72567046 03:06:34 INFO - Bytes received: 72567046 03:06:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:06:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.common.tests.zip 03:06:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:06:46 INFO - Fetch https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.common.tests.zip into memory 03:06:47 INFO - Content-Length response header: 72567046 03:06:47 INFO - Bytes received: 72567046 03:07:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.talos.tests.zip 03:07:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:07:00 INFO - Fetch https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.talos.tests.zip into memory 03:07:01 INFO - Content-Length response header: 14496686 03:07:01 INFO - Bytes received: 14496686 03:07: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')]} 03:07:01 INFO - trying https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.tar.bz2 03:07:01 INFO - Downloading https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:07:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:07:02 INFO - Downloaded 62294010 bytes. 03:07:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.tar.bz2 03:07:02 INFO - mkdir: /builds/slave/test/properties 03:07:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:07:02 INFO - Writing to file /builds/slave/test/properties/build_url 03:07:02 INFO - Contents: 03:07:02 INFO - build_url:https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.tar.bz2 03:07:02 INFO - Running post-action listener: _resource_record_post_action 03:07:02 INFO - Running post-action listener: set_extra_try_arguments 03:07:02 INFO - [mozharness: 2017-07-30 10:07:02.494683Z] Finished download-and-extract step (success) 03:07:02 INFO - [mozharness: 2017-07-30 10:07:02.494781Z] Running populate-webroot step. 03:07:02 INFO - Running pre-action listener: _resource_record_pre_action 03:07:02 INFO - Running main action method: populate_webroot 03:07:02 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:07:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:07:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:07:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:07:02 INFO - 'tests': ['damp', 'tps']}, 03:07:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:07:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:07:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:07:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:07:02 INFO - 'other-e10s': {'tests': ['a11yr', 03:07:02 INFO - 'ts_paint', 03:07:02 INFO - 'tpaint', 03:07:02 INFO - 'sessionrestore', 03:07:02 INFO - 'sessionrestore_many_windows', 03:07:02 INFO - 'sessionrestore_no_auto_restore', 03:07:02 INFO - 'tabpaint']}, 03:07:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:07:02 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:07:02 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:07:02 INFO - 'talos_options': ['--mitmproxy', 03:07:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:07:02 INFO - '--firstNonBlankPaint'], 03:07:02 INFO - 'tests': ['quantum_pageload_google', 03:07:02 INFO - 'quantum_pageload_youtube', 03:07:02 INFO - 'quantum_pageload_amazon', 03:07:02 INFO - 'quantum_pageload_facebook']}, 03:07:02 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:07:02 INFO - 'talos_options': ['--stylo', 03:07:02 INFO - '--mitmproxy', 03:07:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:07:02 INFO - '--firstNonBlankPaint'], 03:07:02 INFO - 'tests': ['quantum_pageload_google', 03:07:02 INFO - 'quantum_pageload_youtube', 03:07:02 INFO - 'quantum_pageload_amazon', 03:07:02 INFO - 'quantum_pageload_facebook']}, 03:07:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:07:02 INFO - 'tsvgr_opacity', 03:07:02 INFO - 'tart', 03:07:02 INFO - 'tscrollx', 03:07:02 INFO - 'cart', 03:07:02 INFO - 'tsvg_static']}, 03:07:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:07:02 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:07:02 INFO - 'talos_options': ['--stylo', 03:07:02 INFO - '--stylo-threads=1', 03:07:02 INFO - '--mitmproxy', 03:07:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:07:02 INFO - '--firstNonBlankPaint'], 03:07:02 INFO - 'tests': ['tp6_google', 03:07:02 INFO - 'tp6_youtube', 03:07:02 INFO - 'tp6_amazon', 03:07:02 INFO - 'tp6_facebook']}, 03:07:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:07:02 INFO - 'talos_options': ['--xperf_path', 03:07:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:02 INFO - 'tests': ['tp5n']}}} 03:07:02 INFO - Running post-action listener: _resource_record_post_action 03:07:02 INFO - [mozharness: 2017-07-30 10:07:02.503529Z] Finished populate-webroot step (success) 03:07:02 INFO - [mozharness: 2017-07-30 10:07:02.503620Z] Running create-virtualenv step. 03:07:02 INFO - Running pre-action listener: _resource_record_pre_action 03:07:02 INFO - Running main action method: create_virtualenv 03:07:02 INFO - Creating virtualenv /builds/slave/test/build/venv 03:07:02 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 03:07:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:07:02 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:07:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:07:02 INFO - Using real prefix '/usr' 03:07:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:07:03 INFO - Installing distribute.............................................................................................................................................................................................done. 03:07:05 INFO - Installing pip.................done. 03:07:05 INFO - Return code: 0 03:07:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:07:05 INFO - Reading from file tmpfile_stdout 03:07:05 INFO - Output received: 03:07:05 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) 03:07:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:05 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 0x1a481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db4eb0>, '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 0x1db5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db6240>, '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': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', '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 03:07:05 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 03:07:05 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 03:07:05 INFO - Using env: {'DISPLAY': ':0', 03:07:05 INFO - 'HOME': '/home/cltbld', 03:07:05 INFO - 'LANG': 'en_US.UTF-8', 03:07:05 INFO - 'LANGUAGE': 'en_US:en', 03:07:05 INFO - 'LOGNAME': 'cltbld', 03:07:05 INFO - 'MAIL': '/var/mail/cltbld', 03:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:05 INFO - 'MOZ_NO_REMOTE': '1', 03:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:05 INFO - 'NO_EM_RESTART': '1', 03:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:05 INFO - 'PWD': '/builds/slave/test', 03:07:05 INFO - 'SHELL': '/bin/bash', 03:07:05 INFO - 'SHLVL': '1', 03:07:05 INFO - 'TERM': 'linux', 03:07:05 INFO - 'TMOUT': '86400', 03:07:05 INFO - 'USER': 'cltbld', 03:07:05 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', 03:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:05 INFO - '_': '/tools/buildbot/bin/python'} 03:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:05 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 03:07:05 INFO - Cleaning up... 03:07:05 INFO - Return code: 0 03:07:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:05 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 0x1a481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db4eb0>, '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 0x1db5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db6240>, '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': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', '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 03:07:05 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 03:07:05 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 03:07:05 INFO - Using env: {'DISPLAY': ':0', 03:07:05 INFO - 'HOME': '/home/cltbld', 03:07:05 INFO - 'LANG': 'en_US.UTF-8', 03:07:05 INFO - 'LANGUAGE': 'en_US:en', 03:07:05 INFO - 'LOGNAME': 'cltbld', 03:07:05 INFO - 'MAIL': '/var/mail/cltbld', 03:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:05 INFO - 'MOZ_NO_REMOTE': '1', 03:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:05 INFO - 'NO_EM_RESTART': '1', 03:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:05 INFO - 'PWD': '/builds/slave/test', 03:07:05 INFO - 'SHELL': '/bin/bash', 03:07:05 INFO - 'SHLVL': '1', 03:07:05 INFO - 'TERM': 'linux', 03:07:05 INFO - 'TMOUT': '86400', 03:07:05 INFO - 'USER': 'cltbld', 03:07:05 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', 03:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:05 INFO - '_': '/tools/buildbot/bin/python'} 03:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:05 INFO - Downloading/unpacking psutil>=3.1.1 03:07:05 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 03:07:05 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 03:07:05 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 03:07:05 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 03:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:07:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:07 INFO - Installing collected packages: psutil 03:07:07 INFO - Running setup.py install for psutil 03:07:07 INFO - building 'psutil._psutil_linux' extension 03:07:07 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 03:07:08 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 03:07:08 INFO - building 'psutil._psutil_posix' extension 03:07:08 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 03:07:08 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 03:07:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:08 INFO - Successfully installed psutil 03:07:08 INFO - Cleaning up... 03:07:08 INFO - Return code: 0 03:07:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:08 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 0x1a481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db4eb0>, '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 0x1db5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db6240>, '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': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', '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 03:07:08 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 03:07:08 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 03:07:08 INFO - Using env: {'DISPLAY': ':0', 03:07:08 INFO - 'HOME': '/home/cltbld', 03:07:08 INFO - 'LANG': 'en_US.UTF-8', 03:07:08 INFO - 'LANGUAGE': 'en_US:en', 03:07:08 INFO - 'LOGNAME': 'cltbld', 03:07:08 INFO - 'MAIL': '/var/mail/cltbld', 03:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:08 INFO - 'MOZ_NO_REMOTE': '1', 03:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:08 INFO - 'NO_EM_RESTART': '1', 03:07:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:08 INFO - 'PWD': '/builds/slave/test', 03:07:08 INFO - 'SHELL': '/bin/bash', 03:07:08 INFO - 'SHLVL': '1', 03:07:08 INFO - 'TERM': 'linux', 03:07:08 INFO - 'TMOUT': '86400', 03:07:08 INFO - 'USER': 'cltbld', 03:07:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', 03:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:08 INFO - '_': '/tools/buildbot/bin/python'} 03:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:07:10 INFO - Installing collected packages: mozsystemmonitor 03:07:10 INFO - Running setup.py install for mozsystemmonitor 03:07:10 INFO - Successfully installed mozsystemmonitor 03:07:10 INFO - Cleaning up... 03:07:10 INFO - Return code: 0 03:07:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:10 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 0x1a481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db4eb0>, '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 0x1db5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db6240>, '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': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', '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 03:07:10 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 03:07:10 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 03:07:10 INFO - Using env: {'DISPLAY': ':0', 03:07:10 INFO - 'HOME': '/home/cltbld', 03:07:10 INFO - 'LANG': 'en_US.UTF-8', 03:07:10 INFO - 'LANGUAGE': 'en_US:en', 03:07:10 INFO - 'LOGNAME': 'cltbld', 03:07:10 INFO - 'MAIL': '/var/mail/cltbld', 03:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:10 INFO - 'MOZ_NO_REMOTE': '1', 03:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:10 INFO - 'NO_EM_RESTART': '1', 03:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:10 INFO - 'PWD': '/builds/slave/test', 03:07:10 INFO - 'SHELL': '/bin/bash', 03:07:10 INFO - 'SHLVL': '1', 03:07:10 INFO - 'TERM': 'linux', 03:07:10 INFO - 'TMOUT': '86400', 03:07:10 INFO - 'USER': 'cltbld', 03:07:10 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', 03:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:10 INFO - '_': '/tools/buildbot/bin/python'} 03:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:10 INFO - Downloading/unpacking jsonschema==2.5.1 03:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:07:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:07:11 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 03:07:11 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 03:07:11 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 03:07:11 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 03:07:11 INFO - Downloading functools32-3.2.3-2.tar.gz 03:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:07:11 INFO - warning: no files found matching '*.txt' 03:07:11 INFO - no previously-included directories found matching 'build' 03:07:11 INFO - no previously-included directories found matching 'dist' 03:07:11 INFO - no previously-included directories found matching '.git*' 03:07:11 INFO - Installing collected packages: jsonschema, functools32 03:07:11 INFO - Running setup.py install for functools32 03:07:11 INFO - warning: no files found matching '*.txt' 03:07:11 INFO - no previously-included directories found matching 'build' 03:07:11 INFO - no previously-included directories found matching 'dist' 03:07:11 INFO - no previously-included directories found matching '.git*' 03:07:11 INFO - Successfully installed jsonschema functools32 03:07:11 INFO - Cleaning up... 03:07:11 INFO - Return code: 0 03:07:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db4eb0>, '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 0x1db5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db6240>, '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': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', '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 03:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:07:11 INFO - Using env: {'DISPLAY': ':0', 03:07:11 INFO - 'HOME': '/home/cltbld', 03:07:11 INFO - 'LANG': 'en_US.UTF-8', 03:07:11 INFO - 'LANGUAGE': 'en_US:en', 03:07:11 INFO - 'LOGNAME': 'cltbld', 03:07:11 INFO - 'MAIL': '/var/mail/cltbld', 03:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:11 INFO - 'MOZ_NO_REMOTE': '1', 03:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:11 INFO - 'NO_EM_RESTART': '1', 03:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:11 INFO - 'PWD': '/builds/slave/test', 03:07:11 INFO - 'SHELL': '/bin/bash', 03:07:11 INFO - 'SHLVL': '1', 03:07:11 INFO - 'TERM': 'linux', 03:07:11 INFO - 'TMOUT': '86400', 03:07:11 INFO - 'USER': 'cltbld', 03:07:11 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', 03:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:11 INFO - '_': '/tools/buildbot/bin/python'} 03:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:07:12 INFO - Cleaning up... 03:07:12 INFO - Return code: 0 03:07:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db4eb0>, '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 0x1db5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db6240>, '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': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', '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 03:07:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:07:12 INFO - Using env: {'DISPLAY': ':0', 03:07:12 INFO - 'HOME': '/home/cltbld', 03:07:12 INFO - 'LANG': 'en_US.UTF-8', 03:07:12 INFO - 'LANGUAGE': 'en_US:en', 03:07:12 INFO - 'LOGNAME': 'cltbld', 03:07:12 INFO - 'MAIL': '/var/mail/cltbld', 03:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:12 INFO - 'MOZ_NO_REMOTE': '1', 03:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:12 INFO - 'NO_EM_RESTART': '1', 03:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:12 INFO - 'PWD': '/builds/slave/test', 03:07:12 INFO - 'SHELL': '/bin/bash', 03:07:12 INFO - 'SHLVL': '1', 03:07:12 INFO - 'TERM': 'linux', 03:07:12 INFO - 'TMOUT': '86400', 03:07:12 INFO - 'USER': 'cltbld', 03:07:12 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', 03:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:12 INFO - '_': '/tools/buildbot/bin/python'} 03:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:12 INFO - Downloading/unpacking blobuploader==1.2.4 03:07:12 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 03:07:12 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 03:07:12 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 03:07:12 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 03:07:13 INFO - Downloading blobuploader-1.2.4.tar.gz 03:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:07:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:07:13 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 03:07:13 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 03:07:13 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 03:07:13 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 03:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:07:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:07:13 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 03:07:13 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 03:07:13 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 03:07:13 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 03:07:13 INFO - Downloading docopt-0.6.1.tar.gz 03:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:07:13 INFO - Installing collected packages: blobuploader, requests, docopt 03:07:13 INFO - Running setup.py install for blobuploader 03:07:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:07:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:07:14 INFO - Running setup.py install for requests 03:07:14 INFO - Running setup.py install for docopt 03:07:14 INFO - Successfully installed blobuploader requests docopt 03:07:14 INFO - Cleaning up... 03:07:14 INFO - Return code: 0 03:07:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:14 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')]} 03:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:14 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')]} 03:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:14 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 0x1a481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db4eb0>, '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 0x1db5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db6240>, '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': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', '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 03:07:14 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 03:07:14 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 03:07:14 INFO - Using env: {'DISPLAY': ':0', 03:07:14 INFO - 'HOME': '/home/cltbld', 03:07:14 INFO - 'LANG': 'en_US.UTF-8', 03:07:14 INFO - 'LANGUAGE': 'en_US:en', 03:07:14 INFO - 'LOGNAME': 'cltbld', 03:07:14 INFO - 'MAIL': '/var/mail/cltbld', 03:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:14 INFO - 'MOZ_NO_REMOTE': '1', 03:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:14 INFO - 'NO_EM_RESTART': '1', 03:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:14 INFO - 'PWD': '/builds/slave/test', 03:07:14 INFO - 'SHELL': '/bin/bash', 03:07:14 INFO - 'SHLVL': '1', 03:07:14 INFO - 'TERM': 'linux', 03:07:14 INFO - 'TMOUT': '86400', 03:07:14 INFO - 'USER': 'cltbld', 03:07:14 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', 03:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:14 INFO - '_': '/tools/buildbot/bin/python'} 03:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:14 INFO - Running setup.py (path:/tmp/pip-zHfDSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:14 INFO - Running setup.py (path:/tmp/pip-WTWEy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:14 INFO - Running setup.py (path:/tmp/pip-NVUQ3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:14 INFO - Running setup.py (path:/tmp/pip-LfxH29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:15 INFO - Running setup.py (path:/tmp/pip-bsV7kM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:15 INFO - Running setup.py (path:/tmp/pip-eSebxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:15 INFO - Running setup.py (path:/tmp/pip-sNxvUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:15 INFO - Running setup.py (path:/tmp/pip-CDyiFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:15 INFO - Running setup.py (path:/tmp/pip-0JWnOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:15 INFO - Running setup.py (path:/tmp/pip-n79EFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:15 INFO - Running setup.py (path:/tmp/pip-K2frj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:15 INFO - Running setup.py (path:/tmp/pip-dEcrTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:15 INFO - Running setup.py (path:/tmp/pip-UZBJVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:15 INFO - Running setup.py (path:/tmp/pip-St_Ayc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:15 INFO - Running setup.py (path:/tmp/pip-E2EhUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:15 INFO - Running setup.py (path:/tmp/pip-0LCMLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:15 INFO - Running setup.py (path:/tmp/pip-BueOQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:07:15 INFO - Running setup.py install for manifestparser 03:07:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:07:16 INFO - Running setup.py install for mozcrash 03:07:16 INFO - Running setup.py install for mozdebug 03:07:16 INFO - Running setup.py install for mozdevice 03:07:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:07:16 INFO - Running setup.py install for mozfile 03:07:16 INFO - Running setup.py install for mozhttpd 03:07:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:07:16 INFO - Running setup.py install for mozinfo 03:07:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:07:16 INFO - Running setup.py install for mozInstall 03:07:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:07:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:07:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:07:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:07:16 INFO - Running setup.py install for mozleak 03:07:16 INFO - Running setup.py install for mozlog 03:07:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:07:16 INFO - Running setup.py install for moznetwork 03:07:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:07:17 INFO - Running setup.py install for mozprocess 03:07:17 INFO - Running setup.py install for mozprofile 03:07:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:07:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:07:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:07:17 INFO - Running setup.py install for mozrunner 03:07:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:07:17 INFO - Running setup.py install for mozscreenshot 03:07:17 INFO - Running setup.py install for moztest 03:07:17 INFO - Running setup.py install for mozversion 03:07:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:07:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:07:17 INFO - Cleaning up... 03:07:17 INFO - Return code: 0 03:07:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:17 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')]} 03:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:17 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')]} 03:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:17 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 0x1a481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db4eb0>, '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 0x1db5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db6240>, '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': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', '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 03:07:17 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 03:07:17 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 03:07:17 INFO - Using env: {'DISPLAY': ':0', 03:07:17 INFO - 'HOME': '/home/cltbld', 03:07:17 INFO - 'LANG': 'en_US.UTF-8', 03:07:17 INFO - 'LANGUAGE': 'en_US:en', 03:07:17 INFO - 'LOGNAME': 'cltbld', 03:07:17 INFO - 'MAIL': '/var/mail/cltbld', 03:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:17 INFO - 'MOZ_NO_REMOTE': '1', 03:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:17 INFO - 'NO_EM_RESTART': '1', 03:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:17 INFO - 'PWD': '/builds/slave/test', 03:07:17 INFO - 'SHELL': '/bin/bash', 03:07:17 INFO - 'SHLVL': '1', 03:07:17 INFO - 'TERM': 'linux', 03:07:17 INFO - 'TMOUT': '86400', 03:07:17 INFO - 'USER': 'cltbld', 03:07:17 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', 03:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:17 INFO - '_': '/tools/buildbot/bin/python'} 03:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:17 INFO - Running setup.py (path:/tmp/pip-KjWpp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:18 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)) 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:18 INFO - Running setup.py (path:/tmp/pip-ADJavg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:18 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)) 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:18 INFO - Running setup.py (path:/tmp/pip-9rjZno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:18 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)) 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:18 INFO - Running setup.py (path:/tmp/pip-Y_hQaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:18 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)) 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:18 INFO - Running setup.py (path:/tmp/pip-lUihhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:18 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)) 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:18 INFO - Running setup.py (path:/tmp/pip-vgBmAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:18 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)) 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:18 INFO - Running setup.py (path:/tmp/pip-l99678-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:18 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)) 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:18 INFO - Running setup.py (path:/tmp/pip-IgNhGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:18 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)) 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:18 INFO - Running setup.py (path:/tmp/pip-OhYd_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:18 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)) 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:18 INFO - Running setup.py (path:/tmp/pip-mfMPEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:18 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)) 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:18 INFO - Running setup.py (path:/tmp/pip-Dgwp3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:18 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)) 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:18 INFO - Running setup.py (path:/tmp/pip-LO2eTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:18 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)) 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:18 INFO - Running setup.py (path:/tmp/pip-S0cNSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:18 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)) 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:18 INFO - Running setup.py (path:/tmp/pip-tzt7CZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:18 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)) 03:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:18 INFO - Running setup.py (path:/tmp/pip-MEGDeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:19 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)) 03:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:19 INFO - Running setup.py (path:/tmp/pip-mrLutR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:19 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)) 03:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:19 INFO - Running setup.py (path:/tmp/pip-K9Xkgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:19 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)) 03:07:19 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)) 03:07:19 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)) 03:07:19 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)) 03:07:19 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)) 03:07:19 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)) 03:07:19 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)) 03:07:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:07:19 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 03:07:19 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 03:07:19 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 03:07:19 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 03:07:20 INFO - Downloading blessings-1.6.tar.gz 03:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:07:20 INFO - Installing collected packages: blessings 03:07:20 INFO - Running setup.py install for blessings 03:07:20 INFO - Successfully installed blessings 03:07:20 INFO - Cleaning up... 03:07:20 INFO - Return code: 0 03:07:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:07:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:20 INFO - Reading from file tmpfile_stdout 03:07:20 INFO - Current package versions: 03:07:20 INFO - argparse == 1.2.1 03:07:20 INFO - blessings == 1.6 03:07:20 INFO - blobuploader == 1.2.4 03:07:20 INFO - docopt == 0.6.1 03:07:20 INFO - functools32 == 3.2.3-2 03:07:20 INFO - jsonschema == 2.5.1 03:07:20 INFO - manifestparser == 1.1 03:07:20 INFO - mozInstall == 1.13 03:07:20 INFO - mozcrash == 1.0 03:07:20 INFO - mozdebug == 0.1 03:07:20 INFO - mozdevice == 0.51 03:07:20 INFO - mozfile == 1.2 03:07:20 INFO - mozhttpd == 0.7 03:07:20 INFO - mozinfo == 0.10 03:07:20 INFO - mozleak == 0.1 03:07:20 INFO - mozlog == 3.5 03:07:20 INFO - moznetwork == 0.27 03:07:20 INFO - mozprocess == 0.25 03:07:20 INFO - mozprofile == 0.28 03:07:20 INFO - mozrunner == 6.13 03:07:20 INFO - mozscreenshot == 0.1 03:07:20 INFO - mozsystemmonitor == 0.3 03:07:20 INFO - moztest == 0.8 03:07:20 INFO - mozversion == 1.4 03:07:20 INFO - psutil == 3.1.1 03:07:20 INFO - requests == 1.2.3 03:07:20 INFO - wsgiref == 0.1.2 03:07:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:20 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')]} 03:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:20 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')]} 03:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:20 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 0x1a481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db4eb0>, '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 0x1db5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db6240>, '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': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', '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 03:07:20 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 03:07:20 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 03:07:20 INFO - Using env: {'DISPLAY': ':0', 03:07:20 INFO - 'HOME': '/home/cltbld', 03:07:20 INFO - 'LANG': 'en_US.UTF-8', 03:07:20 INFO - 'LANGUAGE': 'en_US:en', 03:07:20 INFO - 'LOGNAME': 'cltbld', 03:07:20 INFO - 'MAIL': '/var/mail/cltbld', 03:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:20 INFO - 'MOZ_NO_REMOTE': '1', 03:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:20 INFO - 'NO_EM_RESTART': '1', 03:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:20 INFO - 'PWD': '/builds/slave/test', 03:07:20 INFO - 'SHELL': '/bin/bash', 03:07:20 INFO - 'SHLVL': '1', 03:07:20 INFO - 'TERM': 'linux', 03:07:20 INFO - 'TMOUT': '86400', 03:07:20 INFO - 'USER': 'cltbld', 03:07:20 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', 03:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:20 INFO - '_': '/tools/buildbot/bin/python'} 03:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:20 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)) 03:07:20 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)) 03:07:20 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)) 03:07:20 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)) 03:07:20 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)) 03:07:20 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)) 03:07:20 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)) 03:07:20 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)) 03:07:20 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)) 03:07:20 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:07:20 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 03:07:20 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 03:07:20 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 03:07:20 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 03:07:22 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:07:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:07:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:07:22 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 03:07:22 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 03:07:22 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 03:07:22 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 03:07:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:07:22 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)) 03:07:22 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)) 03:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:07:22 INFO - Installing collected packages: marionette-driver, simplejson 03:07:22 INFO - Running setup.py install for marionette-driver 03:07:22 INFO - Running setup.py install for simplejson 03:07:22 INFO - building 'simplejson._speedups' extension 03:07:22 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 03:07:23 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 03:07:23 INFO - Successfully installed marionette-driver simplejson 03:07:23 INFO - Cleaning up... 03:07:23 INFO - Return code: 0 03:07:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:07:23 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')]} 03:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:23 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')]} 03:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:23 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 0x1a481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db4eb0>, '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 0x1db5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db6240>, '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': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', '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 03:07:23 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 03:07:23 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 03:07:23 INFO - Using env: {'DISPLAY': ':0', 03:07:23 INFO - 'HOME': '/home/cltbld', 03:07:23 INFO - 'LANG': 'en_US.UTF-8', 03:07:23 INFO - 'LANGUAGE': 'en_US:en', 03:07:23 INFO - 'LOGNAME': 'cltbld', 03:07:23 INFO - 'MAIL': '/var/mail/cltbld', 03:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:23 INFO - 'MOZ_NO_REMOTE': '1', 03:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:23 INFO - 'NO_EM_RESTART': '1', 03:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:23 INFO - 'PWD': '/builds/slave/test', 03:07:23 INFO - 'SHELL': '/bin/bash', 03:07:23 INFO - 'SHLVL': '1', 03:07:23 INFO - 'TERM': 'linux', 03:07:23 INFO - 'TMOUT': '86400', 03:07:23 INFO - 'USER': 'cltbld', 03:07:23 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', 03:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:23 INFO - '_': '/tools/buildbot/bin/python'} 03:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:07:23 INFO - Cleaning up... 03:07:23 INFO - Return code: 0 03:07:23 INFO - Running post-action listener: _resource_record_post_action 03:07:23 INFO - Running post-action listener: _start_resource_monitoring 03:07:23 INFO - Starting resource monitoring. 03:07:23 INFO - [mozharness: 2017-07-30 10:07:23.833712Z] Finished create-virtualenv step (success) 03:07:23 INFO - [mozharness: 2017-07-30 10:07:23.834701Z] Running install step. 03:07:23 INFO - Running pre-action listener: _resource_record_pre_action 03:07:23 INFO - Running main action method: install 03:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:24 INFO - Reading from file tmpfile_stdout 03:07:24 INFO - Detecting whether we're running mozinstall >=1.0... 03:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:07:24 INFO - Reading from file tmpfile_stdout 03:07:24 INFO - Output received: 03:07:24 INFO - Usage: mozinstall [options] installer 03:07:24 INFO - Options: 03:07:24 INFO - -h, --help show this help message and exit 03:07:24 INFO - -d DEST, --destination=DEST 03:07:24 INFO - Directory to install application into. [default: 03:07:24 INFO - "/builds/slave/test"] 03:07:24 INFO - --app=APP Application being installed. [default: firefox] 03:07:24 INFO - mkdir: /builds/slave/test/build/application 03:07:24 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'] 03:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:07:42 INFO - Reading from file tmpfile_stdout 03:07:42 INFO - Output received: 03:07:42 INFO - /builds/slave/test/build/application/firefox/firefox 03:07:42 INFO - Running post-action listener: _resource_record_post_action 03:07:42 INFO - [mozharness: 2017-07-30 10:07:42.201052Z] Finished install step (success) 03:07:42 INFO - [mozharness: 2017-07-30 10:07:42.201202Z] Running setup-mitmproxy step. 03:07:42 INFO - Running pre-action listener: _resource_record_pre_action 03:07:42 INFO - Running main action method: setup_mitmproxy 03:07:42 INFO - Skipping: mitmproxy is not required 03:07:42 INFO - Running post-action listener: _resource_record_post_action 03:07:42 INFO - [mozharness: 2017-07-30 10:07:42.202776Z] Finished setup-mitmproxy step (success) 03:07:42 INFO - [mozharness: 2017-07-30 10:07:42.203091Z] Running run-tests step. 03:07:42 INFO - Running pre-action listener: _resource_record_pre_action 03:07:42 INFO - Running pre-action listener: _set_gcov_prefix 03:07:42 INFO - Running main action method: run_tests 03:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:07:42 INFO - Python 2.7.3 03:07:42 INFO - Return code: 0 03:07:42 INFO - grabbing minidump binary from tooltool 03:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:42 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 0x1db4eb0>, '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 0x1db5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db6240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:07:42 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 03:07:42 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 03:07:42 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 03:07:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:07:42 INFO - Return code: 0 03:07:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:07:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:07:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:07:42 INFO - ENV: RUST_BACKTRACE is now 1 03:07:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:07:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 03:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 03:07:42 INFO - Using env: {'DISPLAY': ':0', 03:07:42 INFO - 'HOME': '/home/cltbld', 03:07:42 INFO - 'LANG': 'en_US.UTF-8', 03:07:42 INFO - 'LANGUAGE': 'en_US:en', 03:07:42 INFO - 'LOGNAME': 'cltbld', 03:07:42 INFO - 'MAIL': '/var/mail/cltbld', 03:07:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:07:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:42 INFO - 'MOZ_NO_REMOTE': '1', 03:07:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:42 INFO - 'NO_EM_RESTART': '1', 03:07:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:42 INFO - 'PWD': '/builds/slave/test', 03:07:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:07:42 INFO - 'RUST_BACKTRACE': '1', 03:07:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:07:42 INFO - 'SHELL': '/bin/bash', 03:07:42 INFO - 'SHLVL': '1', 03:07:42 INFO - 'STYLO_FORCE_ENABLED': '1', 03:07:42 INFO - 'TERM': 'linux', 03:07:42 INFO - 'TMOUT': '86400', 03:07:42 INFO - 'USER': 'cltbld', 03:07:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613', 03:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:42 INFO - '_': '/tools/buildbot/bin/python'} 03:07:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 03:07:42 INFO - mozversion application_buildid: 20170730091942 03:07:42 INFO - mozversion application_changeset: 8b577b152383f5560ab57fdc307fa872cd268ea7 03:07:42 INFO - mozversion application_display_name: Nightly 03:07:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:07:42 INFO - mozversion application_name: Firefox 03:07:42 INFO - mozversion application_remotingname: firefox 03:07:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:07:42 INFO - mozversion application_vendor: Mozilla 03:07:42 INFO - mozversion application_version: 56.0a1 03:07:42 INFO - mozversion platform_buildid: 20170730091942 03:07:42 INFO - mozversion platform_changeset: 8b577b152383f5560ab57fdc307fa872cd268ea7 03:07:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:07:42 INFO - mozversion platform_version: 56.0a1 03:07:42 INFO - using testdate: 1501409262 03:07:42 INFO - actual date: 1501409262 03:07:42 INFO - starting webserver on 'localhost:49623' 03:07:42 INFO - SUITE-START | Running 2 tests 03:07:42 INFO - TEST-START | dromaeo_css 03:07:42 INFO - Initialising browser for dromaeo_css test... 03:07:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49623/getInfo.html -profile /tmp/tmpHtJaae/profile 03:07:42 INFO - TEST-INFO | started process 3365 (/builds/slave/test/build/application/firefox/firefox http://localhost:49623/getInfo.html) 03:07:51 INFO - TEST-INFO | 3365: exit 0 03:07:51 INFO - Browser initialized. 03:07:51 INFO - Running cycle 1/1 for dromaeo_css test... 03:07:51 INFO - TEST-INFO | started process 3593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHtJaae/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:07:52 INFO - PID 3593 | 03:07:52 INFO - PID 3593 | (/builds/slave/test/build/application/firefox/firefox:3647): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:07:52 INFO - PID 3593 | 03:08:02 INFO - PID 3593 | RSS: Main: 173309952 03:08:02 INFO - PID 3593 | 03:11:02 INFO - PID 3593 | Cycle 1(1): loaded http://localhost:49623/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49623/tests/dromaeo/cssquery-ext.html) 03:11:03 INFO - PID 3593 | RSS: Main: 175415296 03:11:03 INFO - PID 3593 | 03:14:05 INFO - PID 3593 | Cycle 1(1): loaded http://localhost:49623/tests/dromaeo/cssquery-ext.html (next: http://localhost:49623/tests/dromaeo/cssquery-jquery.html) 03:14:06 INFO - PID 3593 | RSS: Main: 171712512 03:14:06 INFO - PID 3593 | 03:17:08 INFO - PID 3593 | Cycle 1(1): loaded http://localhost:49623/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49623/tests/dromaeo/cssquery-mootools.html) 03:17:08 INFO - PID 3593 | RSS: Main: 175190016 03:17:08 INFO - PID 3593 | 03:20:10 INFO - PID 3593 | Cycle 1(1): loaded http://localhost:49623/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49623/tests/dromaeo/cssquery-prototype.html) 03:20:11 INFO - PID 3593 | RSS: Main: 173670400 03:20:11 INFO - PID 3593 | 03:23:15 INFO - PID 3593 | Cycle 1(1): loaded http://localhost:49623/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49623/tests/dromaeo/cssquery-yui.html) 03:23:16 INFO - PID 3593 | RSS: Main: 175374336 03:23:16 INFO - PID 3593 | 03:26:17 INFO - PID 3593 | Cycle 1(1): loaded http://localhost:49623/tests/dromaeo/cssquery-yui.html (next: http://localhost:49623/tests/dromaeo/cssquery-dojo.html) 03:26:18 INFO - PID 3593 | RSS: Main: 176484352 03:26:18 INFO - PID 3593 | 03:26:18 INFO - PID 3593 | __start_tp_report 03:26:18 INFO - PID 3593 | _x_x_mozilla_page_load 03:26:18 INFO - PID 3593 | _x_x_mozilla_page_load_details 03:26:18 INFO - PID 3593 | |i|pagename|runs| 03:26:18 INFO - PID 3593 | |0;dojo.html;3101.519264513998;3135.9372812543766;3154.05378386484;3166.984165079175;3169.3344397676487;6004.699765011754;6045.274567051949;6064.969675151624;6067.24159480065;6109.663968481732;6062.696865156747;6083.239595050619;6106.755729770804;6114.296855861578;6120.2043734314475;5571.888562228753;5589.524890384322;5614.691191984439;5627.409122042188;5657.688827114507;5615.2700148980575;5626.381098079229;5632.633878797886;5661.0376236039765;5698.373178950312;5584.664920104807;5655.57583181261;5663.037283661767;5675.035244008528;5698.857528561778;5541.806036788693;5591.077472217079;5628.127640215773;5633.464820842013;5703.657780533182;5447.101228297326;5448.346198456171;5467.808626698086;5509.724513774336;5568.081266591008;5917.467427931464;5953.196318496991;6014.278286605591;6025.216721826178;6075.422834830684;6489;6512.902306465407;6526.543141980063;6573.211214654224;6599.934000660028;6452.516061295421;6531.183602049744;6573.375529324754;6628.4697224221945;6630.602163870135;6126.724297406628;6127;6128.38716128388;6132.202813634243;6145.877082458326;6822.590644561342;6828.283030281848;6853.280405557444;6863.485238607024;6866.793996180123;6359.109724638462;6387.936120638734;6396.552241343062;6482.67586620667;6491.772787952494;6302.432781049728;6469.514786390945;6547.574407663486;6559.704813283413;6584.473242140617;6402.647854368054;6441.452476539453;6484.740610375532;6497.122888410004;6522.673866306665;6484.773032943825;6544.443722283564;6557.049227861933;6578.440832529192;6582.275949645536;5304.07178743726;5384.434634363413;5402.648827826179;5403.864903377447;5404.459554044564;4587.6788624795945;4620.468646105741;4639.188142075123;4660;4666.183417901853;5641.323041235078;5718.628289161191;5736.799212027559;5774;5863.677497737665;6486.4486518646445;6489.383508566679;6501.447376972916;6507.284198738135;6574.8356291093105;5774.900971914778;5833.4749872511675;5859.150423188699;5859.501942334864;5862.8534286642325;5914.8817023659285;5932.406759324033;5938.435848594377;5956.0768080946655;5962.522998160137;6477.514186436036;6563.474922006228;6575.210974682973;6585.86828263432;6599.505037122235;6513.967430162914;6545.37818907203;6545.901811472927;6595.307492713388;6620.702068406837;6309.400606942333;6450.387213214737;6452.354764523698;6562.967185164043;6569.9014514783275;6476.384743449365;6480.092787009917;6486.318936511599;6493.253275873146;6494.837629059122;6128.66292353907;6481.773137940149;6509.609423434609;6515.0553169791065;6543.836404089936;6234.906476402948;6378.872422551616;6404.356841290028;6455.3221911700475;6455.4512866405;6274.341194174546;6315.115883776367;6317.778877739441;6318.968405157945;6325.082862984749;6223;6225.439710426083;6226.128342032029;6226.50187984951;6263.68681565929;6184.5980011299125;6272;6282.434580887742;6376.458001069961;6394.520410969103;6179.2584889811715;6198.81403557894;6211.844703882439;6281.340459251713;6294.087357333253 03:26:18 INFO - PID 3593 | |1;ext.html;824.381713714714;837.6984285657167;861.6381119929629;882.488156869016;899.1233547291388;39758.2048359033;40522.79738601303;40527.59472405275;40533.797331013375;40579.18841623166;37091.44362834553;37318.253634927285;37389.25221495568;37498;37505.43741843875;6960.164780226367;7084.752033678822;7106.5736055836815;7107.218205997337;7108.147022357324;6968.989496523001;7049;7052.047973523586;7052.3652871241575;7055.153381594216;7686.192949740281;7831.138574756772;7853.018372703412;7864.764057078268;7895;7792.493487923295;7818.80452988677;7826.921730782677;7829.3736501079775;7840.686372545091;7475.588842613654;7646.808829779245;7648;7687.577183254919;7750.612469376565;38046;38205;38356.04109897247;38440.03899902497;38463.807680961414;3482.5995010573856;3561.12752375667;3566.554180727409;3572.1248294167835;3572.356975744365;31068.533971990437;31186.376272474652;31198.22004449884;31217.687823121705;31234.219144521343;4779.522047795227;4836.129496690594;4849.9757501212625;4867.196912509432;4896.804127834882;178596;181490;183518;185335;190168.9999999986;47418;47542.76228618904;47663.28505072427;47762.52237477581;47821;49884;50414.243786343235;50423.495765042615;50453.74773126111;50527.74736126296;15400.460983865734;15505.767413488808;15539;15578.454754083552;15684;12834.935825321001;12897.806532902014;12926.870731292754;12993;13241.933790330986;13924.512642057682;13955.79066314006;14033.719325613634;14113.506027288995;14167.291635418187;5885.882282354329;5930.436608522184;5932.762689492458;5937.9406205937385;5943.138244954457;976.8167499726712;979.1236843025595;989.2926557511414;1017.1964148322742;1029.2126523209752;21730.782692172877;21755.782442175692;21956.341309760734;22141.778582214294;22242.332730018126;1073.8295258168635;1074.6131392698621;1101.6309536305266;1123.4158237716342;1128.0468004536153;11649.825252621218;11678.182527223184;11831.230969986924;11894.583689570823;11928.522859085539;207615;208710;209416;209448;209469;49574.50425495699;49796.50203497919;50047;50169.498305017216;50584;1402.3408997771032;1467.2736995187663;1490.3516970117817;1492.7760835874487;1497.4234919555831;21646.614248796326;21769.782302176776;22074.22740204085;22195.22316718907;22361.105555777587;35308.11729706778;35651.10872228111;35692.28615427729;35742;35781.10547236236;176118;202404;207620;207642;207654;31193;31788.682113179497;34590.308193836485;35206.47190292199;35321.64678353183;45010;45245.77377113093;45304.54695453003;45355.31967020563;45563.31655025111;31345.373092537564;31694.524582131748;31807.84096079505;31829;31990.52014219742;29783.851080744458;31051.844740776152;31609.683903160672;31661.366772663958;31663.683363166074;35324.82337588296;36050.45924311085;36138.45792313065;36420.63579364278;36552.63447365492;31587;32136.35727285488;32237.710491580074;32552.674473255913;32860.34279314448;22269.888650556644;23682.88158559196;23774.643380348964;23922.043118275073;23923.521529568963 03:26:18 INFO - PID 3593 | |2;jquery.html;573.8450618333047;577.6129992904754;582.3157789597223;598.2073752278231;600.5945986459141;22207.22274720385;22989.655155172684;23007;23092;23122.306330810083;24328;26434.339141521472;26581.202563923063;26637.334066648342;26648.866755666193;6564.277929427771;6749.898751518731;6756.087928129688;6766.594004359729;6776.728930842785;6155.953487907066;6493.285738568754;6493.383128602775;6622.966885165568;6692.665366731669;6427.292997770265;6444.548881578291;6445.387688169616;6451.83870403239;6462.870742585145;6449.35506449356;6472.838179045514;6475.643839588821;6476.708548115323;6479.578827376229;6013.308469525973;6035.094735789623;6038.245219347582;6050.062240352752;6064.272287325505;28320.71679283222;29094;29638;29684.109476715734;29877.40245195084;1861.7486639303656;1932.7584051993501;1933.1880610143774;1934.110309257729;1934.8258656720964;18482.260709571736;18797.436076917715;19047.619047619108;19105.713414298796;19132.61734765297;2361.1381845626393;2377.0135393811547;2420.649005894153;2432.987835060831;2437.695288088989;141834;146567;146775;147250;147444.2627786865;14509.419623215164;14851.777223341658;14887.627809304853;15265.847341526665;15290.464833730988;23888.28335149948;23964.281071567882;23967.400814979766;23996;24014.39964000914;9275.72172834816;9518.896934827977;9534.189593884597;9596.136347728738;9638.373505722106;8428.747137585882;8522.10517895612;8578.18507241811;8660.610272537624;8673.306135509145;7732.806679832936;8921;9081.046490118575;9222.354435189607;9394.295427842939;2690.233283514189;2707.742764437375;2709.986450067737;2725.3459169799107;2728.4133911209187;930.8091841172543;934.3693007220235;952.514217748953;961.2502248246379;961.9374740641836;18818.623627527373;18835.71746423805;18916;19684.901575492317;24735.38161545976;999.0808456220295;1000.2448151645461;1017.2624846986024;1035.177034257767;1049.506731836036;10262.179025678077;11126.332420054823;11170.664880053611;11236.269642473213;11335.886641133648;498499;505457;512978;513284;515602;119898;121059;121103;121463;122871;1265.9620211393674;1293.2822283632674;1309.070559902461;1311.8229039079793;1321.378951892609;16959.321627134777;17604.207810648808;17740.20169092368;18075;18572.535686607942;56668;56840.14739778989;58273.70863145827;58544;58797.412025880905;71241.6437917807;71732.64133679507;71917.6404117976;72000.63999679968;73315.63342183255;19884;20868.165273388895;20888.37334879956;20901.581968360853;21106.472338191666;22937.770622293563;23308.76691233066;23314.300570982898;23465.530689386458;23730;17573.384931527336;17952.820471795116;18230;18253.54366140857;18287.725684115016;13966.930165349515;15071.246437677853;15136.848631513985;15155.848441515443;15513.534593962198;17098.316067357664;17463.47609571715;17484.038377889337;17816.91091544534;17885.37401190952;20111;20416.387508374773;20429.897850510653;20472.79527204709;20481.38555843327;16960.406385776438;17012.234449449556;17182.140892955053;17324.39364622232;17325.393611223546 03:26:18 INFO - PID 3593 | |3;mootools.html;1375.4773186189248;1408.0706733555855;1416.7591509443396;1431.685029293555;1441.0777102654297;13798.44806207753;14093.154410735364;14698.485553005634;14796.112233265998;14799.186044767534;14449.205293708868;14823.92588037061;14828.110313381205;14852.183129927877;14855.405783768663;2749.587561865726;2798.9720102799015;2803.4673412051748;2803.5654473556633;2806.2423145750636;2686.1807148819603;2797.049003338864;2818.6335776349047;2820.873060712273;2828.5332920068163;2651.2576478586025;2673.5588627876473;2687.9596806047825;2692.6634170728657;2700.486907487581;2669.292637451077;2673.131232349494;2677.772389346908;2707.323169207698;2717.9320516987136;2601.648777415063;2650.628911952309;2653.1907768130714;2657.22940347301;2669.079167687145;14043.719125617532;14215.076020058663;14291.356888940023;14329.928350358286;14337.928310358486;7375.59434231117;7572.318491335806;7582.279683430121;7630.351420129296;7648.38812894967;4961.826336078256;5132;5262.947370526284;5278.709670968095;5279.5512381447625;1703.1484257871064;1745.1797655102082;1749.160403006564;1797.8471829894474;1812.392848395789;23272;23500.059997600074;23506.412339691473;23583.882080589658;23615.17346892868;6792.524523283421;7013.26360732126;7187.353138217481;7218.8917166242545;7275.381592564586;14906.552803415914;14982.550523484313;15039.548813535612;15053.172075535951;15055.171965541782;7612.429067819825;7707.421943354271;7737.3036426721865;7794.2985131338455;7805.726799561988;7029.086218791626;7073.504854660125;7080.36276735086;7244.058272424551;7265.782026539212;4955.306257124005;5063.164577844688;5113.718745469035;5151.871203219875;5151.948480515147;1455.4105587237186;1481.0891301849285;1487.1969136666296;1506.0662389318475;1506.563096701966;818.5825229133185;820.8727647214691;830.0371568980075;837.4933165434946;856.486108334994;6485.578437401554;6575.276719560845;6747.797566073025;6756.5608235465525;6767.120274364301;688.2841844481783;696.6934548798513;703.6270776488469;711;719.4460265595462;4040.9797951010055;4123.474314503593;4234.301340278819;4252.87241382759;4256.297710877732;18110.818891811177;19372.321968731027;20026.098825552886;20253.29113481021;20255.29106481266;18939.85942721839;19032.33386831454;19271.807281927282;19316.42050738452;19408.4177474676;9686.854697179548;10266.6406675766;10335.328203666737;10369.481525923673;10402.323848949794;6905.654717264017;7371.778846634609;7537.54774713519;7808.063032435917;7915.643796029308;16407.67184656324;16456.09491477932;16726.916365418096;16755.664886701954;17797.644047118727;17485.737713934555;17489.038102903953;17588.2085306159;17695.734563981292;17816.91091544534;10577.100946419332;10859;10947.45262736844;10958.28771129874;10961.835572466578;13098.934505327412;13147.474101035852;13515.932420337835;13624.65938351549;13742.65643358924;10922.453877305945;10997.395143266876;11279.266847654877;11420.885791142315;11453.427328633701;10866.07638350749;11034.17243706709;11176.944115279372;11198.88801112011;11445.084393248353;9028.683996060106;9076.954615227145;9113.3165012623;9420.57607407682;9424.764380890258;6459.257185423548;6940.7917762467205;6968.442524597918;6982.1272340957385;7008.614526201108;6339.144215530844;6374;6738.7304507819135;6750.662466876538;6859.485538584527 03:26:18 INFO - PID 3593 | |4;prototype.html;492.1412135822988;511.1744532579882;531.2748098845076;533.6531254684458;538.6283464409557;5914.34942156363;5989.1315759214995;6036.4868986136125;6053.2130822993;6094.26868775747;5627.43725627437;5842.020569509549;5844.970775146129;5900.586958912867;5944.346121926585;4783.641226907987;4792.353032340624;4811.182099043171;4858.41698996121;4864.635152363569;4785.353977213066;4787.593054590347;4824.348712923763;4832.7583620819;4848;4637.489876113625;4727.739974301412;4731.668783185179;4732.929006064912;4787.80848766049;4751.976240118812;4753.239481682931;4769.3322934788985;4781.450133234688;4791.904161916742;4307.504636966726;4321.848735294281;4331.610155086026;4359.106383191438;4362.694611377205;5853.882922341572;5858.297004359504;5859.9159155555935;5889.617174883619;5949.315828679671;5406.162044883049;5489.752961116759;5518.19986102017;5537.556995440355;5556.749946252388;6234.906476402857;6280.434760871498;6303.5272354573135;6319.8736025279695;6344.904826427607;4729.787159577827;4731.976340118277;4746.264329029006;4766.785494652749;4768.976155119237;6558;6573.605583664996;6704.195496540447;6716.395524402778;6775.254721980578;4821.397325334333;4821.421429428491;4882.9491613522405;4893.119238537098;4903.239997800347;4896.534829191221;4944.75276236194;4958.380202474691;4978.103941290602;4998.500149984972;5415.675059496364;5488.286522752017;5494.5054945055135;5570.721463926869;5575.881165157295;6276.780312689125;6276.874462510724;6336.303006669263;6340.778072767431;6375;1626.1950334584456;1641.4501142117524;1664.7086759816984;1686.1906284983277;1699.5156380431517;1191.66037679261;1203.789336866045;1213.1689792491995;1213.4842691855927;1222.370479203211;5595.944040559623;5663.32040155184;5669.971650141805;5676.716164191774;5701.971490142523;6428.8071357859335;6436.806895793134;6535;6555.901661475082;6560.573562718408;5735.799247026334;5740.770369185186;5747.252857128547;5762.798302059492;5762.942370576325;3460.982695086559;3468.150303175738;3479.2867462170193;3480.077779388464;3492.5634295713035;6442.226932768098;6470.741170353133;6489.545731798823;6501.902471462932;6515.934840651627;6598;6607.57050791697;6673.499487538454;6729.22613899398;6740.191177058784;6296.811095666954;6350.269718982284;6375.968120159369;6408.359164083555;6448.9355106449275;6447.0336547351635;6540.74344351198;6587;6602.207735071822;6618.0403841443685;6368.331325210971;6451.935480645321;6456.9354306456335;6494.155759751202;6508.707108180049;6389.233292004989;6423.325550817097;6423.811594854967;6478.935210647834;6489.610623362613;4847.061175529675;4852.8786780329365;4874.122657921466;4875.317455556154;4882.389701287339;6417.7753778617525;6434.388733070351;6457.870842583216;6480.481561475165;6491.707873145625;6268.4671802897265;6277.5605707600025;6292.4651404629285;6296.370362963667;6312.873742525216;5979;6161.907571386343;6334.113224148715;6337.556371054166;6434.324395938546;6015.924506045408;6033.952853808799;6128.8774224516155;6238.157848690369;6289.9056514153235;6212.223472065992;6222.937770622417;6287.245530536365;6300.275468321019;6316.3367846377305;6037.18498002764;6089.208402907594;6099.878002440015;6107.725152368243;6117.816465506042 03:26:18 INFO - PID 3593 | |5;yui.html;892.1836519584581;906.1663269791791;923.4044041593171;924.8381533231683;927.5084205371152;16717.74923376149;17417.12914354282;17435.56411089722;17441;21327.893360533177;19460.708089378637;20886;21269.149234030658;21277.14891404342;21299;1021.2442792333694;1044.3785947361307;1044.8119338519064;1045.0176833776227;1050.3015494696017;1050.3907733514543;1052.4790228836698;1053.6470282455386;1053.7207639975413;1053.7945100705365;1071.3786004117594;1074.6131392698621;1074.6292529077455;1076.531708706715;1078.4931082391304;1068.3002633275216;1073.6617965340931;1073.9301945373525;1082.0207712020633;1083.653230966091;792.5442870349515;796.625585974591;796.9322607578363;798.1419973528422;801.1707882341748;16354.836451635569;16991.15044247795;17172.82827171737;18036.27854885803;18121.637567248712;20354;20520.79479205204;21039.5792084159;21087.68368474474;21100;15505.147216903066;16000;16122.596935076599;16193.352265909349;16203.756943645854;3405.216800135983;3420.247545539977;3422.366862130489;3425.5718035245595;3428.0401487583517;117926;121680.39159804233;122334;124519.3774031124;125190;16534;16887.408940687263;17079.146042698063;17087.743683844754;17092.743608845878;28942.27644308867;30802.38395232083;30947.13160854893;30959.0712278632;31001.759929603013;7904.4071694623135;8250.216229458192;8308.792280193044;8494.830103397897;8712.564371781513;4169.854055108057;4264.296391095435;4275.1022285319805;4283.100548884707;4286.485621725413;4813.9037219255415;4850.005748821483;4903.068417000758;4909.484504127086;4978.477259887732;1071.614218881202;1089.7112265249716;1091.2197778588347;1094.3980810554162;1095.2990086344746;679.3851564334285;684.7397988764237;694.121935751275;697.9616121113387;700.9905735740517;10235.7441063974;11211.831822522669;11753.647390578297;11985;12273.938630306791;603.1856993059334;617.6355949989528;635.1203583037434;638.5274896576593;698.6367089113633;5058.64589478733;5237.764300606482;5321.304703635856;5331.947200327902;5876.206712093898;95077.52461237788;96734.5163274179;96844;98280;101437.49281253546;83630;86773.56613217019;88416.55791721;89775.55112224397;91559;74397.62801185959;74980.62509687417;78164.60917695375;78326.60836695781;80146;11365.659030229106;11467.942660286646;11478.016418527808;12009.159358844798;12119.81820272679;32109.197270068435;33510.497342540366;33691.663083368854;34183.82908085543;35894.641053590174;65341.67329163324;66146.66926665336;66159.00761488485;67533;73122.26877731155;17582;17995.640087198444;18708.532286692942;20157.092930818442;20266.18935242574;17161;19081.809181908004;19588.8041119587;21777.891110544348;21911;19258.133383998033;19267.421977340702;19543.315983940494;19711.802881970998;20437.89781051085;19552.8044719551;19581.804181958567;19767.703484448033;19976.90011549933;20455.4886127848;18232.90883545574;18248.36130735471;18440.815591844446;18858.434246972614;19489.122989465224;12463.252204867737;13036.804447933479;13374.465021399035;13709.108907920952;13825.10136841102;13480.797788033384;14493.130412175304;14804.925975370053;15344.616384590474;15397 03:26:18 INFO - PID 3593 | __end_tp_report 03:26:18 INFO - PID 3593 | __start_cc_report 03:26:18 INFO - PID 3593 | _x_x_mozilla_cycle_collect,359 03:26:18 INFO - PID 3593 | __end_cc_report 03:26:18 INFO - PID 3593 | __startTimestamp1501410378168__endTimestamp 03:26:18 INFO - PID 3593 | 03:26:18 INFO - PID 3593 | ------- Summary: start ------- 03:26:18 INFO - PID 3593 | Number of tests: 6 03:26:18 INFO - PID 3593 | 03:26:18 INFO - PID 3593 | [#0] dojo.html Cycles:165 Average:6041.53 Median:6226.13 stddev:690.06 (11.1%) stddev-sans-first:652.49 03:26:18 INFO - PID 3593 | Values: 3101.5 3135.9 3154.1 3167.0 3169.3 6004.7 6045.3 6065.0 6067.2 6109.7 6062.7 6083.2 6106.8 6114.3 6120.2 5571.9 5589.5 5614.7 5627.4 5657.7 5615.3 5626.4 5632.6 5661.0 5698.4 5584.7 5655.6 5663.0 5675.0 5698.9 5541.8 5591.1 5628.1 5633.5 5703.7 5447.1 5448.3 5467.8 5509.7 5568.1 5917.5 5953.2 6014.3 6025.2 6075.4 6489.0 6512.9 6526.5 6573.2 6599.9 6452.5 6531.2 6573.4 6628.5 6630.6 6126.7 6127.0 6128.4 6132.2 6145.9 6822.6 6828.3 6853.3 6863.5 6866.8 6359.1 6387.9 6396.6 6482.7 6491.8 6302.4 6469.5 6547.6 6559.7 6584.5 6402.6 6441.5 6484.7 6497.1 6522.7 6484.8 6544.4 6557.0 6578.4 6582.3 5304.1 5384.4 5402.6 5403.9 5404.5 4587.7 4620.5 4639.2 4660.0 4666.2 5641.3 5718.6 5736.8 5774.0 5863.7 6486.4 6489.4 6501.4 6507.3 6574.8 5774.9 5833.5 5859.2 5859.5 5862.9 5914.9 5932.4 5938.4 5956.1 5962.5 6477.5 6563.5 6575.2 6585.9 6599.5 6514.0 6545.4 6545.9 6595.3 6620.7 6309.4 6450.4 6452.4 6563.0 6569.9 6476.4 6480.1 6486.3 6493.3 6494.8 6128.7 6481.8 6509.6 6515.1 6543.8 6234.9 6378.9 6404.4 6455.3 6455.5 6274.3 6315.1 6317.8 6319.0 6325.1 6223.0 6225.4 6226.1 6226.5 6263.7 6184.6 6272.0 6282.4 6376.5 6394.5 6179.3 6198.8 6211.8 6281.3 6294.1 03:26:18 INFO - PID 3593 | 03:26:18 INFO - PID 3593 | [#1] ext.html Cycles:180 Average:36447.00 Median:19606.12 stddev:51262.58 (261.5%) stddev-sans-first:51336.60 03:26:18 INFO - PID 3593 | Values: 824.4 837.7 861.6 882.5 899.1 39758.2 40522.8 40527.6 40533.8 40579.2 37091.4 37318.3 37389.3 37498.0 37505.4 6960.2 7084.8 7106.6 7107.2 7108.1 6969.0 7049.0 7052.0 7052.4 7055.2 7686.2 7831.1 7853.0 7864.8 7895.0 7792.5 7818.8 7826.9 7829.4 7840.7 7475.6 7646.8 7648.0 7687.6 7750.6 38046.0 38205.0 38356.0 38440.0 38463.8 3482.6 3561.1 3566.6 3572.1 3572.4 31068.5 31186.4 31198.2 31217.7 31234.2 4779.5 4836.1 4850.0 4867.2 4896.8 178596.0 181490.0 183518.0 185335.0 190169.0 47418.0 47542.8 47663.3 47762.5 47821.0 49884.0 50414.2 50423.5 50453.7 50527.7 15400.5 15505.8 15539.0 15578.5 15684.0 12834.9 12897.8 12926.9 12993.0 13241.9 13924.5 13955.8 14033.7 14113.5 14167.3 5885.9 5930.4 5932.8 5937.9 5943.1 976.8 979.1 989.3 1017.2 1029.2 21730.8 21755.8 21956.3 22141.8 22242.3 1073.8 1074.6 1101.6 1123.4 1128.0 11649.8 11678.2 11831.2 11894.6 11928.5 207615.0 208710.0 209416.0 209448.0 209469.0 49574.5 49796.5 50047.0 50169.5 50584.0 1402.3 1467.3 1490.4 1492.8 1497.4 21646.6 21769.8 22074.2 22195.2 22361.1 35308.1 35651.1 35692.3 35742.0 35781.1 176118.0 202404.0 207620.0 207642.0 207654.0 31193.0 31788.7 34590.3 35206.5 35321.6 45010.0 45245.8 45304.5 45355.3 45563.3 31345.4 31694.5 31807.8 31829.0 31990.5 29783.9 31051.8 31609.7 31661.4 31663.7 35324.8 36050.5 36138.5 36420.6 36552.6 31587.0 32136.4 32237.7 32552.7 32860.3 22269.9 23682.9 23774.6 23922.0 23923.5 03:26:18 INFO - PID 3593 | 03:26:18 INFO - PID 3593 | [#2] jquery.html Cycles:180 Average:35935.91 Median:23926.28 stddev:85946.15 (359.2%) stddev-sans-first:86146.25 03:26:18 INFO - PID 3593 | Values: 573.8 577.6 582.3 598.2 600.6 22207.2 22989.7 23007.0 23092.0 23122.3 24328.0 26434.3 26581.2 26637.3 26648.9 6564.3 6749.9 6756.1 6766.6 6776.7 6156.0 6493.3 6493.4 6623.0 6692.7 6427.3 6444.5 6445.4 6451.8 6462.9 6449.4 6472.8 6475.6 6476.7 6479.6 6013.3 6035.1 6038.2 6050.1 6064.3 28320.7 29094.0 29638.0 29684.1 29877.4 1861.7 1932.8 1933.2 1934.1 1934.8 18482.3 18797.4 19047.6 19105.7 19132.6 2361.1 2377.0 2420.6 2433.0 2437.7 141834.0 146567.0 146775.0 147250.0 147444.3 14509.4 14851.8 14887.6 15265.8 15290.5 23888.3 23964.3 23967.4 23996.0 24014.4 9275.7 9518.9 9534.2 9596.1 9638.4 8428.7 8522.1 8578.2 8660.6 8673.3 7732.8 8921.0 9081.0 9222.4 9394.3 2690.2 2707.7 2710.0 2725.3 2728.4 930.8 934.4 952.5 961.3 961.9 18818.6 18835.7 18916.0 19684.9 24735.4 999.1 1000.2 1017.3 1035.2 1049.5 10262.2 11126.3 11170.7 11236.3 11335.9 498499.0 505457.0 512978.0 513284.0 515602.0 119898.0 121059.0 121103.0 121463.0 122871.0 1266.0 1293.3 1309.1 1311.8 1321.4 16959.3 17604.2 17740.2 18075.0 18572.5 56668.0 56840.1 58273.7 58544.0 58797.4 71241.6 71732.6 71917.6 72000.6 73315.6 19884.0 20868.2 20888.4 20901.6 21106.5 22937.8 23308.8 23314.3 23465.5 23730.0 17573.4 17952.8 18230.0 18253.5 18287.7 13966.9 15071.2 15136.8 15155.8 15513.5 17098.3 17463.5 17484.0 17816.9 17885.4 20111.0 20416.4 20429.9 20472.8 20481.4 16960.4 17012.2 17182.1 17324.4 17325.4 03:26:18 INFO - PID 3593 | 03:26:18 INFO - PID 3593 | [#3] mootools.html Cycles:180 Average:8686.00 Median:2671.21 stddev:6029.51 (225.7%) stddev-sans-first:6021.40 03:26:18 INFO - PID 3593 | Values: 1375.5 1408.1 1416.8 1431.7 1441.1 13798.4 14093.2 14698.5 14796.1 14799.2 14449.2 14823.9 14828.1 14852.2 14855.4 2749.6 2799.0 2803.5 2803.6 2806.2 2686.2 2797.0 2818.6 2820.9 2828.5 2651.3 2673.6 2688.0 2692.7 2700.5 2669.3 2673.1 2677.8 2707.3 2717.9 2601.6 2650.6 2653.2 2657.2 2669.1 14043.7 14215.1 14291.4 14329.9 14337.9 7375.6 7572.3 7582.3 7630.4 7648.4 4961.8 5132.0 5262.9 5278.7 5279.6 1703.1 1745.2 1749.2 1797.8 1812.4 23272.0 23500.1 23506.4 23583.9 23615.2 6792.5 7013.3 7187.4 7218.9 7275.4 14906.6 14982.6 15039.5 15053.2 15055.2 7612.4 7707.4 7737.3 7794.3 7805.7 7029.1 7073.5 7080.4 7244.1 7265.8 4955.3 5063.2 5113.7 5151.9 5151.9 1455.4 1481.1 1487.2 1506.1 1506.6 818.6 820.9 830.0 837.5 856.5 6485.6 6575.3 6747.8 6756.6 6767.1 688.3 696.7 703.6 711.0 719.4 4041.0 4123.5 4234.3 4252.9 4256.3 18110.8 19372.3 20026.1 20253.3 20255.3 18939.9 19032.3 19271.8 19316.4 19408.4 9686.9 10266.6 10335.3 10369.5 10402.3 6905.7 7371.8 7537.5 7808.1 7915.6 16407.7 16456.1 16726.9 16755.7 17797.6 17485.7 17489.0 17588.2 17695.7 17816.9 10577.1 10859.0 10947.5 10958.3 10961.8 13098.9 13147.5 13515.9 13624.7 13742.7 10922.5 10997.4 11279.3 11420.9 11453.4 10866.1 11034.2 11176.9 11198.9 11445.1 9028.7 9077.0 9113.3 9420.6 9424.8 6459.3 6940.8 6968.4 6982.1 7008.6 6339.1 6374.0 6738.7 6750.7 6859.5 03:26:18 INFO - PID 3593 | 03:26:18 INFO - PID 3593 | [#4] prototype.html Cycles:180 Average:5338.71 Median:5874.77 stddev:1495.11 (25.4%) stddev-sans-first:1454.38 03:26:18 INFO - PID 3593 | Values: 492.1 511.2 531.3 533.7 538.6 5914.3 5989.1 6036.5 6053.2 6094.3 5627.4 5842.0 5845.0 5900.6 5944.3 4783.6 4792.4 4811.2 4858.4 4864.6 4785.4 4787.6 4824.3 4832.8 4848.0 4637.5 4727.7 4731.7 4732.9 4787.8 4752.0 4753.2 4769.3 4781.5 4791.9 4307.5 4321.8 4331.6 4359.1 4362.7 5853.9 5858.3 5859.9 5889.6 5949.3 5406.2 5489.8 5518.2 5537.6 5556.7 6234.9 6280.4 6303.5 6319.9 6344.9 4729.8 4732.0 4746.3 4766.8 4769.0 6558.0 6573.6 6704.2 6716.4 6775.3 4821.4 4821.4 4882.9 4893.1 4903.2 4896.5 4944.8 4958.4 4978.1 4998.5 5415.7 5488.3 5494.5 5570.7 5575.9 6276.8 6276.9 6336.3 6340.8 6375.0 1626.2 1641.5 1664.7 1686.2 1699.5 1191.7 1203.8 1213.2 1213.5 1222.4 5595.9 5663.3 5670.0 5676.7 5702.0 6428.8 6436.8 6535.0 6555.9 6560.6 5735.8 5740.8 5747.3 5762.8 5762.9 3461.0 3468.2 3479.3 3480.1 3492.6 6442.2 6470.7 6489.5 6501.9 6515.9 6598.0 6607.6 6673.5 6729.2 6740.2 6296.8 6350.3 6376.0 6408.4 6448.9 6447.0 6540.7 6587.0 6602.2 6618.0 6368.3 6451.9 6456.9 6494.2 6508.7 6389.2 6423.3 6423.8 6478.9 6489.6 4847.1 4852.9 4874.1 4875.3 4882.4 6417.8 6434.4 6457.9 6480.5 6491.7 6268.5 6277.6 6292.5 6296.4 6312.9 5979.0 6161.9 6334.1 6337.6 6434.3 6015.9 6034.0 6128.9 6238.2 6289.9 6212.2 6222.9 6287.2 6300.3 6316.3 6037.2 6089.2 6099.9 6107.7 6117.8 03:26:18 INFO - PID 3593 | 03:26:18 INFO - PID 3593 | [#5] yui.html Cycles:180 Average:22503.60 Median:20211.64 stddev:29628.86 (146.6%) stddev-sans-first:29667.54 03:26:18 INFO - PID 3593 | Values: 892.2 906.2 923.4 924.8 927.5 16717.7 17417.1 17435.6 17441.0 21327.9 19460.7 20886.0 21269.1 21277.1 21299.0 1021.2 1044.4 1044.8 1045.0 1050.3 1050.4 1052.5 1053.6 1053.7 1053.8 1071.4 1074.6 1074.6 1076.5 1078.5 1068.3 1073.7 1073.9 1082.0 1083.7 792.5 796.6 796.9 798.1 801.2 16354.8 16991.2 17172.8 18036.3 18121.6 20354.0 20520.8 21039.6 21087.7 21100.0 15505.1 16000.0 16122.6 16193.4 16203.8 3405.2 3420.2 3422.4 3425.6 3428.0 117926.0 121680.4 122334.0 124519.4 125190.0 16534.0 16887.4 17079.1 17087.7 17092.7 28942.3 30802.4 30947.1 30959.1 31001.8 7904.4 8250.2 8308.8 8494.8 8712.6 4169.9 4264.3 4275.1 4283.1 4286.5 4813.9 4850.0 4903.1 4909.5 4978.5 1071.6 1089.7 1091.2 1094.4 1095.3 679.4 684.7 694.1 698.0 701.0 10235.7 11211.8 11753.6 11985.0 12273.9 603.2 617.6 635.1 638.5 698.6 5058.6 5237.8 5321.3 5331.9 5876.2 95077.5 96734.5 96844.0 98280.0 101437.5 83630.0 86773.6 88416.6 89775.6 91559.0 74397.6 74980.6 78164.6 78326.6 80146.0 11365.7 11467.9 11478.0 12009.2 12119.8 32109.2 33510.5 33691.7 34183.8 35894.6 65341.7 66146.7 66159.0 67533.0 73122.3 17582.0 17995.6 18708.5 20157.1 20266.2 17161.0 19081.8 19588.8 21777.9 21911.0 19258.1 19267.4 19543.3 19711.8 20437.9 19552.8 19581.8 19767.7 19976.9 20455.5 18232.9 18248.4 18440.8 18858.4 19489.1 12463.3 13036.8 13374.5 13709.1 13825.1 13480.8 14493.1 14804.9 15344.6 15397.0 03:26:18 INFO - PID 3593 | -------- Summary: end -------- 03:26:18 INFO - PID 3593 | 03:26:18 INFO - TEST-INFO | 3593: exit 0 03:26:18 INFO - TEST-OK | dromaeo_css | took 1116253ms 03:26:18 INFO - TEST-START | kraken 03:26:18 INFO - Initialising browser for kraken test... 03:26:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49623/getInfo.html -profile /tmp/tmpNC8T2a/profile 03:26:18 INFO - TEST-INFO | started process 3973 (/builds/slave/test/build/application/firefox/firefox http://localhost:49623/getInfo.html) 03:26:24 INFO - TEST-INFO | 3973: exit 0 03:26:24 INFO - Browser initialized. 03:26:24 INFO - Running cycle 1/1 for kraken test... 03:26:24 INFO - TEST-INFO | started process 4199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNC8T2a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:25 INFO - PID 4199 | 03:26:25 INFO - PID 4199 | (/builds/slave/test/build/application/firefox/firefox:4253): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:26:25 INFO - PID 4199 | 03:26:36 INFO - PID 4199 | RSS: Main: 174129152 03:26:36 INFO - PID 4199 | 03:26:38 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:49623/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49623/tests/kraken/driver.html?testName=audio-beat-detection) 03:26:39 INFO - PID 4199 | RSS: Main: 178757632 03:26:39 INFO - PID 4199 | 03:26:42 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:49623/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49623/tests/kraken/driver.html?testName=audio-dft) 03:26:43 INFO - PID 4199 | RSS: Main: 178970624 03:26:43 INFO - PID 4199 | 03:26:46 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:49623/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49623/tests/kraken/driver.html?testName=audio-fft) 03:26:46 INFO - PID 4199 | RSS: Main: 174149632 03:26:46 INFO - PID 4199 | 03:26:49 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:49623/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49623/tests/kraken/driver.html?testName=audio-oscillator) 03:26:49 INFO - PID 4199 | RSS: Main: 174182400 03:26:49 INFO - PID 4199 | 03:26:52 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:49623/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49623/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:26:52 INFO - PID 4199 | RSS: Main: 175079424 03:26:52 INFO - PID 4199 | 03:26:55 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:49623/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49623/tests/kraken/driver.html?testName=imaging-darkroom) 03:26:56 INFO - PID 4199 | RSS: Main: 177594368 03:26:56 INFO - PID 4199 | 03:26:59 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:49623/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49623/tests/kraken/driver.html?testName=imaging-desaturate) 03:27:00 INFO - PID 4199 | RSS: Main: 176775168 03:27:00 INFO - PID 4199 | 03:27:03 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:49623/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49623/tests/kraken/driver.html?testName=json-parse-financial) 03:27:04 INFO - PID 4199 | RSS: Main: 177668096 03:27:04 INFO - PID 4199 | 03:27:05 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:49623/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49623/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:27:06 INFO - PID 4199 | RSS: Main: 177197056 03:27:06 INFO - PID 4199 | 03:27:08 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:49623/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49623/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:27:09 INFO - PID 4199 | RSS: Main: 174862336 03:27:09 INFO - PID 4199 | 03:27:11 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:49623/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49623/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:27:11 INFO - PID 4199 | RSS: Main: 174874624 03:27:11 INFO - PID 4199 | 03:27:14 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:49623/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:27:15 INFO - PID 4199 | RSS: Main: 175775744 03:27:15 INFO - PID 4199 | 03:27:18 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:49623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:27:19 INFO - PID 4199 | RSS: Main: 175697920 03:27:19 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:49623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49623/tests/kraken/driver.html?testName=ai-astar) 03:27:21 INFO - PID 4199 | RSS: Main: 177311744 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | __start_tp_report 03:27:21 INFO - PID 4199 | _x_x_mozilla_page_load 03:27:21 INFO - PID 4199 | _x_x_mozilla_page_load_details 03:27:21 INFO - PID 4199 | |i|pagename|runs| 03:27:21 INFO - PID 4199 | |0;ai-astar;100;109;106;107;116;111;116;101;112;111 03:27:21 INFO - PID 4199 | |1;audio-beat-detection;155;125;148;191;119;153;158;132;169;121 03:27:21 INFO - PID 4199 | |2;audio-dft;163;165;165;161;165;167;166;170;167;165 03:27:21 INFO - PID 4199 | |3;audio-fft;76;74;74;167;75;75;75;76;168;78 03:27:21 INFO - PID 4199 | |4;audio-oscillator;79;78;136;79;79;79;123;80;79;132 03:27:21 INFO - PID 4199 | |5;imaging-gaussian-blur;115;114;114;115;114;114;113;116;115;114 03:27:21 INFO - PID 4199 | |6;imaging-darkroom;150;150;151;153;151;150;151;150;149;149 03:27:21 INFO - PID 4199 | |7;imaging-desaturate;96;94;94;93;98;100;96;95;97;94 03:27:21 INFO - PID 4199 | |8;json-parse-financial;59;58;60;58;62;62;58;60;60;60 03:27:21 INFO - PID 4199 | |9;json-stringify-tinderbox;59;55;53;54;64;60;54;54;54;53 03:27:21 INFO - PID 4199 | |10;stanford-crypto-aes;79;81;82;82;81;83;80;83;79;93 03:27:21 INFO - PID 4199 | |11;stanford-crypto-ccm;141;132;144;138;135;144;128;132;130;178 03:27:21 INFO - PID 4199 | |12;stanford-crypto-pbkdf2;177;180;179;181;185;177;186;183;181;187 03:27:21 INFO - PID 4199 | |13;stanford-crypto-sha256-iterative;69;67;68;69;70;66;74;69;68;70 03:27:21 INFO - PID 4199 | __end_tp_report 03:27:21 INFO - PID 4199 | __start_cc_report 03:27:21 INFO - PID 4199 | _x_x_mozilla_cycle_collect,977 03:27:21 INFO - PID 4199 | __end_cc_report 03:27:21 INFO - PID 4199 | __startTimestamp1501410441424__endTimestamp 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | ------- Summary: start ------- 03:27:21 INFO - PID 4199 | Number of tests: 14 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:5.51 (5.0%) stddev-sans-first:4.81 03:27:21 INFO - PID 4199 | Values: 100.0 109.0 106.0 107.0 116.0 111.0 116.0 101.0 112.0 111.0 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:154.00 stddev:23.12 (15.0%) stddev-sans-first:24.35 03:27:21 INFO - PID 4199 | Values: 155.0 125.0 148.0 191.0 119.0 153.0 158.0 132.0 169.0 121.0 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.50 stddev:2.41 (1.5%) stddev-sans-first:2.40 03:27:21 INFO - PID 4199 | Values: 163.0 165.0 165.0 161.0 165.0 167.0 166.0 170.0 167.0 165.0 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.00 stddev:38.86 (51.8%) stddev-sans-first:40.68 03:27:21 INFO - PID 4199 | Values: 76.0 74.0 74.0 167.0 75.0 75.0 75.0 76.0 168.0 78.0 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:79.00 stddev:25.00 (31.6%) stddev-sans-first:25.89 03:27:21 INFO - PID 4199 | Values: 79.0 78.0 136.0 79.0 79.0 79.0 123.0 80.0 79.0 132.0 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.84 (0.7%) stddev-sans-first:0.87 03:27:21 INFO - PID 4199 | Values: 115.0 114.0 114.0 115.0 114.0 114.0 113.0 116.0 115.0 114.0 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:1.17 (0.8%) stddev-sans-first:1.24 03:27:21 INFO - PID 4199 | Values: 150.0 150.0 151.0 153.0 151.0 150.0 151.0 150.0 149.0 149.0 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.50 stddev:2.16 (2.3%) stddev-sans-first:2.29 03:27:21 INFO - PID 4199 | Values: 96.0 94.0 94.0 93.0 98.0 100.0 96.0 95.0 97.0 94.0 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:60.00 stddev:1.49 (2.5%) stddev-sans-first:1.56 03:27:21 INFO - PID 4199 | Values: 59.0 58.0 60.0 58.0 62.0 62.0 58.0 60.0 60.0 60.0 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | [#9] json-stringify-tinderbox Cycles:10 Average:56.00 Median:54.50 stddev:3.71 (6.8%) stddev-sans-first:3.77 03:27:21 INFO - PID 4199 | Values: 59.0 55.0 53.0 54.0 64.0 60.0 54.0 54.0 54.0 53.0 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:4.03 (4.9%) stddev-sans-first:4.09 03:27:21 INFO - PID 4199 | Values: 79.0 81.0 82.0 82.0 81.0 83.0 80.0 83.0 79.0 93.0 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:139.50 stddev:14.44 (10.4%) stddev-sans-first:15.32 03:27:21 INFO - PID 4199 | Values: 141.0 132.0 144.0 138.0 135.0 144.0 128.0 132.0 130.0 178.0 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.60 Median:182.00 stddev:3.57 (2.0%) stddev-sans-first:3.37 03:27:21 INFO - PID 4199 | Values: 177.0 180.0 179.0 181.0 185.0 177.0 186.0 183.0 181.0 187.0 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:2.16 (3.1%) stddev-sans-first:2.29 03:27:21 INFO - PID 4199 | Values: 69.0 67.0 68.0 69.0 70.0 66.0 74.0 69.0 68.0 70.0 03:27:21 INFO - PID 4199 | -------- Summary: end -------- 03:27:21 INFO - PID 4199 | 03:27:21 INFO - PID 4199 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:27:22 INFO - TEST-INFO | 4199: exit 0 03:27:22 INFO - TEST-OK | kraken | took 63358ms 03:27:22 INFO - SUITE-END | took 1179s 03:27:22 INFO - Completed test suite (00:19:39) 03:27:22 INFO - javascript benchmark 03:27:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8343.868263673405, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3101.519264513998, 3135.9372812543766, 3154.05378386484, 3166.984165079175, 3169.3344397676487, 6004.699765011754, 6045.274567051949, 6064.969675151624, 6067.24159480065, 6109.663968481732, 6062.696865156747, 6083.239595050619, 6106.755729770804, 6114.296855861578, 6120.2043734314475, 5571.888562228753, 5589.524890384322, 5614.691191984439, 5627.409122042188, 5657.688827114507, 5615.2700148980575, 5626.381098079229, 5632.633878797886, 5661.0376236039765, 5698.373178950312, 5584.664920104807, 5655.57583181261, 5663.037283661767, 5675.035244008528, 5698.857528561778, 5541.806036788693, 5591.077472217079, 5628.127640215773, 5633.464820842013, 5703.657780533182, 5447.101228297326, 5448.346198456171, 5467.808626698086, 5509.724513774336, 5568.081266591008, 5917.467427931464, 5953.196318496991, 6014.278286605591, 6025.216721826178, 6075.422834830684, 6489.0, 6512.902306465407, 6526.543141980063, 6573.211214654224, 6599.934000660028, 6452.516061295421, 6531.183602049744, 6573.375529324754, 6628.4697224221945, 6630.602163870135, 6126.724297406628, 6127.0, 6128.38716128388, 6132.202813634243, 6145.877082458326, 6822.590644561342, 6828.283030281848, 6853.280405557444, 6863.485238607024, 6866.793996180123, 6359.109724638462, 6387.936120638734, 6396.552241343062, 6482.67586620667, 6491.772787952494, 6302.432781049728, 6469.514786390945, 6547.574407663486, 6559.704813283413, 6584.473242140617, 6402.647854368054, 6441.452476539453, 6484.740610375532, 6497.122888410004, 6522.673866306665, 6484.773032943825, 6544.443722283564, 6557.049227861933, 6578.440832529192, 6582.275949645536, 5304.07178743726, 5384.434634363413, 5402.648827826179, 5403.864903377447, 5404.459554044564, 4587.6788624795945, 4620.468646105741, 4639.188142075123, 4660.0, 4666.183417901853, 5641.323041235078, 5718.628289161191, 5736.799212027559, 5774.0, 5863.677497737665, 6486.4486518646445, 6489.383508566679, 6501.447376972916, 6507.284198738135, 6574.8356291093105, 5774.900971914778, 5833.4749872511675, 5859.150423188699, 5859.501942334864, 5862.8534286642325, 5914.8817023659285, 5932.406759324033, 5938.435848594377, 5956.0768080946655, 5962.522998160137, 6477.514186436036, 6563.474922006228, 6575.210974682973, 6585.86828263432, 6599.505037122235, 6513.967430162914, 6545.37818907203, 6545.901811472927, 6595.307492713388, 6620.702068406837, 6309.400606942333, 6450.387213214737, 6452.354764523698, 6562.967185164043, 6569.9014514783275, 6476.384743449365, 6480.092787009917, 6486.318936511599, 6493.253275873146, 6494.837629059122, 6128.66292353907, 6481.773137940149, 6509.609423434609, 6515.0553169791065, 6543.836404089936, 6234.906476402948, 6378.872422551616, 6404.356841290028, 6455.3221911700475, 6455.4512866405, 6274.341194174546, 6315.115883776367, 6317.778877739441, 6318.968405157945, 6325.082862984749, 6223.0, 6225.439710426083, 6226.128342032029, 6226.50187984951, 6263.68681565929, 6184.5980011299125, 6272.0, 6282.434580887742, 6376.458001069961, 6394.520410969103, 6179.2584889811715, 6198.81403557894, 6211.844703882439, 6281.340459251713, 6294.087357333253], "value": 5991.443470695944, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [824.381713714714, 837.6984285657167, 861.6381119929629, 882.488156869016, 899.1233547291388, 39758.2048359033, 40522.79738601303, 40527.59472405275, 40533.797331013375, 40579.18841623166, 37091.44362834553, 37318.253634927285, 37389.25221495568, 37498.0, 37505.43741843875, 6960.164780226367, 7084.752033678822, 7106.5736055836815, 7107.218205997337, 7108.147022357324, 6968.989496523001, 7049.0, 7052.047973523586, 7052.3652871241575, 7055.153381594216, 7686.192949740281, 7831.138574756772, 7853.018372703412, 7864.764057078268, 7895.0, 7792.493487923295, 7818.80452988677, 7826.921730782677, 7829.3736501079775, 7840.686372545091, 7475.588842613654, 7646.808829779245, 7648.0, 7687.577183254919, 7750.612469376565, 38046.0, 38205.0, 38356.04109897247, 38440.03899902497, 38463.807680961414, 3482.5995010573856, 3561.12752375667, 3566.554180727409, 3572.1248294167835, 3572.356975744365, 31068.533971990437, 31186.376272474652, 31198.22004449884, 31217.687823121705, 31234.219144521343, 4779.522047795227, 4836.129496690594, 4849.9757501212625, 4867.196912509432, 4896.804127834882, 178596.0, 181490.0, 183518.0, 185335.0, 190168.9999999986, 47418.0, 47542.76228618904, 47663.28505072427, 47762.52237477581, 47821.0, 49884.0, 50414.243786343235, 50423.495765042615, 50453.74773126111, 50527.74736126296, 15400.460983865734, 15505.767413488808, 15539.0, 15578.454754083552, 15684.0, 12834.935825321001, 12897.806532902014, 12926.870731292754, 12993.0, 13241.933790330986, 13924.512642057682, 13955.79066314006, 14033.719325613634, 14113.506027288995, 14167.291635418187, 5885.882282354329, 5930.436608522184, 5932.762689492458, 5937.9406205937385, 5943.138244954457, 976.8167499726712, 979.1236843025595, 989.2926557511414, 1017.1964148322742, 1029.2126523209752, 21730.782692172877, 21755.782442175692, 21956.341309760734, 22141.778582214294, 22242.332730018126, 1073.8295258168635, 1074.6131392698621, 1101.6309536305266, 1123.4158237716342, 1128.0468004536153, 11649.825252621218, 11678.182527223184, 11831.230969986924, 11894.583689570823, 11928.522859085539, 207615.0, 208710.0, 209416.0, 209448.0, 209469.0, 49574.50425495699, 49796.50203497919, 50047.0, 50169.498305017216, 50584.0, 1402.3408997771032, 1467.2736995187663, 1490.3516970117817, 1492.7760835874487, 1497.4234919555831, 21646.614248796326, 21769.782302176776, 22074.22740204085, 22195.22316718907, 22361.105555777587, 35308.11729706778, 35651.10872228111, 35692.28615427729, 35742.0, 35781.10547236236, 176118.0, 202404.0, 207620.0, 207642.0, 207654.0, 31193.0, 31788.682113179497, 34590.308193836485, 35206.47190292199, 35321.64678353183, 45010.0, 45245.77377113093, 45304.54695453003, 45355.31967020563, 45563.31655025111, 31345.373092537564, 31694.524582131748, 31807.84096079505, 31829.0, 31990.52014219742, 29783.851080744458, 31051.844740776152, 31609.683903160672, 31661.366772663958, 31663.683363166074, 35324.82337588296, 36050.45924311085, 36138.45792313065, 36420.63579364278, 36552.63447365492, 31587.0, 32136.35727285488, 32237.710491580074, 32552.674473255913, 32860.34279314448, 22269.888650556644, 23682.88158559196, 23774.643380348964, 23922.043118275073, 23923.521529568963], "value": 16805.866863023606, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.8450618333047, 577.6129992904754, 582.3157789597223, 598.2073752278231, 600.5945986459141, 22207.22274720385, 22989.655155172684, 23007.0, 23092.0, 23122.306330810083, 24328.0, 26434.339141521472, 26581.202563923063, 26637.334066648342, 26648.866755666193, 6564.277929427771, 6749.898751518731, 6756.087928129688, 6766.594004359729, 6776.728930842785, 6155.953487907066, 6493.285738568754, 6493.383128602775, 6622.966885165568, 6692.665366731669, 6427.292997770265, 6444.548881578291, 6445.387688169616, 6451.83870403239, 6462.870742585145, 6449.35506449356, 6472.838179045514, 6475.643839588821, 6476.708548115323, 6479.578827376229, 6013.308469525973, 6035.094735789623, 6038.245219347582, 6050.062240352752, 6064.272287325505, 28320.71679283222, 29094.0, 29638.0, 29684.109476715734, 29877.40245195084, 1861.7486639303656, 1932.7584051993501, 1933.1880610143774, 1934.110309257729, 1934.8258656720964, 18482.260709571736, 18797.436076917715, 19047.619047619108, 19105.713414298796, 19132.61734765297, 2361.1381845626393, 2377.0135393811547, 2420.649005894153, 2432.987835060831, 2437.695288088989, 141834.0, 146567.0, 146775.0, 147250.0, 147444.2627786865, 14509.419623215164, 14851.777223341658, 14887.627809304853, 15265.847341526665, 15290.464833730988, 23888.28335149948, 23964.281071567882, 23967.400814979766, 23996.0, 24014.39964000914, 9275.72172834816, 9518.896934827977, 9534.189593884597, 9596.136347728738, 9638.373505722106, 8428.747137585882, 8522.10517895612, 8578.18507241811, 8660.610272537624, 8673.306135509145, 7732.806679832936, 8921.0, 9081.046490118575, 9222.354435189607, 9394.295427842939, 2690.233283514189, 2707.742764437375, 2709.986450067737, 2725.3459169799107, 2728.4133911209187, 930.8091841172543, 934.3693007220235, 952.514217748953, 961.2502248246379, 961.9374740641836, 18818.623627527373, 18835.71746423805, 18916.0, 19684.901575492317, 24735.38161545976, 999.0808456220295, 1000.2448151645461, 1017.2624846986024, 1035.177034257767, 1049.506731836036, 10262.179025678077, 11126.332420054823, 11170.664880053611, 11236.269642473213, 11335.886641133648, 498499.0, 505457.0, 512978.0, 513284.0, 515602.0, 119898.0, 121059.0, 121103.0, 121463.0, 122871.0, 1265.9620211393674, 1293.2822283632674, 1309.070559902461, 1311.8229039079793, 1321.378951892609, 16959.321627134777, 17604.207810648808, 17740.20169092368, 18075.0, 18572.535686607942, 56668.0, 56840.14739778989, 58273.70863145827, 58544.0, 58797.412025880905, 71241.6437917807, 71732.64133679507, 71917.6404117976, 72000.63999679968, 73315.63342183255, 19884.0, 20868.165273388895, 20888.37334879956, 20901.581968360853, 21106.472338191666, 22937.770622293563, 23308.76691233066, 23314.300570982898, 23465.530689386458, 23730.0, 17573.384931527336, 17952.820471795116, 18230.0, 18253.54366140857, 18287.725684115016, 13966.930165349515, 15071.246437677853, 15136.848631513985, 15155.848441515443, 15513.534593962198, 17098.316067357664, 17463.47609571715, 17484.038377889337, 17816.91091544534, 17885.37401190952, 20111.0, 20416.387508374773, 20429.897850510653, 20472.79527204709, 20481.38555843327, 16960.406385776438, 17012.234449449556, 17182.140892955053, 17324.39364622232, 17325.393611223546], "value": 12131.484630167015, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.4773186189248, 1408.0706733555855, 1416.7591509443396, 1431.685029293555, 1441.0777102654297, 13798.44806207753, 14093.154410735364, 14698.485553005634, 14796.112233265998, 14799.186044767534, 14449.205293708868, 14823.92588037061, 14828.110313381205, 14852.183129927877, 14855.405783768663, 2749.587561865726, 2798.9720102799015, 2803.4673412051748, 2803.5654473556633, 2806.2423145750636, 2686.1807148819603, 2797.049003338864, 2818.6335776349047, 2820.873060712273, 2828.5332920068163, 2651.2576478586025, 2673.5588627876473, 2687.9596806047825, 2692.6634170728657, 2700.486907487581, 2669.292637451077, 2673.131232349494, 2677.772389346908, 2707.323169207698, 2717.9320516987136, 2601.648777415063, 2650.628911952309, 2653.1907768130714, 2657.22940347301, 2669.079167687145, 14043.719125617532, 14215.076020058663, 14291.356888940023, 14329.928350358286, 14337.928310358486, 7375.59434231117, 7572.318491335806, 7582.279683430121, 7630.351420129296, 7648.38812894967, 4961.826336078256, 5132.0, 5262.947370526284, 5278.709670968095, 5279.5512381447625, 1703.1484257871064, 1745.1797655102082, 1749.160403006564, 1797.8471829894474, 1812.392848395789, 23272.0, 23500.059997600074, 23506.412339691473, 23583.882080589658, 23615.17346892868, 6792.524523283421, 7013.26360732126, 7187.353138217481, 7218.8917166242545, 7275.381592564586, 14906.552803415914, 14982.550523484313, 15039.548813535612, 15053.172075535951, 15055.171965541782, 7612.429067819825, 7707.421943354271, 7737.3036426721865, 7794.2985131338455, 7805.726799561988, 7029.086218791626, 7073.504854660125, 7080.36276735086, 7244.058272424551, 7265.782026539212, 4955.306257124005, 5063.164577844688, 5113.718745469035, 5151.871203219875, 5151.948480515147, 1455.4105587237186, 1481.0891301849285, 1487.1969136666296, 1506.0662389318475, 1506.563096701966, 818.5825229133185, 820.8727647214691, 830.0371568980075, 837.4933165434946, 856.486108334994, 6485.578437401554, 6575.276719560845, 6747.797566073025, 6756.5608235465525, 6767.120274364301, 688.2841844481783, 696.6934548798513, 703.6270776488469, 711.0, 719.4460265595462, 4040.9797951010055, 4123.474314503593, 4234.301340278819, 4252.87241382759, 4256.297710877732, 18110.818891811177, 19372.321968731027, 20026.098825552886, 20253.29113481021, 20255.29106481266, 18939.85942721839, 19032.33386831454, 19271.807281927282, 19316.42050738452, 19408.4177474676, 9686.854697179548, 10266.6406675766, 10335.328203666737, 10369.481525923673, 10402.323848949794, 6905.654717264017, 7371.778846634609, 7537.54774713519, 7808.063032435917, 7915.643796029308, 16407.67184656324, 16456.09491477932, 16726.916365418096, 16755.664886701954, 17797.644047118727, 17485.737713934555, 17489.038102903953, 17588.2085306159, 17695.734563981292, 17816.91091544534, 10577.100946419332, 10859.0, 10947.45262736844, 10958.28771129874, 10961.835572466578, 13098.934505327412, 13147.474101035852, 13515.932420337835, 13624.65938351549, 13742.65643358924, 10922.453877305945, 10997.395143266876, 11279.266847654877, 11420.885791142315, 11453.427328633701, 10866.07638350749, 11034.17243706709, 11176.944115279372, 11198.88801112011, 11445.084393248353, 9028.683996060106, 9076.954615227145, 9113.3165012623, 9420.57607407682, 9424.764380890258, 6459.257185423548, 6940.7917762467205, 6968.442524597918, 6982.1272340957385, 7008.614526201108, 6339.144215530844, 6374.0, 6738.7304507819135, 6750.662466876538, 6859.485538584527], "value": 6266.351053684298, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.1412135822988, 511.1744532579882, 531.2748098845076, 533.6531254684458, 538.6283464409557, 5914.34942156363, 5989.1315759214995, 6036.4868986136125, 6053.2130822993, 6094.26868775747, 5627.43725627437, 5842.020569509549, 5844.970775146129, 5900.586958912867, 5944.346121926585, 4783.641226907987, 4792.353032340624, 4811.182099043171, 4858.41698996121, 4864.635152363569, 4785.353977213066, 4787.593054590347, 4824.348712923763, 4832.7583620819, 4848.0, 4637.489876113625, 4727.739974301412, 4731.668783185179, 4732.929006064912, 4787.80848766049, 4751.976240118812, 4753.239481682931, 4769.3322934788985, 4781.450133234688, 4791.904161916742, 4307.504636966726, 4321.848735294281, 4331.610155086026, 4359.106383191438, 4362.694611377205, 5853.882922341572, 5858.297004359504, 5859.9159155555935, 5889.617174883619, 5949.315828679671, 5406.162044883049, 5489.752961116759, 5518.19986102017, 5537.556995440355, 5556.749946252388, 6234.906476402857, 6280.434760871498, 6303.5272354573135, 6319.8736025279695, 6344.904826427607, 4729.787159577827, 4731.976340118277, 4746.264329029006, 4766.785494652749, 4768.976155119237, 6558.0, 6573.605583664996, 6704.195496540447, 6716.395524402778, 6775.254721980578, 4821.397325334333, 4821.421429428491, 4882.9491613522405, 4893.119238537098, 4903.239997800347, 4896.534829191221, 4944.75276236194, 4958.380202474691, 4978.103941290602, 4998.500149984972, 5415.675059496364, 5488.286522752017, 5494.5054945055135, 5570.721463926869, 5575.881165157295, 6276.780312689125, 6276.874462510724, 6336.303006669263, 6340.778072767431, 6375.0, 1626.1950334584456, 1641.4501142117524, 1664.7086759816984, 1686.1906284983277, 1699.5156380431517, 1191.66037679261, 1203.789336866045, 1213.1689792491995, 1213.4842691855927, 1222.370479203211, 5595.944040559623, 5663.32040155184, 5669.971650141805, 5676.716164191774, 5701.971490142523, 6428.8071357859335, 6436.806895793134, 6535.0, 6555.901661475082, 6560.573562718408, 5735.799247026334, 5740.770369185186, 5747.252857128547, 5762.798302059492, 5762.942370576325, 3460.982695086559, 3468.150303175738, 3479.2867462170193, 3480.077779388464, 3492.5634295713035, 6442.226932768098, 6470.741170353133, 6489.545731798823, 6501.902471462932, 6515.934840651627, 6598.0, 6607.57050791697, 6673.499487538454, 6729.22613899398, 6740.191177058784, 6296.811095666954, 6350.269718982284, 6375.968120159369, 6408.359164083555, 6448.9355106449275, 6447.0336547351635, 6540.74344351198, 6587.0, 6602.207735071822, 6618.0403841443685, 6368.331325210971, 6451.935480645321, 6456.9354306456335, 6494.155759751202, 6508.707108180049, 6389.233292004989, 6423.325550817097, 6423.811594854967, 6478.935210647834, 6489.610623362613, 4847.061175529675, 4852.8786780329365, 4874.122657921466, 4875.317455556154, 4882.389701287339, 6417.7753778617525, 6434.388733070351, 6457.870842583216, 6480.481561475165, 6491.707873145625, 6268.4671802897265, 6277.5605707600025, 6292.4651404629285, 6296.370362963667, 6312.873742525216, 5979.0, 6161.907571386343, 6334.113224148715, 6337.556371054166, 6434.324395938546, 6015.924506045408, 6033.952853808799, 6128.8774224516155, 6238.157848690369, 6289.9056514153235, 6212.223472065992, 6222.937770622417, 6287.245530536365, 6300.275468321019, 6316.3367846377305, 6037.18498002764, 6089.208402907594, 6099.878002440015, 6107.725152368243, 6117.816465506042], "value": 4904.287119914568, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [892.1836519584581, 906.1663269791791, 923.4044041593171, 924.8381533231683, 927.5084205371152, 16717.74923376149, 17417.12914354282, 17435.56411089722, 17441.0, 21327.893360533177, 19460.708089378637, 20886.0, 21269.149234030658, 21277.14891404342, 21299.0, 1021.2442792333694, 1044.3785947361307, 1044.8119338519064, 1045.0176833776227, 1050.3015494696017, 1050.3907733514543, 1052.4790228836698, 1053.6470282455386, 1053.7207639975413, 1053.7945100705365, 1071.3786004117594, 1074.6131392698621, 1074.6292529077455, 1076.531708706715, 1078.4931082391304, 1068.3002633275216, 1073.6617965340931, 1073.9301945373525, 1082.0207712020633, 1083.653230966091, 792.5442870349515, 796.625585974591, 796.9322607578363, 798.1419973528422, 801.1707882341748, 16354.836451635569, 16991.15044247795, 17172.82827171737, 18036.27854885803, 18121.637567248712, 20354.0, 20520.79479205204, 21039.5792084159, 21087.68368474474, 21100.0, 15505.147216903066, 16000.0, 16122.596935076599, 16193.352265909349, 16203.756943645854, 3405.216800135983, 3420.247545539977, 3422.366862130489, 3425.5718035245595, 3428.0401487583517, 117926.0, 121680.39159804233, 122334.0, 124519.3774031124, 125190.0, 16534.0, 16887.408940687263, 17079.146042698063, 17087.743683844754, 17092.743608845878, 28942.27644308867, 30802.38395232083, 30947.13160854893, 30959.0712278632, 31001.759929603013, 7904.4071694623135, 8250.216229458192, 8308.792280193044, 8494.830103397897, 8712.564371781513, 4169.854055108057, 4264.296391095435, 4275.1022285319805, 4283.100548884707, 4286.485621725413, 4813.9037219255415, 4850.005748821483, 4903.068417000758, 4909.484504127086, 4978.477259887732, 1071.614218881202, 1089.7112265249716, 1091.2197778588347, 1094.3980810554162, 1095.2990086344746, 679.3851564334285, 684.7397988764237, 694.121935751275, 697.9616121113387, 700.9905735740517, 10235.7441063974, 11211.831822522669, 11753.647390578297, 11985.0, 12273.938630306791, 603.1856993059334, 617.6355949989528, 635.1203583037434, 638.5274896576593, 698.6367089113633, 5058.64589478733, 5237.764300606482, 5321.304703635856, 5331.947200327902, 5876.206712093898, 95077.52461237788, 96734.5163274179, 96844.0, 98280.0, 101437.49281253546, 83630.0, 86773.56613217019, 88416.55791721, 89775.55112224397, 91559.0, 74397.62801185959, 74980.62509687417, 78164.60917695375, 78326.60836695781, 80146.0, 11365.659030229106, 11467.942660286646, 11478.016418527808, 12009.159358844798, 12119.81820272679, 32109.197270068435, 33510.497342540366, 33691.663083368854, 34183.82908085543, 35894.641053590174, 65341.67329163324, 66146.66926665336, 66159.00761488485, 67533.0, 73122.26877731155, 17582.0, 17995.640087198444, 18708.532286692942, 20157.092930818442, 20266.18935242574, 17161.0, 19081.809181908004, 19588.8041119587, 21777.891110544348, 21911.0, 19258.133383998033, 19267.421977340702, 19543.315983940494, 19711.802881970998, 20437.89781051085, 19552.8044719551, 19581.804181958567, 19767.703484448033, 19976.90011549933, 20455.4886127848, 18232.90883545574, 18248.36130735471, 18440.815591844446, 18858.434246972614, 19489.122989465224, 12463.252204867737, 13036.804447933479, 13374.465021399035, 13709.108907920952, 13825.10136841102, 13480.797788033384, 14493.130412175304, 14804.925975370053, 15344.616384590474, 15397.0], "value": 8988.344009066805, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 106.0, 107.0, 116.0, 111.0, 116.0, 101.0, 112.0, 111.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 148.0, 191.0, 119.0, 153.0, 158.0, 132.0, 169.0, 121.0], "value": 147.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 165.0, 161.0, 165.0, 167.0, 166.0, 170.0, 167.0, 165.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 167.0, 75.0, 75.0, 75.0, 76.0, 168.0, 78.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 136.0, 79.0, 79.0, 79.0, 123.0, 80.0, 79.0, 132.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 115.0, 114.0, 114.0, 113.0, 116.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 153.0, 151.0, 150.0, 151.0, 150.0, 149.0, 149.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 94.0, 93.0, 98.0, 100.0, 96.0, 95.0, 97.0, 94.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 60.0, 58.0, 62.0, 62.0, 58.0, 60.0, 60.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 53.0, 54.0, 64.0, 60.0, 54.0, 54.0, 54.0, 53.0], "value": 56.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 82.0, 82.0, 81.0, 83.0, 80.0, 83.0, 79.0, 93.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 132.0, 144.0, 138.0, 135.0, 144.0, 128.0, 132.0, 130.0, 178.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 180.0, 179.0, 181.0, 185.0, 177.0, 186.0, 183.0, 181.0, 187.0], "value": 181.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 69.0, 70.0, 66.0, 74.0, 69.0, 68.0, 70.0], "value": 69.0, "unit": "score"}]}]} 03:27:22 INFO - Return code: 0 03:27:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:27:22 INFO - # TBPL SUCCESS # 03:27:22 INFO - Running post-action listener: _package_coverage_data 03:27:22 INFO - Running post-action listener: _resource_record_post_action 03:27:22 INFO - [mozharness: 2017-07-30 10:27:22.690269Z] Finished run-tests step (success) 03:27:22 INFO - Running post-run listener: _resource_record_post_run 03:27:22 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 6918144; Write bytes: 442494976; Read time: 2484; Write time: 298032 03:27:22 INFO - TinderboxPrint: CPU usage
13.2% 03:27:22 INFO - TinderboxPrint: I/O read bytes / time
6,918,144 / 2,484 03:27:22 INFO - TinderboxPrint: I/O write bytes / time
442,494,976 / 298,032 03:27:22 INFO - TinderboxPrint: CPU idle
8,292.7 (86.8%) 03:27:22 INFO - TinderboxPrint: CPU user
1,204.3 (12.6%) 03:27:22 INFO - TinderboxPrint: Swap in / out
0 / 0 03:27:22 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 115720192; Read time: 176; Write time: 91360 03:27:22 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:27:22 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4542464; Write bytes: 326774784; Read time: 1892; Write time: 206672 03:27:23 INFO - Running post-run listener: _upload_blobber_files 03:27:23 INFO - Blob upload gear active. 03:27:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:27:23 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 03:27:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:27:23 INFO - (blobuploader) - INFO - Open directory for files ... 03:27:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:27:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:27:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:24 INFO - (blobuploader) - INFO - Done attempting. 03:27:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:27:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:27:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:31 INFO - (blobuploader) - INFO - Done attempting. 03:27:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:27:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:27:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:32 INFO - (blobuploader) - INFO - Done attempting. 03:27:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:27:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:27:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:32 INFO - (blobuploader) - INFO - Done attempting. 03:27:32 INFO - (blobuploader) - INFO - Iteration through files over. 03:27:33 INFO - Return code: 0 03:27:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:27:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:27:33 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37403a70fef2c134822d4d2030351af3d7d558072d10b6b049d6355c1cfc0025d9d2e39b647712739723128f3d7ba5495da836ff056b6cd1212f10354efbec35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0303c8f665195b221579e9d49c5bd3ed2847f7735ba875421978488d19de3fa9dc9f639bc72f4d7128a9cbeae623cf6daec7043b90aab4f1138e71d6366cd124", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cd6d11b69a380e7e62143e8b2ff1b70e22a8648b2e83aa68abe9db0b61a868178d2f0bff8eafcad88583f61c7b235cdd838c5f11cfe5757f7dd50a46e8684c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d0908a86bc157f786445b8e67b44404056c24b980ff060b0b6bc37bf9568ce2eac6ce57265015b061fad3069165ecc138c034f6c54937af9d972601d76a96d7"} 03:27:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:27:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:27:33 INFO - Contents: 03:27:33 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37403a70fef2c134822d4d2030351af3d7d558072d10b6b049d6355c1cfc0025d9d2e39b647712739723128f3d7ba5495da836ff056b6cd1212f10354efbec35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0303c8f665195b221579e9d49c5bd3ed2847f7735ba875421978488d19de3fa9dc9f639bc72f4d7128a9cbeae623cf6daec7043b90aab4f1138e71d6366cd124", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cd6d11b69a380e7e62143e8b2ff1b70e22a8648b2e83aa68abe9db0b61a868178d2f0bff8eafcad88583f61c7b235cdd838c5f11cfe5757f7dd50a46e8684c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d0908a86bc157f786445b8e67b44404056c24b980ff060b0b6bc37bf9568ce2eac6ce57265015b061fad3069165ecc138c034f6c54937af9d972601d76a96d7"} 03:27:33 INFO - Running post-run listener: copy_logs_to_upload_dir 03:27:33 INFO - Copying logs to upload dir... 03:27:33 INFO - mkdir: /builds/slave/test/build/upload/logs 03:27:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.563893 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-07-30 03:27:32.900067) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:32.906562) ========= 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=1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37403a70fef2c134822d4d2030351af3d7d558072d10b6b049d6355c1cfc0025d9d2e39b647712739723128f3d7ba5495da836ff056b6cd1212f10354efbec35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0303c8f665195b221579e9d49c5bd3ed2847f7735ba875421978488d19de3fa9dc9f639bc72f4d7128a9cbeae623cf6daec7043b90aab4f1138e71d6366cd124", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cd6d11b69a380e7e62143e8b2ff1b70e22a8648b2e83aa68abe9db0b61a868178d2f0bff8eafcad88583f61c7b235cdd838c5f11cfe5757f7dd50a46e8684c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d0908a86bc157f786445b8e67b44404056c24b980ff060b0b6bc37bf9568ce2eac6ce57265015b061fad3069165ecc138c034f6c54937af9d972601d76a96d7"} build_url:https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/BhLq2Mq1QfOaTK4I1eOx5w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37403a70fef2c134822d4d2030351af3d7d558072d10b6b049d6355c1cfc0025d9d2e39b647712739723128f3d7ba5495da836ff056b6cd1212f10354efbec35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0303c8f665195b221579e9d49c5bd3ed2847f7735ba875421978488d19de3fa9dc9f639bc72f4d7128a9cbeae623cf6daec7043b90aab4f1138e71d6366cd124", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cd6d11b69a380e7e62143e8b2ff1b70e22a8648b2e83aa68abe9db0b61a868178d2f0bff8eafcad88583f61c7b235cdd838c5f11cfe5757f7dd50a46e8684c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d0908a86bc157f786445b8e67b44404056c24b980ff060b0b6bc37bf9568ce2eac6ce57265015b061fad3069165ecc138c034f6c54937af9d972601d76a96d7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:32.933894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:32.934243) ========= 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=1f5564757af27664ca02d71f000001b0-1501394084.8318-1230374613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004333 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:33.015086) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-30 03:27:33.015414) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-30 03:27:33.015716) ========= ========= Total master_lag: 0.30 =========