builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-083 starttime: 1500897886.25 results: success (0) revision: 758016d026077ebaf65aaecc8df437a7164dd9b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 05:04:46.246022) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 05:04:46.246493) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 05:04:46.246774) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 05:04:46.263277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 05:04:46.263658) ========= 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=3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-24 05:04:46-- 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% 42.3M=0s 2017-07-24 05:04:46 (42.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123256 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 05:04:46.403382) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 05:04:46.403718) ========= 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=3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017706 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 05:04:46.452978) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 05:04:46.453322) ========= 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=3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-24 05:04:47,031 truncating revision to first 12 chars 2017-07-24 05:04:47,031 Setting DEBUG logging. 2017-07-24 05:04:47,031 attempt 1/10 2017-07-24 05:04:47,031 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 05:04:47,901 unpacking tar archive at: mozilla-central-758016d02607/testing/mozharness/ program finished with exit code 0 elapsedTime=1.227256 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 05:04:47.693287) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 05:04:47.693628) ========= script_repo_revision: 758016d026077ebaf65aaecc8df437a7164dd9b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 05:04:47.694009) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 05:04:47.694278) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 05:04:47.701939) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-07-24 05:04:47.702336) ========= /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=3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:04:48 INFO - MultiFileLogger online at 20170724 05:04:48 in /builds/slave/test 05:04:48 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 05:04:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:04:48 INFO - {'append_to_log': False, 05:04:48 INFO - 'base_work_dir': '/builds/slave/test', 05:04:48 INFO - 'blob_upload_branch': 'Firefox', 05:04:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:04:48 INFO - 'branch': 'Firefox', 05:04:48 INFO - 'buildbot_json_path': 'buildprops.json', 05:04:48 INFO - 'code_coverage': False, 05:04:48 INFO - 'config_files': ('talos/linux_config.py',), 05:04:48 INFO - 'default_actions': ('clobber', 05:04:48 INFO - 'read-buildbot-config', 05:04:48 INFO - 'download-and-extract', 05:04:48 INFO - 'populate-webroot', 05:04:48 INFO - 'create-virtualenv', 05:04:48 INFO - 'install', 05:04:48 INFO - 'setup-mitmproxy', 05:04:48 INFO - 'run-tests'), 05:04:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:04:48 INFO - 'disable_ccov_upload': False, 05:04:48 INFO - 'download_minidump_stackwalk': True, 05:04:48 INFO - 'download_symbols': 'ondemand', 05:04:48 INFO - 'enable_stylo': False, 05:04:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:04:48 INFO - 'tooltool.py': '/tools/tooltool.py', 05:04:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:04:48 INFO - '/tools/misc-python/virtualenv.py')}, 05:04:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:04:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:04:48 INFO - 'gecko_profile': False, 05:04:48 INFO - 'gecko_profile_interval': 0, 05:04:48 INFO - 'installer_path': 'installer.exe', 05:04:48 INFO - 'log_level': 'info', 05:04:48 INFO - 'log_name': 'talos', 05:04:48 INFO - 'log_to_console': True, 05:04:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:04:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:04:48 INFO - 'opt_config_files': (), 05:04:48 INFO - 'pip_index': False, 05:04:48 INFO - 'suite': 'dromaeojs-e10s', 05:04:48 INFO - 'system_bits': '32', 05:04:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:04:48 INFO - 'title': 'talos-linux64-ix-083', 05:04:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:04:48 INFO - 'use_talos_json': True, 05:04:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:04:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:04:48 INFO - 'work_dir': 'build'} 05:04:48 INFO - [mozharness: 2017-07-24 12:04:48.387922Z] Running clobber step. 05:04:48 INFO - Running pre-action listener: _resource_record_pre_action 05:04:48 INFO - Running main action method: clobber 05:04:48 INFO - rmtree: /builds/slave/test/build 05:04:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:04:49 INFO - Running post-action listener: _resource_record_post_action 05:04:49 INFO - [mozharness: 2017-07-24 12:04:49.418299Z] Finished clobber step (success) 05:04:49 INFO - [mozharness: 2017-07-24 12:04:49.418402Z] Running read-buildbot-config step. 05:04:49 INFO - Running pre-action listener: _resource_record_pre_action 05:04:49 INFO - Running main action method: read_buildbot_config 05:04:49 INFO - Using buildbot properties: 05:04:49 INFO - { 05:04:49 INFO - "project": "", 05:04:49 INFO - "product": "firefox", 05:04:49 INFO - "who": "cbook@mozilla.com", 05:04:49 INFO - "installer_path": "public/build/target.tar.bz2", 05:04:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:04:49 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:04:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:04:49 INFO - "stage_platform": "linux64-pgo", 05:04:49 INFO - "basedir": "/builds/slave/test", 05:04:49 INFO - "buildnumber": 88, 05:04:49 INFO - "platform": "ubuntu64_hw", 05:04:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:04:49 INFO - "slavebuilddir": "test", 05:04:49 INFO - "taskId": "bexsFq0uSqeke7KBhDbSVw", 05:04:49 INFO - "branch": "mozilla-central", 05:04:49 INFO - "script_repo_revision": "production", 05:04:49 INFO - "revision": "758016d026077ebaf65aaecc8df437a7164dd9b5", 05:04:49 INFO - "slavename": "talos-linux64-ix-083", 05:04:49 INFO - "repo_path": "mozilla-central" 05:04:49 INFO - } 05:04:49 INFO - Finding installer, test and symbols from parent task. 05:04:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bexsFq0uSqeke7KBhDbSVw'}, attempt #1 05:04:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bexsFq0uSqeke7KBhDbSVw'}, attempt #1 05:04:50 INFO - Task dependencies: UUxB1dC4Rbe0zwRGAH1LSg 05:04:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg'}, attempt #1 05:04:50 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.tar.bz2 05:04:50 INFO - Set test_url: https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/test_packages.json 05:04:50 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.crashreporter-symbols.zip 05:04:50 INFO - Running post-action listener: _resource_record_post_action 05:04:50 INFO - [mozharness: 2017-07-24 12:04:50.782068Z] Finished read-buildbot-config step (success) 05:04:50 INFO - [mozharness: 2017-07-24 12:04:50.782291Z] Running download-and-extract step. 05:04:50 INFO - Running pre-action listener: _resource_record_pre_action 05:04:50 INFO - Running main action method: download_and_extract 05:04:50 INFO - mkdir: /builds/slave/test/build/tests 05:04:50 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')]} 05:04:50 INFO - trying https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.test_packages.json 05:04:50 INFO - Downloading https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:04:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:04:51 INFO - Downloaded 989 bytes. 05:04:51 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:04:51 INFO - Using the following test package requirements: 05:04:51 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:04:51 INFO - u'common': [u'target.common.tests.zip'], 05:04:51 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:04:51 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:04:51 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:04:51 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:04:51 INFO - u'mozbase': [u'target.common.tests.zip'], 05:04:51 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:04:51 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:04:51 INFO - u'web-platform': [u'target.common.tests.zip', 05:04:51 INFO - u'target.web-platform.tests.tar.gz'], 05:04:51 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:04:51 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:04:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.common.tests.zip 05:04:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:04:51 INFO - Fetch https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.common.tests.zip into memory 05:04:52 INFO - Content-Length response header: 73372074 05:04:52 INFO - Bytes received: 73372074 05:05:03 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:05:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.common.tests.zip 05:05:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:05:03 INFO - Fetch https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.common.tests.zip into memory 05:05:04 INFO - Content-Length response header: 73372074 05:05:04 INFO - Bytes received: 73372074 05:05:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.talos.tests.zip 05:05:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:05:17 INFO - Fetch https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.talos.tests.zip into memory 05:05:17 INFO - Content-Length response header: 14498880 05:05:17 INFO - Bytes received: 14498880 05:05:18 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')]} 05:05:18 INFO - trying https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.tar.bz2 05:05:18 INFO - Downloading https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:05:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:05:19 INFO - Downloaded 62900647 bytes. 05:05:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.tar.bz2 05:05:19 INFO - mkdir: /builds/slave/test/properties 05:05:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:05:19 INFO - Writing to file /builds/slave/test/properties/build_url 05:05:19 INFO - Contents: 05:05:19 INFO - build_url:https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.tar.bz2 05:05:19 INFO - Running post-action listener: _resource_record_post_action 05:05:19 INFO - Running post-action listener: set_extra_try_arguments 05:05:19 INFO - [mozharness: 2017-07-24 12:05:19.257801Z] Finished download-and-extract step (success) 05:05:19 INFO - [mozharness: 2017-07-24 12:05:19.257899Z] Running populate-webroot step. 05:05:19 INFO - Running pre-action listener: _resource_record_pre_action 05:05:19 INFO - Running main action method: populate_webroot 05:05:19 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:05:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:05:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:05:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:05:19 INFO - 'tests': ['damp', 'tps']}, 05:05:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:05:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:05:19 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:05:19 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:05:19 INFO - 'other-e10s': {'tests': ['a11yr', 05:05:19 INFO - 'ts_paint', 05:05:19 INFO - 'tpaint', 05:05:19 INFO - 'sessionrestore', 05:05:19 INFO - 'sessionrestore_many_windows', 05:05:19 INFO - 'sessionrestore_no_auto_restore', 05:05:19 INFO - 'tabpaint']}, 05:05:19 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:05:19 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:05:19 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:05:19 INFO - 'talos_options': ['--mitmproxy', 05:05:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:05:19 INFO - '--firstNonBlankPaint'], 05:05:19 INFO - 'tests': ['quantum_pageload_google', 05:05:19 INFO - 'quantum_pageload_youtube', 05:05:19 INFO - 'quantum_pageload_amazon', 05:05:19 INFO - 'quantum_pageload_facebook']}, 05:05:19 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:05:19 INFO - 'talos_options': ['--stylo', 05:05:19 INFO - '--mitmproxy', 05:05:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:05:19 INFO - '--firstNonBlankPaint'], 05:05:19 INFO - 'tests': ['quantum_pageload_google', 05:05:19 INFO - 'quantum_pageload_youtube', 05:05:19 INFO - 'quantum_pageload_amazon', 05:05:19 INFO - 'quantum_pageload_facebook']}, 05:05:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:05:19 INFO - 'tsvgr_opacity', 05:05:19 INFO - 'tart', 05:05:19 INFO - 'tscrollx', 05:05:19 INFO - 'cart', 05:05:19 INFO - 'tsvg_static']}, 05:05:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:05:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:05:19 INFO - 'talos_options': ['--xperf_path', 05:05:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:19 INFO - 'tests': ['tp5n']}}} 05:05:19 INFO - Running post-action listener: _resource_record_post_action 05:05:19 INFO - [mozharness: 2017-07-24 12:05:19.265226Z] Finished populate-webroot step (success) 05:05:19 INFO - [mozharness: 2017-07-24 12:05:19.265317Z] Running create-virtualenv step. 05:05:19 INFO - Running pre-action listener: _resource_record_pre_action 05:05:19 INFO - Running main action method: create_virtualenv 05:05:19 INFO - Creating virtualenv /builds/slave/test/build/venv 05:05:19 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 05:05:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:05:19 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:05:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:05:19 INFO - Using real prefix '/usr' 05:05:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:05:19 INFO - Installing distribute.............................................................................................................................................................................................done. 05:05:21 INFO - Installing pip.................done. 05:05:21 INFO - Return code: 0 05:05:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:05:22 INFO - Reading from file tmpfile_stdout 05:05:22 INFO - Output received: 05:05:22 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) 05:05:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:05:22 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')]} 05:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:22 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')]} 05:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:22 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 0x24e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284eeb0>, '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 0x284fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', '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 05:05:22 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 05:05:22 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 05:05:22 INFO - Using env: {'DISPLAY': ':0', 05:05:22 INFO - 'HOME': '/home/cltbld', 05:05:22 INFO - 'LANG': 'en_US.UTF-8', 05:05:22 INFO - 'LANGUAGE': 'en_US:en', 05:05:22 INFO - 'LOGNAME': 'cltbld', 05:05:22 INFO - 'MAIL': '/var/mail/cltbld', 05:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:22 INFO - 'MOZ_NO_REMOTE': '1', 05:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:22 INFO - 'NO_EM_RESTART': '1', 05:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:22 INFO - 'PWD': '/builds/slave/test', 05:05:22 INFO - 'SHELL': '/bin/bash', 05:05:22 INFO - 'SHLVL': '1', 05:05:22 INFO - 'TERM': 'linux', 05:05:22 INFO - 'TMOUT': '86400', 05:05:22 INFO - 'USER': 'cltbld', 05:05:22 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', 05:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:22 INFO - '_': '/tools/buildbot/bin/python'} 05:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:22 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 05:05:22 INFO - Cleaning up... 05:05:22 INFO - Return code: 0 05:05:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:05:22 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')]} 05:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:22 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')]} 05:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:22 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 0x24e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284eeb0>, '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 0x284fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', '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 05:05:22 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 05:05:22 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 05:05:22 INFO - Using env: {'DISPLAY': ':0', 05:05:22 INFO - 'HOME': '/home/cltbld', 05:05:22 INFO - 'LANG': 'en_US.UTF-8', 05:05:22 INFO - 'LANGUAGE': 'en_US:en', 05:05:22 INFO - 'LOGNAME': 'cltbld', 05:05:22 INFO - 'MAIL': '/var/mail/cltbld', 05:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:22 INFO - 'MOZ_NO_REMOTE': '1', 05:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:22 INFO - 'NO_EM_RESTART': '1', 05:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:22 INFO - 'PWD': '/builds/slave/test', 05:05:22 INFO - 'SHELL': '/bin/bash', 05:05:22 INFO - 'SHLVL': '1', 05:05:22 INFO - 'TERM': 'linux', 05:05:22 INFO - 'TMOUT': '86400', 05:05:22 INFO - 'USER': 'cltbld', 05:05:22 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', 05:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:22 INFO - '_': '/tools/buildbot/bin/python'} 05:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:22 INFO - Downloading/unpacking psutil>=3.1.1 05:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:05:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:23 INFO - Installing collected packages: psutil 05:05:23 INFO - Running setup.py install for psutil 05:05:23 INFO - building 'psutil._psutil_linux' extension 05:05:23 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 05:05:24 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 05:05:24 INFO - building 'psutil._psutil_posix' extension 05:05:24 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 05:05:24 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 05:05:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:24 INFO - Successfully installed psutil 05:05:24 INFO - Cleaning up... 05:05:24 INFO - Return code: 0 05:05:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:05:24 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')]} 05:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:24 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')]} 05:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:24 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 0x24e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284eeb0>, '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 0x284fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', '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 05:05:24 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 05:05:24 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 05:05:24 INFO - Using env: {'DISPLAY': ':0', 05:05:24 INFO - 'HOME': '/home/cltbld', 05:05:24 INFO - 'LANG': 'en_US.UTF-8', 05:05:24 INFO - 'LANGUAGE': 'en_US:en', 05:05:24 INFO - 'LOGNAME': 'cltbld', 05:05:24 INFO - 'MAIL': '/var/mail/cltbld', 05:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:24 INFO - 'MOZ_NO_REMOTE': '1', 05:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:24 INFO - 'NO_EM_RESTART': '1', 05:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:24 INFO - 'PWD': '/builds/slave/test', 05:05:24 INFO - 'SHELL': '/bin/bash', 05:05:24 INFO - 'SHLVL': '1', 05:05:24 INFO - 'TERM': 'linux', 05:05:24 INFO - 'TMOUT': '86400', 05:05:24 INFO - 'USER': 'cltbld', 05:05:24 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', 05:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:24 INFO - '_': '/tools/buildbot/bin/python'} 05:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:05: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 05:05: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 05:05: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 05:05: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 05:05:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:05:25 INFO - Installing collected packages: mozsystemmonitor 05:05:25 INFO - Running setup.py install for mozsystemmonitor 05:05:25 INFO - Successfully installed mozsystemmonitor 05:05:25 INFO - Cleaning up... 05:05:25 INFO - Return code: 0 05:05:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:05: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')]} 05:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05: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')]} 05:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284eeb0>, '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 0x284fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', '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 05:05: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==2.5.1'] in /builds/slave/test/build 05:05: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==2.5.1 05:05:25 INFO - Using env: {'DISPLAY': ':0', 05:05:25 INFO - 'HOME': '/home/cltbld', 05:05:25 INFO - 'LANG': 'en_US.UTF-8', 05:05:25 INFO - 'LANGUAGE': 'en_US:en', 05:05:25 INFO - 'LOGNAME': 'cltbld', 05:05:25 INFO - 'MAIL': '/var/mail/cltbld', 05:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:25 INFO - 'MOZ_NO_REMOTE': '1', 05:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:25 INFO - 'NO_EM_RESTART': '1', 05:05:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:25 INFO - 'PWD': '/builds/slave/test', 05:05:25 INFO - 'SHELL': '/bin/bash', 05:05:25 INFO - 'SHLVL': '1', 05:05:25 INFO - 'TERM': 'linux', 05:05:25 INFO - 'TMOUT': '86400', 05:05:25 INFO - 'USER': 'cltbld', 05:05:25 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', 05:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:25 INFO - '_': '/tools/buildbot/bin/python'} 05:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:26 INFO - Downloading/unpacking jsonschema==2.5.1 05:05:26 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 05:05:26 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 05:05:26 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 05:05:26 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 05:05:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:05:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:05:27 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 05:05:27 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 05:05:27 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 05:05:27 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 05:05:27 INFO - Downloading functools32-3.2.3-2.tar.gz 05:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:05:27 INFO - warning: no files found matching '*.txt' 05:05:27 INFO - no previously-included directories found matching 'build' 05:05:27 INFO - no previously-included directories found matching 'dist' 05:05:27 INFO - no previously-included directories found matching '.git*' 05:05:27 INFO - Installing collected packages: jsonschema, functools32 05:05:27 INFO - Running setup.py install for functools32 05:05:27 INFO - warning: no files found matching '*.txt' 05:05:27 INFO - no previously-included directories found matching 'build' 05:05:27 INFO - no previously-included directories found matching 'dist' 05:05:27 INFO - no previously-included directories found matching '.git*' 05:05:27 INFO - Successfully installed jsonschema functools32 05:05:27 INFO - Cleaning up... 05:05:27 INFO - Return code: 0 05:05:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:05:27 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')]} 05:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:27 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')]} 05:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:27 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 0x24e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284eeb0>, '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 0x284fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', '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 05:05:27 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 05:05:27 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 05:05:27 INFO - Using env: {'DISPLAY': ':0', 05:05:27 INFO - 'HOME': '/home/cltbld', 05:05:27 INFO - 'LANG': 'en_US.UTF-8', 05:05:27 INFO - 'LANGUAGE': 'en_US:en', 05:05:27 INFO - 'LOGNAME': 'cltbld', 05:05:27 INFO - 'MAIL': '/var/mail/cltbld', 05:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:27 INFO - 'MOZ_NO_REMOTE': '1', 05:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:27 INFO - 'NO_EM_RESTART': '1', 05:05:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:27 INFO - 'PWD': '/builds/slave/test', 05:05:27 INFO - 'SHELL': '/bin/bash', 05:05:27 INFO - 'SHLVL': '1', 05:05:27 INFO - 'TERM': 'linux', 05:05:27 INFO - 'TMOUT': '86400', 05:05:27 INFO - 'USER': 'cltbld', 05:05:27 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', 05:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:27 INFO - '_': '/tools/buildbot/bin/python'} 05:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:05:27 INFO - Cleaning up... 05:05:27 INFO - Return code: 0 05:05:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:05:27 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')]} 05:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:27 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')]} 05:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:27 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 0x24e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284eeb0>, '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 0x284fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', '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 05:05:27 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 05:05:27 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 05:05:27 INFO - Using env: {'DISPLAY': ':0', 05:05:27 INFO - 'HOME': '/home/cltbld', 05:05:27 INFO - 'LANG': 'en_US.UTF-8', 05:05:27 INFO - 'LANGUAGE': 'en_US:en', 05:05:27 INFO - 'LOGNAME': 'cltbld', 05:05:27 INFO - 'MAIL': '/var/mail/cltbld', 05:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:27 INFO - 'MOZ_NO_REMOTE': '1', 05:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:27 INFO - 'NO_EM_RESTART': '1', 05:05:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:27 INFO - 'PWD': '/builds/slave/test', 05:05:27 INFO - 'SHELL': '/bin/bash', 05:05:27 INFO - 'SHLVL': '1', 05:05:27 INFO - 'TERM': 'linux', 05:05:27 INFO - 'TMOUT': '86400', 05:05:27 INFO - 'USER': 'cltbld', 05:05:27 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', 05:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:27 INFO - '_': '/tools/buildbot/bin/python'} 05:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:27 INFO - Downloading/unpacking blobuploader==1.2.4 05:05:27 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 05:05:27 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 05:05:27 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 05:05:27 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 05:05:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:05:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:05:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:29 INFO - Downloading docopt-0.6.1.tar.gz 05:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:05:29 INFO - Installing collected packages: blobuploader, requests, docopt 05:05:29 INFO - Running setup.py install for blobuploader 05:05:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:05:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:05:29 INFO - Running setup.py install for requests 05:05:30 INFO - Running setup.py install for docopt 05:05:30 INFO - Successfully installed blobuploader requests docopt 05:05:30 INFO - Cleaning up... 05:05:30 INFO - Return code: 0 05:05:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:30 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 0x24e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284eeb0>, '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 0x284fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', '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 05:05:30 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 05:05:30 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 05:05:30 INFO - Using env: {'DISPLAY': ':0', 05:05:30 INFO - 'HOME': '/home/cltbld', 05:05:30 INFO - 'LANG': 'en_US.UTF-8', 05:05:30 INFO - 'LANGUAGE': 'en_US:en', 05:05:30 INFO - 'LOGNAME': 'cltbld', 05:05:30 INFO - 'MAIL': '/var/mail/cltbld', 05:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:30 INFO - 'MOZ_NO_REMOTE': '1', 05:05:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:30 INFO - 'NO_EM_RESTART': '1', 05:05:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:30 INFO - 'PWD': '/builds/slave/test', 05:05:30 INFO - 'SHELL': '/bin/bash', 05:05:30 INFO - 'SHLVL': '1', 05:05:30 INFO - 'TERM': 'linux', 05:05:30 INFO - 'TMOUT': '86400', 05:05:30 INFO - 'USER': 'cltbld', 05:05:30 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', 05:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:30 INFO - '_': '/tools/buildbot/bin/python'} 05:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:30 INFO - Running setup.py (path:/tmp/pip-DcXUnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:30 INFO - Running setup.py (path:/tmp/pip-sp8fxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:30 INFO - Running setup.py (path:/tmp/pip-kkSDNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:30 INFO - Running setup.py (path:/tmp/pip-Zof2JI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:30 INFO - Running setup.py (path:/tmp/pip-w8D6nE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:30 INFO - Running setup.py (path:/tmp/pip-J1oR4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:30 INFO - Running setup.py (path:/tmp/pip-LOfMxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:30 INFO - Running setup.py (path:/tmp/pip-uE8NfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:30 INFO - Running setup.py (path:/tmp/pip-I8_5O3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:31 INFO - Running setup.py (path:/tmp/pip-DjEDVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:31 INFO - Running setup.py (path:/tmp/pip-gsxzAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:31 INFO - Running setup.py (path:/tmp/pip-9b_Alp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:31 INFO - Running setup.py (path:/tmp/pip-i0KaRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:31 INFO - Running setup.py (path:/tmp/pip-nkoluk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:31 INFO - Running setup.py (path:/tmp/pip-lKI40l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:31 INFO - Running setup.py (path:/tmp/pip-Duzy4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:31 INFO - Running setup.py (path:/tmp/pip-8ibX88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:05:31 INFO - Running setup.py install for manifestparser 05:05:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:05:31 INFO - Running setup.py install for mozcrash 05:05:31 INFO - Running setup.py install for mozdebug 05:05:31 INFO - Running setup.py install for mozdevice 05:05:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozfile 05:05:32 INFO - Running setup.py install for mozhttpd 05:05:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozinfo 05:05:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozInstall 05:05:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozleak 05:05:32 INFO - Running setup.py install for mozlog 05:05:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for moznetwork 05:05:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozprocess 05:05:32 INFO - Running setup.py install for mozprofile 05:05:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozrunner 05:05:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:05:33 INFO - Running setup.py install for mozscreenshot 05:05:33 INFO - Running setup.py install for moztest 05:05:33 INFO - Running setup.py install for mozversion 05:05:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:05:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:05:33 INFO - Cleaning up... 05:05:33 INFO - Return code: 0 05:05:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:33 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 0x24e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284eeb0>, '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 0x284fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', '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 05:05:33 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 05:05:33 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 05:05:33 INFO - Using env: {'DISPLAY': ':0', 05:05:33 INFO - 'HOME': '/home/cltbld', 05:05:33 INFO - 'LANG': 'en_US.UTF-8', 05:05:33 INFO - 'LANGUAGE': 'en_US:en', 05:05:33 INFO - 'LOGNAME': 'cltbld', 05:05:33 INFO - 'MAIL': '/var/mail/cltbld', 05:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:33 INFO - 'MOZ_NO_REMOTE': '1', 05:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:33 INFO - 'NO_EM_RESTART': '1', 05:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:33 INFO - 'PWD': '/builds/slave/test', 05:05:33 INFO - 'SHELL': '/bin/bash', 05:05:33 INFO - 'SHLVL': '1', 05:05:33 INFO - 'TERM': 'linux', 05:05:33 INFO - 'TMOUT': '86400', 05:05:33 INFO - 'USER': 'cltbld', 05:05:33 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', 05:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:33 INFO - '_': '/tools/buildbot/bin/python'} 05:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:33 INFO - Running setup.py (path:/tmp/pip-fhIlS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:33 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)) 05:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:33 INFO - Running setup.py (path:/tmp/pip-wdpELz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:33 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)) 05:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:33 INFO - Running setup.py (path:/tmp/pip-GTVviT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:33 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)) 05:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:33 INFO - Running setup.py (path:/tmp/pip-H30Kd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:33 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)) 05:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:33 INFO - Running setup.py (path:/tmp/pip-rCAc5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:33 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)) 05:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:33 INFO - Running setup.py (path:/tmp/pip-M3gFpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:34 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)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:34 INFO - Running setup.py (path:/tmp/pip-6NpsCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:34 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)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:34 INFO - Running setup.py (path:/tmp/pip-ENrygN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:34 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)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:34 INFO - Running setup.py (path:/tmp/pip-Osp1P2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:34 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)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:34 INFO - Running setup.py (path:/tmp/pip-e2Dkwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:34 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)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:34 INFO - Running setup.py (path:/tmp/pip-JGcSap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:34 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)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:34 INFO - Running setup.py (path:/tmp/pip-aVvTrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:34 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)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:34 INFO - Running setup.py (path:/tmp/pip-mpbWsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:34 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)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:34 INFO - Running setup.py (path:/tmp/pip-DRMaRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:34 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)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:34 INFO - Running setup.py (path:/tmp/pip-XavdV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:34 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)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:34 INFO - Running setup.py (path:/tmp/pip-hFfl6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:34 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)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:34 INFO - Running setup.py (path:/tmp/pip-U6cEna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:34 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)) 05:05:34 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)) 05:05:34 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)) 05:05:34 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)) 05:05:34 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)) 05:05:34 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)) 05:05:34 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)) 05:05:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:35 INFO - Downloading blessings-1.6.tar.gz 05:05:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:05:35 INFO - Installing collected packages: blessings 05:05:35 INFO - Running setup.py install for blessings 05:05:36 INFO - Successfully installed blessings 05:05:36 INFO - Cleaning up... 05:05:36 INFO - Return code: 0 05:05:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:05:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:36 INFO - Reading from file tmpfile_stdout 05:05:36 INFO - Current package versions: 05:05:36 INFO - argparse == 1.2.1 05:05:36 INFO - blessings == 1.6 05:05:36 INFO - blobuploader == 1.2.4 05:05:36 INFO - docopt == 0.6.1 05:05:36 INFO - functools32 == 3.2.3-2 05:05:36 INFO - jsonschema == 2.5.1 05:05:36 INFO - manifestparser == 1.1 05:05:36 INFO - mozInstall == 1.13 05:05:36 INFO - mozcrash == 1.0 05:05:36 INFO - mozdebug == 0.1 05:05:36 INFO - mozdevice == 0.51 05:05:36 INFO - mozfile == 1.2 05:05:36 INFO - mozhttpd == 0.7 05:05:36 INFO - mozinfo == 0.10 05:05:36 INFO - mozleak == 0.1 05:05:36 INFO - mozlog == 3.5 05:05:36 INFO - moznetwork == 0.27 05:05:36 INFO - mozprocess == 0.25 05:05:36 INFO - mozprofile == 0.28 05:05:36 INFO - mozrunner == 6.13 05:05:36 INFO - mozscreenshot == 0.1 05:05:36 INFO - mozsystemmonitor == 0.3 05:05:36 INFO - moztest == 0.8 05:05:36 INFO - mozversion == 1.4 05:05:36 INFO - psutil == 3.1.1 05:05:36 INFO - requests == 1.2.3 05:05:36 INFO - wsgiref == 0.1.2 05:05:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:36 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 0x24e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284eeb0>, '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 0x284fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', '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 05:05:36 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 05:05:36 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 05:05:36 INFO - Using env: {'DISPLAY': ':0', 05:05:36 INFO - 'HOME': '/home/cltbld', 05:05:36 INFO - 'LANG': 'en_US.UTF-8', 05:05:36 INFO - 'LANGUAGE': 'en_US:en', 05:05:36 INFO - 'LOGNAME': 'cltbld', 05:05:36 INFO - 'MAIL': '/var/mail/cltbld', 05:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:36 INFO - 'MOZ_NO_REMOTE': '1', 05:05:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:36 INFO - 'NO_EM_RESTART': '1', 05:05:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:36 INFO - 'PWD': '/builds/slave/test', 05:05:36 INFO - 'SHELL': '/bin/bash', 05:05:36 INFO - 'SHLVL': '1', 05:05:36 INFO - 'TERM': 'linux', 05:05:36 INFO - 'TMOUT': '86400', 05:05:36 INFO - 'USER': 'cltbld', 05:05:36 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', 05:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:36 INFO - '_': '/tools/buildbot/bin/python'} 05:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:36 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)) 05:05:36 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)) 05:05:36 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)) 05:05:36 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)) 05:05:36 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)) 05:05:36 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)) 05:05:36 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)) 05:05:36 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)) 05:05:36 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)) 05:05:36 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:37 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:05:37 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 05:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:05:37 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)) 05:05:37 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)) 05:05:37 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)) 05:05:37 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)) 05:05:37 INFO - Installing collected packages: marionette-driver, simplejson 05:05:37 INFO - Running setup.py install for marionette-driver 05:05:38 INFO - Running setup.py install for simplejson 05:05:38 INFO - building 'simplejson._speedups' extension 05:05:38 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 05:05:38 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 05:05:39 INFO - Successfully installed marionette-driver simplejson 05:05:39 INFO - Cleaning up... 05:05:39 INFO - Return code: 0 05:05:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:05:39 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')]} 05:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:39 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')]} 05:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:39 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 0x24e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284eeb0>, '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 0x284fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', '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 05:05:39 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 05:05:39 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 05:05:39 INFO - Using env: {'DISPLAY': ':0', 05:05:39 INFO - 'HOME': '/home/cltbld', 05:05:39 INFO - 'LANG': 'en_US.UTF-8', 05:05:39 INFO - 'LANGUAGE': 'en_US:en', 05:05:39 INFO - 'LOGNAME': 'cltbld', 05:05:39 INFO - 'MAIL': '/var/mail/cltbld', 05:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:39 INFO - 'MOZ_NO_REMOTE': '1', 05:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:39 INFO - 'NO_EM_RESTART': '1', 05:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:39 INFO - 'PWD': '/builds/slave/test', 05:05:39 INFO - 'SHELL': '/bin/bash', 05:05:39 INFO - 'SHLVL': '1', 05:05:39 INFO - 'TERM': 'linux', 05:05:39 INFO - 'TMOUT': '86400', 05:05:39 INFO - 'USER': 'cltbld', 05:05:39 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', 05:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:39 INFO - '_': '/tools/buildbot/bin/python'} 05:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:05:39 INFO - Cleaning up... 05:05:39 INFO - Return code: 0 05:05:39 INFO - Running post-action listener: _resource_record_post_action 05:05:39 INFO - Running post-action listener: _start_resource_monitoring 05:05:39 INFO - Starting resource monitoring. 05:05:39 INFO - [mozharness: 2017-07-24 12:05:39.393154Z] Finished create-virtualenv step (success) 05:05:39 INFO - [mozharness: 2017-07-24 12:05:39.393667Z] Running install step. 05:05:39 INFO - Running pre-action listener: _resource_record_pre_action 05:05:39 INFO - Running main action method: install 05:05:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:39 INFO - Reading from file tmpfile_stdout 05:05:39 INFO - Detecting whether we're running mozinstall >=1.0... 05:05:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:05:39 INFO - Reading from file tmpfile_stdout 05:05:39 INFO - Output received: 05:05:39 INFO - Usage: mozinstall [options] installer 05:05:39 INFO - Options: 05:05:39 INFO - -h, --help show this help message and exit 05:05:39 INFO - -d DEST, --destination=DEST 05:05:39 INFO - Directory to install application into. [default: 05:05:39 INFO - "/builds/slave/test"] 05:05:39 INFO - --app=APP Application being installed. [default: firefox] 05:05:39 INFO - mkdir: /builds/slave/test/build/application 05:05:39 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'] 05:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:05:57 INFO - Reading from file tmpfile_stdout 05:05:57 INFO - Output received: 05:05:57 INFO - /builds/slave/test/build/application/firefox/firefox 05:05:57 INFO - Running post-action listener: _resource_record_post_action 05:05:57 INFO - [mozharness: 2017-07-24 12:05:57.622667Z] Finished install step (success) 05:05:57 INFO - [mozharness: 2017-07-24 12:05:57.622821Z] Running setup-mitmproxy step. 05:05:57 INFO - Running pre-action listener: _resource_record_pre_action 05:05:57 INFO - Running main action method: setup_mitmproxy 05:05:57 INFO - Skipping: mitmproxy is not required 05:05:57 INFO - Running post-action listener: _resource_record_post_action 05:05:57 INFO - [mozharness: 2017-07-24 12:05:57.623354Z] Finished setup-mitmproxy step (success) 05:05:57 INFO - [mozharness: 2017-07-24 12:05:57.623459Z] Running run-tests step. 05:05:57 INFO - Running pre-action listener: _resource_record_pre_action 05:05:57 INFO - Running pre-action listener: _set_gcov_prefix 05:05:57 INFO - Running main action method: run_tests 05:05:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:05:57 INFO - Python 2.7.3 05:05:57 INFO - Return code: 0 05:05:57 INFO - grabbing minidump binary from tooltool 05:05:57 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')]} 05:05:57 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 0x284eeb0>, '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 0x284fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:05:57 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 05:05:57 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 05:05:57 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 05:05:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:05:57 INFO - Return code: 0 05:05:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:05:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:05:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:05:57 INFO - ENV: RUST_BACKTRACE is now 1 05:05:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:05:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:05:57 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/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--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 05:05:57 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/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-083 --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 05:05:57 INFO - Using env: {'DISPLAY': ':0', 05:05:57 INFO - 'HOME': '/home/cltbld', 05:05:57 INFO - 'LANG': 'en_US.UTF-8', 05:05:57 INFO - 'LANGUAGE': 'en_US:en', 05:05:57 INFO - 'LOGNAME': 'cltbld', 05:05:57 INFO - 'MAIL': '/var/mail/cltbld', 05:05:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:05:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:57 INFO - 'MOZ_NO_REMOTE': '1', 05:05:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:57 INFO - 'NO_EM_RESTART': '1', 05:05:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:57 INFO - 'PWD': '/builds/slave/test', 05:05:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:05:57 INFO - 'RUST_BACKTRACE': '1', 05:05:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:05:57 INFO - 'SHELL': '/bin/bash', 05:05:57 INFO - 'SHLVL': '1', 05:05:57 INFO - 'TERM': 'linux', 05:05:57 INFO - 'TMOUT': '86400', 05:05:57 INFO - 'USER': 'cltbld', 05:05:57 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488', 05:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:57 INFO - '_': '/tools/buildbot/bin/python'} 05:05:57 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/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--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 05:05:57 INFO - mozversion application_buildid: 20170724105843 05:05:57 INFO - mozversion application_changeset: 758016d026077ebaf65aaecc8df437a7164dd9b5 05:05:57 INFO - mozversion application_display_name: Nightly 05:05:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:05:57 INFO - mozversion application_name: Firefox 05:05:57 INFO - mozversion application_remotingname: firefox 05:05:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:05:57 INFO - mozversion application_vendor: Mozilla 05:05:57 INFO - mozversion application_version: 56.0a1 05:05:57 INFO - mozversion platform_buildid: 20170724105843 05:05:57 INFO - mozversion platform_changeset: 758016d026077ebaf65aaecc8df437a7164dd9b5 05:05:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:05:57 INFO - mozversion platform_version: 56.0a1 05:05:57 INFO - using testdate: 1500897957 05:05:57 INFO - actual date: 1500897957 05:05:57 INFO - starting webserver on 'localhost:34020' 05:05:57 INFO - SUITE-START | Running 2 tests 05:05:57 INFO - TEST-START | dromaeo_css 05:05:57 INFO - Initialising browser for dromaeo_css test... 05:05:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34020/getInfo.html -profile /tmp/tmpZ7AsBK/profile 05:05:58 INFO - TEST-INFO | started process 9393 (/builds/slave/test/build/application/firefox/firefox http://localhost:34020/getInfo.html) 05:06:03 INFO - TEST-INFO | 9393: exit 0 05:06:03 INFO - Browser initialized. 05:06:03 INFO - Running cycle 1/1 for dromaeo_css test... 05:06:03 INFO - TEST-INFO | started process 9598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ7AsBK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:15 INFO - PID 9598 | RSS: Main: 166895616 05:06:15 INFO - PID 9598 | 05:09:12 INFO - PID 9598 | Cycle 1(1): loaded http://localhost:34020/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34020/tests/dromaeo/cssquery-ext.html) 05:09:15 INFO - PID 9598 | RSS: Main: 173088768 05:09:15 INFO - PID 9598 | 05:12:17 INFO - PID 9598 | Cycle 1(1): loaded http://localhost:34020/tests/dromaeo/cssquery-ext.html (next: http://localhost:34020/tests/dromaeo/cssquery-jquery.html) 05:12:17 INFO - PID 9598 | RSS: Main: 168960000 05:12:17 INFO - PID 9598 | 05:15:19 INFO - PID 9598 | Cycle 1(1): loaded http://localhost:34020/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34020/tests/dromaeo/cssquery-mootools.html) 05:15:19 INFO - PID 9598 | RSS: Main: 172158976 05:15:19 INFO - PID 9598 | 05:18:21 INFO - PID 9598 | Cycle 1(1): loaded http://localhost:34020/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34020/tests/dromaeo/cssquery-prototype.html) 05:18:22 INFO - PID 9598 | RSS: Main: 171212800 05:18:22 INFO - PID 9598 | 05:21:25 INFO - PID 9598 | Cycle 1(1): loaded http://localhost:34020/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34020/tests/dromaeo/cssquery-yui.html) 05:21:26 INFO - PID 9598 | RSS: Main: 172789760 05:21:26 INFO - PID 9598 | 05:24:27 INFO - PID 9598 | Cycle 1(1): loaded http://localhost:34020/tests/dromaeo/cssquery-yui.html (next: http://localhost:34020/tests/dromaeo/cssquery-dojo.html) 05:24:27 INFO - PID 9598 | RSS: Main: 172498944 05:24:27 INFO - PID 9598 | 05:24:27 INFO - PID 9598 | __start_tp_report 05:24:27 INFO - PID 9598 | _x_x_mozilla_page_load 05:24:27 INFO - PID 9598 | _x_x_mozilla_page_load_details 05:24:27 INFO - PID 9598 | |i|pagename|runs| 05:24:27 INFO - PID 9598 | |0;dojo.html;3294.028261662809;3368.0569440556646;3388.0852169914124;3390.9491357629627;3422.623511413744;6122.877542449149;6186.381361863817;6215.3784621537825;6223.315435302113;6281.62310261384;6085.300190478097;6132.877342453159;6166.845828854281;6176.351483094267;6179.351168127349;5381.784728610861;5407.053765591026;5427.565794736432;5464.562834973212;5510.476504732044;5476.069068258405;5479.479449452296;5543.722813859291;5555.3611334696425;5576.163575463673;5238.449962753894;5462.562994960394;5488.368837583689;5515.751791169407;5530.225768392408;5390.0836857734275;5422.674639521601;5451.291332126798;5509.5041446270025;5512.503874651261;5405.37838148614;5406.513413792738;5455.890882182334;5478.534324582415;5486.91769623456;6023.0062039763825;6027.276726792769;6125.84685382869;6144.754209831602;6189.690515474208;6655.800325990228;6715.328467153295;6724.462043036594;6744.291849355796;6754.358335958076;6754.223264324616;6783.525153239275;6822.283660215656;6854.10896583446;6859.2454829968665;6225.564210505221;6244.281907580641;6306.747730090837;6323.810285691437;6344.777932772331;6735.090762746966;6742.056112144303;6844.452443804584;6890.724371025103;6956.826079348057;6556.704948277339;6560.606363618198;6627.469802415795;6652.900206496906;6679.165104361955;6668.266490686021;6690.866182676319;6728.629925354055;6749.730010799612;6753.628550429676;6598.670066496656;6607.933920660828;6618.86762264752;6670.533062685662;6695.296993815677;6581.3747693969;6642.96678516614;6652.70062847173;6696.430803381767;6704.731810727614;4864.124457597595;4934.284528743312;4988.7505624718615;4988.7505624718615;4992.251162325608;4330.307150855848;4349.586789255016;4370.759608221515;4381.496127945264;4406.030673251879;6317.652529110943;6361.077643741724;6424.74301027963;6443.742250310029;6456.548041637135;6663.500237482208;6717.059611654372;6744.224414192333;6766.6278354689985;6781.050652908597;6469.805905822833;6483.546151769331;6545.672716364163;6563.50773691975;6568.967155164193;5580.972095139498;5587.106063029895;5643;5648.576356773258;5652.265205523256;7003.299670033058;7075.398591119812;7081.752138675121;7113.75101871432;7157.57054576727;6649.102371179829;6659.800205993828;6660.666966651551;6670.132882725215;6680.799576012728;6982.546134501445;7057.329553692391;7065.858682826418;7071.398931090915;7074.903389974562;6582.539222254396;6596.406323430914;6598.967005164944;6602.867942641216;6625.933740662725;6729.394354508117;6732.831679208059;6735.831604209934;6736.7642132525125;6738.663066846736;6317.115603815561;6514.250861151028;6517.576357536745;6518.250401203923;6568.6058836469965;6529.477641788741;6604.306547812411;6616.503762217757;6624.171978502687;6625.304343044104;6476.963685810248;6483.286838447862;6552.180977377828;6561.475081993524;6625.536212465081;6459.61242325462;6489;6542.280349161683;6596.769113081019;6616.7022483987375;6410.134631824831;6416.967915160394;6461;6486.027095935648;6499.155109835691 05:24:27 INFO - PID 9598 | |1;ext.html;891.1452300564357;924.8150369926014;947.8530827721701;1209.4799236328374;1242.857071436785;40277;44091.33862992054;44170.77914610422;44186;44293.33559996603;41296;41422.58577414225;41519.79240103803;41757.164856702846;41885.371719424154;7127.322904324081;7177;7222.602756848398;7246.782596522113;7254.673539690727;7114.893276600855;7157.534760240567;7158.3915367193595;7168.211496735355;7169.283071692815;7194.1726701429225;7219.205887352413;7490.4007679385795;7652.693892244331;7663.693452261903;7576.28025337592;7617.162112167657;7624.199459056802;7627.313541781266;7628.122765881912;7403.7408690695565;7472.103347598323;7549.622518874089;7551.395888328921;7612.124605670363;42407.151856962686;42726;42729;42748.358774618406;42799.786001070104;3483.164040630256;3516.4022116240044;3530.505729197914;3530.6469353064745;3532.1699400640828;33260.66739332624;33342;33426;33533.66466335354;33537.16157096068;5092.0579692756955;5108.616853735947;5145.845624631267;5154.768035438415;5166.61250406221;211081;213713;214479;214645;214803;53472.19791703128;53726;53756;54210.72894635502;54346.184807227924;56755;56992.43007569954;57164;57221;57308.42691573114;16661.91669041647;16850.07324597159;16871.746923796152;16872.24074916607;16876.15619219059;13613;13614.591562253148;13619.795703064461;13623.386947587382;13628.863711362957;14189.85810141906;15414.460493882885;15527;15558.22208889551;15708.13605251722;5373.704446255415;6278.246610406689;6314.557980941382;6328.335524769833;6359;1073.2487258918788;1086.8261078227445;1098.1763677242068;1101.4657890922897;1105.745678493951;24353.756462435504;24917.5016499669;32201.838990804896;32389.346121443865;33197.506112225004;1165.1610840195046;1190.7023244188954;1200.1958687679275;1204.114975493012;1217.5008246618843;17007.23467443968;17715.55711107207;17953.29443702846;18083.54791130206;18304.816951830577;290238;291899;291939;293599;293609;62378.68810655917;62656;62871;62909.37090629127;62988.05517917235;1510.919692419925;1512.5764785859756;1543.8358690181326;1552.9301181446863;1568.858802707739;29990.400191996476;30018.849905750332;30216.5467517983;30425.391492170475;30652.693473064985;39793.60206397899;39863.60136398599;39891;39910.40134397928;39935.2012959745;241717;242254;242296;242472;242506;35141.12147196341;36923.26153476969;36942.445863311536;36964.63035369612;36985.630143699294;41941;45812.31281530713;46903.53096468992;46930.530694692614;47437.28844067411;33924;34202.31595368128;34230.657693423746;34260.82869585636;34344.48483272803;32690.182745431553;33756.49365259474;33990.15024624404;34176.09503192157;34222.14444638904;37336.25327493489;38420;38804;39388.212235755695;39892.40161397639;31077.689223107478;33117.66882331242;33229.50155747714;33276.66723332833;33368.833155834065;24841.378965526008;25053.624195636716;25284.367890802878;25768.742312576633;27195.864020679768 05:24:27 INFO - PID 9598 | |2;jquery.html;556.8870016607168;565.3837317324115;570.7289037707087;585.5023230254285;591.3229352391512;22903;23357.649635255486;24066.518669626596;24109;24113.879430602865;25104.37239069024;25570.23289301324;25579.232623021293;25649.35876603086;25685;6206.534509911741;6290.842728931768;6329.968350158243;6334.84162895929;6342.841428964267;6177.351378105302;6419.679016049202;6466.74133034678;6486.578372405802;6498.122753428298;6432.356764323554;6433.485321174295;6442.291347951722;6448.097266382711;6469.902951455732;6415.967920160416;6416.711247993851;6434.613923164625;6484.157059582248;6492.57798243115;5946.256717910262;5969.492593129589;5989.670568118751;6007.309159446676;6015.037593984942;28992.42015159685;30753.923612673672;31050;31210.53184202239;31422.057338279887;2220.3117033719436;2254.3913143451177;2254.391314345134;2256.5825322315422;2257.593633146033;19983;20456.590868182553;20463.4884127898;20465.07907144182;20500.17999280027;2283.25794116911;2307.896144673494;2321.802646775026;2334.323046316566;2399.9040038398443;149615;154411;154935;155250;155905;15266.542003739905;15525;15859.762103568455;16079.437219697254;16139.838601614068;24302.270931872074;24332.1483748068;24476.265712028668;24544.509109817704;24567.63148552773;10459.94770026145;10777.730556735987;10808.243422960317;10877.619283325046;10888.67333979982;9925.255605829592;10000.649912261897;10009.349392289478;10032.598696052222;10081.294309398272;8566.742997710078;9616.711498654911;9684.370515916444;9732.464714440774;9946.552405141641;2744.3550765570076;2767.972320276812;2774.1122840690787;2779.6803367612983;2860.914172574826;1062.6811956413046;1070.2936062198912;1077.8437126616755;1084.322298563398;1090.9509072091776;25551.872240638677;25583.87208063985;26829.731702682722;26928.73071269262;26968.460630787275;1131.134681968295;1136.2954967919777;1141.2581821815886;1148.9885101149048;1153.6366044696063;12198.32909190003;12613.747725045449;14337.78493322601;15134.394624214909;15539.689206215813;597894;610866;661134;679687;688786;137612;144726;145695.90064347698;148504;149920;1339.3437215764206;1342.3489607540334;1358.5109360630165;1377.8966577506726;1378.7173629405947;22672.65991010169;23008;23317.41706457352;23486.530269394858;23518.059277628705;65504.34495654982;67831;68081;70294.64852675704;70474;80497.59751201207;84003;84806.57596711977;86070;86808.5659571698;14401.63995900111;14872.553823385315;15101.773473397689;15123.621909452351;15138.545843624708;23490;25148.49703005966;26199.214023579323;26303.736962630894;26570.202893913214;20416.489587760425;20812.58374832525;20854.644448110823;20929.476763081046;20936.58126837485;17877.37429189972;18100.45698629043;18137.727934081264;19014.334498292494;19132.330368437037;21490;21500;21551.353459396243;21597.676034859804;21705.565888681824;15335.463258785889;15347.846521534642;15452.304646291168;15452.381904724134;15487.993280436736;19484.805151948298;19902.104405301507;19909.701354479985;20240.79759202389;20261.088251028443 05:24:27 INFO - PID 9598 | |3;mootools.html;1409.9295035248238;1448.8333841608219;1449.1450044473759;1456.9053011554254;1461.4154338264686;14851.331690073946;15128.319225634845;15373.077615343087;15397.076175429482;15441.459548915776;15790.526284211463;15994.040357578524;16022.75965860513;16066.75899861503;16112.75830862538;2166.9024893879814;2205.5368372641765;2207.172310383606;2213.3359992002415;2217.7782221777857;2341.4848733278736;2408.9397765055837;2420.6006009008493;2420.7095148582193;2423.466837295792;2407.7471865454136;2446.2538925627678;2468.456939473322;2471.765182307678;2475.8885850136785;2431.197704757426;2434.817388695846;2437.390652336916;2440.4386990991993;2448.4980578981354;2288.61093614086;2311.04091801902;2406.6149416093517;2457.397937505305;2457.471643596635;14922.104673719612;15010.549683509404;15098.396064157421;15167.165805880672;15181.468648597245;7451.21762214965;7673.577953212571;7728.763397856316;7877.251661092187;7905.328047116002;4781.0676918001;4841.443234028096;4914.680545764514;4928.43323017854;4941.703497790144;1930.9710354344695;1966.7541557305337;1985.5830275642134;2026.9290574829959;2041.6733322668301;25823.612645810328;25903.0933917312;26052.088176913716;26100.60849087265;26150.215493535034;6448.129502517194;6471.352864713491;6563.245226798979;6663.966680166568;6664.766733164316;17645.647087058187;17777.555561110818;17790.46628601144;17853.821461785217;17856.642867142586;7592;7832.647530861125;7846.568438735811;7858.567778772108;7866.292033716879;7043.36609705129;7196.676149573282;7197.244289349647;7231.240719724458;7236.710531578678;5044.344235249468;5134.127198376285;5138.254953031789;5196.272521846944;5202.401723801736;1443.4659176104908;1450.7388670039495;1453.600259928507;1462.166565057928;1464.3776395032069;862.4652715316419;866.7313132928812;873.3362644390182;890.1988210610502;905.0768216419216;7456.7390141344795;7561.3194812467145;8479.533625650525;8500.40497165205;8676.566171691391;715.3561794385095;737.5279820914619;753.4236309223448;758.6396461680657;1002.3033991375924;5050.217216331474;5548.361938377057;5620.747066382022;5664.235328230719;5684.715764211773;20651.793482065288;21161.894190529256;21248;21349;21358.893205534183;21793;21957.560848783254;22285.442863928532;22324.665130023062;22353.44116397103;11523.71190720222;11953.940230298967;12046.819297710541;12141.817872731739;12164.513419463476;8533.957330213309;8745.693900713699;9035.05131961161;9074.04722504154;9079.954600226956;17662.381816636356;18381.26474941041;18671.439856803776;18980;19086.7136992948;18331.266749329876;19053;19289.90355048216;19317.61364772725;19811.009449527755;12426.316552589695;12582.370881455707;12680.23918564889;12694.682632933882;12706.428210730724;14369.64075898111;14613.488527901472;14737.1894545801;14762.188079655722;14778.6305342363;11213.495392707511;11624.476898539755;11818.940905295418;11930.463129159381;11975.161738678557;11012;11312.886871131512;11741.76516469683;11852.881471185177;12154.939225303817;10517.894821051692;10555.208359372924;10560.207984401355;10622.415767132881;10631.521581528696;7619.238076192337;7747.961260193663;7773.18381569927;7778.92221077782;7828.725994590162;7413.1104267488245;7604.2395760423515;7643.520237653175;7663.31030207284;7725.768226953201 05:24:27 INFO - PID 9598 | |4;prototype.html;491.2214140587169;500.0299419126895;511.5549471959395;522.8117877564074;528.278899302452;5901.763929442817;6045.304789949158;6069.666168360733;6129.509639228862;6157.199564056677;5902.704864756766;5935.376785437532;5968.343482216953;5970.253718285215;6022.247219097613;4705.7647117644065;4718.480967093634;4722;4724.24412094065;4759.143354196243;4575.565321294472;4666.859994200179;4703.365045718835;4722.858314250578;4745.169595320823;4624.953750462486;4646.395968524104;4656.0687862427485;4684.3676103726075;4694.389729335182;4665.440147182326;4674;4679.532046795311;4694.319323698045;4698.308608900793;4265.3815196796295;4286.678499112548;4302.7848607569495;4309.267424537836;4313.202057619319;5949.821505354803;5953.970230148865;5956.761729530814;5959.374265702126;5962.34414214436;5517.944820551783;5569.916451253234;5570.275864137677;5607.588736843156;5613.635113717595;6462.967685161591;6465.4827613790785;6487.156669632965;6507.381798729113;6519.641419721914;4777;4836.839158601945;4843.39457567804;4853.587445067174;4865.270209468573;6550.508711846631;6566.80299591013;6574.539782215247;6588.077669126278;6723.193216814014;4864.708117512961;4928.408590969107;4956.231784073474;4965.106280869406;5007.198848184273;5068.76974131381;5072.442031376546;5082.313887625197;5087;5094.235864620263;5496.945030549723;5505.476979687003;5559.24950131727;5572.3870374258795;5587.972060139673;6091.269047714302;6330.620162790247;6331.973768394162;6430.228372595318;6462.127612772216;1661.8172001079872;1724.1293146960704;1741.312181688226;1744.9563760905826;1745.3891138101817;1000.5947591225565;1225.9089410424729;1226.1662069792626;1241.472374240944;1243.5947379461152;6087.8478038048515;6209.223847019122;6247.562670613104;6249.1877355567285;6286.119943207955;6611.702473388709;6623.503237257225;6625.701843416961;6635.668216589152;6646.634435106115;6213.502919766408;6245.594036387621;6268.122462855113;6275.184226050585;6294.559380843297;3501.4418583729994;3517.525134106914;3517.8592856285463;3526.6951228045787;3544;6809.301581908468;6884.173899132136;6920.238773734885;7024.613646249403;7037.964810175917;6713.899291510631;6751.392374686204;6760.42536384403;6760.594364338155;6812.727490900308;6971.6165610891885;6977.581345119309;6997.335253150943;7015.579065256101;7037.7184912602925;6463.192100987377;6580.400741706903;6580.901286480803;6581.835454113685;6618.7352505899225;6397.584157029964;6439.905216113366;6489.3510648934725;6502.642354670538;6532.967335163294;6827.556208846409;6962.373386395248;7008.404285635778;7024.051753013482;7038.40173585251;4935.235038569028;4937.21004639256;4948.282499037691;4954.430240522386;5015.824446144367;6562.146920900253;6572.605643661395;6574.145361103026;6619.172603424572;6683.532152749261;6434.260060093149;6464.482841372773;6484.1246431733;6489.286178520265;6551.082848401133;6183.938160618336;6199.535034872312;6355;6375.6174629522375;6440.101954120571;6125.816225513242;6246.190433366373;6288.622682639057;6292.056191571301;6302.180716506825;5820.621659592113;6356.2054743157105;6375.968120159369;6453.903191452038;6458.644774537445;6080.847978800565;6250.312465628868;6268.749250029948;6324.4940404766585;6339.270983836917 05:24:27 INFO - PID 9598 | |5;yui.html;897.7890195803985;921.3826736086821;924.2328867040358;953.0659953245819;980.14727187347;17234.48296551104;17802.82197178028;17865.374711885088;17893.194806233718;22364.664530032063;19743.1115599798;20350.18599256028;20606.896965515152;20644.1742330307;20652.69020964683;983.552483619953;1012.7012531303246;1020;1021.7598864266891;1021.8824835143942;1035.9119474844647;1051.0750539525206;1051.4532443129606;1052.763128296135;1079.2067830144838;1140.4297851074464;1144.3934714601232;1148.0930065248485;1148.5578052449825;1150.3270586706788;1141.4007645985841;1147.8909503597145;1150.6490520391278;1151.3149675942843;1153.3425947210094;835.5195762436623;836.5524444422205;836.8368168207202;837.8826964225013;838.8238469921324;16849.578760530963;16893.493195204162;16937.407190748265;17169.48491545243;20158.79841201584;18698.71951920722;18838.434846954613;19359.80640193594;19384.515387115294;19525.9023704882;15783;15883.92058039714;15904.681906361924;15971.92014039934;16052.197390130446;3508.947365789515;3532.311199316134;3536.7701099428455;3547.6274991126074;3551.1654761131113;132091.99999999904;137676;139710;141747;141798;16242.106684132486;16388.180590970405;16632.58418539522;16820.15899205035;16944.661106777796;31117.68882311193;31121.844390778355;31362.05913822589;31417.685823141477;31449.528257076163;8188.222118898695;8494.53280069602;8497.575121243914;9267.536623168815;9297.767555811024;3827.2154208387215;4318.157959197926;4496.685232033792;4509.729416235036;4538.1377538267625;5377.327834020747;5487.917681234785;5512.91730624041;6134.110553969738;6252.812415627538;1110.3448965110624;1128.9209755317213;1139.6125317391961;1142.954281828734;1146.39241202163;687.7420967137324;708.7767353283699;711.1324184494908;719.2486295869575;736.3556887723242;12840.55058072963;13152.145110567782;13280.335983200801;13682.247476388895;13817.447302108005;621.6083867163749;624.8906441372833;628.4689437425368;632.9651869147149;644.3266786208424;6032.788852390146;6168.259808822881;6218.875622487525;6305.779297724557;6351.777687780906;124715;132096;132293;134428;139249;111750;115761;117282;121449;121524;94728;95821.23884111989;98088.01911980931;98609;102290.48854755827;11261.605843795427;11660.883391166319;11743.412829358327;12045.855643713834;12092.697682558006;45762;47474;47554.52445475501;48011.27983080187;49455.25817112674;81861;84903;86831.56584217292;87266;88291.55854220688;17097.401590944257;18716.532086697942;18755.90622046881;18771.530711731768;18810.811891881454;22179.55640887141;22472.43818904475;22523.211687590854;22649.320520384415;22884.512506687013;18446.631067378847;18828.6234275311;19060.142293596546;19173.520661983563;19530;19858.801411986275;20014;20281.49296267605;20323.187072517525;20400.89799551052;18557.072146392355;19172.616547669248;19174.520636984187;19591.510212244237;19807.405777826687;12575.371231438574;13971.510997115458;14237.928810355881;14270.714585708436;14544.49094281695;14604;14771.409143634135;14907.180105094323;15038.92480537634;15187.848121518644 05:24:27 INFO - PID 9598 | __end_tp_report 05:24:27 INFO - PID 9598 | __start_cc_report 05:24:27 INFO - PID 9598 | _x_x_mozilla_cycle_collect,343 05:24:27 INFO - PID 9598 | __end_cc_report 05:24:27 INFO - PID 9598 | __startTimestamp1500899067931__endTimestamp 05:24:27 INFO - PID 9598 | 05:24:27 INFO - PID 9598 | ------- Summary: start ------- 05:24:27 INFO - PID 9598 | Number of tests: 6 05:24:27 INFO - PID 9598 | 05:24:27 INFO - PID 9598 | [#0] dojo.html Cycles:165 Average:6175.54 Median:6514.25 stddev:801.49 (12.3%) stddev-sans-first:771.42 05:24:27 INFO - PID 9598 | Values: 3294.0 3368.1 3388.1 3390.9 3422.6 6122.9 6186.4 6215.4 6223.3 6281.6 6085.3 6132.9 6166.8 6176.4 6179.4 5381.8 5407.1 5427.6 5464.6 5510.5 5476.1 5479.5 5543.7 5555.4 5576.2 5238.4 5462.6 5488.4 5515.8 5530.2 5390.1 5422.7 5451.3 5509.5 5512.5 5405.4 5406.5 5455.9 5478.5 5486.9 6023.0 6027.3 6125.8 6144.8 6189.7 6655.8 6715.3 6724.5 6744.3 6754.4 6754.2 6783.5 6822.3 6854.1 6859.2 6225.6 6244.3 6306.7 6323.8 6344.8 6735.1 6742.1 6844.5 6890.7 6956.8 6556.7 6560.6 6627.5 6652.9 6679.2 6668.3 6690.9 6728.6 6749.7 6753.6 6598.7 6607.9 6618.9 6670.5 6695.3 6581.4 6643.0 6652.7 6696.4 6704.7 4864.1 4934.3 4988.8 4988.8 4992.3 4330.3 4349.6 4370.8 4381.5 4406.0 6317.7 6361.1 6424.7 6443.7 6456.5 6663.5 6717.1 6744.2 6766.6 6781.1 6469.8 6483.5 6545.7 6563.5 6569.0 5581.0 5587.1 5643.0 5648.6 5652.3 7003.3 7075.4 7081.8 7113.8 7157.6 6649.1 6659.8 6660.7 6670.1 6680.8 6982.5 7057.3 7065.9 7071.4 7074.9 6582.5 6596.4 6599.0 6602.9 6625.9 6729.4 6732.8 6735.8 6736.8 6738.7 6317.1 6514.3 6517.6 6518.3 6568.6 6529.5 6604.3 6616.5 6624.2 6625.3 6477.0 6483.3 6552.2 6561.5 6625.5 6459.6 6489.0 6542.3 6596.8 6616.7 6410.1 6417.0 6461.0 6486.0 6499.2 05:24:27 INFO - PID 9598 | 05:24:27 INFO - PID 9598 | [#1] ext.html Cycles:180 Average:43064.68 Median:3530.58 stddev:65466.46 (1854.3%) stddev-sans-first:65573.53 05:24:27 INFO - PID 9598 | Values: 891.1 924.8 947.9 1209.5 1242.9 40277.0 44091.3 44170.8 44186.0 44293.3 41296.0 41422.6 41519.8 41757.2 41885.4 7127.3 7177.0 7222.6 7246.8 7254.7 7114.9 7157.5 7158.4 7168.2 7169.3 7194.2 7219.2 7490.4 7652.7 7663.7 7576.3 7617.2 7624.2 7627.3 7628.1 7403.7 7472.1 7549.6 7551.4 7612.1 42407.2 42726.0 42729.0 42748.4 42799.8 3483.2 3516.4 3530.5 3530.6 3532.2 33260.7 33342.0 33426.0 33533.7 33537.2 5092.1 5108.6 5145.8 5154.8 5166.6 211081.0 213713.0 214479.0 214645.0 214803.0 53472.2 53726.0 53756.0 54210.7 54346.2 56755.0 56992.4 57164.0 57221.0 57308.4 16661.9 16850.1 16871.7 16872.2 16876.2 13613.0 13614.6 13619.8 13623.4 13628.9 14189.9 15414.5 15527.0 15558.2 15708.1 5373.7 6278.2 6314.6 6328.3 6359.0 1073.2 1086.8 1098.2 1101.5 1105.7 24353.8 24917.5 32201.8 32389.3 33197.5 1165.2 1190.7 1200.2 1204.1 1217.5 17007.2 17715.6 17953.3 18083.5 18304.8 290238.0 291899.0 291939.0 293599.0 293609.0 62378.7 62656.0 62871.0 62909.4 62988.1 1510.9 1512.6 1543.8 1552.9 1568.9 29990.4 30018.8 30216.5 30425.4 30652.7 39793.6 39863.6 39891.0 39910.4 39935.2 241717.0 242254.0 242296.0 242472.0 242506.0 35141.1 36923.3 36942.4 36964.6 36985.6 41941.0 45812.3 46903.5 46930.5 47437.3 33924.0 34202.3 34230.7 34260.8 34344.5 32690.2 33756.5 33990.2 34176.1 34222.1 37336.3 38420.0 38804.0 39388.2 39892.4 31077.7 33117.7 33229.5 33276.7 33368.8 24841.4 25053.6 25284.4 25768.7 27195.9 05:24:27 INFO - PID 9598 | 05:24:27 INFO - PID 9598 | [#2] jquery.html Cycles:180 Average:42054.18 Median:12825.87 stddev:108566.75 (846.5%) stddev-sans-first:108826.60 05:24:27 INFO - PID 9598 | Values: 556.9 565.4 570.7 585.5 591.3 22903.0 23357.6 24066.5 24109.0 24113.9 25104.4 25570.2 25579.2 25649.4 25685.0 6206.5 6290.8 6330.0 6334.8 6342.8 6177.4 6419.7 6466.7 6486.6 6498.1 6432.4 6433.5 6442.3 6448.1 6469.9 6416.0 6416.7 6434.6 6484.2 6492.6 5946.3 5969.5 5989.7 6007.3 6015.0 28992.4 30753.9 31050.0 31210.5 31422.1 2220.3 2254.4 2254.4 2256.6 2257.6 19983.0 20456.6 20463.5 20465.1 20500.2 2283.3 2307.9 2321.8 2334.3 2399.9 149615.0 154411.0 154935.0 155250.0 155905.0 15266.5 15525.0 15859.8 16079.4 16139.8 24302.3 24332.1 24476.3 24544.5 24567.6 10459.9 10777.7 10808.2 10877.6 10888.7 9925.3 10000.6 10009.3 10032.6 10081.3 8566.7 9616.7 9684.4 9732.5 9946.6 2744.4 2768.0 2774.1 2779.7 2860.9 1062.7 1070.3 1077.8 1084.3 1091.0 25551.9 25583.9 26829.7 26928.7 26968.5 1131.1 1136.3 1141.3 1149.0 1153.6 12198.3 12613.7 14337.8 15134.4 15539.7 597894.0 610866.0 661134.0 679687.0 688786.0 137612.0 144726.0 145695.9 148504.0 149920.0 1339.3 1342.3 1358.5 1377.9 1378.7 22672.7 23008.0 23317.4 23486.5 23518.1 65504.3 67831.0 68081.0 70294.6 70474.0 80497.6 84003.0 84806.6 86070.0 86808.6 14401.6 14872.6 15101.8 15123.6 15138.5 23490.0 25148.5 26199.2 26303.7 26570.2 20416.5 20812.6 20854.6 20929.5 20936.6 17877.4 18100.5 18137.7 19014.3 19132.3 21490.0 21500.0 21551.4 21597.7 21705.6 15335.5 15347.8 15452.3 15452.4 15488.0 19484.8 19902.1 19909.7 20240.8 20261.1 05:24:27 INFO - PID 9598 | 05:24:27 INFO - PID 9598 | [#3] mootools.html Cycles:180 Average:9441.63 Median:12321.03 stddev:6783.92 (55.1%) stddev-sans-first:6776.11 05:24:27 INFO - PID 9598 | Values: 1409.9 1448.8 1449.1 1456.9 1461.4 14851.3 15128.3 15373.1 15397.1 15441.5 15790.5 15994.0 16022.8 16066.8 16112.8 2166.9 2205.5 2207.2 2213.3 2217.8 2341.5 2408.9 2420.6 2420.7 2423.5 2407.7 2446.3 2468.5 2471.8 2475.9 2431.2 2434.8 2437.4 2440.4 2448.5 2288.6 2311.0 2406.6 2457.4 2457.5 14922.1 15010.5 15098.4 15167.2 15181.5 7451.2 7673.6 7728.8 7877.3 7905.3 4781.1 4841.4 4914.7 4928.4 4941.7 1931.0 1966.8 1985.6 2026.9 2041.7 25823.6 25903.1 26052.1 26100.6 26150.2 6448.1 6471.4 6563.2 6664.0 6664.8 17645.6 17777.6 17790.5 17853.8 17856.6 7592.0 7832.6 7846.6 7858.6 7866.3 7043.4 7196.7 7197.2 7231.2 7236.7 5044.3 5134.1 5138.3 5196.3 5202.4 1443.5 1450.7 1453.6 1462.2 1464.4 862.5 866.7 873.3 890.2 905.1 7456.7 7561.3 8479.5 8500.4 8676.6 715.4 737.5 753.4 758.6 1002.3 5050.2 5548.4 5620.7 5664.2 5684.7 20651.8 21161.9 21248.0 21349.0 21358.9 21793.0 21957.6 22285.4 22324.7 22353.4 11523.7 11953.9 12046.8 12141.8 12164.5 8534.0 8745.7 9035.1 9074.0 9080.0 17662.4 18381.3 18671.4 18980.0 19086.7 18331.3 19053.0 19289.9 19317.6 19811.0 12426.3 12582.4 12680.2 12694.7 12706.4 14369.6 14613.5 14737.2 14762.2 14778.6 11213.5 11624.5 11818.9 11930.5 11975.2 11012.0 11312.9 11741.8 11852.9 12154.9 10517.9 10555.2 10560.2 10622.4 10631.5 7619.2 7748.0 7773.2 7778.9 7828.7 7413.1 7604.2 7643.5 7663.3 7725.8 05:24:27 INFO - PID 9598 | 05:24:27 INFO - PID 9598 | [#4] prototype.html Cycles:180 Average:5453.57 Median:6089.56 stddev:1565.94 (25.7%) stddev-sans-first:1525.39 05:24:27 INFO - PID 9598 | Values: 491.2 500.0 511.6 522.8 528.3 5901.8 6045.3 6069.7 6129.5 6157.2 5902.7 5935.4 5968.3 5970.3 6022.2 4705.8 4718.5 4722.0 4724.2 4759.1 4575.6 4666.9 4703.4 4722.9 4745.2 4625.0 4646.4 4656.1 4684.4 4694.4 4665.4 4674.0 4679.5 4694.3 4698.3 4265.4 4286.7 4302.8 4309.3 4313.2 5949.8 5954.0 5956.8 5959.4 5962.3 5517.9 5569.9 5570.3 5607.6 5613.6 6463.0 6465.5 6487.2 6507.4 6519.6 4777.0 4836.8 4843.4 4853.6 4865.3 6550.5 6566.8 6574.5 6588.1 6723.2 4864.7 4928.4 4956.2 4965.1 5007.2 5068.8 5072.4 5082.3 5087.0 5094.2 5496.9 5505.5 5559.2 5572.4 5588.0 6091.3 6330.6 6332.0 6430.2 6462.1 1661.8 1724.1 1741.3 1745.0 1745.4 1000.6 1225.9 1226.2 1241.5 1243.6 6087.8 6209.2 6247.6 6249.2 6286.1 6611.7 6623.5 6625.7 6635.7 6646.6 6213.5 6245.6 6268.1 6275.2 6294.6 3501.4 3517.5 3517.9 3526.7 3544.0 6809.3 6884.2 6920.2 7024.6 7038.0 6713.9 6751.4 6760.4 6760.6 6812.7 6971.6 6977.6 6997.3 7015.6 7037.7 6463.2 6580.4 6580.9 6581.8 6618.7 6397.6 6439.9 6489.4 6502.6 6533.0 6827.6 6962.4 7008.4 7024.1 7038.4 4935.2 4937.2 4948.3 4954.4 5015.8 6562.1 6572.6 6574.1 6619.2 6683.5 6434.3 6464.5 6484.1 6489.3 6551.1 6183.9 6199.5 6355.0 6375.6 6440.1 6125.8 6246.2 6288.6 6292.1 6302.2 5820.6 6356.2 6376.0 6453.9 6458.6 6080.8 6250.3 6268.7 6324.5 6339.3 05:24:27 INFO - PID 9598 | 05:24:27 INFO - PID 9598 | [#5] yui.html Cycles:180 Average:26396.44 Median:19174.02 stddev:37620.08 (196.2%) stddev-sans-first:37676.89 05:24:27 INFO - PID 9598 | Values: 897.8 921.4 924.2 953.1 980.1 17234.5 17802.8 17865.4 17893.2 22364.7 19743.1 20350.2 20606.9 20644.2 20652.7 983.6 1012.7 1020.0 1021.8 1021.9 1035.9 1051.1 1051.5 1052.8 1079.2 1140.4 1144.4 1148.1 1148.6 1150.3 1141.4 1147.9 1150.6 1151.3 1153.3 835.5 836.6 836.8 837.9 838.8 16849.6 16893.5 16937.4 17169.5 20158.8 18698.7 18838.4 19359.8 19384.5 19525.9 15783.0 15883.9 15904.7 15971.9 16052.2 3508.9 3532.3 3536.8 3547.6 3551.2 132092.0 137676.0 139710.0 141747.0 141798.0 16242.1 16388.2 16632.6 16820.2 16944.7 31117.7 31121.8 31362.1 31417.7 31449.5 8188.2 8494.5 8497.6 9267.5 9297.8 3827.2 4318.2 4496.7 4509.7 4538.1 5377.3 5487.9 5512.9 6134.1 6252.8 1110.3 1128.9 1139.6 1143.0 1146.4 687.7 708.8 711.1 719.2 736.4 12840.6 13152.1 13280.3 13682.2 13817.4 621.6 624.9 628.5 633.0 644.3 6032.8 6168.3 6218.9 6305.8 6351.8 124715.0 132096.0 132293.0 134428.0 139249.0 111750.0 115761.0 117282.0 121449.0 121524.0 94728.0 95821.2 98088.0 98609.0 102290.5 11261.6 11660.9 11743.4 12045.9 12092.7 45762.0 47474.0 47554.5 48011.3 49455.3 81861.0 84903.0 86831.6 87266.0 88291.6 17097.4 18716.5 18755.9 18771.5 18810.8 22179.6 22472.4 22523.2 22649.3 22884.5 18446.6 18828.6 19060.1 19173.5 19530.0 19858.8 20014.0 20281.5 20323.2 20400.9 18557.1 19172.6 19174.5 19591.5 19807.4 12575.4 13971.5 14237.9 14270.7 14544.5 14604.0 14771.4 14907.2 15038.9 15187.8 05:24:27 INFO - PID 9598 | -------- Summary: end -------- 05:24:27 INFO - PID 9598 | 05:24:28 INFO - TEST-INFO | 9598: exit 0 05:24:28 INFO - TEST-OK | dromaeo_css | took 1110664ms 05:24:28 INFO - TEST-START | kraken 05:24:28 INFO - Initialising browser for kraken test... 05:24:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34020/getInfo.html -profile /tmp/tmpquDg0h/profile 05:24:28 INFO - TEST-INFO | started process 9962 (/builds/slave/test/build/application/firefox/firefox http://localhost:34020/getInfo.html) 05:24:34 INFO - TEST-INFO | 9962: exit 0 05:24:34 INFO - Browser initialized. 05:24:34 INFO - Running cycle 1/1 for kraken test... 05:24:34 INFO - TEST-INFO | started process 10171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpquDg0h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:45 INFO - PID 10171 | RSS: Main: 170024960 05:24:45 INFO - PID 10171 | 05:24:48 INFO - PID 10171 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34020/tests/kraken/driver.html?testName=audio-beat-detection) 05:24:49 INFO - PID 10171 | RSS: Main: 173494272 05:24:49 INFO - PID 10171 | 05:24:51 INFO - PID 10171 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34020/tests/kraken/driver.html?testName=audio-dft) 05:24:52 INFO - PID 10171 | RSS: Main: 174346240 05:24:52 INFO - PID 10171 | 05:24:55 INFO - PID 10171 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34020/tests/kraken/driver.html?testName=audio-fft) 05:24:56 INFO - PID 10171 | RSS: Main: 168808448 05:24:56 INFO - PID 10171 | 05:24:58 INFO - PID 10171 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34020/tests/kraken/driver.html?testName=audio-oscillator) 05:24:58 INFO - PID 10171 | RSS: Main: 170024960 05:24:58 INFO - PID 10171 | 05:25:00 INFO - PID 10171 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34020/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:25:01 INFO - PID 10171 | RSS: Main: 170070016 05:25:01 INFO - PID 10171 | 05:25:04 INFO - PID 10171 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34020/tests/kraken/driver.html?testName=imaging-darkroom) 05:25:05 INFO - PID 10171 | RSS: Main: 173236224 05:25:05 INFO - PID 10171 | 05:25:08 INFO - PID 10171 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34020/tests/kraken/driver.html?testName=imaging-desaturate) 05:25:09 INFO - PID 10171 | RSS: Main: 174489600 05:25:09 INFO - PID 10171 | 05:25:12 INFO - PID 10171 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34020/tests/kraken/driver.html?testName=json-parse-financial) 05:25:12 INFO - PID 10171 | RSS: Main: 173158400 05:25:12 INFO - PID 10171 | 05:25:14 INFO - PID 10171 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34020/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:25:14 INFO - PID 10171 | RSS: Main: 172863488 05:25:14 INFO - PID 10171 | 05:25:16 INFO - PID 10171 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:25:17 INFO - PID 10171 | RSS: Main: 172969984 05:25:17 INFO - PID 10171 | 05:25:19 INFO - PID 10171 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:25:19 INFO - PID 10171 | RSS: Main: 170278912 05:25:19 INFO - PID 10171 | 05:25:22 INFO - PID 10171 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:25:23 INFO - PID 10171 | RSS: Main: 170549248 05:25:23 INFO - PID 10171 | 05:25:25 INFO - PID 10171 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:25:26 INFO - PID 10171 | RSS: Main: 170844160 05:25:26 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34020/tests/kraken/driver.html?testName=ai-astar) 05:25:28 INFO - PID 10171 | RSS: Main: 172236800 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | __start_tp_report 05:25:28 INFO - PID 10171 | _x_x_mozilla_page_load 05:25:28 INFO - PID 10171 | _x_x_mozilla_page_load_details 05:25:28 INFO - PID 10171 | |i|pagename|runs| 05:25:28 INFO - PID 10171 | |0;ai-astar;102;106;95;109;107;107;111;109;109;109 05:25:28 INFO - PID 10171 | |1;audio-beat-detection;140;114;140;168;120;149;146;114;167;117 05:25:28 INFO - PID 10171 | |2;audio-dft;164;163;164;162;163;162;162;162;164;165 05:25:28 INFO - PID 10171 | |3;audio-fft;75;74;76;176;77;77;75;75;155;75 05:25:28 INFO - PID 10171 | |4;audio-oscillator;80;80;140;79;81;80;127;80;80;127 05:25:28 INFO - PID 10171 | |5;imaging-gaussian-blur;116;114;115;114;117;114;114;114;114;114 05:25:28 INFO - PID 10171 | |6;imaging-darkroom;148;148;148;148;149;149;150;148;147;148 05:25:28 INFO - PID 10171 | |7;imaging-desaturate;94;95;94;94;95;97;94;94;94;94 05:25:28 INFO - PID 10171 | |8;json-parse-financial;48;46;50;47;46;48;47;47;46;48 05:25:28 INFO - PID 10171 | |9;json-stringify-tinderbox;54;54;54;54;53;53;54;54;54;56 05:25:28 INFO - PID 10171 | |10;stanford-crypto-aes;75;74;76;75;74;75;74;74;75;75 05:25:28 INFO - PID 10171 | |11;stanford-crypto-ccm;119;134;124;120;118;117;124;117;122;155 05:25:28 INFO - PID 10171 | |12;stanford-crypto-pbkdf2;167;168;166;159;160;163;161;169;176;163 05:25:28 INFO - PID 10171 | |13;stanford-crypto-sha256-iterative;63;61;61;60;61;74;62;60;60;63 05:25:28 INFO - PID 10171 | __end_tp_report 05:25:28 INFO - PID 10171 | __start_cc_report 05:25:28 INFO - PID 10171 | _x_x_mozilla_cycle_collect,888 05:25:28 INFO - PID 10171 | __end_cc_report 05:25:28 INFO - PID 10171 | __startTimestamp1500899128531__endTimestamp 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | ------- Summary: start ------- 05:25:28 INFO - PID 10171 | Number of tests: 14 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | [#0] ai-astar Cycles:10 Average:106.40 Median:109.00 stddev:4.70 (4.3%) stddev-sans-first:4.70 05:25:28 INFO - PID 10171 | Values: 102.0 106.0 95.0 109.0 107.0 107.0 111.0 109.0 109.0 109.0 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:143.00 stddev:20.68 (14.5%) stddev-sans-first:21.91 05:25:28 INFO - PID 10171 | Values: 140.0 114.0 140.0 168.0 120.0 149.0 146.0 114.0 167.0 117.0 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 05:25:28 INFO - PID 10171 | Values: 164.0 163.0 164.0 162.0 163.0 162.0 162.0 162.0 164.0 165.0 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.00 stddev:38.28 (51.0%) stddev-sans-first:40.01 05:25:28 INFO - PID 10171 | Values: 75.0 74.0 76.0 176.0 77.0 77.0 75.0 75.0 155.0 75.0 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:80.00 stddev:25.05 (31.3%) stddev-sans-first:25.94 05:25:28 INFO - PID 10171 | Values: 80.0 80.0 140.0 79.0 81.0 80.0 127.0 80.0 80.0 127.0 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:1.01 05:25:28 INFO - PID 10171 | Values: 116.0 114.0 115.0 114.0 117.0 114.0 114.0 114.0 114.0 114.0 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 05:25:28 INFO - PID 10171 | Values: 148.0 148.0 148.0 148.0 149.0 149.0 150.0 148.0 147.0 148.0 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 05:25:28 INFO - PID 10171 | Values: 94.0 95.0 94.0 94.0 95.0 97.0 94.0 94.0 94.0 94.0 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | [#8] json-parse-financial Cycles:10 Average:47.30 Median:47.50 stddev:1.25 (2.6%) stddev-sans-first:1.30 05:25:28 INFO - PID 10171 | Values: 48.0 46.0 50.0 47.0 46.0 48.0 47.0 47.0 46.0 48.0 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 05:25:28 INFO - PID 10171 | Values: 54.0 54.0 54.0 54.0 53.0 53.0 54.0 54.0 54.0 56.0 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:75.00 stddev:0.67 (0.9%) stddev-sans-first:0.71 05:25:28 INFO - PID 10171 | Values: 75.0 74.0 76.0 75.0 74.0 75.0 74.0 74.0 75.0 75.0 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:123.00 stddev:11.69 (9.5%) stddev-sans-first:12.20 05:25:28 INFO - PID 10171 | Values: 119.0 134.0 124.0 120.0 118.0 117.0 124.0 117.0 122.0 155.0 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:166.50 stddev:5.12 (3.1%) stddev-sans-first:5.39 05:25:28 INFO - PID 10171 | Values: 167.0 168.0 166.0 159.0 160.0 163.0 161.0 169.0 176.0 163.0 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:61.50 stddev:4.20 (6.8%) stddev-sans-first:4.45 05:25:28 INFO - PID 10171 | Values: 63.0 61.0 61.0 60.0 61.0 74.0 62.0 60.0 60.0 63.0 05:25:28 INFO - PID 10171 | -------- Summary: end -------- 05:25:28 INFO - PID 10171 | 05:25:28 INFO - PID 10171 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:25:29 INFO - TEST-INFO | 10171: exit 0 05:25:29 INFO - TEST-OK | kraken | took 60574ms 05:25:29 INFO - SUITE-END | took 1171s 05:25:29 INFO - Completed test suite (00:19:31) 05:25:29 INFO - javascript benchmark 05:25:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8824.092682068702, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3294.028261662809, 3368.0569440556646, 3388.0852169914124, 3390.9491357629627, 3422.623511413744, 6122.877542449149, 6186.381361863817, 6215.3784621537825, 6223.315435302113, 6281.62310261384, 6085.300190478097, 6132.877342453159, 6166.845828854281, 6176.351483094267, 6179.351168127349, 5381.784728610861, 5407.053765591026, 5427.565794736432, 5464.562834973212, 5510.476504732044, 5476.069068258405, 5479.479449452296, 5543.722813859291, 5555.3611334696425, 5576.163575463673, 5238.449962753894, 5462.562994960394, 5488.368837583689, 5515.751791169407, 5530.225768392408, 5390.0836857734275, 5422.674639521601, 5451.291332126798, 5509.5041446270025, 5512.503874651261, 5405.37838148614, 5406.513413792738, 5455.890882182334, 5478.534324582415, 5486.91769623456, 6023.0062039763825, 6027.276726792769, 6125.84685382869, 6144.754209831602, 6189.690515474208, 6655.800325990228, 6715.328467153295, 6724.462043036594, 6744.291849355796, 6754.358335958076, 6754.223264324616, 6783.525153239275, 6822.283660215656, 6854.10896583446, 6859.2454829968665, 6225.564210505221, 6244.281907580641, 6306.747730090837, 6323.810285691437, 6344.777932772331, 6735.090762746966, 6742.056112144303, 6844.452443804584, 6890.724371025103, 6956.826079348057, 6556.704948277339, 6560.606363618198, 6627.469802415795, 6652.900206496906, 6679.165104361955, 6668.266490686021, 6690.866182676319, 6728.629925354055, 6749.730010799612, 6753.628550429676, 6598.670066496656, 6607.933920660828, 6618.86762264752, 6670.533062685662, 6695.296993815677, 6581.3747693969, 6642.96678516614, 6652.70062847173, 6696.430803381767, 6704.731810727614, 4864.124457597595, 4934.284528743312, 4988.7505624718615, 4988.7505624718615, 4992.251162325608, 4330.307150855848, 4349.586789255016, 4370.759608221515, 4381.496127945264, 4406.030673251879, 6317.652529110943, 6361.077643741724, 6424.74301027963, 6443.742250310029, 6456.548041637135, 6663.500237482208, 6717.059611654372, 6744.224414192333, 6766.6278354689985, 6781.050652908597, 6469.805905822833, 6483.546151769331, 6545.672716364163, 6563.50773691975, 6568.967155164193, 5580.972095139498, 5587.106063029895, 5643.0, 5648.576356773258, 5652.265205523256, 7003.299670033058, 7075.398591119812, 7081.752138675121, 7113.75101871432, 7157.57054576727, 6649.102371179829, 6659.800205993828, 6660.666966651551, 6670.132882725215, 6680.799576012728, 6982.546134501445, 7057.329553692391, 7065.858682826418, 7071.398931090915, 7074.903389974562, 6582.539222254396, 6596.406323430914, 6598.967005164944, 6602.867942641216, 6625.933740662725, 6729.394354508117, 6732.831679208059, 6735.831604209934, 6736.7642132525125, 6738.663066846736, 6317.115603815561, 6514.250861151028, 6517.576357536745, 6518.250401203923, 6568.6058836469965, 6529.477641788741, 6604.306547812411, 6616.503762217757, 6624.171978502687, 6625.304343044104, 6476.963685810248, 6483.286838447862, 6552.180977377828, 6561.475081993524, 6625.536212465081, 6459.61242325462, 6489.0, 6542.280349161683, 6596.769113081019, 6616.7022483987375, 6410.134631824831, 6416.967915160394, 6461.0, 6486.027095935648, 6499.155109835691], "value": 6113.058170679106, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [891.1452300564357, 924.8150369926014, 947.8530827721701, 1209.4799236328374, 1242.857071436785, 40277.0, 44091.33862992054, 44170.77914610422, 44186.0, 44293.33559996603, 41296.0, 41422.58577414225, 41519.79240103803, 41757.164856702846, 41885.371719424154, 7127.322904324081, 7177.0, 7222.602756848398, 7246.782596522113, 7254.673539690727, 7114.893276600855, 7157.534760240567, 7158.3915367193595, 7168.211496735355, 7169.283071692815, 7194.1726701429225, 7219.205887352413, 7490.4007679385795, 7652.693892244331, 7663.693452261903, 7576.28025337592, 7617.162112167657, 7624.199459056802, 7627.313541781266, 7628.122765881912, 7403.7408690695565, 7472.103347598323, 7549.622518874089, 7551.395888328921, 7612.124605670363, 42407.151856962686, 42726.0, 42729.0, 42748.358774618406, 42799.786001070104, 3483.164040630256, 3516.4022116240044, 3530.505729197914, 3530.6469353064745, 3532.1699400640828, 33260.66739332624, 33342.0, 33426.0, 33533.66466335354, 33537.16157096068, 5092.0579692756955, 5108.616853735947, 5145.845624631267, 5154.768035438415, 5166.61250406221, 211081.0, 213713.0, 214479.0, 214645.0, 214803.0, 53472.19791703128, 53726.0, 53756.0, 54210.72894635502, 54346.184807227924, 56755.0, 56992.43007569954, 57164.0, 57221.0, 57308.42691573114, 16661.91669041647, 16850.07324597159, 16871.746923796152, 16872.24074916607, 16876.15619219059, 13613.0, 13614.591562253148, 13619.795703064461, 13623.386947587382, 13628.863711362957, 14189.85810141906, 15414.460493882885, 15527.0, 15558.22208889551, 15708.13605251722, 5373.704446255415, 6278.246610406689, 6314.557980941382, 6328.335524769833, 6359.0, 1073.2487258918788, 1086.8261078227445, 1098.1763677242068, 1101.4657890922897, 1105.745678493951, 24353.756462435504, 24917.5016499669, 32201.838990804896, 32389.346121443865, 33197.506112225004, 1165.1610840195046, 1190.7023244188954, 1200.1958687679275, 1204.114975493012, 1217.5008246618843, 17007.23467443968, 17715.55711107207, 17953.29443702846, 18083.54791130206, 18304.816951830577, 290238.0, 291899.0, 291939.0, 293599.0, 293609.0, 62378.68810655917, 62656.0, 62871.0, 62909.37090629127, 62988.05517917235, 1510.919692419925, 1512.5764785859756, 1543.8358690181326, 1552.9301181446863, 1568.858802707739, 29990.400191996476, 30018.849905750332, 30216.5467517983, 30425.391492170475, 30652.693473064985, 39793.60206397899, 39863.60136398599, 39891.0, 39910.40134397928, 39935.2012959745, 241717.0, 242254.0, 242296.0, 242472.0, 242506.0, 35141.12147196341, 36923.26153476969, 36942.445863311536, 36964.63035369612, 36985.630143699294, 41941.0, 45812.31281530713, 46903.53096468992, 46930.530694692614, 47437.28844067411, 33924.0, 34202.31595368128, 34230.657693423746, 34260.82869585636, 34344.48483272803, 32690.182745431553, 33756.49365259474, 33990.15024624404, 34176.09503192157, 34222.14444638904, 37336.25327493489, 38420.0, 38804.0, 39388.212235755695, 39892.40161397639, 31077.689223107478, 33117.66882331242, 33229.50155747714, 33276.66723332833, 33368.833155834065, 24841.378965526008, 25053.624195636716, 25284.367890802878, 25768.742312576633, 27195.864020679768], "value": 18633.476125626825, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.8870016607168, 565.3837317324115, 570.7289037707087, 585.5023230254285, 591.3229352391512, 22903.0, 23357.649635255486, 24066.518669626596, 24109.0, 24113.879430602865, 25104.37239069024, 25570.23289301324, 25579.232623021293, 25649.35876603086, 25685.0, 6206.534509911741, 6290.842728931768, 6329.968350158243, 6334.84162895929, 6342.841428964267, 6177.351378105302, 6419.679016049202, 6466.74133034678, 6486.578372405802, 6498.122753428298, 6432.356764323554, 6433.485321174295, 6442.291347951722, 6448.097266382711, 6469.902951455732, 6415.967920160416, 6416.711247993851, 6434.613923164625, 6484.157059582248, 6492.57798243115, 5946.256717910262, 5969.492593129589, 5989.670568118751, 6007.309159446676, 6015.037593984942, 28992.42015159685, 30753.923612673672, 31050.0, 31210.53184202239, 31422.057338279887, 2220.3117033719436, 2254.3913143451177, 2254.391314345134, 2256.5825322315422, 2257.593633146033, 19983.0, 20456.590868182553, 20463.4884127898, 20465.07907144182, 20500.17999280027, 2283.25794116911, 2307.896144673494, 2321.802646775026, 2334.323046316566, 2399.9040038398443, 149615.0, 154411.0, 154935.0, 155250.0, 155905.0, 15266.542003739905, 15525.0, 15859.762103568455, 16079.437219697254, 16139.838601614068, 24302.270931872074, 24332.1483748068, 24476.265712028668, 24544.509109817704, 24567.63148552773, 10459.94770026145, 10777.730556735987, 10808.243422960317, 10877.619283325046, 10888.67333979982, 9925.255605829592, 10000.649912261897, 10009.349392289478, 10032.598696052222, 10081.294309398272, 8566.742997710078, 9616.711498654911, 9684.370515916444, 9732.464714440774, 9946.552405141641, 2744.3550765570076, 2767.972320276812, 2774.1122840690787, 2779.6803367612983, 2860.914172574826, 1062.6811956413046, 1070.2936062198912, 1077.8437126616755, 1084.322298563398, 1090.9509072091776, 25551.872240638677, 25583.87208063985, 26829.731702682722, 26928.73071269262, 26968.460630787275, 1131.134681968295, 1136.2954967919777, 1141.2581821815886, 1148.9885101149048, 1153.6366044696063, 12198.32909190003, 12613.747725045449, 14337.78493322601, 15134.394624214909, 15539.689206215813, 597894.0, 610866.0, 661134.0, 679687.0, 688786.0, 137612.0, 144726.0, 145695.90064347698, 148504.0, 149920.0, 1339.3437215764206, 1342.3489607540334, 1358.5109360630165, 1377.8966577506726, 1378.7173629405947, 22672.65991010169, 23008.0, 23317.41706457352, 23486.530269394858, 23518.059277628705, 65504.34495654982, 67831.0, 68081.0, 70294.64852675704, 70474.0, 80497.59751201207, 84003.0, 84806.57596711977, 86070.0, 86808.5659571698, 14401.63995900111, 14872.553823385315, 15101.773473397689, 15123.621909452351, 15138.545843624708, 23490.0, 25148.49703005966, 26199.214023579323, 26303.736962630894, 26570.202893913214, 20416.489587760425, 20812.58374832525, 20854.644448110823, 20929.476763081046, 20936.58126837485, 17877.37429189972, 18100.45698629043, 18137.727934081264, 19014.334498292494, 19132.330368437037, 21490.0, 21500.0, 21551.353459396243, 21597.676034859804, 21705.565888681824, 15335.463258785889, 15347.846521534642, 15452.304646291168, 15452.381904724134, 15487.993280436736, 19484.805151948298, 19902.104405301507, 19909.701354479985, 20240.79759202389, 20261.088251028443], "value": 13053.882532724514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.9295035248238, 1448.8333841608219, 1449.1450044473759, 1456.9053011554254, 1461.4154338264686, 14851.331690073946, 15128.319225634845, 15373.077615343087, 15397.076175429482, 15441.459548915776, 15790.526284211463, 15994.040357578524, 16022.75965860513, 16066.75899861503, 16112.75830862538, 2166.9024893879814, 2205.5368372641765, 2207.172310383606, 2213.3359992002415, 2217.7782221777857, 2341.4848733278736, 2408.9397765055837, 2420.6006009008493, 2420.7095148582193, 2423.466837295792, 2407.7471865454136, 2446.2538925627678, 2468.456939473322, 2471.765182307678, 2475.8885850136785, 2431.197704757426, 2434.817388695846, 2437.390652336916, 2440.4386990991993, 2448.4980578981354, 2288.61093614086, 2311.04091801902, 2406.6149416093517, 2457.397937505305, 2457.471643596635, 14922.104673719612, 15010.549683509404, 15098.396064157421, 15167.165805880672, 15181.468648597245, 7451.21762214965, 7673.577953212571, 7728.763397856316, 7877.251661092187, 7905.328047116002, 4781.0676918001, 4841.443234028096, 4914.680545764514, 4928.43323017854, 4941.703497790144, 1930.9710354344695, 1966.7541557305337, 1985.5830275642134, 2026.9290574829959, 2041.6733322668301, 25823.612645810328, 25903.0933917312, 26052.088176913716, 26100.60849087265, 26150.215493535034, 6448.129502517194, 6471.352864713491, 6563.245226798979, 6663.966680166568, 6664.766733164316, 17645.647087058187, 17777.555561110818, 17790.46628601144, 17853.821461785217, 17856.642867142586, 7592.0, 7832.647530861125, 7846.568438735811, 7858.567778772108, 7866.292033716879, 7043.36609705129, 7196.676149573282, 7197.244289349647, 7231.240719724458, 7236.710531578678, 5044.344235249468, 5134.127198376285, 5138.254953031789, 5196.272521846944, 5202.401723801736, 1443.4659176104908, 1450.7388670039495, 1453.600259928507, 1462.166565057928, 1464.3776395032069, 862.4652715316419, 866.7313132928812, 873.3362644390182, 890.1988210610502, 905.0768216419216, 7456.7390141344795, 7561.3194812467145, 8479.533625650525, 8500.40497165205, 8676.566171691391, 715.3561794385095, 737.5279820914619, 753.4236309223448, 758.6396461680657, 1002.3033991375924, 5050.217216331474, 5548.361938377057, 5620.747066382022, 5664.235328230719, 5684.715764211773, 20651.793482065288, 21161.894190529256, 21248.0, 21349.0, 21358.893205534183, 21793.0, 21957.560848783254, 22285.442863928532, 22324.665130023062, 22353.44116397103, 11523.71190720222, 11953.940230298967, 12046.819297710541, 12141.817872731739, 12164.513419463476, 8533.957330213309, 8745.693900713699, 9035.05131961161, 9074.04722504154, 9079.954600226956, 17662.381816636356, 18381.26474941041, 18671.439856803776, 18980.0, 19086.7136992948, 18331.266749329876, 19053.0, 19289.90355048216, 19317.61364772725, 19811.009449527755, 12426.316552589695, 12582.370881455707, 12680.23918564889, 12694.682632933882, 12706.428210730724, 14369.64075898111, 14613.488527901472, 14737.1894545801, 14762.188079655722, 14778.6305342363, 11213.495392707511, 11624.476898539755, 11818.940905295418, 11930.463129159381, 11975.161738678557, 11012.0, 11312.886871131512, 11741.76516469683, 11852.881471185177, 12154.939225303817, 10517.894821051692, 10555.208359372924, 10560.207984401355, 10622.415767132881, 10631.521581528696, 7619.238076192337, 7747.961260193663, 7773.18381569927, 7778.92221077782, 7828.725994590162, 7413.1104267488245, 7604.2395760423515, 7643.520237653175, 7663.31030207284, 7725.768226953201], "value": 6608.803141461359, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.2214140587169, 500.0299419126895, 511.5549471959395, 522.8117877564074, 528.278899302452, 5901.763929442817, 6045.304789949158, 6069.666168360733, 6129.509639228862, 6157.199564056677, 5902.704864756766, 5935.376785437532, 5968.343482216953, 5970.253718285215, 6022.247219097613, 4705.7647117644065, 4718.480967093634, 4722.0, 4724.24412094065, 4759.143354196243, 4575.565321294472, 4666.859994200179, 4703.365045718835, 4722.858314250578, 4745.169595320823, 4624.953750462486, 4646.395968524104, 4656.0687862427485, 4684.3676103726075, 4694.389729335182, 4665.440147182326, 4674.0, 4679.532046795311, 4694.319323698045, 4698.308608900793, 4265.3815196796295, 4286.678499112548, 4302.7848607569495, 4309.267424537836, 4313.202057619319, 5949.821505354803, 5953.970230148865, 5956.761729530814, 5959.374265702126, 5962.34414214436, 5517.944820551783, 5569.916451253234, 5570.275864137677, 5607.588736843156, 5613.635113717595, 6462.967685161591, 6465.4827613790785, 6487.156669632965, 6507.381798729113, 6519.641419721914, 4777.0, 4836.839158601945, 4843.39457567804, 4853.587445067174, 4865.270209468573, 6550.508711846631, 6566.80299591013, 6574.539782215247, 6588.077669126278, 6723.193216814014, 4864.708117512961, 4928.408590969107, 4956.231784073474, 4965.106280869406, 5007.198848184273, 5068.76974131381, 5072.442031376546, 5082.313887625197, 5087.0, 5094.235864620263, 5496.945030549723, 5505.476979687003, 5559.24950131727, 5572.3870374258795, 5587.972060139673, 6091.269047714302, 6330.620162790247, 6331.973768394162, 6430.228372595318, 6462.127612772216, 1661.8172001079872, 1724.1293146960704, 1741.312181688226, 1744.9563760905826, 1745.3891138101817, 1000.5947591225565, 1225.9089410424729, 1226.1662069792626, 1241.472374240944, 1243.5947379461152, 6087.8478038048515, 6209.223847019122, 6247.562670613104, 6249.1877355567285, 6286.119943207955, 6611.702473388709, 6623.503237257225, 6625.701843416961, 6635.668216589152, 6646.634435106115, 6213.502919766408, 6245.594036387621, 6268.122462855113, 6275.184226050585, 6294.559380843297, 3501.4418583729994, 3517.525134106914, 3517.8592856285463, 3526.6951228045787, 3544.0, 6809.301581908468, 6884.173899132136, 6920.238773734885, 7024.613646249403, 7037.964810175917, 6713.899291510631, 6751.392374686204, 6760.42536384403, 6760.594364338155, 6812.727490900308, 6971.6165610891885, 6977.581345119309, 6997.335253150943, 7015.579065256101, 7037.7184912602925, 6463.192100987377, 6580.400741706903, 6580.901286480803, 6581.835454113685, 6618.7352505899225, 6397.584157029964, 6439.905216113366, 6489.3510648934725, 6502.642354670538, 6532.967335163294, 6827.556208846409, 6962.373386395248, 7008.404285635778, 7024.051753013482, 7038.40173585251, 4935.235038569028, 4937.21004639256, 4948.282499037691, 4954.430240522386, 5015.824446144367, 6562.146920900253, 6572.605643661395, 6574.145361103026, 6619.172603424572, 6683.532152749261, 6434.260060093149, 6464.482841372773, 6484.1246431733, 6489.286178520265, 6551.082848401133, 6183.938160618336, 6199.535034872312, 6355.0, 6375.6174629522375, 6440.101954120571, 6125.816225513242, 6246.190433366373, 6288.622682639057, 6292.056191571301, 6302.180716506825, 5820.621659592113, 6356.2054743157105, 6375.968120159369, 6453.903191452038, 6458.644774537445, 6080.847978800565, 6250.312465628868, 6268.749250029948, 6324.4940404766585, 6339.270983836917], "value": 4993.126796855375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.7890195803985, 921.3826736086821, 924.2328867040358, 953.0659953245819, 980.14727187347, 17234.48296551104, 17802.82197178028, 17865.374711885088, 17893.194806233718, 22364.664530032063, 19743.1115599798, 20350.18599256028, 20606.896965515152, 20644.1742330307, 20652.69020964683, 983.552483619953, 1012.7012531303246, 1020.0, 1021.7598864266891, 1021.8824835143942, 1035.9119474844647, 1051.0750539525206, 1051.4532443129606, 1052.763128296135, 1079.2067830144838, 1140.4297851074464, 1144.3934714601232, 1148.0930065248485, 1148.5578052449825, 1150.3270586706788, 1141.4007645985841, 1147.8909503597145, 1150.6490520391278, 1151.3149675942843, 1153.3425947210094, 835.5195762436623, 836.5524444422205, 836.8368168207202, 837.8826964225013, 838.8238469921324, 16849.578760530963, 16893.493195204162, 16937.407190748265, 17169.48491545243, 20158.79841201584, 18698.71951920722, 18838.434846954613, 19359.80640193594, 19384.515387115294, 19525.9023704882, 15783.0, 15883.92058039714, 15904.681906361924, 15971.92014039934, 16052.197390130446, 3508.947365789515, 3532.311199316134, 3536.7701099428455, 3547.6274991126074, 3551.1654761131113, 132091.99999999904, 137676.0, 139710.0, 141747.0, 141798.0, 16242.106684132486, 16388.180590970405, 16632.58418539522, 16820.15899205035, 16944.661106777796, 31117.68882311193, 31121.844390778355, 31362.05913822589, 31417.685823141477, 31449.528257076163, 8188.222118898695, 8494.53280069602, 8497.575121243914, 9267.536623168815, 9297.767555811024, 3827.2154208387215, 4318.157959197926, 4496.685232033792, 4509.729416235036, 4538.1377538267625, 5377.327834020747, 5487.917681234785, 5512.91730624041, 6134.110553969738, 6252.812415627538, 1110.3448965110624, 1128.9209755317213, 1139.6125317391961, 1142.954281828734, 1146.39241202163, 687.7420967137324, 708.7767353283699, 711.1324184494908, 719.2486295869575, 736.3556887723242, 12840.55058072963, 13152.145110567782, 13280.335983200801, 13682.247476388895, 13817.447302108005, 621.6083867163749, 624.8906441372833, 628.4689437425368, 632.9651869147149, 644.3266786208424, 6032.788852390146, 6168.259808822881, 6218.875622487525, 6305.779297724557, 6351.777687780906, 124715.0, 132096.0, 132293.0, 134428.0, 139249.0, 111750.0, 115761.0, 117282.0, 121449.0, 121524.0, 94728.0, 95821.23884111989, 98088.01911980931, 98609.0, 102290.48854755827, 11261.605843795427, 11660.883391166319, 11743.412829358327, 12045.855643713834, 12092.697682558006, 45762.0, 47474.0, 47554.52445475501, 48011.27983080187, 49455.25817112674, 81861.0, 84903.0, 86831.56584217292, 87266.0, 88291.55854220688, 17097.401590944257, 18716.532086697942, 18755.90622046881, 18771.530711731768, 18810.811891881454, 22179.55640887141, 22472.43818904475, 22523.211687590854, 22649.320520384415, 22884.512506687013, 18446.631067378847, 18828.6234275311, 19060.142293596546, 19173.520661983563, 19530.0, 19858.801411986275, 20014.0, 20281.49296267605, 20323.187072517525, 20400.89799551052, 18557.072146392355, 19172.616547669248, 19174.520636984187, 19591.510212244237, 19807.405777826687, 12575.371231438574, 13971.510997115458, 14237.928810355881, 14270.714585708436, 14544.49094281695, 14604.0, 14771.409143634135, 14907.180105094323, 15038.92480537634, 15187.848121518644], "value": 9620.611967961748, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1482.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 106.0, 95.0, 109.0, 107.0, 107.0, 111.0, 109.0, 109.0, 109.0], "value": 106.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 114.0, 140.0, 168.0, 120.0, 149.0, 146.0, 114.0, 167.0, 117.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 162.0, 163.0, 162.0, 162.0, 162.0, 164.0, 165.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 176.0, 77.0, 77.0, 75.0, 75.0, 155.0, 75.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 140.0, 79.0, 81.0, 80.0, 127.0, 80.0, 80.0, 127.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 115.0, 114.0, 117.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 150.0, 148.0, 147.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 97.0, 94.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 46.0, 50.0, 47.0, 46.0, 48.0, 47.0, 47.0, 46.0, 48.0], "value": 47.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 53.0, 53.0, 54.0, 54.0, 54.0, 56.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 75.0, 74.0, 75.0, 74.0, 74.0, 75.0, 75.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 134.0, 124.0, 120.0, 118.0, 117.0, 124.0, 117.0, 122.0, 155.0], "value": 125.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 166.0, 159.0, 160.0, 163.0, 161.0, 169.0, 176.0, 163.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 60.0, 61.0, 74.0, 62.0, 60.0, 60.0, 63.0], "value": 62.5, "unit": "score"}]}]} 05:25:29 INFO - Return code: 0 05:25:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:25:29 INFO - # TBPL SUCCESS # 05:25:29 INFO - Running post-action listener: _package_coverage_data 05:25:29 INFO - Running post-action listener: _resource_record_post_action 05:25:29 INFO - [mozharness: 2017-07-24 12:25:29.813852Z] Finished run-tests step (success) 05:25:29 INFO - Running post-run listener: _resource_record_post_run 05:25:29 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 432889856; Read time: 192; Write time: 304460 05:25:29 INFO - TinderboxPrint: CPU usage
13.1% 05:25:29 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 192 05:25:29 INFO - TinderboxPrint: I/O write bytes / time
432,889,856 / 304,460 05:25:29 INFO - TinderboxPrint: CPU idle
8,248.2 (86.9%) 05:25:29 INFO - TinderboxPrint: CPU user
1,191.6 (12.6%) 05:25:29 INFO - TinderboxPrint: Swap in / out
0 / 0 05:25:29 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107790336; Read time: 0; Write time: 82576 05:25:29 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:25:29 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323977216; Read time: 180; Write time: 221828 05:25:30 INFO - Running post-run listener: _upload_blobber_files 05:25:30 INFO - Blob upload gear active. 05:25:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:25:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:25:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:25:30 INFO - (blobuploader) - INFO - Open directory for files ... 05:25:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:25:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:25:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:31 INFO - (blobuploader) - INFO - Done attempting. 05:25:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:25:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:25:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:32 INFO - (blobuploader) - INFO - Done attempting. 05:25:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:25:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:25:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:32 INFO - (blobuploader) - INFO - Done attempting. 05:25:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:25:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:25:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:36 INFO - (blobuploader) - INFO - Done attempting. 05:25:36 INFO - (blobuploader) - INFO - Iteration through files over. 05:25:36 INFO - Return code: 0 05:25:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:25:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:25:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e3157a98520257a47474e7121f787177641efac98c17ad48cfda478d193cfe3b3fefdcdeb7811f013ba1cb11e563293a74e012ac8286ae118a1c170019cb3e1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e02320de549815669563dbbd7d654598a980a5e4ee9edfd94bf5e8c6b3d0a52750d7ef574dff63832f6b5bc20fa1702f7dabfe1b109a32ecfc848c6f4cc99a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90ae1155e497a4cb6a93785898f9f526a5cd76dba0a001ed2f0675b52e63d08c23a04b88ae33e5b2be0969132fac412cd576b9f525d1637c6c152b61357c2e62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2895936a85e451713a9a69a3fb360403a4dd92a20c9f2185cf98b80cc49b02907b6d297b28f21100e815780c3339b1e3892038079c5eab52dba8fc5e8d4a1cb0"} 05:25:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:25:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:25:36 INFO - Contents: 05:25:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e3157a98520257a47474e7121f787177641efac98c17ad48cfda478d193cfe3b3fefdcdeb7811f013ba1cb11e563293a74e012ac8286ae118a1c170019cb3e1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e02320de549815669563dbbd7d654598a980a5e4ee9edfd94bf5e8c6b3d0a52750d7ef574dff63832f6b5bc20fa1702f7dabfe1b109a32ecfc848c6f4cc99a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90ae1155e497a4cb6a93785898f9f526a5cd76dba0a001ed2f0675b52e63d08c23a04b88ae33e5b2be0969132fac412cd576b9f525d1637c6c152b61357c2e62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2895936a85e451713a9a69a3fb360403a4dd92a20c9f2185cf98b80cc49b02907b6d297b28f21100e815780c3339b1e3892038079c5eab52dba8fc5e8d4a1cb0"} 05:25:36 INFO - Running post-run listener: copy_logs_to_upload_dir 05:25:36 INFO - Copying logs to upload dir... 05:25:36 INFO - mkdir: /builds/slave/test/build/upload/logs 05:25:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.187427 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-07-24 05:25:35.900686) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 05:25:35.904416) ========= 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=3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e3157a98520257a47474e7121f787177641efac98c17ad48cfda478d193cfe3b3fefdcdeb7811f013ba1cb11e563293a74e012ac8286ae118a1c170019cb3e1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e02320de549815669563dbbd7d654598a980a5e4ee9edfd94bf5e8c6b3d0a52750d7ef574dff63832f6b5bc20fa1702f7dabfe1b109a32ecfc848c6f4cc99a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90ae1155e497a4cb6a93785898f9f526a5cd76dba0a001ed2f0675b52e63d08c23a04b88ae33e5b2be0969132fac412cd576b9f525d1637c6c152b61357c2e62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2895936a85e451713a9a69a3fb360403a4dd92a20c9f2185cf98b80cc49b02907b6d297b28f21100e815780c3339b1e3892038079c5eab52dba8fc5e8d4a1cb0"} build_url:https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/UUxB1dC4Rbe0zwRGAH1LSg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e3157a98520257a47474e7121f787177641efac98c17ad48cfda478d193cfe3b3fefdcdeb7811f013ba1cb11e563293a74e012ac8286ae118a1c170019cb3e1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e02320de549815669563dbbd7d654598a980a5e4ee9edfd94bf5e8c6b3d0a52750d7ef574dff63832f6b5bc20fa1702f7dabfe1b109a32ecfc848c6f4cc99a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90ae1155e497a4cb6a93785898f9f526a5cd76dba0a001ed2f0675b52e63d08c23a04b88ae33e5b2be0969132fac412cd576b9f525d1637c6c152b61357c2e62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2895936a85e451713a9a69a3fb360403a4dd92a20c9f2185cf98b80cc49b02907b6d297b28f21100e815780c3339b1e3892038079c5eab52dba8fc5e8d4a1cb0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 05:25:35.929941) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 05:25:35.930298) ========= 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=3297cc2eebb5444a7688c33f000001b5-1500897885.638051-993602488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004377 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 05:25:36.013916) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 05:25:36.014239) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 05:25:36.014545) ========= ========= Total master_lag: 0.17 =========