builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-087 starttime: 1500941758.74 results: success (0) revision: 899590a34d56e099d4e064a9e4d41a54993790e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 17:15:58.738048) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 17:15:58.738487) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 17:15:58.738765) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 17:15:58.790694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 17:15:58.790948) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-24 17:15:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.4M=0s 2017-07-24 17:15:59 (50.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092704 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 17:15:58.913222) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 17:15:58.913610) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013994 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 17:15:58.969039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 17:15:58.969373) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 899590a34d56e099d4e064a9e4d41a54993790e9 --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 899590a34d56e099d4e064a9e4d41a54993790e9 --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=ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-24 17:15:59,497 truncating revision to first 12 chars 2017-07-24 17:15:59,497 Setting DEBUG logging. 2017-07-24 17:15:59,497 attempt 1/10 2017-07-24 17:15:59,497 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/899590a34d56?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-24 17:16:00,728 unpacking tar archive at: mozilla-central-899590a34d56/testing/mozharness/ program finished with exit code 0 elapsedTime=1.531446 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 17:16:00.515919) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 17:16:00.516217) ========= script_repo_revision: 899590a34d56e099d4e064a9e4d41a54993790e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 17:16:00.516555) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 17:16:00.516820) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 17:16:00.523999) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-07-24 17:16:00.524267) ========= /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=ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:16:01 INFO - MultiFileLogger online at 20170724 17:16:01 in /builds/slave/test 17:16:01 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 17:16:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:16:01 INFO - {'append_to_log': False, 17:16:01 INFO - 'base_work_dir': '/builds/slave/test', 17:16:01 INFO - 'blob_upload_branch': 'Firefox', 17:16:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:16:01 INFO - 'branch': 'Firefox', 17:16:01 INFO - 'buildbot_json_path': 'buildprops.json', 17:16:01 INFO - 'code_coverage': False, 17:16:01 INFO - 'config_files': ('talos/linux_config.py',), 17:16:01 INFO - 'default_actions': ('clobber', 17:16:01 INFO - 'read-buildbot-config', 17:16:01 INFO - 'download-and-extract', 17:16:01 INFO - 'populate-webroot', 17:16:01 INFO - 'create-virtualenv', 17:16:01 INFO - 'install', 17:16:01 INFO - 'setup-mitmproxy', 17:16:01 INFO - 'run-tests'), 17:16:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:16:01 INFO - 'disable_ccov_upload': False, 17:16:01 INFO - 'download_minidump_stackwalk': True, 17:16:01 INFO - 'download_symbols': 'ondemand', 17:16:01 INFO - 'enable_stylo': False, 17:16:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:16:01 INFO - 'tooltool.py': '/tools/tooltool.py', 17:16:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:16:01 INFO - '/tools/misc-python/virtualenv.py')}, 17:16:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:16:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:16:01 INFO - 'gecko_profile': False, 17:16:01 INFO - 'gecko_profile_interval': 0, 17:16:01 INFO - 'installer_path': 'installer.exe', 17:16:01 INFO - 'log_level': 'info', 17:16:01 INFO - 'log_name': 'talos', 17:16:01 INFO - 'log_to_console': True, 17:16:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:16:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:16:01 INFO - 'opt_config_files': (), 17:16:01 INFO - 'pip_index': False, 17:16:01 INFO - 'suite': 'dromaeojs-e10s', 17:16:01 INFO - 'system_bits': '32', 17:16:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:16:01 INFO - 'title': 'talos-linux64-ix-087', 17:16:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:16:01 INFO - 'use_talos_json': True, 17:16:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:16:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:16:01 INFO - 'work_dir': 'build'} 17:16:01 INFO - [mozharness: 2017-07-25 00:16:01.155062Z] Running clobber step. 17:16:01 INFO - Running pre-action listener: _resource_record_pre_action 17:16:01 INFO - Running main action method: clobber 17:16:01 INFO - rmtree: /builds/slave/test/build 17:16:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:16:02 INFO - Running post-action listener: _resource_record_post_action 17:16:02 INFO - [mozharness: 2017-07-25 00:16:02.727248Z] Finished clobber step (success) 17:16:02 INFO - [mozharness: 2017-07-25 00:16:02.727349Z] Running read-buildbot-config step. 17:16:02 INFO - Running pre-action listener: _resource_record_pre_action 17:16:02 INFO - Running main action method: read_buildbot_config 17:16:02 INFO - Using buildbot properties: 17:16:02 INFO - { 17:16:02 INFO - "project": "", 17:16:02 INFO - "product": "firefox", 17:16:02 INFO - "who": "kwierso@gmail.com", 17:16:02 INFO - "installer_path": "public/build/target.tar.bz2", 17:16:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:16:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:16:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 17:16:02 INFO - "stage_platform": "linux64-pgo", 17:16:02 INFO - "basedir": "/builds/slave/test", 17:16:02 INFO - "buildnumber": 91, 17:16:02 INFO - "platform": "ubuntu64_hw", 17:16:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:16:02 INFO - "slavebuilddir": "test", 17:16:02 INFO - "taskId": "Iy1n1nnMRFqaRN5-JxNchg", 17:16:02 INFO - "branch": "mozilla-central", 17:16:02 INFO - "script_repo_revision": "production", 17:16:02 INFO - "revision": "899590a34d56e099d4e064a9e4d41a54993790e9", 17:16:02 INFO - "slavename": "talos-linux64-ix-087", 17:16:02 INFO - "repo_path": "mozilla-central" 17:16:02 INFO - } 17:16:02 INFO - Finding installer, test and symbols from parent task. 17:16:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iy1n1nnMRFqaRN5-JxNchg'}, attempt #1 17:16:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iy1n1nnMRFqaRN5-JxNchg'}, attempt #1 17:16:03 INFO - Task dependencies: U8RV3YgMTjCb3WKAh3m6ew 17:16:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew'}, attempt #1 17:16:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.tar.bz2 17:16:04 INFO - Set test_url: https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/test_packages.json 17:16:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.crashreporter-symbols.zip 17:16:04 INFO - Running post-action listener: _resource_record_post_action 17:16:04 INFO - [mozharness: 2017-07-25 00:16:04.358629Z] Finished read-buildbot-config step (success) 17:16:04 INFO - [mozharness: 2017-07-25 00:16:04.358940Z] Running download-and-extract step. 17:16:04 INFO - Running pre-action listener: _resource_record_pre_action 17:16:04 INFO - Running main action method: download_and_extract 17:16:04 INFO - mkdir: /builds/slave/test/build/tests 17:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:04 INFO - trying https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.test_packages.json 17:16:04 INFO - Downloading https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:16:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:16:05 INFO - Downloaded 989 bytes. 17:16:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:16:05 INFO - Using the following test package requirements: 17:16:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:16:05 INFO - u'common': [u'target.common.tests.zip'], 17:16:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:16:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:16:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:16:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:16:05 INFO - u'mozbase': [u'target.common.tests.zip'], 17:16:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:16:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:16:05 INFO - u'web-platform': [u'target.common.tests.zip', 17:16:05 INFO - u'target.web-platform.tests.tar.gz'], 17:16:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:16:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:16:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.common.tests.zip 17:16:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:16:05 INFO - Fetch https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.common.tests.zip into memory 17:16:06 INFO - Content-Length response header: 73380820 17:16:06 INFO - Bytes received: 73380820 17:16:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:16:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.common.tests.zip 17:16:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:16:17 INFO - Fetch https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.common.tests.zip into memory 17:16:19 INFO - Content-Length response header: 73380820 17:16:19 INFO - Bytes received: 73380820 17:16:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.talos.tests.zip 17:16:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:16:31 INFO - Fetch https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.talos.tests.zip into memory 17:16:32 INFO - Content-Length response header: 14498976 17:16:32 INFO - Bytes received: 14498976 17:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:32 INFO - trying https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.tar.bz2 17:16:32 INFO - Downloading https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:16:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:16:34 INFO - Downloaded 62849961 bytes. 17:16:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.tar.bz2 17:16:34 INFO - mkdir: /builds/slave/test/properties 17:16:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:16:34 INFO - Writing to file /builds/slave/test/properties/build_url 17:16:34 INFO - Contents: 17:16:34 INFO - build_url:https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.tar.bz2 17:16:34 INFO - Running post-action listener: _resource_record_post_action 17:16:34 INFO - Running post-action listener: set_extra_try_arguments 17:16:34 INFO - [mozharness: 2017-07-25 00:16:34.673233Z] Finished download-and-extract step (success) 17:16:34 INFO - [mozharness: 2017-07-25 00:16:34.673484Z] Running populate-webroot step. 17:16:34 INFO - Running pre-action listener: _resource_record_pre_action 17:16:34 INFO - Running main action method: populate_webroot 17:16:34 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:16:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:16:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:16:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:16:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:16:34 INFO - 'tests': ['damp', 'tps']}, 17:16:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:16:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:16:34 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:16:34 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:16:34 INFO - 'other-e10s': {'tests': ['a11yr', 17:16:34 INFO - 'ts_paint', 17:16:34 INFO - 'tpaint', 17:16:34 INFO - 'sessionrestore', 17:16:34 INFO - 'sessionrestore_many_windows', 17:16:34 INFO - 'sessionrestore_no_auto_restore', 17:16:34 INFO - 'tabpaint']}, 17:16:34 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:16:34 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:16:34 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:16:34 INFO - 'talos_options': ['--mitmproxy', 17:16:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:16:34 INFO - '--firstNonBlankPaint'], 17:16:34 INFO - 'tests': ['quantum_pageload_google', 17:16:34 INFO - 'quantum_pageload_youtube', 17:16:34 INFO - 'quantum_pageload_amazon', 17:16:34 INFO - 'quantum_pageload_facebook']}, 17:16:34 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:16:34 INFO - 'talos_options': ['--stylo', 17:16:34 INFO - '--mitmproxy', 17:16:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:16:34 INFO - '--firstNonBlankPaint'], 17:16:34 INFO - 'tests': ['quantum_pageload_google', 17:16:34 INFO - 'quantum_pageload_youtube', 17:16:34 INFO - 'quantum_pageload_amazon', 17:16:34 INFO - 'quantum_pageload_facebook']}, 17:16:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:16:34 INFO - 'tsvgr_opacity', 17:16:34 INFO - 'tart', 17:16:34 INFO - 'tscrollx', 17:16:34 INFO - 'cart', 17:16:34 INFO - 'tsvg_static']}, 17:16:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:16:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:16:34 INFO - 'talos_options': ['--xperf_path', 17:16:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:16:34 INFO - 'tests': ['tp5n']}}} 17:16:34 INFO - Running post-action listener: _resource_record_post_action 17:16:34 INFO - [mozharness: 2017-07-25 00:16:34.685786Z] Finished populate-webroot step (success) 17:16:34 INFO - [mozharness: 2017-07-25 00:16:34.685877Z] Running create-virtualenv step. 17:16:34 INFO - Running pre-action listener: _resource_record_pre_action 17:16:34 INFO - Running main action method: create_virtualenv 17:16:34 INFO - Creating virtualenv /builds/slave/test/build/venv 17:16:34 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 17:16:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:16:34 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:16:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:16:34 INFO - Using real prefix '/usr' 17:16:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:16:35 INFO - Installing distribute.............................................................................................................................................................................................done. 17:16:37 INFO - Installing pip.................done. 17:16:37 INFO - Return code: 0 17:16:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:16:37 INFO - Reading from file tmpfile_stdout 17:16:37 INFO - Output received: 17:16:37 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) 17:16:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:37 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1600a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0eb0>, '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 0x17a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a2240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', '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 17:16:37 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 17:16:37 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 17:16:37 INFO - Using env: {'DISPLAY': ':0', 17:16:37 INFO - 'HOME': '/home/cltbld', 17:16:37 INFO - 'LANG': 'en_US.UTF-8', 17:16:37 INFO - 'LANGUAGE': 'en_US:en', 17:16:37 INFO - 'LOGNAME': 'cltbld', 17:16:37 INFO - 'MAIL': '/var/mail/cltbld', 17:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:37 INFO - 'MOZ_NO_REMOTE': '1', 17:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:37 INFO - 'NO_EM_RESTART': '1', 17:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:37 INFO - 'PWD': '/builds/slave/test', 17:16:37 INFO - 'SHELL': '/bin/bash', 17:16:37 INFO - 'SHLVL': '1', 17:16:37 INFO - 'TERM': 'linux', 17:16:37 INFO - 'TMOUT': '86400', 17:16:37 INFO - 'USER': 'cltbld', 17:16:37 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', 17:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:37 INFO - '_': '/tools/buildbot/bin/python'} 17:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:37 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 17:16:37 INFO - Cleaning up... 17:16:37 INFO - Return code: 0 17:16:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:37 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1600a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0eb0>, '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 0x17a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a2240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', '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 17:16:37 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 17:16:37 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 17:16:37 INFO - Using env: {'DISPLAY': ':0', 17:16:37 INFO - 'HOME': '/home/cltbld', 17:16:37 INFO - 'LANG': 'en_US.UTF-8', 17:16:37 INFO - 'LANGUAGE': 'en_US:en', 17:16:37 INFO - 'LOGNAME': 'cltbld', 17:16:37 INFO - 'MAIL': '/var/mail/cltbld', 17:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:37 INFO - 'MOZ_NO_REMOTE': '1', 17:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:37 INFO - 'NO_EM_RESTART': '1', 17:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:37 INFO - 'PWD': '/builds/slave/test', 17:16:37 INFO - 'SHELL': '/bin/bash', 17:16:37 INFO - 'SHLVL': '1', 17:16:37 INFO - 'TERM': 'linux', 17:16:37 INFO - 'TMOUT': '86400', 17:16:37 INFO - 'USER': 'cltbld', 17:16:37 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', 17:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:37 INFO - '_': '/tools/buildbot/bin/python'} 17:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:37 INFO - Downloading/unpacking psutil>=3.1.1 17:16: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 17:16: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 17:16: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 17:16: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 17:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:16:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:39 INFO - Installing collected packages: psutil 17:16:39 INFO - Running setup.py install for psutil 17:16:39 INFO - building 'psutil._psutil_linux' extension 17:16:39 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 17:16:39 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 17:16:39 INFO - building 'psutil._psutil_posix' extension 17:16:39 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 17:16:39 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 17:16:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:39 INFO - Successfully installed psutil 17:16:39 INFO - Cleaning up... 17:16:39 INFO - Return code: 0 17:16:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:16: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')]} 17:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16: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')]} 17:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1600a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0eb0>, '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 0x17a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a2240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', '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 17:16: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:16: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 mozsystemmonitor==0.3 17:16:39 INFO - Using env: {'DISPLAY': ':0', 17:16:39 INFO - 'HOME': '/home/cltbld', 17:16:39 INFO - 'LANG': 'en_US.UTF-8', 17:16:39 INFO - 'LANGUAGE': 'en_US:en', 17:16:39 INFO - 'LOGNAME': 'cltbld', 17:16:39 INFO - 'MAIL': '/var/mail/cltbld', 17:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:39 INFO - 'MOZ_NO_REMOTE': '1', 17:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:39 INFO - 'NO_EM_RESTART': '1', 17:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:39 INFO - 'PWD': '/builds/slave/test', 17:16:39 INFO - 'SHELL': '/bin/bash', 17:16:39 INFO - 'SHLVL': '1', 17:16:39 INFO - 'TERM': 'linux', 17:16:39 INFO - 'TMOUT': '86400', 17:16:39 INFO - 'USER': 'cltbld', 17:16:39 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', 17:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:39 INFO - '_': '/tools/buildbot/bin/python'} 17:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:16:39 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 17:16:39 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 17:16:39 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 17:16:39 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 17:16:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:16:41 INFO - Installing collected packages: mozsystemmonitor 17:16:41 INFO - Running setup.py install for mozsystemmonitor 17:16:41 INFO - Successfully installed mozsystemmonitor 17:16:41 INFO - Cleaning up... 17:16:41 INFO - Return code: 0 17:16:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:16:41 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')]} 17:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:41 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')]} 17:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:41 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1600a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0eb0>, '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 0x17a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a2240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', '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 17:16:41 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 17:16:41 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 17:16:41 INFO - Using env: {'DISPLAY': ':0', 17:16:41 INFO - 'HOME': '/home/cltbld', 17:16:41 INFO - 'LANG': 'en_US.UTF-8', 17:16:41 INFO - 'LANGUAGE': 'en_US:en', 17:16:41 INFO - 'LOGNAME': 'cltbld', 17:16:41 INFO - 'MAIL': '/var/mail/cltbld', 17:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:41 INFO - 'MOZ_NO_REMOTE': '1', 17:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:41 INFO - 'NO_EM_RESTART': '1', 17:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:41 INFO - 'PWD': '/builds/slave/test', 17:16:41 INFO - 'SHELL': '/bin/bash', 17:16:41 INFO - 'SHLVL': '1', 17:16:41 INFO - 'TERM': 'linux', 17:16:41 INFO - 'TMOUT': '86400', 17:16:41 INFO - 'USER': 'cltbld', 17:16:41 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', 17:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:41 INFO - '_': '/tools/buildbot/bin/python'} 17:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:41 INFO - Downloading/unpacking jsonschema==2.5.1 17:16:41 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 17:16:41 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 17:16:41 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 17:16:41 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 17:16:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:16:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:42 INFO - Downloading functools32-3.2.3-2.tar.gz 17:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:16:42 INFO - warning: no files found matching '*.txt' 17:16:42 INFO - no previously-included directories found matching 'build' 17:16:42 INFO - no previously-included directories found matching 'dist' 17:16:42 INFO - no previously-included directories found matching '.git*' 17:16:42 INFO - Installing collected packages: jsonschema, functools32 17:16:42 INFO - Running setup.py install for functools32 17:16:42 INFO - warning: no files found matching '*.txt' 17:16:42 INFO - no previously-included directories found matching 'build' 17:16:42 INFO - no previously-included directories found matching 'dist' 17:16:42 INFO - no previously-included directories found matching '.git*' 17:16:42 INFO - Successfully installed jsonschema functools32 17:16:42 INFO - Cleaning up... 17:16:42 INFO - Return code: 0 17:16:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:42 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1600a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0eb0>, '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 0x17a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a2240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', '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 17:16:42 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 17:16:42 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 17:16:42 INFO - Using env: {'DISPLAY': ':0', 17:16:42 INFO - 'HOME': '/home/cltbld', 17:16:42 INFO - 'LANG': 'en_US.UTF-8', 17:16:42 INFO - 'LANGUAGE': 'en_US:en', 17:16:42 INFO - 'LOGNAME': 'cltbld', 17:16:42 INFO - 'MAIL': '/var/mail/cltbld', 17:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:42 INFO - 'MOZ_NO_REMOTE': '1', 17:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:42 INFO - 'NO_EM_RESTART': '1', 17:16:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:42 INFO - 'PWD': '/builds/slave/test', 17:16:42 INFO - 'SHELL': '/bin/bash', 17:16:42 INFO - 'SHLVL': '1', 17:16:42 INFO - 'TERM': 'linux', 17:16:42 INFO - 'TMOUT': '86400', 17:16:42 INFO - 'USER': 'cltbld', 17:16:42 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', 17:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:42 INFO - '_': '/tools/buildbot/bin/python'} 17:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:16:43 INFO - Cleaning up... 17:16:43 INFO - Return code: 0 17:16:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:43 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1600a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0eb0>, '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 0x17a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a2240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', '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 17:16:43 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 17:16:43 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 17:16:43 INFO - Using env: {'DISPLAY': ':0', 17:16:43 INFO - 'HOME': '/home/cltbld', 17:16:43 INFO - 'LANG': 'en_US.UTF-8', 17:16:43 INFO - 'LANGUAGE': 'en_US:en', 17:16:43 INFO - 'LOGNAME': 'cltbld', 17:16:43 INFO - 'MAIL': '/var/mail/cltbld', 17:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:43 INFO - 'MOZ_NO_REMOTE': '1', 17:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:43 INFO - 'NO_EM_RESTART': '1', 17:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:43 INFO - 'PWD': '/builds/slave/test', 17:16:43 INFO - 'SHELL': '/bin/bash', 17:16:43 INFO - 'SHLVL': '1', 17:16:43 INFO - 'TERM': 'linux', 17:16:43 INFO - 'TMOUT': '86400', 17:16:43 INFO - 'USER': 'cltbld', 17:16:43 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', 17:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:43 INFO - '_': '/tools/buildbot/bin/python'} 17:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:43 INFO - Downloading/unpacking blobuploader==1.2.4 17:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:44 INFO - Downloading blobuploader-1.2.4.tar.gz 17:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:16:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:16:44 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 17:16:44 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 17:16:44 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 17:16:44 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 17:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:16:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:16:44 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 17:16:44 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 17:16:44 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 17:16:44 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 17:16:44 INFO - Downloading docopt-0.6.1.tar.gz 17:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:16:44 INFO - Installing collected packages: blobuploader, requests, docopt 17:16:44 INFO - Running setup.py install for blobuploader 17:16:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:16:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:16:45 INFO - Running setup.py install for requests 17:16:45 INFO - Running setup.py install for docopt 17:16:45 INFO - Successfully installed blobuploader requests docopt 17:16:45 INFO - Cleaning up... 17:16:45 INFO - Return code: 0 17:16:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:45 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1600a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0eb0>, '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 0x17a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a2240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', '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 17:16:45 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 17:16:45 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 17:16:45 INFO - Using env: {'DISPLAY': ':0', 17:16:45 INFO - 'HOME': '/home/cltbld', 17:16:45 INFO - 'LANG': 'en_US.UTF-8', 17:16:45 INFO - 'LANGUAGE': 'en_US:en', 17:16:45 INFO - 'LOGNAME': 'cltbld', 17:16:45 INFO - 'MAIL': '/var/mail/cltbld', 17:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:45 INFO - 'MOZ_NO_REMOTE': '1', 17:16:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:45 INFO - 'NO_EM_RESTART': '1', 17:16:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:45 INFO - 'PWD': '/builds/slave/test', 17:16:45 INFO - 'SHELL': '/bin/bash', 17:16:45 INFO - 'SHLVL': '1', 17:16:45 INFO - 'TERM': 'linux', 17:16:45 INFO - 'TMOUT': '86400', 17:16:45 INFO - 'USER': 'cltbld', 17:16:45 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', 17:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:45 INFO - '_': '/tools/buildbot/bin/python'} 17:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:45 INFO - Running setup.py (path:/tmp/pip-cHo1No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:45 INFO - Running setup.py (path:/tmp/pip-TUIlfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:45 INFO - Running setup.py (path:/tmp/pip-5FC8DI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:45 INFO - Running setup.py (path:/tmp/pip-0F577d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:46 INFO - Running setup.py (path:/tmp/pip-3Dx1O3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:46 INFO - Running setup.py (path:/tmp/pip-ZLS6SQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:46 INFO - Running setup.py (path:/tmp/pip-5PNHIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:46 INFO - Running setup.py (path:/tmp/pip-7_tZQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:46 INFO - Running setup.py (path:/tmp/pip-Eu0aB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:46 INFO - Running setup.py (path:/tmp/pip-iY35bD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:46 INFO - Running setup.py (path:/tmp/pip-lNWdy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:46 INFO - Running setup.py (path:/tmp/pip-1bbopM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:46 INFO - Running setup.py (path:/tmp/pip-m24ptp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:46 INFO - Running setup.py (path:/tmp/pip-ZAKKQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:46 INFO - Running setup.py (path:/tmp/pip-he8Sj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:46 INFO - Running setup.py (path:/tmp/pip-POy61D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:46 INFO - Running setup.py (path:/tmp/pip-95LZEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:16:46 INFO - Running setup.py install for manifestparser 17:16:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:16:47 INFO - Running setup.py install for mozcrash 17:16:47 INFO - Running setup.py install for mozdebug 17:16:47 INFO - Running setup.py install for mozdevice 17:16:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:16:47 INFO - Running setup.py install for mozfile 17:16:47 INFO - Running setup.py install for mozhttpd 17:16:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:16:47 INFO - Running setup.py install for mozinfo 17:16:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:16:47 INFO - Running setup.py install for mozInstall 17:16:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:16:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:16:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:16:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:16:47 INFO - Running setup.py install for mozleak 17:16:47 INFO - Running setup.py install for mozlog 17:16:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:16:47 INFO - Running setup.py install for moznetwork 17:16:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:16:48 INFO - Running setup.py install for mozprocess 17:16:48 INFO - Running setup.py install for mozprofile 17:16:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:16:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:16:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:16:48 INFO - Running setup.py install for mozrunner 17:16:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:16:48 INFO - Running setup.py install for mozscreenshot 17:16:48 INFO - Running setup.py install for moztest 17:16:48 INFO - Running setup.py install for mozversion 17:16:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:16:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:16:48 INFO - Cleaning up... 17:16:48 INFO - Return code: 0 17:16:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:48 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')]} 17:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:48 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')]} 17:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:48 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1600a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0eb0>, '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 0x17a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a2240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', '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 17:16:48 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 17:16:48 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 17:16:48 INFO - Using env: {'DISPLAY': ':0', 17:16:48 INFO - 'HOME': '/home/cltbld', 17:16:48 INFO - 'LANG': 'en_US.UTF-8', 17:16:48 INFO - 'LANGUAGE': 'en_US:en', 17:16:48 INFO - 'LOGNAME': 'cltbld', 17:16:48 INFO - 'MAIL': '/var/mail/cltbld', 17:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:48 INFO - 'MOZ_NO_REMOTE': '1', 17:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:48 INFO - 'NO_EM_RESTART': '1', 17:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:48 INFO - 'PWD': '/builds/slave/test', 17:16:48 INFO - 'SHELL': '/bin/bash', 17:16:48 INFO - 'SHLVL': '1', 17:16:48 INFO - 'TERM': 'linux', 17:16:48 INFO - 'TMOUT': '86400', 17:16:48 INFO - 'USER': 'cltbld', 17:16:48 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', 17:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:48 INFO - '_': '/tools/buildbot/bin/python'} 17:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:48 INFO - Running setup.py (path:/tmp/pip-hxLf2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:49 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)) 17:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:49 INFO - Running setup.py (path:/tmp/pip-36xgQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:49 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)) 17:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:49 INFO - Running setup.py (path:/tmp/pip-0_sb1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:49 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)) 17:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:49 INFO - Running setup.py (path:/tmp/pip-4mWpg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:49 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)) 17:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:49 INFO - Running setup.py (path:/tmp/pip-44Bpiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:49 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)) 17:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:49 INFO - Running setup.py (path:/tmp/pip-3GjYdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:49 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)) 17:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:49 INFO - Running setup.py (path:/tmp/pip-mgvpNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:49 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)) 17:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:49 INFO - Running setup.py (path:/tmp/pip-5MxsXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:49 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)) 17:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:49 INFO - Running setup.py (path:/tmp/pip-UrV9oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:49 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)) 17:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:49 INFO - Running setup.py (path:/tmp/pip-qktZgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:49 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)) 17:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:49 INFO - Running setup.py (path:/tmp/pip-3k57Ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:49 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)) 17:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:49 INFO - Running setup.py (path:/tmp/pip-if146K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:49 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)) 17:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:49 INFO - Running setup.py (path:/tmp/pip-7bn2eX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:49 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)) 17:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:49 INFO - Running setup.py (path:/tmp/pip-lphHKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:49 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)) 17:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:49 INFO - Running setup.py (path:/tmp/pip-zZZLbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:50 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)) 17:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:50 INFO - Running setup.py (path:/tmp/pip-IVpnt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:50 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)) 17:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:50 INFO - Running setup.py (path:/tmp/pip-oAywB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:16:50 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 17:16:50 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 17:16:50 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 17:16:50 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 17:16:51 INFO - Downloading blessings-1.6.tar.gz 17:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:16:51 INFO - Installing collected packages: blessings 17:16:51 INFO - Running setup.py install for blessings 17:16:51 INFO - Successfully installed blessings 17:16:51 INFO - Cleaning up... 17:16:51 INFO - Return code: 0 17:16:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:16:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:51 INFO - Reading from file tmpfile_stdout 17:16:51 INFO - Current package versions: 17:16:51 INFO - argparse == 1.2.1 17:16:51 INFO - blessings == 1.6 17:16:51 INFO - blobuploader == 1.2.4 17:16:51 INFO - docopt == 0.6.1 17:16:51 INFO - functools32 == 3.2.3-2 17:16:51 INFO - jsonschema == 2.5.1 17:16:51 INFO - manifestparser == 1.1 17:16:51 INFO - mozInstall == 1.13 17:16:51 INFO - mozcrash == 1.0 17:16:51 INFO - mozdebug == 0.1 17:16:51 INFO - mozdevice == 0.51 17:16:51 INFO - mozfile == 1.2 17:16:51 INFO - mozhttpd == 0.7 17:16:51 INFO - mozinfo == 0.10 17:16:51 INFO - mozleak == 0.1 17:16:51 INFO - mozlog == 3.5 17:16:51 INFO - moznetwork == 0.27 17:16:51 INFO - mozprocess == 0.25 17:16:51 INFO - mozprofile == 0.28 17:16:51 INFO - mozrunner == 6.13 17:16:51 INFO - mozscreenshot == 0.1 17:16:51 INFO - mozsystemmonitor == 0.3 17:16:51 INFO - moztest == 0.8 17:16:51 INFO - mozversion == 1.4 17:16:51 INFO - psutil == 3.1.1 17:16:51 INFO - requests == 1.2.3 17:16:51 INFO - wsgiref == 0.1.2 17:16:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:51 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')]} 17:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:51 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')]} 17:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:51 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1600a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0eb0>, '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 0x17a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a2240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', '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 17:16:51 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 17:16:51 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 17:16:51 INFO - Using env: {'DISPLAY': ':0', 17:16:51 INFO - 'HOME': '/home/cltbld', 17:16:51 INFO - 'LANG': 'en_US.UTF-8', 17:16:51 INFO - 'LANGUAGE': 'en_US:en', 17:16:51 INFO - 'LOGNAME': 'cltbld', 17:16:51 INFO - 'MAIL': '/var/mail/cltbld', 17:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:51 INFO - 'MOZ_NO_REMOTE': '1', 17:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:51 INFO - 'NO_EM_RESTART': '1', 17:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:51 INFO - 'PWD': '/builds/slave/test', 17:16:51 INFO - 'SHELL': '/bin/bash', 17:16:51 INFO - 'SHLVL': '1', 17:16:51 INFO - 'TERM': 'linux', 17:16:51 INFO - 'TMOUT': '86400', 17:16:51 INFO - 'USER': 'cltbld', 17:16:51 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', 17:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:51 INFO - '_': '/tools/buildbot/bin/python'} 17:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:51 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)) 17:16:51 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)) 17:16:51 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)) 17:16:51 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)) 17:16:51 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)) 17:16:51 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)) 17:16:51 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)) 17:16:51 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)) 17:16:51 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)) 17:16:51 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:16:51 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 17:16:51 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 17:16:51 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 17:16:51 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 17:16:53 INFO - Downloading marionette_driver-1.4.0.tar.gz 17:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 17:16:53 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 17:16:53 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 17:16:53 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 17:16:53 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 17:16:53 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 17:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:16:53 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)) 17:16:53 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)) 17:16:53 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)) 17:16:53 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)) 17:16:53 INFO - Installing collected packages: marionette-driver, simplejson 17:16:53 INFO - Running setup.py install for marionette-driver 17:16:53 INFO - Running setup.py install for simplejson 17:16:53 INFO - building 'simplejson._speedups' extension 17:16:53 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 17:16:54 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 17:16:54 INFO - Successfully installed marionette-driver simplejson 17:16:54 INFO - Cleaning up... 17:16:54 INFO - Return code: 0 17:16:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:16:54 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')]} 17:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:54 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')]} 17:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:54 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 0x14341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1600a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0eb0>, '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 0x17a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a2240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', '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 17:16:54 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 17:16:54 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 17:16:54 INFO - Using env: {'DISPLAY': ':0', 17:16:54 INFO - 'HOME': '/home/cltbld', 17:16:54 INFO - 'LANG': 'en_US.UTF-8', 17:16:54 INFO - 'LANGUAGE': 'en_US:en', 17:16:54 INFO - 'LOGNAME': 'cltbld', 17:16:54 INFO - 'MAIL': '/var/mail/cltbld', 17:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:54 INFO - 'MOZ_NO_REMOTE': '1', 17:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:54 INFO - 'NO_EM_RESTART': '1', 17:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:54 INFO - 'PWD': '/builds/slave/test', 17:16:54 INFO - 'SHELL': '/bin/bash', 17:16:54 INFO - 'SHLVL': '1', 17:16:54 INFO - 'TERM': 'linux', 17:16:54 INFO - 'TMOUT': '86400', 17:16:54 INFO - 'USER': 'cltbld', 17:16:54 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', 17:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:54 INFO - '_': '/tools/buildbot/bin/python'} 17:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:16:54 INFO - Cleaning up... 17:16:54 INFO - Return code: 0 17:16:54 INFO - Running post-action listener: _resource_record_post_action 17:16:54 INFO - Running post-action listener: _start_resource_monitoring 17:16:54 INFO - Starting resource monitoring. 17:16:54 INFO - [mozharness: 2017-07-25 00:16:54.750959Z] Finished create-virtualenv step (success) 17:16:54 INFO - [mozharness: 2017-07-25 00:16:54.751480Z] Running install step. 17:16:54 INFO - Running pre-action listener: _resource_record_pre_action 17:16:54 INFO - Running main action method: install 17:16:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:54 INFO - Reading from file tmpfile_stdout 17:16:54 INFO - Detecting whether we're running mozinstall >=1.0... 17:16:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:16:55 INFO - Reading from file tmpfile_stdout 17:16:55 INFO - Output received: 17:16:55 INFO - Usage: mozinstall [options] installer 17:16:55 INFO - Options: 17:16:55 INFO - -h, --help show this help message and exit 17:16:55 INFO - -d DEST, --destination=DEST 17:16:55 INFO - Directory to install application into. [default: 17:16:55 INFO - "/builds/slave/test"] 17:16:55 INFO - --app=APP Application being installed. [default: firefox] 17:16:55 INFO - mkdir: /builds/slave/test/build/application 17:16:55 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'] 17:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:17:12 INFO - Reading from file tmpfile_stdout 17:17:12 INFO - Output received: 17:17:12 INFO - /builds/slave/test/build/application/firefox/firefox 17:17:12 INFO - Running post-action listener: _resource_record_post_action 17:17:12 INFO - [mozharness: 2017-07-25 00:17:12.936056Z] Finished install step (success) 17:17:12 INFO - [mozharness: 2017-07-25 00:17:12.936311Z] Running setup-mitmproxy step. 17:17:12 INFO - Running pre-action listener: _resource_record_pre_action 17:17:12 INFO - Running main action method: setup_mitmproxy 17:17:12 INFO - Skipping: mitmproxy is not required 17:17:12 INFO - Running post-action listener: _resource_record_post_action 17:17:12 INFO - [mozharness: 2017-07-25 00:17:12.937497Z] Finished setup-mitmproxy step (success) 17:17:12 INFO - [mozharness: 2017-07-25 00:17:12.937726Z] Running run-tests step. 17:17:12 INFO - Running pre-action listener: _resource_record_pre_action 17:17:12 INFO - Running pre-action listener: _set_gcov_prefix 17:17:12 INFO - Running main action method: run_tests 17:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:17:12 INFO - Python 2.7.3 17:17:12 INFO - Return code: 0 17:17:12 INFO - grabbing minidump binary from tooltool 17:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:12 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 0x17a0eb0>, '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 0x17a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a2240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:17:12 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 17:17:12 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 17:17:12 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 17:17:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:17:13 INFO - Return code: 0 17:17:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:17:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:17:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:17:13 INFO - ENV: RUST_BACKTRACE is now 1 17:17:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:17:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:17:13 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/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 17:17:13 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/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-087 --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 17:17:13 INFO - Using env: {'DISPLAY': ':0', 17:17:13 INFO - 'HOME': '/home/cltbld', 17:17:13 INFO - 'LANG': 'en_US.UTF-8', 17:17:13 INFO - 'LANGUAGE': 'en_US:en', 17:17:13 INFO - 'LOGNAME': 'cltbld', 17:17:13 INFO - 'MAIL': '/var/mail/cltbld', 17:17:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:17:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:13 INFO - 'MOZ_NO_REMOTE': '1', 17:17:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:13 INFO - 'NO_EM_RESTART': '1', 17:17:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:13 INFO - 'PWD': '/builds/slave/test', 17:17:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:17:13 INFO - 'RUST_BACKTRACE': '1', 17:17:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:17:13 INFO - 'SHELL': '/bin/bash', 17:17:13 INFO - 'SHLVL': '1', 17:17:13 INFO - 'TERM': 'linux', 17:17:13 INFO - 'TMOUT': '86400', 17:17:13 INFO - 'USER': 'cltbld', 17:17:13 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596', 17:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:13 INFO - '_': '/tools/buildbot/bin/python'} 17:17:13 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/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 17:17:13 INFO - mozversion application_buildid: 20170724231022 17:17:13 INFO - mozversion application_changeset: 899590a34d56e099d4e064a9e4d41a54993790e9 17:17:13 INFO - mozversion application_display_name: Nightly 17:17:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:17:13 INFO - mozversion application_name: Firefox 17:17:13 INFO - mozversion application_remotingname: firefox 17:17:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:17:13 INFO - mozversion application_vendor: Mozilla 17:17:13 INFO - mozversion application_version: 56.0a1 17:17:13 INFO - mozversion platform_buildid: 20170724231022 17:17:13 INFO - mozversion platform_changeset: 899590a34d56e099d4e064a9e4d41a54993790e9 17:17:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:17:13 INFO - mozversion platform_version: 56.0a1 17:17:13 INFO - using testdate: 1500941833 17:17:13 INFO - actual date: 1500941833 17:17:13 INFO - starting webserver on 'localhost:41759' 17:17:13 INFO - SUITE-START | Running 2 tests 17:17:13 INFO - TEST-START | dromaeo_css 17:17:13 INFO - Initialising browser for dromaeo_css test... 17:17:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41759/getInfo.html -profile /tmp/tmpNE0Dau/profile 17:17:13 INFO - TEST-INFO | started process 29985 (/builds/slave/test/build/application/firefox/firefox http://localhost:41759/getInfo.html) 17:17:19 INFO - TEST-INFO | 29985: exit 0 17:17:19 INFO - Browser initialized. 17:17:19 INFO - Running cycle 1/1 for dromaeo_css test... 17:17:19 INFO - TEST-INFO | started process 30191 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNE0Dau/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:30 INFO - PID 30191 | RSS: Main: 169795584 17:17:30 INFO - PID 30191 | 17:20:29 INFO - PID 30191 | Cycle 1(1): loaded http://localhost:41759/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41759/tests/dromaeo/cssquery-ext.html) 17:20:30 INFO - PID 30191 | RSS: Main: 172695552 17:20:30 INFO - PID 30191 | 17:23:32 INFO - PID 30191 | Cycle 1(1): loaded http://localhost:41759/tests/dromaeo/cssquery-ext.html (next: http://localhost:41759/tests/dromaeo/cssquery-jquery.html) 17:23:32 INFO - PID 30191 | RSS: Main: 170582016 17:23:32 INFO - PID 30191 | 17:26:34 INFO - PID 30191 | Cycle 1(1): loaded http://localhost:41759/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41759/tests/dromaeo/cssquery-mootools.html) 17:26:35 INFO - PID 30191 | RSS: Main: 172154880 17:26:35 INFO - PID 30191 | 17:29:36 INFO - PID 30191 | Cycle 1(1): loaded http://localhost:41759/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41759/tests/dromaeo/cssquery-prototype.html) 17:29:37 INFO - PID 30191 | RSS: Main: 171401216 17:29:37 INFO - PID 30191 | 17:32:40 INFO - PID 30191 | Cycle 1(1): loaded http://localhost:41759/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41759/tests/dromaeo/cssquery-yui.html) 17:32:41 INFO - PID 30191 | RSS: Main: 170688512 17:32:41 INFO - PID 30191 | 17:35:43 INFO - PID 30191 | Cycle 1(1): loaded http://localhost:41759/tests/dromaeo/cssquery-yui.html (next: http://localhost:41759/tests/dromaeo/cssquery-dojo.html) 17:35:43 INFO - PID 30191 | RSS: Main: 172945408 17:35:43 INFO - PID 30191 | 17:35:43 INFO - PID 30191 | __start_tp_report 17:35:43 INFO - PID 30191 | _x_x_mozilla_page_load 17:35:43 INFO - PID 30191 | _x_x_mozilla_page_load_details 17:35:43 INFO - PID 30191 | |i|pagename|runs| 17:35:43 INFO - PID 30191 | |0;dojo.html;3363.966360336396;3394.5756780402457;3408.096854333601;3431.1936694876717;3460.463628137638;6067.02927531595;6089.908651370233;6218.906716399252;6222.657753823543;6266.780662676807;6107.206063211787;6111.938880611204;6137.018077107664;6164.075388691698;6179.691015449232;5417.052015897222;5429.429909859467;5430.782768689258;5455.809046683366;5486.039943009977;5446.101393270105;5468.043092458824;5487.42382049883;5503.587230957674;5531.502164805167;5321.175217841241;5367.543758780469;5375.6774593524315;5394.406615272317;5427.83716488506;5433.972830135864;5435.619506634537;5448.782048718046;5505.972470137664;5506.889862202734;5366.087765079946;5397.433269506724;5454.91817622736;5473.042217611902;5475.260839786658;5963.493103086243;6027.819165425;6078.8176354708985;6179.598326108833;6205.0692396140485;6737.258901520829;6754.054432379471;6763.661816909135;6778.491613128986;6787.219469760991;6764;6770.52606317558;6772.661366931634;6866.965665171692;6875.690593923286;6028.788992385245;6129.478994285536;6164.260288765332;6238.251409830849;6294.402031807017;6806.76176333826;6864.38220560142;6872.381485666314;6880.208775990725;6900.03399524067;6512.967435162794;6542.705578248991;6606;6619.834504137339;6620.271770105284;6633.071370008202;6645.534812563171;6747.865042699119;6756.4932630052945;6767.086443330186;6605.8348541285895;6619.238787539494;6675.766348177887;6678.09845670838;6710.261871194165;6518.380753828379;6590.637514936629;6617.239017512951;6708.463322934153;6716.294789047178;4839.9758001210475;4846.200376937766;4870.829520966749;4893.241547560134;4901.117798796179;4351.6301114405;4372.562743725665;4380.102079073782;4382.824687012484;4391.451068616423;6403.295637479873;6424.453921416732;6492.577982431127;6500.837479062967;6532.085508028785;6537.738490460423;6620.602763834186;6642.003699445026;6692.899606505906;6703.731850725916;6391.584547004522;6427.807165785034;6430.839229019312;6439.613623182624;6455.2576453708425;5521.2270282160525;5524.447555244524;5588.608797384144;5597.216389705444;5603.663780173121;6967.93032069683;6983.546069505466;7058.153021637437;7074.080369551925;7118.857622847514;6655.534112612071;6694.631795251308;6742.9662851685425;6748.662566871735;6755.763548275787;7082.18554866197;7088.681009354488;7156.570605763671;7171.713131474683;7175.820604484721;6484.448821850196;6521.315261897433;6625.668716564056;6669.633170175687;6704.061431399706;6592.43964263043;6625.204975402982;6650;6668.766593169215;6673.299303573055;6452.645104519296;6528.314526974599;6535.117759102461;6551.181102362205;6570.5400621957915;6332.746690132343;6359.17330747;6410.871782564229;6515.0553169791065;6533.281339052795;6415.390537898892;6433.420992110732;6443.613383197023;6446.64543450096;6453.806385808433;6546.672666366568;6560.507961902781;6563.7702680405955;6605.240397354366;6629.900551491828;6184.226971628546;6311.147995020797;6328.588641738273;6331.873362532816;6332.0818481320875 17:35:43 INFO - PID 30191 | |1;ext.html;857.6983543726803;873.8524149800551;906.6826610686261;923.7875288683603;932.664240873285;42251.78874105629;42902.57097429025;43137.78431107848;43253.78373108138;43310.78344608273;37884.62115378845;38061.80969095151;38087;38168.618313816856;38179.80910095446;6562.540622156451;6726.327367263259;6737.730490780363;6738.966305168467;6780.423663988567;6617.106690596756;6661.9000714989315;6673.366030227145;6704.094947182117;6704.396604305612;7153;7341.119065712095;7341.8898716519025;7343.265673432667;7349.265073492661;7250.528715633493;7294.307040831112;7298.1607115181905;7318.63406829659;7319.085114360705;7109.751158709472;7211.783646490614;7269.091363579552;7281.708731650728;7289.161746399179;39491;39842;40029.39955900664;40029.59970400288;40169.39745903814;3495.6504349565093;3533.27567848593;3549.165946002713;3550.0769799851964;3551.129973156593;30848.691513084807;30868.53697194544;31255.84372078125;31285.843570782;31313.530297045563;5019.774110165052;5036.143855544567;5066.847994560169;5076.111680455942;5089.643724939256;206993;207055;209041;209588.95205524028;210273;50378.49621503811;50690;50733.74633126885;50777;50900;53180;53194;53271.467285327424;53288;53355;16411.261493232596;16659.750103748454;16681.749773753403;16682.582935426468;16695.41566045207;13300.534481293302;13415.597532074053;13418.127821691558;13430.39563219638;13494;14815;14864.925675371771;14964.476243331648;14969.625759356104;15107.39570417193;5784.82645520635;5907.852303692442;5923.7926672566255;5926.703664816742;5978.940210597925;1026.6714651311659;1079.4548752879746;1091.4597274349248;1103.9944800276107;1107.0755918807724;24240.87879560591;24465.510689786104;24513.264602061965;24607.87696061508;24678.5064298713;1190.9642710718692;1200.4237965776476;1216.9634910952686;1219.6280134558867;1221.9816702749465;12591.496340146476;12926.741465170644;13048.412821423059;13071.934640326737;13133.67165820843;279460;279594;280314;281180;282631;55159.44840551543;55407.168892466645;55669.164962525596;59070;59118.11322830075;1497.0119720984098;1503.443725821453;1515.9469418570297;1528.113694057444;1534.90023148495;27979.58030629583;28224.001913694017;28316;28354.574681379385;28530;35255.471167933014;35293.294134117685;38278.808605956794;38621.227575448895;38733;230790;232125;232391;233324;233468;33135.83432082824;33153.50269745907;33219;33310.66689333076;33410.33179336448;41085.79457102815;42282.78858605687;42394.57605423906;42422.15155696931;42941;30289.545656815608;31566;31729.04812855618;32111;32157.517637234992;30531;30631.54052689256;31549.842250789516;32044.19889502781;32413.837930810194;36073;36261.63738362688;36353.27293454063;36516.81741591275;36812;30253.394932100793;31223.375532489677;31467.685323146474;31505.8424707875;31972.040838774876;23430.531389371776;25715.228543143734;25913;26361;26559.867200663874 17:35:43 INFO - PID 30191 | |2;jquery.html;433.53178567147484;526.2606038515884;540.2895192821442;545.6371512943891;555.9694216818078;22327.441813954658;23361;23504.29487115385;24995.750042499614;25329.240122796346;27735.861320693417;28304.43391132176;28380.29049273769;28383.716162838366;28438.715612843866;5972.522198224143;5987.37132601075;6113.052476866093;6145.354737752538;6228.408301211378;6230.5950113242725;6271.059341098849;6272.843178920518;6273.404026617464;6273.623582585036;6181.969090154543;6190.102435146901;6219.751209951619;6223.346548612399;6241.687915604224;6213.005919052953;6224.346443623423;6227.190465239535;6228.719707613146;6230.376962303779;5719.342275638313;5721.8569535761935;5764.711764411804;5774.335951365605;5787;28525.57211641806;31448.842755786303;31659.366812663848;32286.6771332286;32312.83843580767;2159.75162856272;2187.890605469736;2191.079746506471;2192.1560199323376;2206.2498750424934;19758.40724778259;20006.399808005783;20061.799382006284;20100.899495502428;20139.194432222692;2232.620454522735;2337.9649305260436;2345.343303874901;2346.7183937927557;2376.809855211579;131419;136410.31794840962;152648;154513;159255;14614.355817850075;14922.030068045542;15006.62483437901;15169.165695886832;15446.922765386325;20034.198632054555;20037.198512059353;20219.494512637008;20347;20395.490112747004;10309.803960772184;10664.413457259925;10682.252242342962;10851.077658399125;11014.58547850169;10088.949555252177;10260.230482713827;10274.486275686186;10294;10400.323978941344;9583.233341332676;9635.56639951204;9642.180414664832;9897.80204395908;9936.453495057696;2660.4014096828446;2714.185744276709;2731.3854382764116;2750.5578490737316;2767.8892844286406;1025.6358992557684;1035.9430231337199;1041.338749893823;1050.3487837540774;1060.745421098946;21087.472813179487;21267.574648506943;21517.02786377734;21669.133234670437;21914.01525374589;1105.6682995101437;1113.9974023378861;1130.304862509567;1137.1925932587956;1145.410113791398;11689.415529223676;11821.290722556674;12085.274883507018;12096.395180241128;12187.756244875052;576733;584037;596747;605671;624477;130010.34994824966;130294;130669.34665326613;132085;132281;1281.6603600045996;1296.8767967043116;1321.966950826237;1329.5612447892172;1330.281647910137;22273.77726222717;22528.887355563118;23687.407814804767;23743.525129496968;24114.87942560276;62227;63464.36535634769;63802.361976379645;64323;66144.66927665331;76809;77092;77450;78309;78816.60591697005;14904.478343257933;15246.847531524543;15267.847321526642;15389.38442462289;15432.691346173238;24971.75028249767;25090.49819003573;25139.49721005533;25422.491550169263;25482.362940926625;18845.434636960912;18862.52843678919;19422.611547768684;19440.70838937389;19446.222151113798;16366.83633163653;17561.912190438965;18054.81945180584;18179.45461636153;18337.541561461072;20801.79198208059;20829.791702082784;20926.895365523076;21149.89425052865;21208.575828483034;14681.339339729951;14821.25893705289;14931;15095.32071056827;15160.545183644508;19974.50063748418;20153.6976945343;20299.391018269474;20401.48996275105;20409.693854591897 17:35:43 INFO - PID 30191 | |3;mootools.html;1406.9085509441886;1426.1656930695542;1462.225020739008;1464.3849583175065;1464.619199008258;15144.242787860605;15842.128682922435;15867.444639437623;15869.682606347866;15988;15945.202739862989;16229.513114606581;16231.26959286832;16255;16274.918625406857;2394.1381102802975;2706.580480025599;2764.847933363674;2766.405222877081;2775.292300463379;2623.462190250994;2657.2692509559834;2660.2551285639956;2662.986685066572;2666.733326667337;2585.4312051348675;2620.3056190109637;2628.68455785306;2638.300850274679;2639.6700412448445;2520.596704527276;2531.354504601324;2534.2523955433007;2539.3270783242456;2546.2743118211315;2496.6879140107485;2498.2879879234333;2515.132279363617;2515.6226566015243;2515.9119430819833;15094.396224151022;15389.153596552185;15409;15431.61420964485;15434.228288585638;7776.339011184056;7997.120316765151;8057.959710201411;8061.355091592659;8080.191980801932;5054.721990290533;5146;5222.242774797671;5385.7307134643115;5434.728263586844;1916.9041547922689;1920.2894928876406;1929.758780152481;1965.4202010406964;1966.3511041356462;27167.86416067907;27217.183484495297;27263.318417039733;27310.453790924268;27406.177814665592;6262.655553944485;6388.680565971683;6394.200724909387;6581.539292249592;6625.17185351831;18012.729809052613;18019.72970405445;18028.639427211645;18037.18832652534;18041.7293740594;7717.8456430871065;7862.056553213651;7863.252990965849;7868.055833300041;7876.369890408868;6264.59280146789;7055.823604409931;7145.96427017872;7228.96385518069;7274.709011639581;5219.217117432339;5344.091504444254;5364.785408583691;5388.838334849961;5435.157550579587;1451.7459444597364;1488.3971991343524;1496.1920562896132;1501.9549413517611;1517.0594231576492;889.7152911068396;897.2956229359921;915.2860768600502;939.6194541210821;950.6387572722459;7984.121746607869;8092.514449133071;8095.959520202361;8157.79605509867;8974.19232269099;979.490664854286;1009.3388830316155;1019.6074511313197;1034.5448002878709;1047.7171163785736;5354.651947623392;5432.266644003009;5536.4186760390385;5677.233573467529;5715.799947001835;22228.88885555562;22856.542869142522;22953.885230573742;23016.88491557565;23017.539649206923;21437.67843482349;21959;22893.08427662875;23010.539789204122;23031.88484057569;12320.876791231973;12396.81404778929;12422.37888105591;12460.190087644274;12479.56321528742;8470.703525376583;9158.542072896462;9170.266378689555;9540.761480963032;9657.130858222794;18636.720449193544;18672.533186669898;19189.136488857755;19594.216231350587;19690.90154549218;18897.90551047236;20057.896815674696;20346.59306813885;20745.48136296544;21003.57992840165;11861.406929653655;12275.93862030684;12571.434285456993;12753.936230318788;13127.212367257995;15116.244187790346;15261.542153735405;15285.923570382078;15290.159041252839;15290.694186116438;11438.428078596204;12105.636830895088;12249.816252756038;12290.877091229331;12587.370631468208;11141.108711302913;11713.824292635787;11734;11753.294802311888;11829;10305.690829275134;10412.531436085546;10442.947785261329;10458.372497650165;10479.79040419172;7876.369890408639;8168.387370947322;8279.751607451786;8310.293625041939;8370.497770133812;8121.431499794958;8141.185881411811;8284.627191776264;8328.208820162075;8455.239028487465 17:35:43 INFO - PID 30191 | |4;prototype.html;467.9953200467994;472.4307209812177;496.1391984906188;501.9447860735319;505.34557747716724;5896.351401345849;6016.428439298271;6062.4543791058795;6110.480609148222;6187.597806142598;5877.6473411595225;5892.440218179277;5908.863795343266;5926.318473375563;5956.583039187259;4627.699199552018;4635.814567417299;4640.3967484227005;4671.439427268732;4672.415948006499;4553.362529245908;4604.907901841962;4642.187617166982;4683.601893839011;4693.436787585478;4577.885552861188;4584.381108550353;4624.514425985273;4643.651726120537;4671.369365135714;4650.325702773112;4679.88300292492;4686;4701;4732.124556956939;4210.768407737573;4214.704970652056;4220.873373798791;4229.577042295777;4256.34026725858;5842.357340692521;5900.763969441217;5913.970430147865;5932.131378615765;5983.431574000507;5500.614956953015;5512.366077901012;5530.806421775259;5557;5626.930883132232;6385.010323399881;6430.292667806538;6483.254425741005;6512.21853377593;6521.532655152553;4643.512431194744;4683;4711.10489007091;4715.976420117878;4726.66913316068;6720.361565651256;6746.92049272119;6772.424343930821;6777.220619628756;6836.38472537474;4816.4220293564995;4917.311576379309;4920.852374428773;4922.90154196914;4933.161362568372;4905.362302900671;4956;4991.575716064175;5003.7998480061115;5015.699058056528;5522.889542209134;5556.86107847299;5567.4432556744005;5577.498025177753;5616.5787565932715;6173.456635841039;6177.887980163524;6336.112944187817;6543.088325695116;6550.213974323112;1695.3557648093645;1708.0776380754253;1712.2808420463434;1717.2873257598208;1720.9588199139341;1045.7666307781922;1194.802857528498;1210.7396909664465;1211.1885037025215;1219.890209881115;6173.629582225081;6340.873182536324;6343.781385378671;6345.524085693592;6364.649944253018;6341.587796793194;6675.766348177791;6687.899681504781;6709.29552397001;6720.6639668016405;6294.622322660655;6316.873662526816;6327.303996560375;6335.334789847;6384.808455746335;3480.599731030964;3483.89548313551;3486.9476957845145;3493.825308734604;3521.964780352215;6846.828829279308;6896.275931017246;6935.514513983972;6961.164660240804;6998.780560941922;6654.101696270942;6697.296783837724;6772.762953296611;6803.625800581016;6827.249002609709;6889.242183359826;6935.306469353024;6968.825779355557;6977.476689248327;6988.161420629557;6545.803625891231;6563.146790917342;6571.441427478718;6571.769988050395;6610.338966103352;6524.706388212637;6541.967290163519;6541.990684285091;6564.934350656432;6586.769463068769;6959.686814093277;6991.405730512964;7008.229094799466;7052.929470705228;7067.692476891792;4897.9020419592125;4902.558769710743;4913.1893237615395;4948.975255123702;4954.281629163823;6584.55139869228;6591.835204119935;6627.966860165669;6642.501812363996;6672.566283191577;6285.182926219745;6298.275698294755;6326.715297811702;6444.967775161094;6447.838804029937;6316.399942005502;6371.617702937839;6373;6387.265464471459;6398.984319939204;6314.589551679126;6334.1765570475545;6374.362563743589;6408.231012278557;6412.583182093149;6178.66017369031;6188.391018335175;6411.262704788823;6510.7721229756735;6537.1174891389055;6148.907766383597;6183.752649893954;6205;6215;6269.122322874892 17:35:43 INFO - PID 30191 | |5;yui.html;851.2594043182428;881.7310720230336;898.1288150494023;944.9494596725106;984.8473486609573;17600.11999400028;18250.36123735668;19036.809631903678;19098.331558395443;19120.617587648238;21446.14215431381;22366.55266894661;22471.314651401128;22506.32481025568;22561.646301221896;1062.5749700119936;1085.5223701571283;1086.0388556127843;1086.5979587552617;1087.6573879228058;1062.914966802654;1077.9353238805656;1090.4166271044992;1104.4146602300793;1109.9889001110007;1158.108256642385;1159.5767544846155;1162.3084264862393;1167.854018247719;1169.918105732599;1141.2581821815845;1149.2185313986486;1158.31659321001;1158.4092113022418;1160.182071639492;837.7319257837495;837.7654256808042;838.7274135905855;843.2621456225802;843.3759018326394;17052;17358.305667773275;17556.122193890253;17639;17681;20840.895795520926;21398.679019814714;21443.57112857734;21937.34187974363;21948.780512194833;16002.119883406407;16525.58686032847;16648.500544983668;16692.24884880183;16932.23804928781;3551.449525323579;3607.4769158472136;3607.981960090209;3608.8015159166234;3610.656987586175;128249;134073;137731;138613.3069334657;139730.6026939728;15840.366385344687;15905.443309484113;15934.36262549485;16104.114273714824;16282.45316694912;30036.54945175824;30930.22674433112;31028;31142.377152456826;31406;8193.59032048407;8604.95697521521;8636.69771558005;8745.562721863882;9105.635774569075;4477.843275485342;4622.907541849144;4623.190941585209;4629.907401852011;4631.814727410933;5481;5499.587530935196;5595.832125036174;5633.6619802811965;5645.125005624052;1092.7158938675843;1132.473399869065;1132.8583927009124;1140.8288756686563;1144.2848219862585;633.1800318587441;654.358728446116;667.8163505036154;680.5236334565824;683.1631251716608;12238.326892020847;13309.800352994713;13655.112417692819;13777.862221377858;13794.172349659053;677.4411110833582;691.094665987558;693.8716337477583;711.6015031582331;714.0253553898891;5890.793822216202;5940.227770389822;6024.638521688713;6273.749050037947;6282.183316168869;125462.37268813598;127745;132966;133394;134683;112665;114118.42940785243;116304.09239768905;117980;123215;106412.30573108782;107252;107693;108875;110534.99999999838;12834.67913302175;13323;13497.46010159622;14034.087784293988;14533.85466145325;50307;50531.494685052676;51504.74247628738;53199;53353.733231333594;63619.68190159019;65273.673631633435;66173;67626;68901.65549172222;19621.31325403604;20173.79826201778;20177.09203085835;20241.19035238574;20339.69490457674;21779;22016.77983220147;22328.441788955406;22544.887275563517;22868.88565557228;16971.236294366536;17086.74369884428;17194.742078869076;19398.90300548488;19471.318503852297;19355.225790968765;19628.803711962697;19751.11119999632;19756.802431975495;19799;20271.189152433737;20329.6950545739;20431;20480;20587.970601470166;12447.564335248222;12864.935675321563;13029.674258143623;13070.477180913038;13258.337083145998;14914.030588011745;15123.092614443169;15132.243387830784;15233;15703.450379237129 17:35:43 INFO - PID 30191 | __end_tp_report 17:35:43 INFO - PID 30191 | __start_cc_report 17:35:43 INFO - PID 30191 | _x_x_mozilla_cycle_collect,337 17:35:43 INFO - PID 30191 | __end_cc_report 17:35:43 INFO - PID 30191 | __startTimestamp1500942943342__endTimestamp 17:35:43 INFO - PID 30191 | 17:35:43 INFO - PID 30191 | ------- Summary: start ------- 17:35:43 INFO - PID 30191 | Number of tests: 6 17:35:43 INFO - PID 30191 | 17:35:43 INFO - PID 30191 | [#0] dojo.html Cycles:165 Average:6150.83 Median:6446.65 stddev:800.21 (12.4%) stddev-sans-first:772.22 17:35:43 INFO - PID 30191 | Values: 3364.0 3394.6 3408.1 3431.2 3460.5 6067.0 6089.9 6218.9 6222.7 6266.8 6107.2 6111.9 6137.0 6164.1 6179.7 5417.1 5429.4 5430.8 5455.8 5486.0 5446.1 5468.0 5487.4 5503.6 5531.5 5321.2 5367.5 5375.7 5394.4 5427.8 5434.0 5435.6 5448.8 5506.0 5506.9 5366.1 5397.4 5454.9 5473.0 5475.3 5963.5 6027.8 6078.8 6179.6 6205.1 6737.3 6754.1 6763.7 6778.5 6787.2 6764.0 6770.5 6772.7 6867.0 6875.7 6028.8 6129.5 6164.3 6238.3 6294.4 6806.8 6864.4 6872.4 6880.2 6900.0 6513.0 6542.7 6606.0 6619.8 6620.3 6633.1 6645.5 6747.9 6756.5 6767.1 6605.8 6619.2 6675.8 6678.1 6710.3 6518.4 6590.6 6617.2 6708.5 6716.3 4840.0 4846.2 4870.8 4893.2 4901.1 4351.6 4372.6 4380.1 4382.8 4391.5 6403.3 6424.5 6492.6 6500.8 6532.1 6537.7 6620.6 6642.0 6692.9 6703.7 6391.6 6427.8 6430.8 6439.6 6455.3 5521.2 5524.4 5588.6 5597.2 5603.7 6967.9 6983.5 7058.2 7074.1 7118.9 6655.5 6694.6 6743.0 6748.7 6755.8 7082.2 7088.7 7156.6 7171.7 7175.8 6484.4 6521.3 6625.7 6669.6 6704.1 6592.4 6625.2 6650.0 6668.8 6673.3 6452.6 6528.3 6535.1 6551.2 6570.5 6332.7 6359.2 6410.9 6515.1 6533.3 6415.4 6433.4 6443.6 6446.6 6453.8 6546.7 6560.5 6563.8 6605.2 6629.9 6184.2 6311.1 6328.6 6331.9 6332.1 17:35:43 INFO - PID 30191 | 17:35:43 INFO - PID 30191 | [#1] ext.html Cycles:180 Average:40797.03 Median:19375.56 stddev:63129.18 (325.8%) stddev-sans-first:63235.04 17:35:43 INFO - PID 30191 | Values: 857.7 873.9 906.7 923.8 932.7 42251.8 42902.6 43137.8 43253.8 43310.8 37884.6 38061.8 38087.0 38168.6 38179.8 6562.5 6726.3 6737.7 6739.0 6780.4 6617.1 6661.9 6673.4 6704.1 6704.4 7153.0 7341.1 7341.9 7343.3 7349.3 7250.5 7294.3 7298.2 7318.6 7319.1 7109.8 7211.8 7269.1 7281.7 7289.2 39491.0 39842.0 40029.4 40029.6 40169.4 3495.7 3533.3 3549.2 3550.1 3551.1 30848.7 30868.5 31255.8 31285.8 31313.5 5019.8 5036.1 5066.8 5076.1 5089.6 206993.0 207055.0 209041.0 209589.0 210273.0 50378.5 50690.0 50733.7 50777.0 50900.0 53180.0 53194.0 53271.5 53288.0 53355.0 16411.3 16659.8 16681.7 16682.6 16695.4 13300.5 13415.6 13418.1 13430.4 13494.0 14815.0 14864.9 14964.5 14969.6 15107.4 5784.8 5907.9 5923.8 5926.7 5978.9 1026.7 1079.5 1091.5 1104.0 1107.1 24240.9 24465.5 24513.3 24607.9 24678.5 1191.0 1200.4 1217.0 1219.6 1222.0 12591.5 12926.7 13048.4 13071.9 13133.7 279460.0 279594.0 280314.0 281180.0 282631.0 55159.4 55407.2 55669.2 59070.0 59118.1 1497.0 1503.4 1515.9 1528.1 1534.9 27979.6 28224.0 28316.0 28354.6 28530.0 35255.5 35293.3 38278.8 38621.2 38733.0 230790.0 232125.0 232391.0 233324.0 233468.0 33135.8 33153.5 33219.0 33310.7 33410.3 41085.8 42282.8 42394.6 42422.2 42941.0 30289.5 31566.0 31729.0 32111.0 32157.5 30531.0 30631.5 31549.8 32044.2 32413.8 36073.0 36261.6 36353.3 36516.8 36812.0 30253.4 31223.4 31467.7 31505.8 31972.0 23430.5 25715.2 25913.0 26361.0 26559.9 17:35:43 INFO - PID 30191 | 17:35:43 INFO - PID 30191 | [#2] jquery.html Cycles:180 Average:39404.43 Median:2189.49 stddev:100014.84 (4568.0%) stddev-sans-first:100252.60 17:35:43 INFO - PID 30191 | Values: 433.5 526.3 540.3 545.6 556.0 22327.4 23361.0 23504.3 24995.8 25329.2 27735.9 28304.4 28380.3 28383.7 28438.7 5972.5 5987.4 6113.1 6145.4 6228.4 6230.6 6271.1 6272.8 6273.4 6273.6 6182.0 6190.1 6219.8 6223.3 6241.7 6213.0 6224.3 6227.2 6228.7 6230.4 5719.3 5721.9 5764.7 5774.3 5787.0 28525.6 31448.8 31659.4 32286.7 32312.8 2159.8 2187.9 2191.1 2192.2 2206.2 19758.4 20006.4 20061.8 20100.9 20139.2 2232.6 2338.0 2345.3 2346.7 2376.8 131419.0 136410.3 152648.0 154513.0 159255.0 14614.4 14922.0 15006.6 15169.2 15446.9 20034.2 20037.2 20219.5 20347.0 20395.5 10309.8 10664.4 10682.3 10851.1 11014.6 10088.9 10260.2 10274.5 10294.0 10400.3 9583.2 9635.6 9642.2 9897.8 9936.5 2660.4 2714.2 2731.4 2750.6 2767.9 1025.6 1035.9 1041.3 1050.3 1060.7 21087.5 21267.6 21517.0 21669.1 21914.0 1105.7 1114.0 1130.3 1137.2 1145.4 11689.4 11821.3 12085.3 12096.4 12187.8 576733.0 584037.0 596747.0 605671.0 624477.0 130010.3 130294.0 130669.3 132085.0 132281.0 1281.7 1296.9 1322.0 1329.6 1330.3 22273.8 22528.9 23687.4 23743.5 24114.9 62227.0 63464.4 63802.4 64323.0 66144.7 76809.0 77092.0 77450.0 78309.0 78816.6 14904.5 15246.8 15267.8 15389.4 15432.7 24971.8 25090.5 25139.5 25422.5 25482.4 18845.4 18862.5 19422.6 19440.7 19446.2 16366.8 17561.9 18054.8 18179.5 18337.5 20801.8 20829.8 20926.9 21149.9 21208.6 14681.3 14821.3 14931.0 15095.3 15160.5 19974.5 20153.7 20299.4 20401.5 20409.7 17:35:43 INFO - PID 30191 | 17:35:43 INFO - PID 30191 | [#3] mootools.html Cycles:180 Average:9743.37 Median:2497.49 stddev:7030.20 (281.5%) stddev-sans-first:7022.02 17:35:43 INFO - PID 30191 | Values: 1406.9 1426.2 1462.2 1464.4 1464.6 15144.2 15842.1 15867.4 15869.7 15988.0 15945.2 16229.5 16231.3 16255.0 16274.9 2394.1 2706.6 2764.8 2766.4 2775.3 2623.5 2657.3 2660.3 2663.0 2666.7 2585.4 2620.3 2628.7 2638.3 2639.7 2520.6 2531.4 2534.3 2539.3 2546.3 2496.7 2498.3 2515.1 2515.6 2515.9 15094.4 15389.2 15409.0 15431.6 15434.2 7776.3 7997.1 8058.0 8061.4 8080.2 5054.7 5146.0 5222.2 5385.7 5434.7 1916.9 1920.3 1929.8 1965.4 1966.4 27167.9 27217.2 27263.3 27310.5 27406.2 6262.7 6388.7 6394.2 6581.5 6625.2 18012.7 18019.7 18028.6 18037.2 18041.7 7717.8 7862.1 7863.3 7868.1 7876.4 6264.6 7055.8 7146.0 7229.0 7274.7 5219.2 5344.1 5364.8 5388.8 5435.2 1451.7 1488.4 1496.2 1502.0 1517.1 889.7 897.3 915.3 939.6 950.6 7984.1 8092.5 8096.0 8157.8 8974.2 979.5 1009.3 1019.6 1034.5 1047.7 5354.7 5432.3 5536.4 5677.2 5715.8 22228.9 22856.5 22953.9 23016.9 23017.5 21437.7 21959.0 22893.1 23010.5 23031.9 12320.9 12396.8 12422.4 12460.2 12479.6 8470.7 9158.5 9170.3 9540.8 9657.1 18636.7 18672.5 19189.1 19594.2 19690.9 18897.9 20057.9 20346.6 20745.5 21003.6 11861.4 12275.9 12571.4 12753.9 13127.2 15116.2 15261.5 15285.9 15290.2 15290.7 11438.4 12105.6 12249.8 12290.9 12587.4 11141.1 11713.8 11734.0 11753.3 11829.0 10305.7 10412.5 10442.9 10458.4 10479.8 7876.4 8168.4 8279.8 8310.3 8370.5 8121.4 8141.2 8284.6 8328.2 8455.2 17:35:43 INFO - PID 30191 | 17:35:43 INFO - PID 30191 | [#4] prototype.html Cycles:180 Average:5447.55 Median:6173.54 stddev:1585.08 (25.7%) stddev-sans-first:1544.83 17:35:43 INFO - PID 30191 | Values: 468.0 472.4 496.1 501.9 505.3 5896.4 6016.4 6062.5 6110.5 6187.6 5877.6 5892.4 5908.9 5926.3 5956.6 4627.7 4635.8 4640.4 4671.4 4672.4 4553.4 4604.9 4642.2 4683.6 4693.4 4577.9 4584.4 4624.5 4643.7 4671.4 4650.3 4679.9 4686.0 4701.0 4732.1 4210.8 4214.7 4220.9 4229.6 4256.3 5842.4 5900.8 5914.0 5932.1 5983.4 5500.6 5512.4 5530.8 5557.0 5626.9 6385.0 6430.3 6483.3 6512.2 6521.5 4643.5 4683.0 4711.1 4716.0 4726.7 6720.4 6746.9 6772.4 6777.2 6836.4 4816.4 4917.3 4920.9 4922.9 4933.2 4905.4 4956.0 4991.6 5003.8 5015.7 5522.9 5556.9 5567.4 5577.5 5616.6 6173.5 6177.9 6336.1 6543.1 6550.2 1695.4 1708.1 1712.3 1717.3 1721.0 1045.8 1194.8 1210.7 1211.2 1219.9 6173.6 6340.9 6343.8 6345.5 6364.6 6341.6 6675.8 6687.9 6709.3 6720.7 6294.6 6316.9 6327.3 6335.3 6384.8 3480.6 3483.9 3486.9 3493.8 3522.0 6846.8 6896.3 6935.5 6961.2 6998.8 6654.1 6697.3 6772.8 6803.6 6827.2 6889.2 6935.3 6968.8 6977.5 6988.2 6545.8 6563.1 6571.4 6571.8 6610.3 6524.7 6542.0 6542.0 6564.9 6586.8 6959.7 6991.4 7008.2 7052.9 7067.7 4897.9 4902.6 4913.2 4949.0 4954.3 6584.6 6591.8 6628.0 6642.5 6672.6 6285.2 6298.3 6326.7 6445.0 6447.8 6316.4 6371.6 6373.0 6387.3 6399.0 6314.6 6334.2 6374.4 6408.2 6412.6 6178.7 6188.4 6411.3 6510.8 6537.1 6148.9 6183.8 6205.0 6215.0 6269.1 17:35:43 INFO - PID 30191 | 17:35:43 INFO - PID 30191 | [#5] yui.html Cycles:180 Average:26274.82 Median:19546.32 stddev:37086.55 (189.7%) stddev-sans-first:37141.46 17:35:43 INFO - PID 30191 | Values: 851.3 881.7 898.1 944.9 984.8 17600.1 18250.4 19036.8 19098.3 19120.6 21446.1 22366.6 22471.3 22506.3 22561.6 1062.6 1085.5 1086.0 1086.6 1087.7 1062.9 1077.9 1090.4 1104.4 1110.0 1158.1 1159.6 1162.3 1167.9 1169.9 1141.3 1149.2 1158.3 1158.4 1160.2 837.7 837.8 838.7 843.3 843.4 17052.0 17358.3 17556.1 17639.0 17681.0 20840.9 21398.7 21443.6 21937.3 21948.8 16002.1 16525.6 16648.5 16692.2 16932.2 3551.4 3607.5 3608.0 3608.8 3610.7 128249.0 134073.0 137731.0 138613.3 139730.6 15840.4 15905.4 15934.4 16104.1 16282.5 30036.5 30930.2 31028.0 31142.4 31406.0 8193.6 8605.0 8636.7 8745.6 9105.6 4477.8 4622.9 4623.2 4629.9 4631.8 5481.0 5499.6 5595.8 5633.7 5645.1 1092.7 1132.5 1132.9 1140.8 1144.3 633.2 654.4 667.8 680.5 683.2 12238.3 13309.8 13655.1 13777.9 13794.2 677.4 691.1 693.9 711.6 714.0 5890.8 5940.2 6024.6 6273.7 6282.2 125462.4 127745.0 132966.0 133394.0 134683.0 112665.0 114118.4 116304.1 117980.0 123215.0 106412.3 107252.0 107693.0 108875.0 110535.0 12834.7 13323.0 13497.5 14034.1 14533.9 50307.0 50531.5 51504.7 53199.0 53353.7 63619.7 65273.7 66173.0 67626.0 68901.7 19621.3 20173.8 20177.1 20241.2 20339.7 21779.0 22016.8 22328.4 22544.9 22868.9 16971.2 17086.7 17194.7 19398.9 19471.3 19355.2 19628.8 19751.1 19756.8 19799.0 20271.2 20329.7 20431.0 20480.0 20588.0 12447.6 12864.9 13029.7 13070.5 13258.3 14914.0 15123.1 15132.2 15233.0 15703.5 17:35:43 INFO - PID 30191 | -------- Summary: end -------- 17:35:43 INFO - PID 30191 | 17:35:43 INFO - TEST-INFO | 30191: exit 0 17:35:43 INFO - TEST-OK | dromaeo_css | took 1110682ms 17:35:43 INFO - TEST-START | kraken 17:35:43 INFO - Initialising browser for kraken test... 17:35:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41759/getInfo.html -profile /tmp/tmptuu9ig/profile 17:35:43 INFO - TEST-INFO | started process 30555 (/builds/slave/test/build/application/firefox/firefox http://localhost:41759/getInfo.html) 17:35:49 INFO - TEST-INFO | 30555: exit 0 17:35:49 INFO - Browser initialized. 17:35:49 INFO - Running cycle 1/1 for kraken test... 17:35:49 INFO - TEST-INFO | started process 30764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptuu9ig/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:36:01 INFO - PID 30764 | RSS: Main: 163680256 17:36:01 INFO - PID 30764 | 17:36:03 INFO - PID 30764 | Cycle 1(1): loaded http://localhost:41759/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41759/tests/kraken/driver.html?testName=audio-beat-detection) 17:36:04 INFO - PID 30764 | RSS: Main: 169840640 17:36:04 INFO - PID 30764 | 17:36:07 INFO - PID 30764 | Cycle 1(1): loaded http://localhost:41759/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41759/tests/kraken/driver.html?testName=audio-dft) 17:36:07 INFO - PID 30764 | RSS: Main: 170516480 17:36:07 INFO - PID 30764 | 17:36:10 INFO - PID 30764 | Cycle 1(1): loaded http://localhost:41759/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41759/tests/kraken/driver.html?testName=audio-fft) 17:36:11 INFO - PID 30764 | RSS: Main: 164323328 17:36:11 INFO - PID 30764 | 17:36:13 INFO - PID 30764 | Cycle 1(1): loaded http://localhost:41759/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41759/tests/kraken/driver.html?testName=audio-oscillator) 17:36:14 INFO - PID 30764 | RSS: Main: 165392384 17:36:14 INFO - PID 30764 | 17:36:16 INFO - PID 30764 | Cycle 1(1): loaded http://localhost:41759/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41759/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:36:16 INFO - PID 30764 | RSS: Main: 165441536 17:36:16 INFO - PID 30764 | 17:36:19 INFO - PID 30764 | Cycle 1(1): loaded http://localhost:41759/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41759/tests/kraken/driver.html?testName=imaging-darkroom) 17:36:20 INFO - PID 30764 | RSS: Main: 168824832 17:36:20 INFO - PID 30764 | 17:36:23 INFO - PID 30764 | Cycle 1(1): loaded http://localhost:41759/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41759/tests/kraken/driver.html?testName=imaging-desaturate) 17:36:24 INFO - PID 30764 | RSS: Main: 170053632 17:36:24 INFO - PID 30764 | 17:36:27 INFO - PID 30764 | Cycle 1(1): loaded http://localhost:41759/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41759/tests/kraken/driver.html?testName=json-parse-financial) 17:36:28 INFO - PID 30764 | RSS: Main: 168591360 17:36:28 INFO - PID 30764 | 17:36:29 INFO - PID 30764 | Cycle 1(1): loaded http://localhost:41759/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41759/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:36:30 INFO - PID 30764 | RSS: Main: 168747008 17:36:30 INFO - PID 30764 | 17:36:31 INFO - PID 30764 | Cycle 1(1): loaded http://localhost:41759/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41759/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:36:32 INFO - PID 30764 | RSS: Main: 169050112 17:36:32 INFO - PID 30764 | 17:36:34 INFO - PID 30764 | Cycle 1(1): loaded http://localhost:41759/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41759/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:36:35 INFO - PID 30764 | RSS: Main: 169234432 17:36:35 INFO - PID 30764 | 17:36:37 INFO - PID 30764 | Cycle 1(1): loaded http://localhost:41759/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41759/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:36:38 INFO - PID 30764 | RSS: Main: 168640512 17:36:38 INFO - PID 30764 | 17:36:41 INFO - PID 30764 | Cycle 1(1): loaded http://localhost:41759/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41759/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:36:41 INFO - PID 30764 | RSS: Main: 168984576 17:36:41 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | Cycle 1(1): loaded http://localhost:41759/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41759/tests/kraken/driver.html?testName=ai-astar) 17:36:43 INFO - PID 30764 | RSS: Main: 170971136 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | __start_tp_report 17:36:43 INFO - PID 30764 | _x_x_mozilla_page_load 17:36:43 INFO - PID 30764 | _x_x_mozilla_page_load_details 17:36:43 INFO - PID 30764 | |i|pagename|runs| 17:36:43 INFO - PID 30764 | |0;ai-astar;103;117;95;108;111;109;112;108;109;111 17:36:43 INFO - PID 30764 | |1;audio-beat-detection;146;111;144;171;115;151;151;113;169;114 17:36:43 INFO - PID 30764 | |2;audio-dft;164;166;164;165;162;164;164;166;165;166 17:36:43 INFO - PID 30764 | |3;audio-fft;78;77;78;177;79;75;75;75;149;76 17:36:43 INFO - PID 30764 | |4;audio-oscillator;81;89;135;80;82;80;138;80;80;126 17:36:43 INFO - PID 30764 | |5;imaging-gaussian-blur;113;114;114;113;114;114;114;113;114;114 17:36:43 INFO - PID 30764 | |6;imaging-darkroom;149;149;155;156;148;149;149;149;149;149 17:36:43 INFO - PID 30764 | |7;imaging-desaturate;95;94;94;94;94;94;95;94;94;95 17:36:43 INFO - PID 30764 | |8;json-parse-financial;48;47;46;47;49;47;46;46;46;47 17:36:43 INFO - PID 30764 | |9;json-stringify-tinderbox;55;54;55;55;55;55;55;54;54;55 17:36:43 INFO - PID 30764 | |10;stanford-crypto-aes;75;75;74;76;81;74;74;76;76;74 17:36:43 INFO - PID 30764 | |11;stanford-crypto-ccm;125;129;114;123;119;117;126;117;116;166 17:36:43 INFO - PID 30764 | |12;stanford-crypto-pbkdf2;163;173;163;185;171;165;163;161;163;163 17:36:43 INFO - PID 30764 | |13;stanford-crypto-sha256-iterative;63;64;67;63;61;61;65;60;61;60 17:36:43 INFO - PID 30764 | __end_tp_report 17:36:43 INFO - PID 30764 | __start_cc_report 17:36:43 INFO - PID 30764 | _x_x_mozilla_cycle_collect,881 17:36:43 INFO - PID 30764 | __end_cc_report 17:36:43 INFO - PID 30764 | __startTimestamp1500943003885__endTimestamp 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | ------- Summary: start ------- 17:36:43 INFO - PID 30764 | Number of tests: 14 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | [#0] ai-astar Cycles:10 Average:108.30 Median:111.00 stddev:5.87 (5.3%) stddev-sans-first:5.90 17:36:43 INFO - PID 30764 | Values: 103.0 117.0 95.0 108.0 111.0 109.0 112.0 108.0 109.0 111.0 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:148.50 stddev:23.44 (15.8%) stddev-sans-first:24.70 17:36:43 INFO - PID 30764 | Values: 146.0 111.0 144.0 171.0 115.0 151.0 151.0 113.0 169.0 114.0 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 17:36:43 INFO - PID 30764 | Values: 164.0 166.0 164.0 165.0 162.0 164.0 164.0 166.0 165.0 166.0 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.50 stddev:37.04 (48.4%) stddev-sans-first:38.84 17:36:43 INFO - PID 30764 | Values: 78.0 77.0 78.0 177.0 79.0 75.0 75.0 75.0 149.0 76.0 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:80.00 stddev:25.09 (31.4%) stddev-sans-first:25.93 17:36:43 INFO - PID 30764 | Values: 81.0 89.0 135.0 80.0 82.0 80.0 138.0 80.0 80.0 126.0 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 17:36:43 INFO - PID 30764 | Values: 113.0 114.0 114.0 113.0 114.0 114.0 114.0 113.0 114.0 114.0 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:149.00 stddev:2.82 (1.9%) stddev-sans-first:2.96 17:36:43 INFO - PID 30764 | Values: 149.0 149.0 155.0 156.0 148.0 149.0 149.0 149.0 149.0 149.0 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 17:36:43 INFO - PID 30764 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | [#8] json-parse-financial Cycles:10 Average:46.90 Median:47.00 stddev:0.99 (2.1%) stddev-sans-first:0.97 17:36:43 INFO - PID 30764 | Values: 48.0 47.0 46.0 47.0 49.0 47.0 46.0 46.0 46.0 47.0 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 17:36:43 INFO - PID 30764 | Values: 55.0 54.0 55.0 55.0 55.0 55.0 55.0 54.0 54.0 55.0 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.50 stddev:2.12 (2.8%) stddev-sans-first:2.24 17:36:43 INFO - PID 30764 | Values: 75.0 75.0 74.0 76.0 81.0 74.0 74.0 76.0 76.0 74.0 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:124.00 stddev:15.16 (12.2%) stddev-sans-first:16.08 17:36:43 INFO - PID 30764 | Values: 125.0 129.0 114.0 123.0 119.0 117.0 126.0 117.0 116.0 166.0 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:164.00 stddev:7.42 (4.5%) stddev-sans-first:7.73 17:36:43 INFO - PID 30764 | Values: 163.0 173.0 163.0 185.0 171.0 165.0 163.0 161.0 163.0 163.0 17:36:43 INFO - PID 30764 | 17:36:43 INFO - PID 30764 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:2.32 (3.7%) stddev-sans-first:2.46 17:36:43 INFO - PID 30764 | Values: 63.0 64.0 67.0 63.0 61.0 61.0 65.0 60.0 61.0 60.0 17:36:43 INFO - PID 30764 | -------- Summary: end -------- 17:36:43 INFO - PID 30764 | 17:36:44 INFO - PID 30764 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:36:44 INFO - TEST-INFO | 30764: exit 0 17:36:44 INFO - TEST-OK | kraken | took 60630ms 17:36:44 INFO - SUITE-END | took 1171s 17:36:45 INFO - Completed test suite (00:19:31) 17:36:45 INFO - javascript benchmark 17:36:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8742.645887091097, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3363.966360336396, 3394.5756780402457, 3408.096854333601, 3431.1936694876717, 3460.463628137638, 6067.02927531595, 6089.908651370233, 6218.906716399252, 6222.657753823543, 6266.780662676807, 6107.206063211787, 6111.938880611204, 6137.018077107664, 6164.075388691698, 6179.691015449232, 5417.052015897222, 5429.429909859467, 5430.782768689258, 5455.809046683366, 5486.039943009977, 5446.101393270105, 5468.043092458824, 5487.42382049883, 5503.587230957674, 5531.502164805167, 5321.175217841241, 5367.543758780469, 5375.6774593524315, 5394.406615272317, 5427.83716488506, 5433.972830135864, 5435.619506634537, 5448.782048718046, 5505.972470137664, 5506.889862202734, 5366.087765079946, 5397.433269506724, 5454.91817622736, 5473.042217611902, 5475.260839786658, 5963.493103086243, 6027.819165425, 6078.8176354708985, 6179.598326108833, 6205.0692396140485, 6737.258901520829, 6754.054432379471, 6763.661816909135, 6778.491613128986, 6787.219469760991, 6764.0, 6770.52606317558, 6772.661366931634, 6866.965665171692, 6875.690593923286, 6028.788992385245, 6129.478994285536, 6164.260288765332, 6238.251409830849, 6294.402031807017, 6806.76176333826, 6864.38220560142, 6872.381485666314, 6880.208775990725, 6900.03399524067, 6512.967435162794, 6542.705578248991, 6606.0, 6619.834504137339, 6620.271770105284, 6633.071370008202, 6645.534812563171, 6747.865042699119, 6756.4932630052945, 6767.086443330186, 6605.8348541285895, 6619.238787539494, 6675.766348177887, 6678.09845670838, 6710.261871194165, 6518.380753828379, 6590.637514936629, 6617.239017512951, 6708.463322934153, 6716.294789047178, 4839.9758001210475, 4846.200376937766, 4870.829520966749, 4893.241547560134, 4901.117798796179, 4351.6301114405, 4372.562743725665, 4380.102079073782, 4382.824687012484, 4391.451068616423, 6403.295637479873, 6424.453921416732, 6492.577982431127, 6500.837479062967, 6532.085508028785, 6537.738490460423, 6620.602763834186, 6642.003699445026, 6692.899606505906, 6703.731850725916, 6391.584547004522, 6427.807165785034, 6430.839229019312, 6439.613623182624, 6455.2576453708425, 5521.2270282160525, 5524.447555244524, 5588.608797384144, 5597.216389705444, 5603.663780173121, 6967.93032069683, 6983.546069505466, 7058.153021637437, 7074.080369551925, 7118.857622847514, 6655.534112612071, 6694.631795251308, 6742.9662851685425, 6748.662566871735, 6755.763548275787, 7082.18554866197, 7088.681009354488, 7156.570605763671, 7171.713131474683, 7175.820604484721, 6484.448821850196, 6521.315261897433, 6625.668716564056, 6669.633170175687, 6704.061431399706, 6592.43964263043, 6625.204975402982, 6650.0, 6668.766593169215, 6673.299303573055, 6452.645104519296, 6528.314526974599, 6535.117759102461, 6551.181102362205, 6570.5400621957915, 6332.746690132343, 6359.17330747, 6410.871782564229, 6515.0553169791065, 6533.281339052795, 6415.390537898892, 6433.420992110732, 6443.613383197023, 6446.64543450096, 6453.806385808433, 6546.672666366568, 6560.507961902781, 6563.7702680405955, 6605.240397354366, 6629.900551491828, 6184.226971628546, 6311.147995020797, 6328.588641738273, 6331.873362532816, 6332.0818481320875], "value": 6089.01263592424, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [857.6983543726803, 873.8524149800551, 906.6826610686261, 923.7875288683603, 932.664240873285, 42251.78874105629, 42902.57097429025, 43137.78431107848, 43253.78373108138, 43310.78344608273, 37884.62115378845, 38061.80969095151, 38087.0, 38168.618313816856, 38179.80910095446, 6562.540622156451, 6726.327367263259, 6737.730490780363, 6738.966305168467, 6780.423663988567, 6617.106690596756, 6661.9000714989315, 6673.366030227145, 6704.094947182117, 6704.396604305612, 7153.0, 7341.119065712095, 7341.8898716519025, 7343.265673432667, 7349.265073492661, 7250.528715633493, 7294.307040831112, 7298.1607115181905, 7318.63406829659, 7319.085114360705, 7109.751158709472, 7211.783646490614, 7269.091363579552, 7281.708731650728, 7289.161746399179, 39491.0, 39842.0, 40029.39955900664, 40029.59970400288, 40169.39745903814, 3495.6504349565093, 3533.27567848593, 3549.165946002713, 3550.0769799851964, 3551.129973156593, 30848.691513084807, 30868.53697194544, 31255.84372078125, 31285.843570782, 31313.530297045563, 5019.774110165052, 5036.143855544567, 5066.847994560169, 5076.111680455942, 5089.643724939256, 206993.0, 207055.0, 209041.0, 209588.95205524028, 210273.0, 50378.49621503811, 50690.0, 50733.74633126885, 50777.0, 50900.0, 53180.0, 53194.0, 53271.467285327424, 53288.0, 53355.0, 16411.261493232596, 16659.750103748454, 16681.749773753403, 16682.582935426468, 16695.41566045207, 13300.534481293302, 13415.597532074053, 13418.127821691558, 13430.39563219638, 13494.0, 14815.0, 14864.925675371771, 14964.476243331648, 14969.625759356104, 15107.39570417193, 5784.82645520635, 5907.852303692442, 5923.7926672566255, 5926.703664816742, 5978.940210597925, 1026.6714651311659, 1079.4548752879746, 1091.4597274349248, 1103.9944800276107, 1107.0755918807724, 24240.87879560591, 24465.510689786104, 24513.264602061965, 24607.87696061508, 24678.5064298713, 1190.9642710718692, 1200.4237965776476, 1216.9634910952686, 1219.6280134558867, 1221.9816702749465, 12591.496340146476, 12926.741465170644, 13048.412821423059, 13071.934640326737, 13133.67165820843, 279460.0, 279594.0, 280314.0, 281180.0, 282631.0, 55159.44840551543, 55407.168892466645, 55669.164962525596, 59070.0, 59118.11322830075, 1497.0119720984098, 1503.443725821453, 1515.9469418570297, 1528.113694057444, 1534.90023148495, 27979.58030629583, 28224.001913694017, 28316.0, 28354.574681379385, 28530.0, 35255.471167933014, 35293.294134117685, 38278.808605956794, 38621.227575448895, 38733.0, 230790.0, 232125.0, 232391.0, 233324.0, 233468.0, 33135.83432082824, 33153.50269745907, 33219.0, 33310.66689333076, 33410.33179336448, 41085.79457102815, 42282.78858605687, 42394.57605423906, 42422.15155696931, 42941.0, 30289.545656815608, 31566.0, 31729.04812855618, 32111.0, 32157.517637234992, 30531.0, 30631.54052689256, 31549.842250789516, 32044.19889502781, 32413.837930810194, 36073.0, 36261.63738362688, 36353.27293454063, 36516.81741591275, 36812.0, 30253.394932100793, 31223.375532489677, 31467.685323146474, 31505.8424707875, 31972.040838774876, 23430.531389371776, 25715.228543143734, 25913.0, 26361.0, 26559.867200663874], "value": 17553.254061636322, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.53178567147484, 526.2606038515884, 540.2895192821442, 545.6371512943891, 555.9694216818078, 22327.441813954658, 23361.0, 23504.29487115385, 24995.750042499614, 25329.240122796346, 27735.861320693417, 28304.43391132176, 28380.29049273769, 28383.716162838366, 28438.715612843866, 5972.522198224143, 5987.37132601075, 6113.052476866093, 6145.354737752538, 6228.408301211378, 6230.5950113242725, 6271.059341098849, 6272.843178920518, 6273.404026617464, 6273.623582585036, 6181.969090154543, 6190.102435146901, 6219.751209951619, 6223.346548612399, 6241.687915604224, 6213.005919052953, 6224.346443623423, 6227.190465239535, 6228.719707613146, 6230.376962303779, 5719.342275638313, 5721.8569535761935, 5764.711764411804, 5774.335951365605, 5787.0, 28525.57211641806, 31448.842755786303, 31659.366812663848, 32286.6771332286, 32312.83843580767, 2159.75162856272, 2187.890605469736, 2191.079746506471, 2192.1560199323376, 2206.2498750424934, 19758.40724778259, 20006.399808005783, 20061.799382006284, 20100.899495502428, 20139.194432222692, 2232.620454522735, 2337.9649305260436, 2345.343303874901, 2346.7183937927557, 2376.809855211579, 131419.0, 136410.31794840962, 152648.0, 154513.0, 159255.0, 14614.355817850075, 14922.030068045542, 15006.62483437901, 15169.165695886832, 15446.922765386325, 20034.198632054555, 20037.198512059353, 20219.494512637008, 20347.0, 20395.490112747004, 10309.803960772184, 10664.413457259925, 10682.252242342962, 10851.077658399125, 11014.58547850169, 10088.949555252177, 10260.230482713827, 10274.486275686186, 10294.0, 10400.323978941344, 9583.233341332676, 9635.56639951204, 9642.180414664832, 9897.80204395908, 9936.453495057696, 2660.4014096828446, 2714.185744276709, 2731.3854382764116, 2750.5578490737316, 2767.8892844286406, 1025.6358992557684, 1035.9430231337199, 1041.338749893823, 1050.3487837540774, 1060.745421098946, 21087.472813179487, 21267.574648506943, 21517.02786377734, 21669.133234670437, 21914.01525374589, 1105.6682995101437, 1113.9974023378861, 1130.304862509567, 1137.1925932587956, 1145.410113791398, 11689.415529223676, 11821.290722556674, 12085.274883507018, 12096.395180241128, 12187.756244875052, 576733.0, 584037.0, 596747.0, 605671.0, 624477.0, 130010.34994824966, 130294.0, 130669.34665326613, 132085.0, 132281.0, 1281.6603600045996, 1296.8767967043116, 1321.966950826237, 1329.5612447892172, 1330.281647910137, 22273.77726222717, 22528.887355563118, 23687.407814804767, 23743.525129496968, 24114.87942560276, 62227.0, 63464.36535634769, 63802.361976379645, 64323.0, 66144.66927665331, 76809.0, 77092.0, 77450.0, 78309.0, 78816.60591697005, 14904.478343257933, 15246.847531524543, 15267.847321526642, 15389.38442462289, 15432.691346173238, 24971.75028249767, 25090.49819003573, 25139.49721005533, 25422.491550169263, 25482.362940926625, 18845.434636960912, 18862.52843678919, 19422.611547768684, 19440.70838937389, 19446.222151113798, 16366.83633163653, 17561.912190438965, 18054.81945180584, 18179.45461636153, 18337.541561461072, 20801.79198208059, 20829.791702082784, 20926.895365523076, 21149.89425052865, 21208.575828483034, 14681.339339729951, 14821.25893705289, 14931.0, 15095.32071056827, 15160.545183644508, 19974.50063748418, 20153.6976945343, 20299.391018269474, 20401.48996275105, 20409.693854591897], "value": 12563.673889413769, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.9085509441886, 1426.1656930695542, 1462.225020739008, 1464.3849583175065, 1464.619199008258, 15144.242787860605, 15842.128682922435, 15867.444639437623, 15869.682606347866, 15988.0, 15945.202739862989, 16229.513114606581, 16231.26959286832, 16255.0, 16274.918625406857, 2394.1381102802975, 2706.580480025599, 2764.847933363674, 2766.405222877081, 2775.292300463379, 2623.462190250994, 2657.2692509559834, 2660.2551285639956, 2662.986685066572, 2666.733326667337, 2585.4312051348675, 2620.3056190109637, 2628.68455785306, 2638.300850274679, 2639.6700412448445, 2520.596704527276, 2531.354504601324, 2534.2523955433007, 2539.3270783242456, 2546.2743118211315, 2496.6879140107485, 2498.2879879234333, 2515.132279363617, 2515.6226566015243, 2515.9119430819833, 15094.396224151022, 15389.153596552185, 15409.0, 15431.61420964485, 15434.228288585638, 7776.339011184056, 7997.120316765151, 8057.959710201411, 8061.355091592659, 8080.191980801932, 5054.721990290533, 5146.0, 5222.242774797671, 5385.7307134643115, 5434.728263586844, 1916.9041547922689, 1920.2894928876406, 1929.758780152481, 1965.4202010406964, 1966.3511041356462, 27167.86416067907, 27217.183484495297, 27263.318417039733, 27310.453790924268, 27406.177814665592, 6262.655553944485, 6388.680565971683, 6394.200724909387, 6581.539292249592, 6625.17185351831, 18012.729809052613, 18019.72970405445, 18028.639427211645, 18037.18832652534, 18041.7293740594, 7717.8456430871065, 7862.056553213651, 7863.252990965849, 7868.055833300041, 7876.369890408868, 6264.59280146789, 7055.823604409931, 7145.96427017872, 7228.96385518069, 7274.709011639581, 5219.217117432339, 5344.091504444254, 5364.785408583691, 5388.838334849961, 5435.157550579587, 1451.7459444597364, 1488.3971991343524, 1496.1920562896132, 1501.9549413517611, 1517.0594231576492, 889.7152911068396, 897.2956229359921, 915.2860768600502, 939.6194541210821, 950.6387572722459, 7984.121746607869, 8092.514449133071, 8095.959520202361, 8157.79605509867, 8974.19232269099, 979.490664854286, 1009.3388830316155, 1019.6074511313197, 1034.5448002878709, 1047.7171163785736, 5354.651947623392, 5432.266644003009, 5536.4186760390385, 5677.233573467529, 5715.799947001835, 22228.88885555562, 22856.542869142522, 22953.885230573742, 23016.88491557565, 23017.539649206923, 21437.67843482349, 21959.0, 22893.08427662875, 23010.539789204122, 23031.88484057569, 12320.876791231973, 12396.81404778929, 12422.37888105591, 12460.190087644274, 12479.56321528742, 8470.703525376583, 9158.542072896462, 9170.266378689555, 9540.761480963032, 9657.130858222794, 18636.720449193544, 18672.533186669898, 19189.136488857755, 19594.216231350587, 19690.90154549218, 18897.90551047236, 20057.896815674696, 20346.59306813885, 20745.48136296544, 21003.57992840165, 11861.406929653655, 12275.93862030684, 12571.434285456993, 12753.936230318788, 13127.212367257995, 15116.244187790346, 15261.542153735405, 15285.923570382078, 15290.159041252839, 15290.694186116438, 11438.428078596204, 12105.636830895088, 12249.816252756038, 12290.877091229331, 12587.370631468208, 11141.108711302913, 11713.824292635787, 11734.0, 11753.294802311888, 11829.0, 10305.690829275134, 10412.531436085546, 10442.947785261329, 10458.372497650165, 10479.79040419172, 7876.369890408639, 8168.387370947322, 8279.751607451786, 8310.293625041939, 8370.497770133812, 8121.431499794958, 8141.185881411811, 8284.627191776264, 8328.208820162075, 8455.239028487465], "value": 6877.346783777913, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.9953200467994, 472.4307209812177, 496.1391984906188, 501.9447860735319, 505.34557747716724, 5896.351401345849, 6016.428439298271, 6062.4543791058795, 6110.480609148222, 6187.597806142598, 5877.6473411595225, 5892.440218179277, 5908.863795343266, 5926.318473375563, 5956.583039187259, 4627.699199552018, 4635.814567417299, 4640.3967484227005, 4671.439427268732, 4672.415948006499, 4553.362529245908, 4604.907901841962, 4642.187617166982, 4683.601893839011, 4693.436787585478, 4577.885552861188, 4584.381108550353, 4624.514425985273, 4643.651726120537, 4671.369365135714, 4650.325702773112, 4679.88300292492, 4686.0, 4701.0, 4732.124556956939, 4210.768407737573, 4214.704970652056, 4220.873373798791, 4229.577042295777, 4256.34026725858, 5842.357340692521, 5900.763969441217, 5913.970430147865, 5932.131378615765, 5983.431574000507, 5500.614956953015, 5512.366077901012, 5530.806421775259, 5557.0, 5626.930883132232, 6385.010323399881, 6430.292667806538, 6483.254425741005, 6512.21853377593, 6521.532655152553, 4643.512431194744, 4683.0, 4711.10489007091, 4715.976420117878, 4726.66913316068, 6720.361565651256, 6746.92049272119, 6772.424343930821, 6777.220619628756, 6836.38472537474, 4816.4220293564995, 4917.311576379309, 4920.852374428773, 4922.90154196914, 4933.161362568372, 4905.362302900671, 4956.0, 4991.575716064175, 5003.7998480061115, 5015.699058056528, 5522.889542209134, 5556.86107847299, 5567.4432556744005, 5577.498025177753, 5616.5787565932715, 6173.456635841039, 6177.887980163524, 6336.112944187817, 6543.088325695116, 6550.213974323112, 1695.3557648093645, 1708.0776380754253, 1712.2808420463434, 1717.2873257598208, 1720.9588199139341, 1045.7666307781922, 1194.802857528498, 1210.7396909664465, 1211.1885037025215, 1219.890209881115, 6173.629582225081, 6340.873182536324, 6343.781385378671, 6345.524085693592, 6364.649944253018, 6341.587796793194, 6675.766348177791, 6687.899681504781, 6709.29552397001, 6720.6639668016405, 6294.622322660655, 6316.873662526816, 6327.303996560375, 6335.334789847, 6384.808455746335, 3480.599731030964, 3483.89548313551, 3486.9476957845145, 3493.825308734604, 3521.964780352215, 6846.828829279308, 6896.275931017246, 6935.514513983972, 6961.164660240804, 6998.780560941922, 6654.101696270942, 6697.296783837724, 6772.762953296611, 6803.625800581016, 6827.249002609709, 6889.242183359826, 6935.306469353024, 6968.825779355557, 6977.476689248327, 6988.161420629557, 6545.803625891231, 6563.146790917342, 6571.441427478718, 6571.769988050395, 6610.338966103352, 6524.706388212637, 6541.967290163519, 6541.990684285091, 6564.934350656432, 6586.769463068769, 6959.686814093277, 6991.405730512964, 7008.229094799466, 7052.929470705228, 7067.692476891792, 4897.9020419592125, 4902.558769710743, 4913.1893237615395, 4948.975255123702, 4954.281629163823, 6584.55139869228, 6591.835204119935, 6627.966860165669, 6642.501812363996, 6672.566283191577, 6285.182926219745, 6298.275698294755, 6326.715297811702, 6444.967775161094, 6447.838804029937, 6316.399942005502, 6371.617702937839, 6373.0, 6387.265464471459, 6398.984319939204, 6314.589551679126, 6334.1765570475545, 6374.362563743589, 6408.231012278557, 6412.583182093149, 6178.66017369031, 6188.391018335175, 6411.262704788823, 6510.7721229756735, 6537.1174891389055, 6148.907766383597, 6183.752649893954, 6205.0, 6215.0, 6269.122322874892], "value": 4976.1223626272795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [851.2594043182428, 881.7310720230336, 898.1288150494023, 944.9494596725106, 984.8473486609573, 17600.11999400028, 18250.36123735668, 19036.809631903678, 19098.331558395443, 19120.617587648238, 21446.14215431381, 22366.55266894661, 22471.314651401128, 22506.32481025568, 22561.646301221896, 1062.5749700119936, 1085.5223701571283, 1086.0388556127843, 1086.5979587552617, 1087.6573879228058, 1062.914966802654, 1077.9353238805656, 1090.4166271044992, 1104.4146602300793, 1109.9889001110007, 1158.108256642385, 1159.5767544846155, 1162.3084264862393, 1167.854018247719, 1169.918105732599, 1141.2581821815845, 1149.2185313986486, 1158.31659321001, 1158.4092113022418, 1160.182071639492, 837.7319257837495, 837.7654256808042, 838.7274135905855, 843.2621456225802, 843.3759018326394, 17052.0, 17358.305667773275, 17556.122193890253, 17639.0, 17681.0, 20840.895795520926, 21398.679019814714, 21443.57112857734, 21937.34187974363, 21948.780512194833, 16002.119883406407, 16525.58686032847, 16648.500544983668, 16692.24884880183, 16932.23804928781, 3551.449525323579, 3607.4769158472136, 3607.981960090209, 3608.8015159166234, 3610.656987586175, 128249.0, 134073.0, 137731.0, 138613.3069334657, 139730.6026939728, 15840.366385344687, 15905.443309484113, 15934.36262549485, 16104.114273714824, 16282.45316694912, 30036.54945175824, 30930.22674433112, 31028.0, 31142.377152456826, 31406.0, 8193.59032048407, 8604.95697521521, 8636.69771558005, 8745.562721863882, 9105.635774569075, 4477.843275485342, 4622.907541849144, 4623.190941585209, 4629.907401852011, 4631.814727410933, 5481.0, 5499.587530935196, 5595.832125036174, 5633.6619802811965, 5645.125005624052, 1092.7158938675843, 1132.473399869065, 1132.8583927009124, 1140.8288756686563, 1144.2848219862585, 633.1800318587441, 654.358728446116, 667.8163505036154, 680.5236334565824, 683.1631251716608, 12238.326892020847, 13309.800352994713, 13655.112417692819, 13777.862221377858, 13794.172349659053, 677.4411110833582, 691.094665987558, 693.8716337477583, 711.6015031582331, 714.0253553898891, 5890.793822216202, 5940.227770389822, 6024.638521688713, 6273.749050037947, 6282.183316168869, 125462.37268813598, 127745.0, 132966.0, 133394.0, 134683.0, 112665.0, 114118.42940785243, 116304.09239768905, 117980.0, 123215.0, 106412.30573108782, 107252.0, 107693.0, 108875.0, 110534.99999999838, 12834.67913302175, 13323.0, 13497.46010159622, 14034.087784293988, 14533.85466145325, 50307.0, 50531.494685052676, 51504.74247628738, 53199.0, 53353.733231333594, 63619.68190159019, 65273.673631633435, 66173.0, 67626.0, 68901.65549172222, 19621.31325403604, 20173.79826201778, 20177.09203085835, 20241.19035238574, 20339.69490457674, 21779.0, 22016.77983220147, 22328.441788955406, 22544.887275563517, 22868.88565557228, 16971.236294366536, 17086.74369884428, 17194.742078869076, 19398.90300548488, 19471.318503852297, 19355.225790968765, 19628.803711962697, 19751.11119999632, 19756.802431975495, 19799.0, 20271.189152433737, 20329.6950545739, 20431.0, 20480.0, 20587.970601470166, 12447.564335248222, 12864.935675321563, 13029.674258143623, 13070.477180913038, 13258.337083145998, 14914.030588011745, 15123.092614443169, 15132.243387830784, 15233.0, 15703.450379237129], "value": 9716.200937884494, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1492.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 95.0, 108.0, 111.0, 109.0, 112.0, 108.0, 109.0, 111.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 144.0, 171.0, 115.0, 151.0, 151.0, 113.0, 169.0, 114.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 164.0, 165.0, 162.0, 164.0, 164.0, 166.0, 165.0, 166.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 78.0, 177.0, 79.0, 75.0, 75.0, 75.0, 149.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 89.0, 135.0, 80.0, 82.0, 80.0, 138.0, 80.0, 80.0, 126.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 155.0, 156.0, 148.0, 149.0, 149.0, 149.0, 149.0, 149.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 46.0, 47.0, 49.0, 47.0, 46.0, 46.0, 46.0, 47.0], "value": 46.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 54.0, 54.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 76.0, 81.0, 74.0, 74.0, 76.0, 76.0, 74.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 129.0, 114.0, 123.0, 119.0, 117.0, 126.0, 117.0, 116.0, 166.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 173.0, 163.0, 185.0, 171.0, 165.0, 163.0, 161.0, 163.0, 163.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 67.0, 63.0, 61.0, 61.0, 65.0, 60.0, 61.0, 60.0], "value": 62.5, "unit": "score"}]}]} 17:36:45 INFO - Return code: 0 17:36:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:36:45 INFO - # TBPL SUCCESS # 17:36:45 INFO - Running post-action listener: _package_coverage_data 17:36:45 INFO - Running post-action listener: _resource_record_post_action 17:36:45 INFO - [mozharness: 2017-07-25 00:36:45.173624Z] Finished run-tests step (success) 17:36:45 INFO - Running post-run listener: _resource_record_post_run 17:36:45 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 434728960; Read time: 12; Write time: 233948 17:36:45 INFO - TinderboxPrint: CPU usage
13.1% 17:36:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:36:45 INFO - TinderboxPrint: I/O write bytes / time
434,728,960 / 233,948 17:36:45 INFO - TinderboxPrint: CPU idle
8,248.7 (86.9%) 17:36:45 INFO - TinderboxPrint: CPU user
1,192.6 (12.6%) 17:36:45 INFO - TinderboxPrint: Swap in / out
0 / 0 17:36:45 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107716608; Read time: 0; Write time: 64960 17:36:45 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:36:45 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 326586368; Read time: 0; Write time: 168964 17:36:45 INFO - Running post-run listener: _upload_blobber_files 17:36:45 INFO - Blob upload gear active. 17:36:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:36:45 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 17:36:45 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'] 17:36:45 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 17:36:46 INFO - (blobuploader) - INFO - Open directory for files ... 17:36:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:36:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:36:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:46 INFO - (blobuploader) - INFO - Done attempting. 17:36:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:36:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:36:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:47 INFO - (blobuploader) - INFO - Done attempting. 17:36:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:36:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:36:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:51 INFO - (blobuploader) - INFO - Done attempting. 17:36:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:36:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:36:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:52 INFO - (blobuploader) - INFO - Done attempting. 17:36:52 INFO - (blobuploader) - INFO - Iteration through files over. 17:36:52 INFO - Return code: 0 17:36:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:36:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:36:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42ea236224c89f2b7516824319c224d38bfadbdd15922ba89dd75731433f3d562689430cb952fd7d03ccb9d899e088530cc35806c13a733ff5895e50bf9fe037", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/953d2c55b103382e10b33cde29cf58c4ff4b56fecbaa08248cdc6164c9e7a3969f023334b99bea1f8ffa448c6d83beb1c69a39337aa1af22f60be25139a01978", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5ee93c61076f9b837dc526f0a01fdba634db6b7e13ec579ec58783f9a5907543b3d26130bfb09ff9965fae549220119b6bac9b2e526f74300f0d37f8772b4cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eaf0a436eba9889b24abc101bfefb3968bcf6a0e99c70eed9ed0568cdef063d96722d57d67ab489f92d8533ad1bb838703549d395e091808086530ac2b1bce7"} 17:36:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:36:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:36:52 INFO - Contents: 17:36:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42ea236224c89f2b7516824319c224d38bfadbdd15922ba89dd75731433f3d562689430cb952fd7d03ccb9d899e088530cc35806c13a733ff5895e50bf9fe037", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/953d2c55b103382e10b33cde29cf58c4ff4b56fecbaa08248cdc6164c9e7a3969f023334b99bea1f8ffa448c6d83beb1c69a39337aa1af22f60be25139a01978", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5ee93c61076f9b837dc526f0a01fdba634db6b7e13ec579ec58783f9a5907543b3d26130bfb09ff9965fae549220119b6bac9b2e526f74300f0d37f8772b4cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eaf0a436eba9889b24abc101bfefb3968bcf6a0e99c70eed9ed0568cdef063d96722d57d67ab489f92d8533ad1bb838703549d395e091808086530ac2b1bce7"} 17:36:52 INFO - Running post-run listener: copy_logs_to_upload_dir 17:36:52 INFO - Copying logs to upload dir... 17:36:52 INFO - mkdir: /builds/slave/test/build/upload/logs 17:36:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.619991 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-07-24 17:36:52.160804) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 17:36:52.165445) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596 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/42ea236224c89f2b7516824319c224d38bfadbdd15922ba89dd75731433f3d562689430cb952fd7d03ccb9d899e088530cc35806c13a733ff5895e50bf9fe037", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/953d2c55b103382e10b33cde29cf58c4ff4b56fecbaa08248cdc6164c9e7a3969f023334b99bea1f8ffa448c6d83beb1c69a39337aa1af22f60be25139a01978", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5ee93c61076f9b837dc526f0a01fdba634db6b7e13ec579ec58783f9a5907543b3d26130bfb09ff9965fae549220119b6bac9b2e526f74300f0d37f8772b4cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eaf0a436eba9889b24abc101bfefb3968bcf6a0e99c70eed9ed0568cdef063d96722d57d67ab489f92d8533ad1bb838703549d395e091808086530ac2b1bce7"} build_url:https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011172 build_url: 'https://queue.taskcluster.net/v1/task/U8RV3YgMTjCb3WKAh3m6ew/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42ea236224c89f2b7516824319c224d38bfadbdd15922ba89dd75731433f3d562689430cb952fd7d03ccb9d899e088530cc35806c13a733ff5895e50bf9fe037", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/953d2c55b103382e10b33cde29cf58c4ff4b56fecbaa08248cdc6164c9e7a3969f023334b99bea1f8ffa448c6d83beb1c69a39337aa1af22f60be25139a01978", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5ee93c61076f9b837dc526f0a01fdba634db6b7e13ec579ec58783f9a5907543b3d26130bfb09ff9965fae549220119b6bac9b2e526f74300f0d37f8772b4cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eaf0a436eba9889b24abc101bfefb3968bcf6a0e99c70eed9ed0568cdef063d96722d57d67ab489f92d8533ad1bb838703549d395e091808086530ac2b1bce7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 17:36:52.189755) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 17:36:52.190092) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1500937646.198492-892059596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 17:36:52.278935) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 17:36:52.279488) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 17:36:52.280054) ========= ========= Total master_lag: 0.20 =========