builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1500896769.97 results: success (0) revision: 758016d026077ebaf65aaecc8df437a7164dd9b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:09.970688) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:09.971146) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:09.971431) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:10.363024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 04:46:10.363334) ========= 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=eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-24 04:46:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2017-07-24 04:46:11 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.986491 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 04:46:11.455105) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:11.455431) ========= 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=eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017578 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:11.488168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-07-24 04:46:11.488466) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 758016d026077ebaf65aaecc8df437a7164dd9b5 --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 758016d026077ebaf65aaecc8df437a7164dd9b5 --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=eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-24 04:46:11,552 truncating revision to first 12 chars 2017-07-24 04:46:11,552 Setting DEBUG logging. 2017-07-24 04:46:11,552 attempt 1/10 2017-07-24 04:46:11,552 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/758016d02607?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-24 04:46:13,612 unpacking tar archive at: mozilla-central-758016d02607/testing/mozharness/ program finished with exit code 0 elapsedTime=2.362046 ========= master_lag: 0.64 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-07-24 04:46:14.493918) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:14.494307) ========= script_repo_revision: 758016d026077ebaf65aaecc8df437a7164dd9b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:14.497722) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:14.498008) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:14.597100) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-07-24 04:46:14.597461) ========= /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=eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:46:14 INFO - MultiFileLogger online at 20170724 04:46:14 in /builds/slave/test 04:46:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:46:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:46:14 INFO - {'append_to_log': False, 04:46:14 INFO - 'base_work_dir': '/builds/slave/test', 04:46:14 INFO - 'blob_upload_branch': 'Firefox', 04:46:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:46:14 INFO - 'branch': 'Firefox', 04:46:14 INFO - 'buildbot_json_path': 'buildprops.json', 04:46:14 INFO - 'code_coverage': False, 04:46:14 INFO - 'config_files': ('talos/linux_config.py',), 04:46:14 INFO - 'default_actions': ('clobber', 04:46:14 INFO - 'read-buildbot-config', 04:46:14 INFO - 'download-and-extract', 04:46:14 INFO - 'populate-webroot', 04:46:14 INFO - 'create-virtualenv', 04:46:14 INFO - 'install', 04:46:14 INFO - 'setup-mitmproxy', 04:46:14 INFO - 'run-tests'), 04:46:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:46:14 INFO - 'disable_ccov_upload': False, 04:46:14 INFO - 'download_minidump_stackwalk': True, 04:46:14 INFO - 'download_symbols': 'ondemand', 04:46:14 INFO - 'enable_stylo': False, 04:46:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:46:14 INFO - 'tooltool.py': '/tools/tooltool.py', 04:46:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:46:14 INFO - '/tools/misc-python/virtualenv.py')}, 04:46:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:46:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:46:14 INFO - 'gecko_profile': False, 04:46:14 INFO - 'gecko_profile_interval': 0, 04:46:14 INFO - 'installer_path': 'installer.exe', 04:46:14 INFO - 'log_level': 'info', 04:46:14 INFO - 'log_name': 'talos', 04:46:14 INFO - 'log_to_console': True, 04:46:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:46:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:46:14 INFO - 'opt_config_files': (), 04:46:14 INFO - 'pip_index': False, 04:46:14 INFO - 'suite': 'dromaeojs-e10s', 04:46:14 INFO - 'system_bits': '32', 04:46:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:46:14 INFO - 'title': 'talos-linux64-ix-010', 04:46:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:46:14 INFO - 'use_talos_json': True, 04:46:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:46:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:46:14 INFO - 'work_dir': 'build'} 04:46:14 INFO - [mozharness: 2017-07-24 11:46:14.761718Z] Running clobber step. 04:46:14 INFO - Running pre-action listener: _resource_record_pre_action 04:46:14 INFO - Running main action method: clobber 04:46:14 INFO - rmtree: /builds/slave/test/build 04:46:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:46:15 INFO - Running post-action listener: _resource_record_post_action 04:46:15 INFO - [mozharness: 2017-07-24 11:46:15.847950Z] Finished clobber step (success) 04:46:15 INFO - [mozharness: 2017-07-24 11:46:15.848053Z] Running read-buildbot-config step. 04:46:15 INFO - Running pre-action listener: _resource_record_pre_action 04:46:15 INFO - Running main action method: read_buildbot_config 04:46:15 INFO - Using buildbot properties: 04:46:15 INFO - { 04:46:15 INFO - "project": "", 04:46:15 INFO - "product": "firefox", 04:46:15 INFO - "who": "cbook@mozilla.com", 04:46:15 INFO - "installer_path": "public/build/target.tar.bz2", 04:46:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 04:46:15 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:46:15 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 04:46:15 INFO - "stage_platform": "linux64-stylo", 04:46:15 INFO - "basedir": "/builds/slave/test", 04:46:15 INFO - "buildnumber": 44, 04:46:15 INFO - "platform": "ubuntu64_hw_stylo", 04:46:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:46:15 INFO - "slavebuilddir": "test", 04:46:15 INFO - "taskId": "H-SvVpSIQSGfh6dRvqOAJw", 04:46:15 INFO - "branch": "mozilla-central", 04:46:15 INFO - "script_repo_revision": "production", 04:46:15 INFO - "revision": "758016d026077ebaf65aaecc8df437a7164dd9b5", 04:46:15 INFO - "slavename": "talos-linux64-ix-010", 04:46:15 INFO - "repo_path": "mozilla-central" 04:46:15 INFO - } 04:46:15 INFO - Finding installer, test and symbols from parent task. 04:46:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H-SvVpSIQSGfh6dRvqOAJw'}, attempt #1 04:46:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H-SvVpSIQSGfh6dRvqOAJw'}, attempt #1 04:46:19 INFO - Task dependencies: Qxjkh3A0R969zOj7BNm3zw 04:46:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw'}, attempt #1 04:46:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2 04:46:19 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/test_packages.json 04:46:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.crashreporter-symbols.zip 04:46:19 INFO - Running post-action listener: _resource_record_post_action 04:46:19 INFO - [mozharness: 2017-07-24 11:46:19.722045Z] Finished read-buildbot-config step (success) 04:46:19 INFO - [mozharness: 2017-07-24 11:46:19.722271Z] Running download-and-extract step. 04:46:19 INFO - Running pre-action listener: _resource_record_pre_action 04:46:19 INFO - Running main action method: download_and_extract 04:46:19 INFO - mkdir: /builds/slave/test/build/tests 04:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:19 INFO - trying https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.test_packages.json 04:46:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:46:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:46:21 INFO - Downloaded 989 bytes. 04:46:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:46:21 INFO - Using the following test package requirements: 04:46:21 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:46:21 INFO - u'common': [u'target.common.tests.zip'], 04:46:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:46:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:46:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:46:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:46:21 INFO - u'mozbase': [u'target.common.tests.zip'], 04:46:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:46:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:46:21 INFO - u'web-platform': [u'target.common.tests.zip', 04:46:21 INFO - u'target.web-platform.tests.tar.gz'], 04:46:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:46:21 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:46:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.common.tests.zip 04:46:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:46:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.common.tests.zip into memory 04:46:22 INFO - Content-Length response header: 72760922 04:46:22 INFO - Bytes received: 72760922 04:46:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:46:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.common.tests.zip 04:46:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:46:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.common.tests.zip into memory 04:46:35 INFO - Content-Length response header: 72760922 04:46:35 INFO - Bytes received: 72760922 04:46:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.talos.tests.zip 04:46:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:46:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.talos.tests.zip into memory 04:46:55 INFO - Content-Length response header: 14498880 04:46:55 INFO - Bytes received: 14498880 04:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:55 INFO - trying https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2 04:46:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:46:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:46:57 INFO - Downloaded 61961168 bytes. 04:46:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2 04:46:57 INFO - mkdir: /builds/slave/test/properties 04:46:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:46:57 INFO - Writing to file /builds/slave/test/properties/build_url 04:46:57 INFO - Contents: 04:46:57 INFO - build_url:https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2 04:46:57 INFO - Running post-action listener: _resource_record_post_action 04:46:57 INFO - Running post-action listener: set_extra_try_arguments 04:46:57 INFO - [mozharness: 2017-07-24 11:46:57.163387Z] Finished download-and-extract step (success) 04:46:57 INFO - [mozharness: 2017-07-24 11:46:57.163486Z] Running populate-webroot step. 04:46:57 INFO - Running pre-action listener: _resource_record_pre_action 04:46:57 INFO - Running main action method: populate_webroot 04:46:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:46:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:46:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:46:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:46:57 INFO - 'tests': ['damp', 'tps']}, 04:46:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:46:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:46:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:46:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:46:57 INFO - 'other-e10s': {'tests': ['a11yr', 04:46:57 INFO - 'ts_paint', 04:46:57 INFO - 'tpaint', 04:46:57 INFO - 'sessionrestore', 04:46:57 INFO - 'sessionrestore_many_windows', 04:46:57 INFO - 'sessionrestore_no_auto_restore', 04:46:57 INFO - 'tabpaint']}, 04:46:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:46:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:46:57 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:46:57 INFO - 'talos_options': ['--mitmproxy', 04:46:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:46:57 INFO - '--firstNonBlankPaint'], 04:46:57 INFO - 'tests': ['quantum_pageload_google', 04:46:57 INFO - 'quantum_pageload_youtube', 04:46:57 INFO - 'quantum_pageload_amazon', 04:46:57 INFO - 'quantum_pageload_facebook']}, 04:46:57 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:46:57 INFO - 'talos_options': ['--stylo', 04:46:57 INFO - '--mitmproxy', 04:46:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:46:57 INFO - '--firstNonBlankPaint'], 04:46:57 INFO - 'tests': ['quantum_pageload_google', 04:46:57 INFO - 'quantum_pageload_youtube', 04:46:57 INFO - 'quantum_pageload_amazon', 04:46:57 INFO - 'quantum_pageload_facebook']}, 04:46:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:46:57 INFO - 'tsvgr_opacity', 04:46:57 INFO - 'tart', 04:46:57 INFO - 'tscrollx', 04:46:57 INFO - 'cart', 04:46:57 INFO - 'tsvg_static']}, 04:46:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:46:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:46:57 INFO - 'talos_options': ['--xperf_path', 04:46:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:57 INFO - 'tests': ['tp5n']}}} 04:46:57 INFO - Running post-action listener: _resource_record_post_action 04:46:57 INFO - [mozharness: 2017-07-24 11:46:57.170837Z] Finished populate-webroot step (success) 04:46:57 INFO - [mozharness: 2017-07-24 11:46:57.170926Z] Running create-virtualenv step. 04:46:57 INFO - Running pre-action listener: _resource_record_pre_action 04:46:57 INFO - Running main action method: create_virtualenv 04:46:57 INFO - Creating virtualenv /builds/slave/test/build/venv 04:46:57 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 04:46:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:46:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:46:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:46:57 INFO - Using real prefix '/usr' 04:46:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:46:57 INFO - Installing distribute.............................................................................................................................................................................................done. 04:46:59 INFO - Installing pip.................done. 04:46:59 INFO - Return code: 0 04:46:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:46:59 INFO - Reading from file tmpfile_stdout 04:46:59 INFO - Output received: 04:46:59 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) 04:46:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0eb0>, '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 0x1cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2240>, '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': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:47:00 INFO - Using env: {'DISPLAY': ':0', 04:47:00 INFO - 'HOME': '/home/cltbld', 04:47:00 INFO - 'LANG': 'en_US.UTF-8', 04:47:00 INFO - 'LANGUAGE': 'en_US:en', 04:47:00 INFO - 'LOGNAME': 'cltbld', 04:47:00 INFO - 'MAIL': '/var/mail/cltbld', 04:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:00 INFO - 'MOZ_NO_REMOTE': '1', 04:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:00 INFO - 'NO_EM_RESTART': '1', 04:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:00 INFO - 'PWD': '/builds/slave/test', 04:47:00 INFO - 'SHELL': '/bin/bash', 04:47:00 INFO - 'SHLVL': '1', 04:47:00 INFO - 'TERM': 'linux', 04:47:00 INFO - 'TMOUT': '86400', 04:47:00 INFO - 'USER': 'cltbld', 04:47:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 04:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:00 INFO - '_': '/tools/buildbot/bin/python'} 04:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:00 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 04:47:00 INFO - Cleaning up... 04:47:00 INFO - Return code: 0 04:47:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0eb0>, '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 0x1cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2240>, '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': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:47:00 INFO - Using env: {'DISPLAY': ':0', 04:47:00 INFO - 'HOME': '/home/cltbld', 04:47:00 INFO - 'LANG': 'en_US.UTF-8', 04:47:00 INFO - 'LANGUAGE': 'en_US:en', 04:47:00 INFO - 'LOGNAME': 'cltbld', 04:47:00 INFO - 'MAIL': '/var/mail/cltbld', 04:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:00 INFO - 'MOZ_NO_REMOTE': '1', 04:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:00 INFO - 'NO_EM_RESTART': '1', 04:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:00 INFO - 'PWD': '/builds/slave/test', 04:47:00 INFO - 'SHELL': '/bin/bash', 04:47:00 INFO - 'SHLVL': '1', 04:47:00 INFO - 'TERM': 'linux', 04:47:00 INFO - 'TMOUT': '86400', 04:47:00 INFO - 'USER': 'cltbld', 04:47:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 04:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:00 INFO - '_': '/tools/buildbot/bin/python'} 04:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:00 INFO - Downloading/unpacking psutil>=3.1.1 04:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:47:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:02 INFO - Installing collected packages: psutil 04:47:02 INFO - Running setup.py install for psutil 04:47:02 INFO - building 'psutil._psutil_linux' extension 04:47:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:47:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:47:02 INFO - building 'psutil._psutil_posix' extension 04:47:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:47:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:47:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:02 INFO - Successfully installed psutil 04:47:02 INFO - Cleaning up... 04:47:02 INFO - Return code: 0 04:47:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:02 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 0x19841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0eb0>, '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 0x1cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2240>, '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': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:47:02 INFO - Using env: {'DISPLAY': ':0', 04:47:02 INFO - 'HOME': '/home/cltbld', 04:47:02 INFO - 'LANG': 'en_US.UTF-8', 04:47:02 INFO - 'LANGUAGE': 'en_US:en', 04:47:02 INFO - 'LOGNAME': 'cltbld', 04:47:02 INFO - 'MAIL': '/var/mail/cltbld', 04:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:02 INFO - 'MOZ_NO_REMOTE': '1', 04:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:02 INFO - 'NO_EM_RESTART': '1', 04:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:02 INFO - 'PWD': '/builds/slave/test', 04:47:02 INFO - 'SHELL': '/bin/bash', 04:47:02 INFO - 'SHLVL': '1', 04:47:02 INFO - 'TERM': 'linux', 04:47:02 INFO - 'TMOUT': '86400', 04:47:02 INFO - 'USER': 'cltbld', 04:47:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 04:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:02 INFO - '_': '/tools/buildbot/bin/python'} 04:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:47:04 INFO - Installing collected packages: mozsystemmonitor 04:47:04 INFO - Running setup.py install for mozsystemmonitor 04:47:04 INFO - Successfully installed mozsystemmonitor 04:47:04 INFO - Cleaning up... 04:47:04 INFO - Return code: 0 04:47:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:04 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 0x19841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0eb0>, '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 0x1cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2240>, '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': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:47:04 INFO - Using env: {'DISPLAY': ':0', 04:47:04 INFO - 'HOME': '/home/cltbld', 04:47:04 INFO - 'LANG': 'en_US.UTF-8', 04:47:04 INFO - 'LANGUAGE': 'en_US:en', 04:47:04 INFO - 'LOGNAME': 'cltbld', 04:47:04 INFO - 'MAIL': '/var/mail/cltbld', 04:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:04 INFO - 'MOZ_NO_REMOTE': '1', 04:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:04 INFO - 'NO_EM_RESTART': '1', 04:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:04 INFO - 'PWD': '/builds/slave/test', 04:47:04 INFO - 'SHELL': '/bin/bash', 04:47:04 INFO - 'SHLVL': '1', 04:47:04 INFO - 'TERM': 'linux', 04:47:04 INFO - 'TMOUT': '86400', 04:47:04 INFO - 'USER': 'cltbld', 04:47:04 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 04:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:04 INFO - '_': '/tools/buildbot/bin/python'} 04:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:04 INFO - Downloading/unpacking jsonschema==2.5.1 04:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:47:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:47: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 04:47: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 04:47: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 04:47: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 04:47:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:47:06 INFO - warning: no files found matching '*.txt' 04:47:06 INFO - no previously-included directories found matching 'build' 04:47:06 INFO - no previously-included directories found matching 'dist' 04:47:06 INFO - no previously-included directories found matching '.git*' 04:47:06 INFO - Installing collected packages: jsonschema, functools32 04:47:06 INFO - Running setup.py install for functools32 04:47:06 INFO - warning: no files found matching '*.txt' 04:47:06 INFO - no previously-included directories found matching 'build' 04:47:06 INFO - no previously-included directories found matching 'dist' 04:47:06 INFO - no previously-included directories found matching '.git*' 04:47:06 INFO - Successfully installed jsonschema functools32 04:47:06 INFO - Cleaning up... 04:47:06 INFO - Return code: 0 04:47:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:06 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 0x19841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0eb0>, '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 0x1cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2240>, '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': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:47:06 INFO - Using env: {'DISPLAY': ':0', 04:47:06 INFO - 'HOME': '/home/cltbld', 04:47:06 INFO - 'LANG': 'en_US.UTF-8', 04:47:06 INFO - 'LANGUAGE': 'en_US:en', 04:47:06 INFO - 'LOGNAME': 'cltbld', 04:47:06 INFO - 'MAIL': '/var/mail/cltbld', 04:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:06 INFO - 'MOZ_NO_REMOTE': '1', 04:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:06 INFO - 'NO_EM_RESTART': '1', 04:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:06 INFO - 'PWD': '/builds/slave/test', 04:47:06 INFO - 'SHELL': '/bin/bash', 04:47:06 INFO - 'SHLVL': '1', 04:47:06 INFO - 'TERM': 'linux', 04:47:06 INFO - 'TMOUT': '86400', 04:47:06 INFO - 'USER': 'cltbld', 04:47:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 04:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:06 INFO - '_': '/tools/buildbot/bin/python'} 04:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:47:06 INFO - Cleaning up... 04:47:06 INFO - Return code: 0 04:47:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:07 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 0x19841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0eb0>, '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 0x1cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2240>, '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': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:47:07 INFO - Using env: {'DISPLAY': ':0', 04:47:07 INFO - 'HOME': '/home/cltbld', 04:47:07 INFO - 'LANG': 'en_US.UTF-8', 04:47:07 INFO - 'LANGUAGE': 'en_US:en', 04:47:07 INFO - 'LOGNAME': 'cltbld', 04:47:07 INFO - 'MAIL': '/var/mail/cltbld', 04:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:07 INFO - 'MOZ_NO_REMOTE': '1', 04:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:07 INFO - 'NO_EM_RESTART': '1', 04:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:07 INFO - 'PWD': '/builds/slave/test', 04:47:07 INFO - 'SHELL': '/bin/bash', 04:47:07 INFO - 'SHLVL': '1', 04:47:07 INFO - 'TERM': 'linux', 04:47:07 INFO - 'TMOUT': '86400', 04:47:07 INFO - 'USER': 'cltbld', 04:47:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 04:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:07 INFO - '_': '/tools/buildbot/bin/python'} 04:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:07 INFO - Downloading/unpacking blobuploader==1.2.4 04:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:47:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:47: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 04:47: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 04:47: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 04:47: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 04:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:47:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:47: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 04:47: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 04:47: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 04:47: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 04:47:13 INFO - Downloading docopt-0.6.1.tar.gz 04:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:47:13 INFO - Installing collected packages: blobuploader, requests, docopt 04:47:13 INFO - Running setup.py install for blobuploader 04:47:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:47:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:47:13 INFO - Running setup.py install for requests 04:47:13 INFO - Running setup.py install for docopt 04:47:13 INFO - Successfully installed blobuploader requests docopt 04:47:13 INFO - Cleaning up... 04:47:13 INFO - Return code: 0 04:47:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:13 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 0x19841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0eb0>, '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 0x1cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2240>, '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': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:47:13 INFO - Using env: {'DISPLAY': ':0', 04:47:13 INFO - 'HOME': '/home/cltbld', 04:47:13 INFO - 'LANG': 'en_US.UTF-8', 04:47:13 INFO - 'LANGUAGE': 'en_US:en', 04:47:13 INFO - 'LOGNAME': 'cltbld', 04:47:13 INFO - 'MAIL': '/var/mail/cltbld', 04:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:13 INFO - 'MOZ_NO_REMOTE': '1', 04:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:13 INFO - 'NO_EM_RESTART': '1', 04:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:13 INFO - 'PWD': '/builds/slave/test', 04:47:13 INFO - 'SHELL': '/bin/bash', 04:47:13 INFO - 'SHLVL': '1', 04:47:13 INFO - 'TERM': 'linux', 04:47:13 INFO - 'TMOUT': '86400', 04:47:13 INFO - 'USER': 'cltbld', 04:47:13 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 04:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:13 INFO - '_': '/tools/buildbot/bin/python'} 04:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:13 INFO - Running setup.py (path:/tmp/pip-lRixxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:14 INFO - Running setup.py (path:/tmp/pip-7qwcqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:14 INFO - Running setup.py (path:/tmp/pip-n6DIXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:14 INFO - Running setup.py (path:/tmp/pip-tnnT6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:14 INFO - Running setup.py (path:/tmp/pip-l1julU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:14 INFO - Running setup.py (path:/tmp/pip-3bWZe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:14 INFO - Running setup.py (path:/tmp/pip-KGXRpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:14 INFO - Running setup.py (path:/tmp/pip-McpbMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:14 INFO - Running setup.py (path:/tmp/pip-Z8QUKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:14 INFO - Running setup.py (path:/tmp/pip-2BbpTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:14 INFO - Running setup.py (path:/tmp/pip-uE4LCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:14 INFO - Running setup.py (path:/tmp/pip-s9dj9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:14 INFO - Running setup.py (path:/tmp/pip-2dbYbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:14 INFO - Running setup.py (path:/tmp/pip-9yhHyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:14 INFO - Running setup.py (path:/tmp/pip-nS2vRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:15 INFO - Running setup.py (path:/tmp/pip-DtPLST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:15 INFO - Running setup.py (path:/tmp/pip-mQl0if-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:47:15 INFO - Running setup.py install for manifestparser 04:47:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Running setup.py install for mozcrash 04:47:15 INFO - Running setup.py install for mozdebug 04:47:15 INFO - Running setup.py install for mozdevice 04:47:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Running setup.py install for mozfile 04:47:15 INFO - Running setup.py install for mozhttpd 04:47:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Running setup.py install for mozinfo 04:47:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Running setup.py install for mozInstall 04:47:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Running setup.py install for mozleak 04:47:16 INFO - Running setup.py install for mozlog 04:47:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Running setup.py install for moznetwork 04:47:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Running setup.py install for mozprocess 04:47:16 INFO - Running setup.py install for mozprofile 04:47:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Running setup.py install for mozrunner 04:47:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Running setup.py install for mozscreenshot 04:47:16 INFO - Running setup.py install for moztest 04:47:16 INFO - Running setup.py install for mozversion 04:47:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:47:16 INFO - Cleaning up... 04:47:16 INFO - Return code: 0 04:47:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47: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 0x19841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0eb0>, '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 0x1cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2240>, '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': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47: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 04:47: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 04:47:17 INFO - Using env: {'DISPLAY': ':0', 04:47:17 INFO - 'HOME': '/home/cltbld', 04:47:17 INFO - 'LANG': 'en_US.UTF-8', 04:47:17 INFO - 'LANGUAGE': 'en_US:en', 04:47:17 INFO - 'LOGNAME': 'cltbld', 04:47:17 INFO - 'MAIL': '/var/mail/cltbld', 04:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:17 INFO - 'MOZ_NO_REMOTE': '1', 04:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:17 INFO - 'NO_EM_RESTART': '1', 04:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:17 INFO - 'PWD': '/builds/slave/test', 04:47:17 INFO - 'SHELL': '/bin/bash', 04:47:17 INFO - 'SHLVL': '1', 04:47:17 INFO - 'TERM': 'linux', 04:47:17 INFO - 'TMOUT': '86400', 04:47:17 INFO - 'USER': 'cltbld', 04:47:17 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 04:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:17 INFO - '_': '/tools/buildbot/bin/python'} 04:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:17 INFO - Running setup.py (path:/tmp/pip-9JZsD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:17 INFO - Running setup.py (path:/tmp/pip-kVAF9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:17 INFO - Running setup.py (path:/tmp/pip-hn4Duf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:17 INFO - Running setup.py (path:/tmp/pip-fkd_H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:17 INFO - Running setup.py (path:/tmp/pip-_HqsZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:17 INFO - Running setup.py (path:/tmp/pip-Y84Yg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47: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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:18 INFO - Running setup.py (path:/tmp/pip-XrYZUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47: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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:18 INFO - Running setup.py (path:/tmp/pip-CkV6Ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47: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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:18 INFO - Running setup.py (path:/tmp/pip-mK3K12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47: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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:18 INFO - Running setup.py (path:/tmp/pip-wjmtYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47: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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:18 INFO - Running setup.py (path:/tmp/pip-s9zI87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47: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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:18 INFO - Running setup.py (path:/tmp/pip-6bzqXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47: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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:18 INFO - Running setup.py (path:/tmp/pip-iQt_Kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47: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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:18 INFO - Running setup.py (path:/tmp/pip-10tcs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47: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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:18 INFO - Running setup.py (path:/tmp/pip-C_6D4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:18 INFO - Running setup.py (path:/tmp/pip-GhfQRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:18 INFO - Running setup.py (path:/tmp/pip-4lpfQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:47:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:20 INFO - Downloading blessings-1.6.tar.gz 04:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:47:20 INFO - Installing collected packages: blessings 04:47:20 INFO - Running setup.py install for blessings 04:47:20 INFO - Successfully installed blessings 04:47:20 INFO - Cleaning up... 04:47:20 INFO - Return code: 0 04:47:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:47:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:20 INFO - Reading from file tmpfile_stdout 04:47:20 INFO - Current package versions: 04:47:20 INFO - argparse == 1.2.1 04:47:20 INFO - blessings == 1.6 04:47:20 INFO - blobuploader == 1.2.4 04:47:20 INFO - docopt == 0.6.1 04:47:20 INFO - functools32 == 3.2.3-2 04:47:20 INFO - jsonschema == 2.5.1 04:47:20 INFO - manifestparser == 1.1 04:47:20 INFO - mozInstall == 1.13 04:47:20 INFO - mozcrash == 1.0 04:47:20 INFO - mozdebug == 0.1 04:47:20 INFO - mozdevice == 0.51 04:47:20 INFO - mozfile == 1.2 04:47:20 INFO - mozhttpd == 0.7 04:47:20 INFO - mozinfo == 0.10 04:47:20 INFO - mozleak == 0.1 04:47:20 INFO - mozlog == 3.5 04:47:20 INFO - moznetwork == 0.27 04:47:20 INFO - mozprocess == 0.25 04:47:20 INFO - mozprofile == 0.28 04:47:20 INFO - mozrunner == 6.13 04:47:20 INFO - mozscreenshot == 0.1 04:47:20 INFO - mozsystemmonitor == 0.3 04:47:20 INFO - moztest == 0.8 04:47:20 INFO - mozversion == 1.4 04:47:20 INFO - psutil == 3.1.1 04:47:20 INFO - requests == 1.2.3 04:47:20 INFO - wsgiref == 0.1.2 04:47:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47: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')]} 04:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:21 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 0x19841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0eb0>, '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 0x1cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2240>, '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': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:47:21 INFO - Using env: {'DISPLAY': ':0', 04:47:21 INFO - 'HOME': '/home/cltbld', 04:47:21 INFO - 'LANG': 'en_US.UTF-8', 04:47:21 INFO - 'LANGUAGE': 'en_US:en', 04:47:21 INFO - 'LOGNAME': 'cltbld', 04:47:21 INFO - 'MAIL': '/var/mail/cltbld', 04:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:21 INFO - 'MOZ_NO_REMOTE': '1', 04:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:21 INFO - 'NO_EM_RESTART': '1', 04:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:21 INFO - 'PWD': '/builds/slave/test', 04:47:21 INFO - 'SHELL': '/bin/bash', 04:47:21 INFO - 'SHLVL': '1', 04:47:21 INFO - 'TERM': 'linux', 04:47:21 INFO - 'TMOUT': '86400', 04:47:21 INFO - 'USER': 'cltbld', 04:47:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 04:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:21 INFO - '_': '/tools/buildbot/bin/python'} 04:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:47:21 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:24 INFO - Downloading marionette_driver-1.4.0.tar.gz 04:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 04:47:24 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 04:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:47:24 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)) 04:47:24 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)) 04:47:24 INFO - Installing collected packages: marionette-driver, simplejson 04:47:24 INFO - Running setup.py install for marionette-driver 04:47:24 INFO - Running setup.py install for simplejson 04:47:24 INFO - building 'simplejson._speedups' extension 04:47:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 04:47:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 04:47:25 INFO - Successfully installed marionette-driver simplejson 04:47:25 INFO - Cleaning up... 04:47:25 INFO - Return code: 0 04:47:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:25 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 0x19841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0eb0>, '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 0x1cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2240>, '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': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:47:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:47:25 INFO - Using env: {'DISPLAY': ':0', 04:47:25 INFO - 'HOME': '/home/cltbld', 04:47:25 INFO - 'LANG': 'en_US.UTF-8', 04:47:25 INFO - 'LANGUAGE': 'en_US:en', 04:47:25 INFO - 'LOGNAME': 'cltbld', 04:47:25 INFO - 'MAIL': '/var/mail/cltbld', 04:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:25 INFO - 'MOZ_NO_REMOTE': '1', 04:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:25 INFO - 'NO_EM_RESTART': '1', 04:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:25 INFO - 'PWD': '/builds/slave/test', 04:47:25 INFO - 'SHELL': '/bin/bash', 04:47:25 INFO - 'SHLVL': '1', 04:47:25 INFO - 'TERM': 'linux', 04:47:25 INFO - 'TMOUT': '86400', 04:47:25 INFO - 'USER': 'cltbld', 04:47:25 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 04:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:25 INFO - '_': '/tools/buildbot/bin/python'} 04:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:47:26 INFO - Cleaning up... 04:47:26 INFO - Return code: 0 04:47:26 INFO - Running post-action listener: _resource_record_post_action 04:47:26 INFO - Running post-action listener: _start_resource_monitoring 04:47:26 INFO - Starting resource monitoring. 04:47:26 INFO - [mozharness: 2017-07-24 11:47:26.123424Z] Finished create-virtualenv step (success) 04:47:26 INFO - [mozharness: 2017-07-24 11:47:26.123946Z] Running install step. 04:47:26 INFO - Running pre-action listener: _resource_record_pre_action 04:47:26 INFO - Running main action method: install 04:47:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:26 INFO - Reading from file tmpfile_stdout 04:47:26 INFO - Detecting whether we're running mozinstall >=1.0... 04:47:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:47:26 INFO - Reading from file tmpfile_stdout 04:47:26 INFO - Output received: 04:47:26 INFO - Usage: mozinstall [options] installer 04:47:26 INFO - Options: 04:47:26 INFO - -h, --help show this help message and exit 04:47:26 INFO - -d DEST, --destination=DEST 04:47:26 INFO - Directory to install application into. [default: 04:47:26 INFO - "/builds/slave/test"] 04:47:26 INFO - --app=APP Application being installed. [default: firefox] 04:47:26 INFO - mkdir: /builds/slave/test/build/application 04:47:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:47:44 INFO - Reading from file tmpfile_stdout 04:47:44 INFO - Output received: 04:47:44 INFO - /builds/slave/test/build/application/firefox/firefox 04:47:44 INFO - Running post-action listener: _resource_record_post_action 04:47:44 INFO - [mozharness: 2017-07-24 11:47:44.376873Z] Finished install step (success) 04:47:44 INFO - [mozharness: 2017-07-24 11:47:44.377130Z] Running setup-mitmproxy step. 04:47:44 INFO - Running pre-action listener: _resource_record_pre_action 04:47:44 INFO - Running main action method: setup_mitmproxy 04:47:44 INFO - Skipping: mitmproxy is not required 04:47:44 INFO - Running post-action listener: _resource_record_post_action 04:47:44 INFO - [mozharness: 2017-07-24 11:47:44.378309Z] Finished setup-mitmproxy step (success) 04:47:44 INFO - [mozharness: 2017-07-24 11:47:44.378533Z] Running run-tests step. 04:47:44 INFO - Running pre-action listener: _resource_record_pre_action 04:47:44 INFO - Running pre-action listener: _set_gcov_prefix 04:47:44 INFO - Running main action method: run_tests 04:47:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:44 INFO - Python 2.7.3 04:47:44 INFO - Return code: 0 04:47:44 INFO - grabbing minidump binary from tooltool 04:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:44 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 0x1cf0eb0>, '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 0x1cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:44 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 04:47:44 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 04:47:44 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 04:47:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:44 INFO - Return code: 0 04:47:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:47:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:44 INFO - ENV: RUST_BACKTRACE is now 1 04:47:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:47:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:44 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/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:47:44 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/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:47:44 INFO - Using env: {'DISPLAY': ':0', 04:47:44 INFO - 'HOME': '/home/cltbld', 04:47:44 INFO - 'LANG': 'en_US.UTF-8', 04:47:44 INFO - 'LANGUAGE': 'en_US:en', 04:47:44 INFO - 'LOGNAME': 'cltbld', 04:47:44 INFO - 'MAIL': '/var/mail/cltbld', 04:47:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:44 INFO - 'MOZ_NO_REMOTE': '1', 04:47:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:44 INFO - 'NO_EM_RESTART': '1', 04:47:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:44 INFO - 'PWD': '/builds/slave/test', 04:47:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:44 INFO - 'RUST_BACKTRACE': '1', 04:47:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:47:44 INFO - 'SHELL': '/bin/bash', 04:47:44 INFO - 'SHLVL': '1', 04:47:44 INFO - 'STYLO_FORCE_ENABLED': '1', 04:47:44 INFO - 'TERM': 'linux', 04:47:44 INFO - 'TMOUT': '86400', 04:47:44 INFO - 'USER': 'cltbld', 04:47:44 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177', 04:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:44 INFO - '_': '/tools/buildbot/bin/python'} 04:47:44 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/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:47:44 INFO - mozversion application_buildid: 20170724105843 04:47:44 INFO - mozversion application_changeset: 758016d026077ebaf65aaecc8df437a7164dd9b5 04:47:44 INFO - mozversion application_display_name: Nightly 04:47:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:44 INFO - mozversion application_name: Firefox 04:47:44 INFO - mozversion application_remotingname: firefox 04:47:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:47:44 INFO - mozversion application_vendor: Mozilla 04:47:44 INFO - mozversion application_version: 56.0a1 04:47:44 INFO - mozversion platform_buildid: 20170724105843 04:47:44 INFO - mozversion platform_changeset: 758016d026077ebaf65aaecc8df437a7164dd9b5 04:47:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:47:44 INFO - mozversion platform_version: 56.0a1 04:47:44 INFO - using testdate: 1500896864 04:47:44 INFO - actual date: 1500896864 04:47:44 INFO - starting webserver on 'localhost:38800' 04:47:44 INFO - SUITE-START | Running 2 tests 04:47:44 INFO - TEST-START | dromaeo_css 04:47:44 INFO - Initialising browser for dromaeo_css test... 04:47:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38800/getInfo.html -profile /tmp/tmp4xAJPT/profile 04:47:44 INFO - TEST-INFO | started process 19272 (/builds/slave/test/build/application/firefox/firefox http://localhost:38800/getInfo.html) 04:47:51 INFO - TEST-INFO | 19272: exit 0 04:47:51 INFO - Browser initialized. 04:47:51 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:51 INFO - TEST-INFO | started process 19500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4xAJPT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:02 INFO - PID 19500 | RSS: Main: 178995200 04:48:02 INFO - PID 19500 | 04:51:02 INFO - PID 19500 | Cycle 1(1): loaded http://localhost:38800/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38800/tests/dromaeo/cssquery-ext.html) 04:51:03 INFO - PID 19500 | RSS: Main: 179236864 04:51:03 INFO - PID 19500 | 04:54:05 INFO - PID 19500 | Cycle 1(1): loaded http://localhost:38800/tests/dromaeo/cssquery-ext.html (next: http://localhost:38800/tests/dromaeo/cssquery-jquery.html) 04:54:06 INFO - PID 19500 | RSS: Main: 179212288 04:54:06 INFO - PID 19500 | 04:57:08 INFO - PID 19500 | Cycle 1(1): loaded http://localhost:38800/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38800/tests/dromaeo/cssquery-mootools.html) 04:57:08 INFO - PID 19500 | RSS: Main: 180748288 04:57:08 INFO - PID 19500 | 05:00:10 INFO - PID 19500 | Cycle 1(1): loaded http://localhost:38800/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38800/tests/dromaeo/cssquery-prototype.html) 05:00:11 INFO - PID 19500 | RSS: Main: 179945472 05:00:11 INFO - PID 19500 | 05:03:15 INFO - PID 19500 | Cycle 1(1): loaded http://localhost:38800/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38800/tests/dromaeo/cssquery-yui.html) 05:03:15 INFO - PID 19500 | RSS: Main: 181612544 05:03:15 INFO - PID 19500 | 05:06:17 INFO - PID 19500 | Cycle 1(1): loaded http://localhost:38800/tests/dromaeo/cssquery-yui.html (next: http://localhost:38800/tests/dromaeo/cssquery-dojo.html) 05:06:17 INFO - PID 19500 | RSS: Main: 183205888 05:06:17 INFO - PID 19500 | 05:06:17 INFO - PID 19500 | __start_tp_report 05:06:17 INFO - PID 19500 | _x_x_mozilla_page_load 05:06:17 INFO - PID 19500 | _x_x_mozilla_page_load_details 05:06:17 INFO - PID 19500 | |i|pagename|runs| 05:06:17 INFO - PID 19500 | |0;dojo.html;3140.324830161515;3148.323110531236;3154.495280755079;3192;3204.5193221016843;6062.393760623935;6079.848003799902;6125.969370153154;6167.537434692394;6176.907346389808;5970.43280888316;6134.294556126047;6153.446189842914;6165.260168779752;6179.0422484514975;5560.749766260518;5588.972055139739;5624.3813180550105;5628;5642.915356269659;5597.8600534986745;5614.775408983635;5639.6334238274585;5664.54683625311;5683.573731970098;5686.715664216793;5703.258576385085;5714.485696287334;5725.427457254283;5751.856203594902;5450.482204190595;5658.207850900898;5675.659460432346;5716.428357164292;5746.425357464262;5486.643368181056;5554.944450555524;5557.722113894289;5618.803341883015;5635.6055076144685;5987.401259873977;6023.367546407608;6055.394460553954;6082.1180928765525;6150.538709596798;6325.335839736854;6452.451541618968;6521.9021714673845;6528.37980391862;6566.146400967891;6497.350264973512;6587.505937054692;6613.7685181018915;6615.437687796543;6617.139771829679;6052.515798736091;6129.662868542228;6181.3509581493745;6185.195924529872;6215.06773983906;6689.662067586405;6819.488538359643;6826.931730682729;6831.555948863308;6832.282610325944;6370.8213980413775;6381.1385462962835;6388.456981156561;6457.61254324742;6504.707288172043;6336.651484168323;6398.424141827258;6404.103425520431;6413.166288382574;6483.935160648333;6413.775517856852;6430.292667806538;6487.351264873475;6488.578242414228;6517.706703198272;6554.639494827735;6610.206775187008;6638.701258443381;6644.66776661165;6646.169228846395;5318.7074710891275;5347.679139251657;5384.78460861569;5405.5135037846785;5410.107332290207;4460.1525710114975;4539.568740969603;4567;4617.538246175355;4666.300054991711;5736.340320863154;5773.047447171254;5817.7091145442555;5825.88348233033;5826.242588463558;6619.271880093186;6634.402903738686;6637.3030831762935;6703.262641109474;6715.597064176165;5557.77768889248;5583.330000399897;5664.85837854057;5667.716614169275;5807.8548036299435;5842.240508733922;5856.297244330707;5902.557308201816;5904.852378690567;5917.408259174048;6374.776882809079;6396.040593910858;6466.321036291121;6495.1231583736535;6503.837404064841;6484.902726459201;6597.406233439014;6614.933850661624;6723.462123030244;6724.7646332378135;6317.368263173646;6422.743090276524;6424.229092508742;6437.25971513282;6437.356264373525;6488.870222595616;6498.122753428227;6538.934610654022;6552.3447655236005;6604.339566043357;6403.743850245938;6614.6361950093205;6668.099806526056;6706.128203333536;6765.560238584476;6377.649229292433;6425.935740642533;6427.260865000585;6428.935710642833;6438;6361.745530178741;6448.516361272829;6451.161349024596;6456.644884531396;6478.1578394808375;6145.692715364304;6275.52933529978;6417;6440.194975628046;6440.420362167428;6325.177726895474;6356.936430635819;6416.711247993945;6427.582207156707;6442.387973142544;6150.569460137747;6180.103884936749;6193.721282542207;6217.160683307696;6222.0355844844125 05:06:17 INFO - PID 19500 | |1;ext.html;820.1757233979849;865.5326123893097;888.1651247827042;895.337450286788;1169.5263418315585;32059.19852003701;43285.56714432855;44139.337909931295;44248.77875610626;44266.778666106664;43776;44093.33859992095;44154.77922610383;44160;44238.557614423844;7190.676419561106;7574.35617972473;7764.340031097336;7766.37868970481;7780.455368124233;7591.5445073295505;7688;7696.191899850519;7700.229977002311;7702.8844567331535;7654.578998155099;7689.653965571535;7692.076950765916;7696.153423123452;7704.075510938667;7660.080790305144;7685.884711729329;7689.307962283421;7699.538027718355;7701.537907725498;7510.324070833596;7547.584882831442;7558.924410755932;7606.353459955911;7606.8478630427635;38320;38364.808175959224;38492;38904.80547597244;39009;3540.716742660581;3547.3260080584864;3555.9466608000903;3575.3385623659447;3586.228960773446;32519.512207316908;32734.67265327364;32845.835770821235;32935.835320823484;32997.17507062318;4855.223164293731;4903.8774030649165;4927.43334516528;4946.901061978776;4967.50324967504;189668;189916;190357;190393.9999999986;191313;51641;51856.740716296175;51892.740536297075;51968.48031519712;51993.48006519886;53984.460155397945;54030;54140.72929635327;54245.18632220441;54379.45620543744;14063.578092657237;15811;16137.193140342935;16185.109818959834;16237.837621623868;11692.35692036946;12604.243745375306;12848.10063295579;12856.421461034275;12880.227186368847;14781.33483993223;14803.703925921636;14865.108093514424;14874.405023798927;15005.17471539054;5656.8020119295625;5895.526118470382;5943.970280148572;5995.940040599626;5999;952.6379975609224;958.3052287091803;976.7069879036261;1011.1051719228535;1013.4375421640913;22464.32607021792;22502.887485562467;22822.376911539588;22855.514391564495;23274;1084.7505073833063;1098.807708650983;1099.3843447669171;1106.9667909962714;1125.0886781706843;12124.757504849853;12224.572139975058;12225.755484890431;12346.567870124503;12368;220171;220419;220536;222811;223512;55305.446945530835;55361;55396;55459.722701386236;55485;1447.486142419426;1454.6290695872485;1490.4261859184076;1497.7603583426817;1503.3836127187801;21910.320228516273;22071.33785986423;22361.664575031064;22664.433389164744;22900.31299061031;38730.6126938727;38782.61217387903;38787;38816.80591597024;38825.805870970464;196089;196862.01568992063;196945;197001;197203;33854.492182617774;34901.82549087238;35162.824185878904;35260.82369588136;35282;43575.78212108919;44276;44563.10873782571;44585;44711;31324.373512530077;31392;32393.838030809697;32521.186970325933;32693.836530817192;31088;32296;32589.67410325961;32733.67266327306;33005.834970824995;36291.81854090712;39650.40524392194;39867;40007.79996100001;40152.79923600363;31673.36653266968;34396;34752.131196719274;34869.12827179341;35044.12389690278;24472.265832025067;24649.260522184362;24731.258062258163;25080.874595627636;25127.74872251254 05:06:17 INFO - PID 19500 | |2;jquery.html;572.7794799002382;574.2534704883656;581.8050952930768;590.3358721438381;603.9245094363204;22616.66075008874;23492.530149397;23496.76503234967;23536.058557657696;23592.52814943702;24683;27140.321491962663;27150.72849271507;27211.319717007085;27380.726192738068;6593.439557637595;6729.798106056802;6767.4586033117475;6773.661316934158;6777;6342.746290148389;6595.109660195884;6597.571157874723;6622.370874766913;6631.237407698104;6615.33846615337;6640.701168447432;6641.169853768279;6650.900236496456;6665;6576.408123268929;6629.436497897685;6634.601923884582;6654.334566543355;6657.667116644173;6178.505719542426;6193.3496982816605;6194.163787888668;6194.659293738842;6196.81409557714;28761.85619071912;28943;29420.705792942226;29768.255793605116;30302.393952121056;1899.534614019574;1939.398786376228;1943.1158822735622;1944.7471828662324;1947.0751393088312;18611.162497687637;19096.949667768265;19223.519412014673;19340.226390944346;19389;2310.849794763352;2361.244401791427;2375.809935205197;2393.868337241451;2455.435249892517;130348;132458.6754132456;132838;132933;132966.3351683245;13862.861371386158;14796.852031479548;15075.39698412073;15152.772708409382;15293.923530382277;24274.635880461807;24277.17921155885;24282;24306.87846560756;24379;10065.798684026278;10131.037551432602;10192;10269.948650256702;10303.742406439898;9197.724068277963;9308.720738377859;9360.578773955189;9398.859017114748;9450.33847630673;7649.77603583424;8923.73228803137;9014.414063085878;9239.676611318706;9566.808663826823;2632.747668401551;2651.2311429685174;2700.6894207166033;2722.754952054285;2820.5346117890726;949.639137127887;952.9907530116035;966.7583104223944;975.0882924465648;987.5901500877055;19298.938558379145;19344.41966741;19786.40640780779;19813.702794458095;20071.39785806428;984.242133557157;1013.8529913162697;1030.7526193713454;1034.2863424237253;1036.6734478639205;9930.907600163977;10528.578856845794;11146.05258553032;11205.71985700364;11329.660110196708;439034;439490;454299;454300;461629;108630.45684771684;110964.4451777736;112214.31678524829;113092;115667;1166.976660466803;1194.8446701928867;1210.6973256685828;1214.757048590268;1217.0932655171953;16501.257443414834;17440.15900998295;17659.823401765818;18009.18958646838;18039.549011274823;52137.7393113032;52801.735991319794;53590.73204634108;53796.73101634467;53834;64972.350276498524;66074.33925660874;66224;66393;67093;14426.783598245825;14745.336459859118;14788.11271323724;14804.851951480347;14811.925940370229;23192.072317107126;23212.18757343485;23220.41948951222;23413;23615.173468928504;18036.188371523574;18379.72430413518;18453.81546184521;18523.35168269104;18592.163352649433;15079.396824126912;15869.365225390855;16279.348826046826;16591.41930032443;17411.3906013294;18384;18823.247070117042;20298.89850550738;20396.79603204008;20455.8977205113;14712.705745884808;15009.399624015354;15044.398224070914;15128.092314461168;15159.166245856584;18560.350387736904;18658.720119198493;18687.972161530703;18766.061696915374;18954.24183032663 05:06:17 INFO - PID 19500 | |3;mootools.html;1368.083384132631;1430.2133826395493;1433.1401159304419;1448.6957738874835;1450.9927450362748;13760;14011.369488373022;14417.062890912084;14420.783688244659;14428.35072421741;14015.229162396065;14913.40346386146;14923.552293431187;14954.925225373885;14964.102153870776;2628.5531459651856;2688.892444302235;2692.165428717094;2692.892284308625;2694.582339737334;2559.4113353928606;2644.087789712546;2703.3511957130345;2706.9458610827774;2708.133397312861;2484.9006039758387;2644.0349272515587;2658.6543749312564;2660.441307325464;2661.3080599044292;2696.4607078584263;2706.0528814914624;2713.6472258606254;2720.7143249958767;2721.6189733437236;2485.9378515537073;2531.240627811649;2544.6691930048974;2629.1192450529097;2638.1162310625773;13492.325383730873;13686.110402823784;13860.653483662889;13908;13917.721645567031;7469.626518674045;7754.418418618569;7769.650365733555;7781.8832717509285;7794.493357931717;4830.9275360869615;5075.822346217865;5229.346331708536;5247.947520524822;5262.578993680497;1867.4771064102074;1907.4930804664298;1912.7800302965197;1947.8441724661993;1967.4982879365814;23081.653775193387;23282.883585582134;23307.4173145671;23311.650325245137;23331.883340583357;6438;6463.741450341934;6522.380373864476;6634.104395906587;6652.800415987528;16018.839811601967;16052;16070.839291606935;16080.35678572844;16106;7436.516626419266;7542.358899493494;7570.962145189239;7598.772036838904;7609.581473019037;5523.512778312314;6200.224971878515;6216.782412615627;7000.7549735759;7037.472189585699;5019;5020.698758074454;5143.331366922276;5170.250313704491;5223.921641175385;1412.3432603839058;1437.7052704195614;1442.2932762946082;1463.0928824129107;1467.559732080393;846.327169899931;870.2428886868465;870.8084221471266;883.5582208895552;894.959726812295;6644.867102658017;6898.758543451056;7036.92963070373;7054.717811287594;7072.292770722886;699.0876905638191;707.734599525178;717.1286886432905;718.964051797408;726.4224941171781;4687.343771871941;5102.719350435687;5191.714455704972;5277.076511610453;5299.125644268653;18858.905705471658;19724.309649162496;19735.802641973685;19744.30894918671;19754.308599198957;18821;19250;19272.710909336372;19273.903630482037;19382.903085484482;10241.795164096826;10895.509702063426;10947.288426252268;10981.61564345244;11000.22998390121;7852.921470785219;8330.875036874573;8500.36247281444;8515.446495977742;8568.700095496628;16147.354105836104;16512.504624861274;16962.830371696124;17210.91394543019;17532.912335438243;16975.236114374635;17065.40271090506;17434.738478922573;17618.414342709217;18123.818761812214;11434.542618295174;11516.021138203347;11726.355050472306;11730.413479326171;11761.647150585497;12859.935700321439;12959.35203239853;13044.152130111512;13088.80366794518;13141.211527308393;10345.63790267337;10755.193360497837;11016.779664406507;11212.49543770516;11248.21262511649;9705.6117755289;10277.74305642365;10304.690859274233;10310.587576496857;10421.645186125756;9495.28785341116;9654.903450965401;9655.372400793925;9676.419414835133;9695;6181.732744787218;6251.46862516673;6409.519286053658;6518.674066296761;6559.212894452697;7043.859122817413;7220.927790722026;7300.26997300287;7337.963310183629;7410.51789642063 05:06:17 INFO - PID 19500 | |4;prototype.html;497.9950200497994;499.34716089742966;522.459254671415;523.7433657507822;532.6324835863254;6007.519398448125;6156.292026416963;6210.441060304572;6223.315435302119;6244.750209991601;5812.389699081599;6095.664738439384;6097.5426842986735;6098.908516372258;6128.854900784734;4920.704757714549;4922.409310882699;4924.039812236615;4932.284818701286;4938.728369939652;4676.883077923062;4879.756012199376;4923.384576927884;4925.975370123145;4952.529509696573;4798.136335459616;4890.168671325883;4909.312696222514;4914.090893184754;4916.50834916509;4887.828925987574;4899.142650036265;4910.238912968495;4920.286558449023;4926.187179115442;4363.214621368153;4432.312991486325;4447.266201076818;4450.399196108517;4484.103179364108;5951.970240148815;5960.821175364746;5999.880002399927;6007.969960150215;6012.8496787580225;5559.360673522557;5598.720063996825;5643.209950606918;5706;5734.311882574076;6398.656282180747;6429.517786166056;6481.578697384655;6508.479321654257;6513.706883190221;4851.442084160331;4863.1732605457155;4865.9756701216265;4876.780544875489;4900.803967841318;6698.4641228701585;6802.251752307292;6871.793846184622;6893.931060689379;6911.205211400653;4946.183879659816;4986.376702912136;5001.7749201285305;5026.29631851541;5046.39443266803;5019.247112933016;5061.4432412435335;5096.566791822663;5098.260752190911;5107.361579802525;5594.356648985337;5666.801661941895;5675.716214189274;5676.801311954062;5676.943230567724;6378.872422551523;6422.775202867877;6456.289808121103;6481.773137940149;6526.314736952551;1647.2834317071872;1649.348507339594;1696.6691495158573;1710.6664200480786;1725.7929048514259;1201.5193922430922;1208.83347569594;1211.473009240983;1233.5374234662002;1235.123062625528;5643.548516118701;5665.648755766393;5687.459691329317;5690.260266165372;5711.9714401428555;6475.967620161963;6612.669366531654;6645.833854153685;6690.483923351718;6705.530612857053;5714;5732.856678582985;5792.015357389254;5795.217645617872;5804;3558.974871359324;3581.659742324475;3586.246888153517;3593.9577522518175;3611.205534782344;6458.837409266283;6520.902186467207;6529.379708927644;6532.934670653328;6544.9672751635935;6760.459163266927;6843.62360070191;6853.348931851466;6906.482013848981;6945.548539344926;6362.1093046973465;6403;6410.55126141175;6528.967355163194;6549.639769812706;6635.668216589054;6637;6660.470879801587;6715.227748808754;6741.59550426976;6595.4393876521035;6667.166604174478;6670.9332906670315;6677.666116694243;6718.529702920749;6400.135981642418;6479.319671434431;6519.152510173647;6525.706343214471;6527.934720652733;4870.878228044327;4885.658003939832;4938.75306234694;4947.505249475168;4955.578775804097;6373.171487706569;6622.304658011032;6721.764738234138;6723.226828914738;6729.192496900403;6234.786650738923;6370.426661600478;6388.744450221939;6398.424141827258;6485.935140648722;6320.968395157995;6358.332375100548;6379.266384365857;6417.839554011187;6463.547551671526;6293.206436165671;6297.653629050446;6367.299597044414;6390.13733146038;6414.262359828679;6250.718717657807;6364.6181229126405;6425.228972523327;6427.678616069272;6486.772962946275;6179.5056395489155;6202.224721909762;6238.282597501164;6248.625082495065;6329.620222786648 05:06:17 INFO - PID 19500 | |5;yui.html;883.889513810774;915.3501014279861;916.7249825052482;927.0544045074024;950.149616093596;18115.72826407603;19324.613507729853;19328.420147395565;19355.612887742252;22379.216727414543;20367.796322036775;21270.14919403226;21635.45911352217;21658.133674653036;21743.891280543576;1028.603987464824;1038.9480525973709;1050.5220124843179;1052.9157667386628;1054.1935419404163;979.9216062714966;1052.9420881851495;1057.984130238047;1062.9946850265737;1068.8236440987266;1124.0221007723292;1124.213050864394;1128.8927551882557;1128.920975531713;1129.779692959873;1112.7106952192407;1117.8435019097292;1118.5246270335115;1122.8652561692568;1124.173732306754;813.8901248331518;820.1757233979812;820.2453742556862;820.5609998650752;820.6020080261069;18708.62582748351;18977.905110474498;19010.239590416368;19216.903915480474;20308.593828123354;20735.896320518452;21043.789562104335;21061.684074738892;21570.89214553933;21587.1365145394;15756.527304180892;15991.520254392386;16253.674926501522;16257.10585917774;16457.341706331732;3511.5083888255663;3528.329617372691;3531.2054787672823;3531.311394278117;3531.9823400882833;121069.39465302617;125738;126966;126978.3651081748;127348;16677.332906683838;17088.91455542714;17205.655886882192;17403.303867845145;17430.302787888344;28680.569791453145;30607.2348191297;30789.84605077005;30836.383272334875;30926.53610195849;8423.70517031901;8566.357523185787;8567.871481927776;8625.0943650917;8633.956830215935;4109.876703698894;4210.494740631144;4213.894652633709;4233.555476674905;4235.089455767024;5097.439281679012;5305.098133317345;5341.86645333862;5342.198670199501;5344.465553444625;1074.403705943209;1095.3756358875364;1097.868255809308;1105.171121658756;1107.6510899066768;672.7914346552584;678.8099332186996;681.4582406986458;705.4885208223997;710.6624353432078;12224.572139975058;12584.274155259334;12757.42591583381;12799.616011519669;12938;669.8626781509779;673.1081317254657;686.306830101591;695.2699665351361;707.9716811327489;5373.38206106295;5500.917486237709;5842.182094506772;6003.729832157564;6175.135481032659;101651.49174254229;102687.48656256672;104602.4769876161;107022;107211;83456;84278.5786071078;89184.5540772292;92006.53996729973;93644;78469.60765196137;79949.60025199837;80850;84242.57878710567;84814;12458.377081146087;12668.683282918;12947;13193.94448444103;13285.601431957057;33739;35857.82071089628;36041.0989725259;36451.45322820213;37069.07327316839;47471.28793068037;47538.524614754795;47994.28008579944;48134.759326203144;48757.51242487672;18040.51129211221;18841.15214815309;18977.43067707971;19067.61864762725;19128.521786955436;21320.253791117237;21749.02129404149;21925.780742193012;22093.226737064124;22283.77716222882;16523.586910327336;17240.137993100547;18422.078896055413;19566;19926.70109948323;17663.558411039827;19498.220071196993;19556.804431955497;20076.59846803085;20110.89944550268;17728;17938.461846144113;19129.23483060662;19232.71150932765;19313;13325.466981321026;13434.529791457642;13706;14014;14032;13637.727245455233;14261.286935653383;14668.486602968846;15325.310361033557;15465.149416782186 05:06:17 INFO - PID 19500 | __end_tp_report 05:06:17 INFO - PID 19500 | __start_cc_report 05:06:17 INFO - PID 19500 | _x_x_mozilla_cycle_collect,389 05:06:17 INFO - PID 19500 | __end_cc_report 05:06:17 INFO - PID 19500 | __startTimestamp1500897977841__endTimestamp 05:06:17 INFO - PID 19500 | 05:06:17 INFO - PID 19500 | ------- Summary: start ------- 05:06:17 INFO - PID 19500 | Number of tests: 6 05:06:17 INFO - PID 19500 | 05:06:17 INFO - PID 19500 | [#0] dojo.html Cycles:165 Average:6059.76 Median:6317.37 stddev:700.17 (11.1%) stddev-sans-first:663.81 05:06:17 INFO - PID 19500 | Values: 3140.3 3148.3 3154.5 3192.0 3204.5 6062.4 6079.8 6126.0 6167.5 6176.9 5970.4 6134.3 6153.4 6165.3 6179.0 5560.7 5589.0 5624.4 5628.0 5642.9 5597.9 5614.8 5639.6 5664.5 5683.6 5686.7 5703.3 5714.5 5725.4 5751.9 5450.5 5658.2 5675.7 5716.4 5746.4 5486.6 5554.9 5557.7 5618.8 5635.6 5987.4 6023.4 6055.4 6082.1 6150.5 6325.3 6452.5 6521.9 6528.4 6566.1 6497.4 6587.5 6613.8 6615.4 6617.1 6052.5 6129.7 6181.4 6185.2 6215.1 6689.7 6819.5 6826.9 6831.6 6832.3 6370.8 6381.1 6388.5 6457.6 6504.7 6336.7 6398.4 6404.1 6413.2 6483.9 6413.8 6430.3 6487.4 6488.6 6517.7 6554.6 6610.2 6638.7 6644.7 6646.2 5318.7 5347.7 5384.8 5405.5 5410.1 4460.2 4539.6 4567.0 4617.5 4666.3 5736.3 5773.0 5817.7 5825.9 5826.2 6619.3 6634.4 6637.3 6703.3 6715.6 5557.8 5583.3 5664.9 5667.7 5807.9 5842.2 5856.3 5902.6 5904.9 5917.4 6374.8 6396.0 6466.3 6495.1 6503.8 6484.9 6597.4 6614.9 6723.5 6724.8 6317.4 6422.7 6424.2 6437.3 6437.4 6488.9 6498.1 6538.9 6552.3 6604.3 6403.7 6614.6 6668.1 6706.1 6765.6 6377.6 6425.9 6427.3 6428.9 6438.0 6361.7 6448.5 6451.2 6456.6 6478.2 6145.7 6275.5 6417.0 6440.2 6440.4 6325.2 6356.9 6416.7 6427.6 6442.4 6150.6 6180.1 6193.7 6217.2 6222.0 05:06:17 INFO - PID 19500 | 05:06:17 INFO - PID 19500 | [#1] ext.html Cycles:180 Average:37928.22 Median:3551.64 stddev:52704.65 (1484.0%) stddev-sans-first:52778.84 05:06:17 INFO - PID 19500 | Values: 820.2 865.5 888.2 895.3 1169.5 32059.2 43285.6 44139.3 44248.8 44266.8 43776.0 44093.3 44154.8 44160.0 44238.6 7190.7 7574.4 7764.3 7766.4 7780.5 7591.5 7688.0 7696.2 7700.2 7702.9 7654.6 7689.7 7692.1 7696.2 7704.1 7660.1 7685.9 7689.3 7699.5 7701.5 7510.3 7547.6 7558.9 7606.4 7606.8 38320.0 38364.8 38492.0 38904.8 39009.0 3540.7 3547.3 3555.9 3575.3 3586.2 32519.5 32734.7 32845.8 32935.8 32997.2 4855.2 4903.9 4927.4 4946.9 4967.5 189668.0 189916.0 190357.0 190394.0 191313.0 51641.0 51856.7 51892.7 51968.5 51993.5 53984.5 54030.0 54140.7 54245.2 54379.5 14063.6 15811.0 16137.2 16185.1 16237.8 11692.4 12604.2 12848.1 12856.4 12880.2 14781.3 14803.7 14865.1 14874.4 15005.2 5656.8 5895.5 5944.0 5995.9 5999.0 952.6 958.3 976.7 1011.1 1013.4 22464.3 22502.9 22822.4 22855.5 23274.0 1084.8 1098.8 1099.4 1107.0 1125.1 12124.8 12224.6 12225.8 12346.6 12368.0 220171.0 220419.0 220536.0 222811.0 223512.0 55305.4 55361.0 55396.0 55459.7 55485.0 1447.5 1454.6 1490.4 1497.8 1503.4 21910.3 22071.3 22361.7 22664.4 22900.3 38730.6 38782.6 38787.0 38816.8 38825.8 196089.0 196862.0 196945.0 197001.0 197203.0 33854.5 34901.8 35162.8 35260.8 35282.0 43575.8 44276.0 44563.1 44585.0 44711.0 31324.4 31392.0 32393.8 32521.2 32693.8 31088.0 32296.0 32589.7 32733.7 33005.8 36291.8 39650.4 39867.0 40007.8 40152.8 31673.4 34396.0 34752.1 34869.1 35044.1 24472.3 24649.3 24731.3 25080.9 25127.7 05:06:17 INFO - PID 19500 | 05:06:17 INFO - PID 19500 | [#2] jquery.html Cycles:180 Average:33261.21 Median:23516.41 stddev:75998.04 (323.2%) stddev-sans-first:76171.61 05:06:17 INFO - PID 19500 | Values: 572.8 574.3 581.8 590.3 603.9 22616.7 23492.5 23496.8 23536.1 23592.5 24683.0 27140.3 27150.7 27211.3 27380.7 6593.4 6729.8 6767.5 6773.7 6777.0 6342.7 6595.1 6597.6 6622.4 6631.2 6615.3 6640.7 6641.2 6650.9 6665.0 6576.4 6629.4 6634.6 6654.3 6657.7 6178.5 6193.3 6194.2 6194.7 6196.8 28761.9 28943.0 29420.7 29768.3 30302.4 1899.5 1939.4 1943.1 1944.7 1947.1 18611.2 19096.9 19223.5 19340.2 19389.0 2310.8 2361.2 2375.8 2393.9 2455.4 130348.0 132458.7 132838.0 132933.0 132966.3 13862.9 14796.9 15075.4 15152.8 15293.9 24274.6 24277.2 24282.0 24306.9 24379.0 10065.8 10131.0 10192.0 10269.9 10303.7 9197.7 9308.7 9360.6 9398.9 9450.3 7649.8 8923.7 9014.4 9239.7 9566.8 2632.7 2651.2 2700.7 2722.8 2820.5 949.6 953.0 966.8 975.1 987.6 19298.9 19344.4 19786.4 19813.7 20071.4 984.2 1013.9 1030.8 1034.3 1036.7 9930.9 10528.6 11146.1 11205.7 11329.7 439034.0 439490.0 454299.0 454300.0 461629.0 108630.5 110964.4 112214.3 113092.0 115667.0 1167.0 1194.8 1210.7 1214.8 1217.1 16501.3 17440.2 17659.8 18009.2 18039.5 52137.7 52801.7 53590.7 53796.7 53834.0 64972.4 66074.3 66224.0 66393.0 67093.0 14426.8 14745.3 14788.1 14804.9 14811.9 23192.1 23212.2 23220.4 23413.0 23615.2 18036.2 18379.7 18453.8 18523.4 18592.2 15079.4 15869.4 16279.3 16591.4 17411.4 18384.0 18823.2 20298.9 20396.8 20455.9 14712.7 15009.4 15044.4 15128.1 15159.2 18560.4 18658.7 18688.0 18766.1 18954.2 05:06:17 INFO - PID 19500 | 05:06:17 INFO - PID 19500 | [#3] mootools.html Cycles:180 Average:8708.01 Median:2633.62 stddev:6009.93 (228.2%) stddev-sans-first:6001.48 05:06:17 INFO - PID 19500 | Values: 1368.1 1430.2 1433.1 1448.7 1451.0 13760.0 14011.4 14417.1 14420.8 14428.4 14015.2 14913.4 14923.6 14954.9 14964.1 2628.6 2688.9 2692.2 2692.9 2694.6 2559.4 2644.1 2703.4 2706.9 2708.1 2484.9 2644.0 2658.7 2660.4 2661.3 2696.5 2706.1 2713.6 2720.7 2721.6 2485.9 2531.2 2544.7 2629.1 2638.1 13492.3 13686.1 13860.7 13908.0 13917.7 7469.6 7754.4 7769.7 7781.9 7794.5 4830.9 5075.8 5229.3 5247.9 5262.6 1867.5 1907.5 1912.8 1947.8 1967.5 23081.7 23282.9 23307.4 23311.7 23331.9 6438.0 6463.7 6522.4 6634.1 6652.8 16018.8 16052.0 16070.8 16080.4 16106.0 7436.5 7542.4 7571.0 7598.8 7609.6 5523.5 6200.2 6216.8 7000.8 7037.5 5019.0 5020.7 5143.3 5170.3 5223.9 1412.3 1437.7 1442.3 1463.1 1467.6 846.3 870.2 870.8 883.6 895.0 6644.9 6898.8 7036.9 7054.7 7072.3 699.1 707.7 717.1 719.0 726.4 4687.3 5102.7 5191.7 5277.1 5299.1 18858.9 19724.3 19735.8 19744.3 19754.3 18821.0 19250.0 19272.7 19273.9 19382.9 10241.8 10895.5 10947.3 10981.6 11000.2 7852.9 8330.9 8500.4 8515.4 8568.7 16147.4 16512.5 16962.8 17210.9 17532.9 16975.2 17065.4 17434.7 17618.4 18123.8 11434.5 11516.0 11726.4 11730.4 11761.6 12859.9 12959.4 13044.2 13088.8 13141.2 10345.6 10755.2 11016.8 11212.5 11248.2 9705.6 10277.7 10304.7 10310.6 10421.6 9495.3 9654.9 9655.4 9676.4 9695.0 6181.7 6251.5 6409.5 6518.7 6559.2 7043.9 7220.9 7300.3 7338.0 7410.5 05:06:17 INFO - PID 19500 | 05:06:17 INFO - PID 19500 | [#4] prototype.html Cycles:180 Average:5452.40 Median:6010.41 stddev:1528.42 (25.4%) stddev-sans-first:1486.78 05:06:17 INFO - PID 19500 | Values: 498.0 499.3 522.5 523.7 532.6 6007.5 6156.3 6210.4 6223.3 6244.8 5812.4 6095.7 6097.5 6098.9 6128.9 4920.7 4922.4 4924.0 4932.3 4938.7 4676.9 4879.8 4923.4 4926.0 4952.5 4798.1 4890.2 4909.3 4914.1 4916.5 4887.8 4899.1 4910.2 4920.3 4926.2 4363.2 4432.3 4447.3 4450.4 4484.1 5952.0 5960.8 5999.9 6008.0 6012.8 5559.4 5598.7 5643.2 5706.0 5734.3 6398.7 6429.5 6481.6 6508.5 6513.7 4851.4 4863.2 4866.0 4876.8 4900.8 6698.5 6802.3 6871.8 6893.9 6911.2 4946.2 4986.4 5001.8 5026.3 5046.4 5019.2 5061.4 5096.6 5098.3 5107.4 5594.4 5666.8 5675.7 5676.8 5676.9 6378.9 6422.8 6456.3 6481.8 6526.3 1647.3 1649.3 1696.7 1710.7 1725.8 1201.5 1208.8 1211.5 1233.5 1235.1 5643.5 5665.6 5687.5 5690.3 5712.0 6476.0 6612.7 6645.8 6690.5 6705.5 5714.0 5732.9 5792.0 5795.2 5804.0 3559.0 3581.7 3586.2 3594.0 3611.2 6458.8 6520.9 6529.4 6532.9 6545.0 6760.5 6843.6 6853.3 6906.5 6945.5 6362.1 6403.0 6410.6 6529.0 6549.6 6635.7 6637.0 6660.5 6715.2 6741.6 6595.4 6667.2 6670.9 6677.7 6718.5 6400.1 6479.3 6519.2 6525.7 6527.9 4870.9 4885.7 4938.8 4947.5 4955.6 6373.2 6622.3 6721.8 6723.2 6729.2 6234.8 6370.4 6388.7 6398.4 6485.9 6321.0 6358.3 6379.3 6417.8 6463.5 6293.2 6297.7 6367.3 6390.1 6414.3 6250.7 6364.6 6425.2 6427.7 6486.8 6179.5 6202.2 6238.3 6248.6 6329.6 05:06:17 INFO - PID 19500 | 05:06:17 INFO - PID 19500 | [#5] yui.html Cycles:180 Average:22675.44 Median:20093.75 stddev:30031.04 (149.5%) stddev-sans-first:30070.71 05:06:17 INFO - PID 19500 | Values: 883.9 915.4 916.7 927.1 950.1 18115.7 19324.6 19328.4 19355.6 22379.2 20367.8 21270.1 21635.5 21658.1 21743.9 1028.6 1038.9 1050.5 1052.9 1054.2 979.9 1052.9 1058.0 1063.0 1068.8 1124.0 1124.2 1128.9 1128.9 1129.8 1112.7 1117.8 1118.5 1122.9 1124.2 813.9 820.2 820.2 820.6 820.6 18708.6 18977.9 19010.2 19216.9 20308.6 20735.9 21043.8 21061.7 21570.9 21587.1 15756.5 15991.5 16253.7 16257.1 16457.3 3511.5 3528.3 3531.2 3531.3 3532.0 121069.4 125738.0 126966.0 126978.4 127348.0 16677.3 17088.9 17205.7 17403.3 17430.3 28680.6 30607.2 30789.8 30836.4 30926.5 8423.7 8566.4 8567.9 8625.1 8634.0 4109.9 4210.5 4213.9 4233.6 4235.1 5097.4 5305.1 5341.9 5342.2 5344.5 1074.4 1095.4 1097.9 1105.2 1107.7 672.8 678.8 681.5 705.5 710.7 12224.6 12584.3 12757.4 12799.6 12938.0 669.9 673.1 686.3 695.3 708.0 5373.4 5500.9 5842.2 6003.7 6175.1 101651.5 102687.5 104602.5 107022.0 107211.0 83456.0 84278.6 89184.6 92006.5 93644.0 78469.6 79949.6 80850.0 84242.6 84814.0 12458.4 12668.7 12947.0 13193.9 13285.6 33739.0 35857.8 36041.1 36451.5 37069.1 47471.3 47538.5 47994.3 48134.8 48757.5 18040.5 18841.2 18977.4 19067.6 19128.5 21320.3 21749.0 21925.8 22093.2 22283.8 16523.6 17240.1 18422.1 19566.0 19926.7 17663.6 19498.2 19556.8 20076.6 20110.9 17728.0 17938.5 19129.2 19232.7 19313.0 13325.5 13434.5 13706.0 14014.0 14032.0 13637.7 14261.3 14668.5 15325.3 15465.1 05:06:17 INFO - PID 19500 | -------- Summary: end -------- 05:06:17 INFO - PID 19500 | 05:06:18 INFO - TEST-INFO | 19500: exit 0 05:06:18 INFO - TEST-OK | dromaeo_css | took 1113951ms 05:06:18 INFO - TEST-START | kraken 05:06:18 INFO - Initialising browser for kraken test... 05:06:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38800/getInfo.html -profile /tmp/tmpQ1fepO/profile 05:06:18 INFO - TEST-INFO | started process 19876 (/builds/slave/test/build/application/firefox/firefox http://localhost:38800/getInfo.html) 05:06:25 INFO - TEST-INFO | 19876: exit 0 05:06:25 INFO - Browser initialized. 05:06:25 INFO - Running cycle 1/1 for kraken test... 05:06:25 INFO - TEST-INFO | started process 20103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ1fepO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:36 INFO - PID 20103 | RSS: Main: 179474432 05:06:36 INFO - PID 20103 | 05:06:39 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:38800/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38800/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:40 INFO - PID 20103 | RSS: Main: 183861248 05:06:40 INFO - PID 20103 | 05:06:42 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:38800/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38800/tests/kraken/driver.html?testName=audio-dft) 05:06:43 INFO - PID 20103 | RSS: Main: 184680448 05:06:43 INFO - PID 20103 | 05:06:46 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:38800/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38800/tests/kraken/driver.html?testName=audio-fft) 05:06:47 INFO - PID 20103 | RSS: Main: 179048448 05:06:47 INFO - PID 20103 | 05:06:49 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:38800/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38800/tests/kraken/driver.html?testName=audio-oscillator) 05:06:50 INFO - PID 20103 | RSS: Main: 179404800 05:06:50 INFO - PID 20103 | 05:06:52 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:38800/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38800/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:06:52 INFO - PID 20103 | RSS: Main: 179335168 05:06:52 INFO - PID 20103 | 05:06:55 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:38800/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38800/tests/kraken/driver.html?testName=imaging-darkroom) 05:06:56 INFO - PID 20103 | RSS: Main: 181649408 05:06:56 INFO - PID 20103 | 05:07:00 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:38800/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38800/tests/kraken/driver.html?testName=imaging-desaturate) 05:07:00 INFO - PID 20103 | RSS: Main: 182190080 05:07:00 INFO - PID 20103 | 05:07:03 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:38800/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38800/tests/kraken/driver.html?testName=json-parse-financial) 05:07:04 INFO - PID 20103 | RSS: Main: 182497280 05:07:04 INFO - PID 20103 | 05:07:05 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:38800/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38800/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:07:06 INFO - PID 20103 | RSS: Main: 182607872 05:07:06 INFO - PID 20103 | 05:07:08 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:38800/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38800/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:07:08 INFO - PID 20103 | RSS: Main: 180068352 05:07:08 INFO - PID 20103 | 05:07:11 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:38800/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38800/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:07:11 INFO - PID 20103 | RSS: Main: 180097024 05:07:11 INFO - PID 20103 | 05:07:14 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:38800/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:07:15 INFO - PID 20103 | RSS: Main: 180314112 05:07:15 INFO - PID 20103 | 05:07:18 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:38800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:07:19 INFO - PID 20103 | RSS: Main: 180146176 05:07:19 INFO - PID 20103 | 05:07:20 INFO - PID 20103 | Cycle 1(1): loaded http://localhost:38800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38800/tests/kraken/driver.html?testName=ai-astar) 05:07:21 INFO - PID 20103 | RSS: Main: 181932032 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | __start_tp_report 05:07:21 INFO - PID 20103 | _x_x_mozilla_page_load 05:07:21 INFO - PID 20103 | _x_x_mozilla_page_load_details 05:07:21 INFO - PID 20103 | |i|pagename|runs| 05:07:21 INFO - PID 20103 | |0;ai-astar;100;108;102;109;108;111;113;101;111;111 05:07:21 INFO - PID 20103 | |1;audio-beat-detection;148;117;144;183;118;148;150;121;172;125 05:07:21 INFO - PID 20103 | |2;audio-dft;162;163;164;164;165;167;166;168;166;168 05:07:21 INFO - PID 20103 | |3;audio-fft;75;74;75;172;75;74;76;73;155;74 05:07:21 INFO - PID 20103 | |4;audio-oscillator;80;88;135;82;81;79;126;80;81;134 05:07:21 INFO - PID 20103 | |5;imaging-gaussian-blur;114;113;115;116;114;114;114;114;115;118 05:07:21 INFO - PID 20103 | |6;imaging-darkroom;151;151;154;150;150;151;151;152;150;151 05:07:21 INFO - PID 20103 | |7;imaging-desaturate;94;94;94;94;95;95;94;94;94;94 05:07:21 INFO - PID 20103 | |8;json-parse-financial;54;55;56;54;54;56;55;54;54;53 05:07:21 INFO - PID 20103 | |9;json-stringify-tinderbox;55;55;54;54;55;55;54;54;55;56 05:07:21 INFO - PID 20103 | |10;stanford-crypto-aes;87;80;86;90;77;78;79;89;91;81 05:07:21 INFO - PID 20103 | |11;stanford-crypto-ccm;133;137;136;128;136;129;138;142;135;181 05:07:21 INFO - PID 20103 | |12;stanford-crypto-pbkdf2;179;186;178;175;191;178;178;189;178;179 05:07:21 INFO - PID 20103 | |13;stanford-crypto-sha256-iterative;68;74;75;70;72;68;67;68;68;71 05:07:21 INFO - PID 20103 | __end_tp_report 05:07:21 INFO - PID 20103 | __start_cc_report 05:07:21 INFO - PID 20103 | _x_x_mozilla_cycle_collect,1001 05:07:21 INFO - PID 20103 | __end_cc_report 05:07:21 INFO - PID 20103 | __startTimestamp1500898041106__endTimestamp 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | ------- Summary: start ------- 05:07:21 INFO - PID 20103 | Number of tests: 14 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | [#0] ai-astar Cycles:10 Average:107.40 Median:110.00 stddev:4.70 (4.3%) stddev-sans-first:4.15 05:07:21 INFO - PID 20103 | Values: 100.0 108.0 102.0 109.0 108.0 111.0 113.0 101.0 111.0 111.0 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:148.00 stddev:22.73 (15.4%) stddev-sans-first:24.02 05:07:21 INFO - PID 20103 | Values: 148.0 117.0 144.0 183.0 118.0 148.0 150.0 121.0 172.0 125.0 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | [#2] audio-dft Cycles:10 Average:165.30 Median:166.00 stddev:2.06 (1.2%) stddev-sans-first:1.80 05:07:21 INFO - PID 20103 | Values: 162.0 163.0 164.0 164.0 165.0 167.0 166.0 168.0 166.0 168.0 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | [#3] audio-fft Cycles:10 Average:92.30 Median:74.50 stddev:37.75 (50.7%) stddev-sans-first:39.52 05:07:21 INFO - PID 20103 | Values: 75.0 74.0 75.0 172.0 75.0 74.0 76.0 73.0 155.0 74.0 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:80.50 stddev:24.43 (30.4%) stddev-sans-first:25.17 05:07:21 INFO - PID 20103 | Values: 80.0 88.0 135.0 82.0 81.0 79.0 126.0 80.0 81.0 134.0 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.42 (1.2%) stddev-sans-first:1.48 05:07:21 INFO - PID 20103 | Values: 114.0 113.0 115.0 116.0 114.0 114.0 114.0 114.0 115.0 118.0 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.20 (0.8%) stddev-sans-first:1.27 05:07:21 INFO - PID 20103 | Values: 151.0 151.0 154.0 150.0 150.0 151.0 151.0 152.0 150.0 151.0 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:07:21 INFO - PID 20103 | Values: 94.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:0.97 (1.8%) stddev-sans-first:1.01 05:07:21 INFO - PID 20103 | Values: 54.0 55.0 56.0 54.0 54.0 56.0 55.0 54.0 54.0 53.0 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 05:07:21 INFO - PID 20103 | Values: 55.0 55.0 54.0 54.0 55.0 55.0 54.0 54.0 55.0 56.0 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:86.50 stddev:5.35 (6.2%) stddev-sans-first:5.55 05:07:21 INFO - PID 20103 | Values: 87.0 80.0 86.0 90.0 77.0 78.0 79.0 89.0 91.0 81.0 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:136.50 stddev:15.15 (11.1%) stddev-sans-first:15.89 05:07:21 INFO - PID 20103 | Values: 133.0 137.0 136.0 128.0 136.0 129.0 138.0 142.0 135.0 181.0 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:179.00 stddev:5.47 (3.1%) stddev-sans-first:5.74 05:07:21 INFO - PID 20103 | Values: 179.0 186.0 178.0 175.0 191.0 178.0 178.0 189.0 178.0 179.0 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:2.81 (4.0%) stddev-sans-first:2.87 05:07:21 INFO - PID 20103 | Values: 68.0 74.0 75.0 70.0 72.0 68.0 67.0 68.0 68.0 71.0 05:07:21 INFO - PID 20103 | -------- Summary: end -------- 05:07:21 INFO - PID 20103 | 05:07:21 INFO - PID 20103 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:07:21 INFO - TEST-INFO | 20103: exit 0 05:07:21 INFO - TEST-OK | kraken | took 63175ms 05:07:21 INFO - SUITE-END | took 1177s 05:07:22 INFO - Completed test suite (00:19:37) 05:07:22 INFO - javascript benchmark 05:07:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8435.218520713039, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.324830161515, 3148.323110531236, 3154.495280755079, 3192.0, 3204.5193221016843, 6062.393760623935, 6079.848003799902, 6125.969370153154, 6167.537434692394, 6176.907346389808, 5970.43280888316, 6134.294556126047, 6153.446189842914, 6165.260168779752, 6179.0422484514975, 5560.749766260518, 5588.972055139739, 5624.3813180550105, 5628.0, 5642.915356269659, 5597.8600534986745, 5614.775408983635, 5639.6334238274585, 5664.54683625311, 5683.573731970098, 5686.715664216793, 5703.258576385085, 5714.485696287334, 5725.427457254283, 5751.856203594902, 5450.482204190595, 5658.207850900898, 5675.659460432346, 5716.428357164292, 5746.425357464262, 5486.643368181056, 5554.944450555524, 5557.722113894289, 5618.803341883015, 5635.6055076144685, 5987.401259873977, 6023.367546407608, 6055.394460553954, 6082.1180928765525, 6150.538709596798, 6325.335839736854, 6452.451541618968, 6521.9021714673845, 6528.37980391862, 6566.146400967891, 6497.350264973512, 6587.505937054692, 6613.7685181018915, 6615.437687796543, 6617.139771829679, 6052.515798736091, 6129.662868542228, 6181.3509581493745, 6185.195924529872, 6215.06773983906, 6689.662067586405, 6819.488538359643, 6826.931730682729, 6831.555948863308, 6832.282610325944, 6370.8213980413775, 6381.1385462962835, 6388.456981156561, 6457.61254324742, 6504.707288172043, 6336.651484168323, 6398.424141827258, 6404.103425520431, 6413.166288382574, 6483.935160648333, 6413.775517856852, 6430.292667806538, 6487.351264873475, 6488.578242414228, 6517.706703198272, 6554.639494827735, 6610.206775187008, 6638.701258443381, 6644.66776661165, 6646.169228846395, 5318.7074710891275, 5347.679139251657, 5384.78460861569, 5405.5135037846785, 5410.107332290207, 4460.1525710114975, 4539.568740969603, 4567.0, 4617.538246175355, 4666.300054991711, 5736.340320863154, 5773.047447171254, 5817.7091145442555, 5825.88348233033, 5826.242588463558, 6619.271880093186, 6634.402903738686, 6637.3030831762935, 6703.262641109474, 6715.597064176165, 5557.77768889248, 5583.330000399897, 5664.85837854057, 5667.716614169275, 5807.8548036299435, 5842.240508733922, 5856.297244330707, 5902.557308201816, 5904.852378690567, 5917.408259174048, 6374.776882809079, 6396.040593910858, 6466.321036291121, 6495.1231583736535, 6503.837404064841, 6484.902726459201, 6597.406233439014, 6614.933850661624, 6723.462123030244, 6724.7646332378135, 6317.368263173646, 6422.743090276524, 6424.229092508742, 6437.25971513282, 6437.356264373525, 6488.870222595616, 6498.122753428227, 6538.934610654022, 6552.3447655236005, 6604.339566043357, 6403.743850245938, 6614.6361950093205, 6668.099806526056, 6706.128203333536, 6765.560238584476, 6377.649229292433, 6425.935740642533, 6427.260865000585, 6428.935710642833, 6438.0, 6361.745530178741, 6448.516361272829, 6451.161349024596, 6456.644884531396, 6478.1578394808375, 6145.692715364304, 6275.52933529978, 6417.0, 6440.194975628046, 6440.420362167428, 6325.177726895474, 6356.936430635819, 6416.711247993945, 6427.582207156707, 6442.387973142544, 6150.569460137747, 6180.103884936749, 6193.721282542207, 6217.160683307696, 6222.0355844844125], "value": 6008.650478906395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.1757233979849, 865.5326123893097, 888.1651247827042, 895.337450286788, 1169.5263418315585, 32059.19852003701, 43285.56714432855, 44139.337909931295, 44248.77875610626, 44266.778666106664, 43776.0, 44093.33859992095, 44154.77922610383, 44160.0, 44238.557614423844, 7190.676419561106, 7574.35617972473, 7764.340031097336, 7766.37868970481, 7780.455368124233, 7591.5445073295505, 7688.0, 7696.191899850519, 7700.229977002311, 7702.8844567331535, 7654.578998155099, 7689.653965571535, 7692.076950765916, 7696.153423123452, 7704.075510938667, 7660.080790305144, 7685.884711729329, 7689.307962283421, 7699.538027718355, 7701.537907725498, 7510.324070833596, 7547.584882831442, 7558.924410755932, 7606.353459955911, 7606.8478630427635, 38320.0, 38364.808175959224, 38492.0, 38904.80547597244, 39009.0, 3540.716742660581, 3547.3260080584864, 3555.9466608000903, 3575.3385623659447, 3586.228960773446, 32519.512207316908, 32734.67265327364, 32845.835770821235, 32935.835320823484, 32997.17507062318, 4855.223164293731, 4903.8774030649165, 4927.43334516528, 4946.901061978776, 4967.50324967504, 189668.0, 189916.0, 190357.0, 190393.9999999986, 191313.0, 51641.0, 51856.740716296175, 51892.740536297075, 51968.48031519712, 51993.48006519886, 53984.460155397945, 54030.0, 54140.72929635327, 54245.18632220441, 54379.45620543744, 14063.578092657237, 15811.0, 16137.193140342935, 16185.109818959834, 16237.837621623868, 11692.35692036946, 12604.243745375306, 12848.10063295579, 12856.421461034275, 12880.227186368847, 14781.33483993223, 14803.703925921636, 14865.108093514424, 14874.405023798927, 15005.17471539054, 5656.8020119295625, 5895.526118470382, 5943.970280148572, 5995.940040599626, 5999.0, 952.6379975609224, 958.3052287091803, 976.7069879036261, 1011.1051719228535, 1013.4375421640913, 22464.32607021792, 22502.887485562467, 22822.376911539588, 22855.514391564495, 23274.0, 1084.7505073833063, 1098.807708650983, 1099.3843447669171, 1106.9667909962714, 1125.0886781706843, 12124.757504849853, 12224.572139975058, 12225.755484890431, 12346.567870124503, 12368.0, 220171.0, 220419.0, 220536.0, 222811.0, 223512.0, 55305.446945530835, 55361.0, 55396.0, 55459.722701386236, 55485.0, 1447.486142419426, 1454.6290695872485, 1490.4261859184076, 1497.7603583426817, 1503.3836127187801, 21910.320228516273, 22071.33785986423, 22361.664575031064, 22664.433389164744, 22900.31299061031, 38730.6126938727, 38782.61217387903, 38787.0, 38816.80591597024, 38825.805870970464, 196089.0, 196862.01568992063, 196945.0, 197001.0, 197203.0, 33854.492182617774, 34901.82549087238, 35162.824185878904, 35260.82369588136, 35282.0, 43575.78212108919, 44276.0, 44563.10873782571, 44585.0, 44711.0, 31324.373512530077, 31392.0, 32393.838030809697, 32521.186970325933, 32693.836530817192, 31088.0, 32296.0, 32589.67410325961, 32733.67266327306, 33005.834970824995, 36291.81854090712, 39650.40524392194, 39867.0, 40007.79996100001, 40152.79923600363, 31673.36653266968, 34396.0, 34752.131196719274, 34869.12827179341, 35044.12389690278, 24472.265832025067, 24649.260522184362, 24731.258062258163, 25080.874595627636, 25127.74872251254], "value": 17401.345599804223, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.7794799002382, 574.2534704883656, 581.8050952930768, 590.3358721438381, 603.9245094363204, 22616.66075008874, 23492.530149397, 23496.76503234967, 23536.058557657696, 23592.52814943702, 24683.0, 27140.321491962663, 27150.72849271507, 27211.319717007085, 27380.726192738068, 6593.439557637595, 6729.798106056802, 6767.4586033117475, 6773.661316934158, 6777.0, 6342.746290148389, 6595.109660195884, 6597.571157874723, 6622.370874766913, 6631.237407698104, 6615.33846615337, 6640.701168447432, 6641.169853768279, 6650.900236496456, 6665.0, 6576.408123268929, 6629.436497897685, 6634.601923884582, 6654.334566543355, 6657.667116644173, 6178.505719542426, 6193.3496982816605, 6194.163787888668, 6194.659293738842, 6196.81409557714, 28761.85619071912, 28943.0, 29420.705792942226, 29768.255793605116, 30302.393952121056, 1899.534614019574, 1939.398786376228, 1943.1158822735622, 1944.7471828662324, 1947.0751393088312, 18611.162497687637, 19096.949667768265, 19223.519412014673, 19340.226390944346, 19389.0, 2310.849794763352, 2361.244401791427, 2375.809935205197, 2393.868337241451, 2455.435249892517, 130348.0, 132458.6754132456, 132838.0, 132933.0, 132966.3351683245, 13862.861371386158, 14796.852031479548, 15075.39698412073, 15152.772708409382, 15293.923530382277, 24274.635880461807, 24277.17921155885, 24282.0, 24306.87846560756, 24379.0, 10065.798684026278, 10131.037551432602, 10192.0, 10269.948650256702, 10303.742406439898, 9197.724068277963, 9308.720738377859, 9360.578773955189, 9398.859017114748, 9450.33847630673, 7649.77603583424, 8923.73228803137, 9014.414063085878, 9239.676611318706, 9566.808663826823, 2632.747668401551, 2651.2311429685174, 2700.6894207166033, 2722.754952054285, 2820.5346117890726, 949.639137127887, 952.9907530116035, 966.7583104223944, 975.0882924465648, 987.5901500877055, 19298.938558379145, 19344.41966741, 19786.40640780779, 19813.702794458095, 20071.39785806428, 984.242133557157, 1013.8529913162697, 1030.7526193713454, 1034.2863424237253, 1036.6734478639205, 9930.907600163977, 10528.578856845794, 11146.05258553032, 11205.71985700364, 11329.660110196708, 439034.0, 439490.0, 454299.0, 454300.0, 461629.0, 108630.45684771684, 110964.4451777736, 112214.31678524829, 113092.0, 115667.0, 1166.976660466803, 1194.8446701928867, 1210.6973256685828, 1214.757048590268, 1217.0932655171953, 16501.257443414834, 17440.15900998295, 17659.823401765818, 18009.18958646838, 18039.549011274823, 52137.7393113032, 52801.735991319794, 53590.73204634108, 53796.73101634467, 53834.0, 64972.350276498524, 66074.33925660874, 66224.0, 66393.0, 67093.0, 14426.783598245825, 14745.336459859118, 14788.11271323724, 14804.851951480347, 14811.925940370229, 23192.072317107126, 23212.18757343485, 23220.41948951222, 23413.0, 23615.173468928504, 18036.188371523574, 18379.72430413518, 18453.81546184521, 18523.35168269104, 18592.163352649433, 15079.396824126912, 15869.365225390855, 16279.348826046826, 16591.41930032443, 17411.3906013294, 18384.0, 18823.247070117042, 20298.89850550738, 20396.79603204008, 20455.8977205113, 14712.705745884808, 15009.399624015354, 15044.398224070914, 15128.092314461168, 15159.166245856584, 18560.350387736904, 18658.720119198493, 18687.972161530703, 18766.061696915374, 18954.24183032663], "value": 11918.909945751062, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.083384132631, 1430.2133826395493, 1433.1401159304419, 1448.6957738874835, 1450.9927450362748, 13760.0, 14011.369488373022, 14417.062890912084, 14420.783688244659, 14428.35072421741, 14015.229162396065, 14913.40346386146, 14923.552293431187, 14954.925225373885, 14964.102153870776, 2628.5531459651856, 2688.892444302235, 2692.165428717094, 2692.892284308625, 2694.582339737334, 2559.4113353928606, 2644.087789712546, 2703.3511957130345, 2706.9458610827774, 2708.133397312861, 2484.9006039758387, 2644.0349272515587, 2658.6543749312564, 2660.441307325464, 2661.3080599044292, 2696.4607078584263, 2706.0528814914624, 2713.6472258606254, 2720.7143249958767, 2721.6189733437236, 2485.9378515537073, 2531.240627811649, 2544.6691930048974, 2629.1192450529097, 2638.1162310625773, 13492.325383730873, 13686.110402823784, 13860.653483662889, 13908.0, 13917.721645567031, 7469.626518674045, 7754.418418618569, 7769.650365733555, 7781.8832717509285, 7794.493357931717, 4830.9275360869615, 5075.822346217865, 5229.346331708536, 5247.947520524822, 5262.578993680497, 1867.4771064102074, 1907.4930804664298, 1912.7800302965197, 1947.8441724661993, 1967.4982879365814, 23081.653775193387, 23282.883585582134, 23307.4173145671, 23311.650325245137, 23331.883340583357, 6438.0, 6463.741450341934, 6522.380373864476, 6634.104395906587, 6652.800415987528, 16018.839811601967, 16052.0, 16070.839291606935, 16080.35678572844, 16106.0, 7436.516626419266, 7542.358899493494, 7570.962145189239, 7598.772036838904, 7609.581473019037, 5523.512778312314, 6200.224971878515, 6216.782412615627, 7000.7549735759, 7037.472189585699, 5019.0, 5020.698758074454, 5143.331366922276, 5170.250313704491, 5223.921641175385, 1412.3432603839058, 1437.7052704195614, 1442.2932762946082, 1463.0928824129107, 1467.559732080393, 846.327169899931, 870.2428886868465, 870.8084221471266, 883.5582208895552, 894.959726812295, 6644.867102658017, 6898.758543451056, 7036.92963070373, 7054.717811287594, 7072.292770722886, 699.0876905638191, 707.734599525178, 717.1286886432905, 718.964051797408, 726.4224941171781, 4687.343771871941, 5102.719350435687, 5191.714455704972, 5277.076511610453, 5299.125644268653, 18858.905705471658, 19724.309649162496, 19735.802641973685, 19744.30894918671, 19754.308599198957, 18821.0, 19250.0, 19272.710909336372, 19273.903630482037, 19382.903085484482, 10241.795164096826, 10895.509702063426, 10947.288426252268, 10981.61564345244, 11000.22998390121, 7852.921470785219, 8330.875036874573, 8500.36247281444, 8515.446495977742, 8568.700095496628, 16147.354105836104, 16512.504624861274, 16962.830371696124, 17210.91394543019, 17532.912335438243, 16975.236114374635, 17065.40271090506, 17434.738478922573, 17618.414342709217, 18123.818761812214, 11434.542618295174, 11516.021138203347, 11726.355050472306, 11730.413479326171, 11761.647150585497, 12859.935700321439, 12959.35203239853, 13044.152130111512, 13088.80366794518, 13141.211527308393, 10345.63790267337, 10755.193360497837, 11016.779664406507, 11212.49543770516, 11248.21262511649, 9705.6117755289, 10277.74305642365, 10304.690859274233, 10310.587576496857, 10421.645186125756, 9495.28785341116, 9654.903450965401, 9655.372400793925, 9676.419414835133, 9695.0, 6181.732744787218, 6251.46862516673, 6409.519286053658, 6518.674066296761, 6559.212894452697, 7043.859122817413, 7220.927790722026, 7300.26997300287, 7337.963310183629, 7410.51789642063], "value": 6299.017630905344, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.9950200497994, 499.34716089742966, 522.459254671415, 523.7433657507822, 532.6324835863254, 6007.519398448125, 6156.292026416963, 6210.441060304572, 6223.315435302119, 6244.750209991601, 5812.389699081599, 6095.664738439384, 6097.5426842986735, 6098.908516372258, 6128.854900784734, 4920.704757714549, 4922.409310882699, 4924.039812236615, 4932.284818701286, 4938.728369939652, 4676.883077923062, 4879.756012199376, 4923.384576927884, 4925.975370123145, 4952.529509696573, 4798.136335459616, 4890.168671325883, 4909.312696222514, 4914.090893184754, 4916.50834916509, 4887.828925987574, 4899.142650036265, 4910.238912968495, 4920.286558449023, 4926.187179115442, 4363.214621368153, 4432.312991486325, 4447.266201076818, 4450.399196108517, 4484.103179364108, 5951.970240148815, 5960.821175364746, 5999.880002399927, 6007.969960150215, 6012.8496787580225, 5559.360673522557, 5598.720063996825, 5643.209950606918, 5706.0, 5734.311882574076, 6398.656282180747, 6429.517786166056, 6481.578697384655, 6508.479321654257, 6513.706883190221, 4851.442084160331, 4863.1732605457155, 4865.9756701216265, 4876.780544875489, 4900.803967841318, 6698.4641228701585, 6802.251752307292, 6871.793846184622, 6893.931060689379, 6911.205211400653, 4946.183879659816, 4986.376702912136, 5001.7749201285305, 5026.29631851541, 5046.39443266803, 5019.247112933016, 5061.4432412435335, 5096.566791822663, 5098.260752190911, 5107.361579802525, 5594.356648985337, 5666.801661941895, 5675.716214189274, 5676.801311954062, 5676.943230567724, 6378.872422551523, 6422.775202867877, 6456.289808121103, 6481.773137940149, 6526.314736952551, 1647.2834317071872, 1649.348507339594, 1696.6691495158573, 1710.6664200480786, 1725.7929048514259, 1201.5193922430922, 1208.83347569594, 1211.473009240983, 1233.5374234662002, 1235.123062625528, 5643.548516118701, 5665.648755766393, 5687.459691329317, 5690.260266165372, 5711.9714401428555, 6475.967620161963, 6612.669366531654, 6645.833854153685, 6690.483923351718, 6705.530612857053, 5714.0, 5732.856678582985, 5792.015357389254, 5795.217645617872, 5804.0, 3558.974871359324, 3581.659742324475, 3586.246888153517, 3593.9577522518175, 3611.205534782344, 6458.837409266283, 6520.902186467207, 6529.379708927644, 6532.934670653328, 6544.9672751635935, 6760.459163266927, 6843.62360070191, 6853.348931851466, 6906.482013848981, 6945.548539344926, 6362.1093046973465, 6403.0, 6410.55126141175, 6528.967355163194, 6549.639769812706, 6635.668216589054, 6637.0, 6660.470879801587, 6715.227748808754, 6741.59550426976, 6595.4393876521035, 6667.166604174478, 6670.9332906670315, 6677.666116694243, 6718.529702920749, 6400.135981642418, 6479.319671434431, 6519.152510173647, 6525.706343214471, 6527.934720652733, 4870.878228044327, 4885.658003939832, 4938.75306234694, 4947.505249475168, 4955.578775804097, 6373.171487706569, 6622.304658011032, 6721.764738234138, 6723.226828914738, 6729.192496900403, 6234.786650738923, 6370.426661600478, 6388.744450221939, 6398.424141827258, 6485.935140648722, 6320.968395157995, 6358.332375100548, 6379.266384365857, 6417.839554011187, 6463.547551671526, 6293.206436165671, 6297.653629050446, 6367.299597044414, 6390.13733146038, 6414.262359828679, 6250.718717657807, 6364.6181229126405, 6425.228972523327, 6427.678616069272, 6486.772962946275, 6179.5056395489155, 6202.224721909762, 6238.282597501164, 6248.625082495065, 6329.620222786648], "value": 5003.2175675579765, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [883.889513810774, 915.3501014279861, 916.7249825052482, 927.0544045074024, 950.149616093596, 18115.72826407603, 19324.613507729853, 19328.420147395565, 19355.612887742252, 22379.216727414543, 20367.796322036775, 21270.14919403226, 21635.45911352217, 21658.133674653036, 21743.891280543576, 1028.603987464824, 1038.9480525973709, 1050.5220124843179, 1052.9157667386628, 1054.1935419404163, 979.9216062714966, 1052.9420881851495, 1057.984130238047, 1062.9946850265737, 1068.8236440987266, 1124.0221007723292, 1124.213050864394, 1128.8927551882557, 1128.920975531713, 1129.779692959873, 1112.7106952192407, 1117.8435019097292, 1118.5246270335115, 1122.8652561692568, 1124.173732306754, 813.8901248331518, 820.1757233979812, 820.2453742556862, 820.5609998650752, 820.6020080261069, 18708.62582748351, 18977.905110474498, 19010.239590416368, 19216.903915480474, 20308.593828123354, 20735.896320518452, 21043.789562104335, 21061.684074738892, 21570.89214553933, 21587.1365145394, 15756.527304180892, 15991.520254392386, 16253.674926501522, 16257.10585917774, 16457.341706331732, 3511.5083888255663, 3528.329617372691, 3531.2054787672823, 3531.311394278117, 3531.9823400882833, 121069.39465302617, 125738.0, 126966.0, 126978.3651081748, 127348.0, 16677.332906683838, 17088.91455542714, 17205.655886882192, 17403.303867845145, 17430.302787888344, 28680.569791453145, 30607.2348191297, 30789.84605077005, 30836.383272334875, 30926.53610195849, 8423.70517031901, 8566.357523185787, 8567.871481927776, 8625.0943650917, 8633.956830215935, 4109.876703698894, 4210.494740631144, 4213.894652633709, 4233.555476674905, 4235.089455767024, 5097.439281679012, 5305.098133317345, 5341.86645333862, 5342.198670199501, 5344.465553444625, 1074.403705943209, 1095.3756358875364, 1097.868255809308, 1105.171121658756, 1107.6510899066768, 672.7914346552584, 678.8099332186996, 681.4582406986458, 705.4885208223997, 710.6624353432078, 12224.572139975058, 12584.274155259334, 12757.42591583381, 12799.616011519669, 12938.0, 669.8626781509779, 673.1081317254657, 686.306830101591, 695.2699665351361, 707.9716811327489, 5373.38206106295, 5500.917486237709, 5842.182094506772, 6003.729832157564, 6175.135481032659, 101651.49174254229, 102687.48656256672, 104602.4769876161, 107022.0, 107211.0, 83456.0, 84278.5786071078, 89184.5540772292, 92006.53996729973, 93644.0, 78469.60765196137, 79949.60025199837, 80850.0, 84242.57878710567, 84814.0, 12458.377081146087, 12668.683282918, 12947.0, 13193.94448444103, 13285.601431957057, 33739.0, 35857.82071089628, 36041.0989725259, 36451.45322820213, 37069.07327316839, 47471.28793068037, 47538.524614754795, 47994.28008579944, 48134.759326203144, 48757.51242487672, 18040.51129211221, 18841.15214815309, 18977.43067707971, 19067.61864762725, 19128.521786955436, 21320.253791117237, 21749.02129404149, 21925.780742193012, 22093.226737064124, 22283.77716222882, 16523.586910327336, 17240.137993100547, 18422.078896055413, 19566.0, 19926.70109948323, 17663.558411039827, 19498.220071196993, 19556.804431955497, 20076.59846803085, 20110.89944550268, 17728.0, 17938.461846144113, 19129.23483060662, 19232.71150932765, 19313.0, 13325.466981321026, 13434.529791457642, 13706.0, 14014.0, 14032.0, 13637.727245455233, 14261.286935653383, 14668.486602968846, 15325.310361033557, 15465.149416782186], "value": 9171.315777017278, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 102.0, 109.0, 108.0, 111.0, 113.0, 101.0, 111.0, 111.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 144.0, 183.0, 118.0, 148.0, 150.0, 121.0, 172.0, 125.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 164.0, 165.0, 167.0, 166.0, 168.0, 166.0, 168.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 172.0, 75.0, 74.0, 76.0, 73.0, 155.0, 74.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 88.0, 135.0, 82.0, 81.0, 79.0, 126.0, 80.0, 81.0, 134.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 116.0, 114.0, 114.0, 114.0, 114.0, 115.0, 118.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 154.0, 150.0, 150.0, 151.0, 151.0, 152.0, 150.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 54.0, 54.0, 56.0, 55.0, 54.0, 54.0, 53.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 55.0, 55.0, 54.0, 54.0, 55.0, 56.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 86.0, 90.0, 77.0, 78.0, 79.0, 89.0, 91.0, 81.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 137.0, 136.0, 128.0, 136.0, 129.0, 138.0, 142.0, 135.0, 181.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 186.0, 178.0, 175.0, 191.0, 178.0, 178.0, 189.0, 178.0, 179.0], "value": 181.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 75.0, 70.0, 72.0, 68.0, 67.0, 68.0, 68.0, 71.0], "value": 70.1, "unit": "score"}]}]} 05:07:22 INFO - Return code: 0 05:07:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:07:22 INFO - # TBPL SUCCESS # 05:07:22 INFO - Running post-action listener: _package_coverage_data 05:07:22 INFO - Running post-action listener: _resource_record_post_action 05:07:22 INFO - [mozharness: 2017-07-24 12:07:22.409214Z] Finished run-tests step (success) 05:07:22 INFO - Running post-run listener: _resource_record_post_run 05:07:22 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 192512; Write bytes: 437313536; Read time: 40; Write time: 545080 05:07:22 INFO - TinderboxPrint: CPU usage
13.2% 05:07:22 INFO - TinderboxPrint: I/O read bytes / time
192,512 / 40 05:07:22 INFO - TinderboxPrint: I/O write bytes / time
437,313,536 / 545,080 05:07:22 INFO - TinderboxPrint: CPU idle
8,278.7 (86.8%) 05:07:22 INFO - TinderboxPrint: CPU user
1,204.1 (12.6%) 05:07:22 INFO - TinderboxPrint: Swap in / out
0 / 0 05:07:22 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 111005696; Read time: 0; Write time: 129424 05:07:22 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:07:22 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 192512; Write bytes: 326307840; Read time: 40; Write time: 415656 05:07:23 INFO - Running post-run listener: _upload_blobber_files 05:07:23 INFO - Blob upload gear active. 05:07:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07: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 05:07: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'] 05:07: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 05:07:23 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:07:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:07:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:27 INFO - (blobuploader) - INFO - Done attempting. 05:07:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:07:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:07:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:28 INFO - (blobuploader) - INFO - Done attempting. 05:07:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:07:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:07:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:28 INFO - (blobuploader) - INFO - Done attempting. 05:07:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:07:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:07:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:29 INFO - (blobuploader) - INFO - Done attempting. 05:07:29 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:29 INFO - Return code: 0 05:07:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:29 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7e5752874fb9e6802028bcde4759eed732d75063161932c56274a53818f40b2854c44d89f3d253e08fcf39a328dd831dad7b1dc243ca7dccdfce250918090f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3335b85f803b04c9d09424638c8e2d697e262f964c02e701dbb279548279681181a5470ddd3cfc312329d149df5369ef92ca35e8df7ea87a4e0a5fb103b2ba7a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b0459a5b7199d211af190da24ca3a8ddefd6f931a321e16768880eec77f3addc8318930dd3e98eec8380f82b941843c3ed93d890b06a1e425afa05e52b408a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5adc098ced412c8d0136a38dea96676e673db0a8bc0ce783f4810e581c78dae21ca514ed8cf2e394d9ca24b3e64a7baa546b3a2200d46573a70c834c837a319"} 05:07:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:29 INFO - Contents: 05:07:29 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7e5752874fb9e6802028bcde4759eed732d75063161932c56274a53818f40b2854c44d89f3d253e08fcf39a328dd831dad7b1dc243ca7dccdfce250918090f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3335b85f803b04c9d09424638c8e2d697e262f964c02e701dbb279548279681181a5470ddd3cfc312329d149df5369ef92ca35e8df7ea87a4e0a5fb103b2ba7a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b0459a5b7199d211af190da24ca3a8ddefd6f931a321e16768880eec77f3addc8318930dd3e98eec8380f82b941843c3ed93d890b06a1e425afa05e52b408a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5adc098ced412c8d0136a38dea96676e673db0a8bc0ce783f4810e581c78dae21ca514ed8cf2e394d9ca24b3e64a7baa546b3a2200d46573a70c834c837a319"} 05:07:29 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:29 INFO - Copying logs to upload dir... 05:07:29 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.243413 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-07-24 05:07:29.863690) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 05:07:29.871033) ========= 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=eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177 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/e7e5752874fb9e6802028bcde4759eed732d75063161932c56274a53818f40b2854c44d89f3d253e08fcf39a328dd831dad7b1dc243ca7dccdfce250918090f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3335b85f803b04c9d09424638c8e2d697e262f964c02e701dbb279548279681181a5470ddd3cfc312329d149df5369ef92ca35e8df7ea87a4e0a5fb103b2ba7a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b0459a5b7199d211af190da24ca3a8ddefd6f931a321e16768880eec77f3addc8318930dd3e98eec8380f82b941843c3ed93d890b06a1e425afa05e52b408a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5adc098ced412c8d0136a38dea96676e673db0a8bc0ce783f4810e581c78dae21ca514ed8cf2e394d9ca24b3e64a7baa546b3a2200d46573a70c834c837a319"} build_url:https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7e5752874fb9e6802028bcde4759eed732d75063161932c56274a53818f40b2854c44d89f3d253e08fcf39a328dd831dad7b1dc243ca7dccdfce250918090f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3335b85f803b04c9d09424638c8e2d697e262f964c02e701dbb279548279681181a5470ddd3cfc312329d149df5369ef92ca35e8df7ea87a4e0a5fb103b2ba7a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b0459a5b7199d211af190da24ca3a8ddefd6f931a321e16768880eec77f3addc8318930dd3e98eec8380f82b941843c3ed93d890b06a1e425afa05e52b408a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5adc098ced412c8d0136a38dea96676e673db0a8bc0ce783f4810e581c78dae21ca514ed8cf2e394d9ca24b3e64a7baa546b3a2200d46573a70c834c837a319"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 05:07:29.899289) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 05:07:29.899869) ========= 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=eca2ab57546de7b41f256b19000001ef-1500896767.861354-198874177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 05:07:29.981635) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 05:07:29.981959) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 05:07:29.982273) ========= ========= Total master_lag: 0.88 =========