builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1502028331.4 results: success (0) revision: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.403675) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.404068) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.404384) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.429472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.429741) ========= 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=836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-06 07:05:31-- 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% 42.4M=0s 2017-08-06 07:05:31 (42.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117976 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.560973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.561288) ========= 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=836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021157 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.635656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.635957) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fe6609d22dfdd710b11e3ac7773aff89f7a8d12c --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 fe6609d22dfdd710b11e3ac7773aff89f7a8d12c --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=836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-06 07:05:31,944 truncating revision to first 12 chars 2017-08-06 07:05:31,944 Setting DEBUG logging. 2017-08-06 07:05:31,944 attempt 1/10 2017-08-06 07:05:31,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fe6609d22dfd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-06 07:05:32,375 unpacking tar archive at: mozilla-central-fe6609d22dfd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.777130 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:32.429757) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:32.430071) ========= script_repo_revision: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:32.433494) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:32.433765) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:32.454070) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-06 07:05:32.454362) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:05:32 INFO - MultiFileLogger online at 20170806 07:05:32 in /builds/slave/test 07:05:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:05:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:05:32 INFO - {'append_to_log': False, 07:05:32 INFO - 'base_work_dir': '/builds/slave/test', 07:05:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:05:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:05:32 INFO - 'branch': 'Firefox-Non-PGO', 07:05:32 INFO - 'buildbot_json_path': 'buildprops.json', 07:05:32 INFO - 'code_coverage': False, 07:05:32 INFO - 'config_files': ('talos/linux_config.py',), 07:05:32 INFO - 'default_actions': ('clobber', 07:05:32 INFO - 'read-buildbot-config', 07:05:32 INFO - 'download-and-extract', 07:05:32 INFO - 'populate-webroot', 07:05:32 INFO - 'create-virtualenv', 07:05:32 INFO - 'install', 07:05:32 INFO - 'setup-mitmproxy', 07:05:32 INFO - 'run-tests'), 07:05:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:05:32 INFO - 'disable_ccov_upload': False, 07:05:32 INFO - 'download_minidump_stackwalk': True, 07:05:32 INFO - 'download_symbols': 'ondemand', 07:05:32 INFO - 'enable_stylo': False, 07:05:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:05:32 INFO - 'tooltool.py': '/tools/tooltool.py', 07:05:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:05:32 INFO - '/tools/misc-python/virtualenv.py')}, 07:05:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:05:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:05:32 INFO - 'gecko_profile': False, 07:05:32 INFO - 'gecko_profile_interval': 0, 07:05:32 INFO - 'installer_path': 'installer.exe', 07:05:32 INFO - 'log_level': 'info', 07:05:32 INFO - 'log_name': 'talos', 07:05:32 INFO - 'log_to_console': True, 07:05:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:05:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:05:32 INFO - 'opt_config_files': (), 07:05:32 INFO - 'pip_index': False, 07:05:32 INFO - 'suite': 'dromaeojs-e10s', 07:05:32 INFO - 'system_bits': '32', 07:05:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:05:32 INFO - 'title': 'talos-linux64-ix-028', 07:05:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:05:32 INFO - 'use_talos_json': True, 07:05:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:05:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:05:32 INFO - 'work_dir': 'build'} 07:05:32 INFO - [mozharness: 2017-08-06 14:05:32.870580Z] Running clobber step. 07:05:32 INFO - Running pre-action listener: _resource_record_pre_action 07:05:32 INFO - Running main action method: clobber 07:05:32 INFO - rmtree: /builds/slave/test/build 07:05:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:05:33 INFO - Running post-action listener: _resource_record_post_action 07:05:33 INFO - [mozharness: 2017-08-06 14:05:33.901487Z] Finished clobber step (success) 07:05:33 INFO - [mozharness: 2017-08-06 14:05:33.901592Z] Running read-buildbot-config step. 07:05:33 INFO - Running pre-action listener: _resource_record_pre_action 07:05:33 INFO - Running main action method: read_buildbot_config 07:05:33 INFO - Using buildbot properties: 07:05:33 INFO - { 07:05:33 INFO - "project": "", 07:05:33 INFO - "product": "firefox", 07:05:33 INFO - "who": "archaeopteryx@coole-files.de", 07:05:33 INFO - "installer_path": "public/build/target.tar.bz2", 07:05:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:05:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:05:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:05:33 INFO - "stage_platform": "linux64", 07:05:33 INFO - "basedir": "/builds/slave/test", 07:05:33 INFO - "buildnumber": 759, 07:05:33 INFO - "platform": "ubuntu64_hw", 07:05:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:05:33 INFO - "slavebuilddir": "test", 07:05:33 INFO - "taskId": "DpgidOYARVOZFGyK2-5FwA", 07:05:33 INFO - "branch": "mozilla-central", 07:05:33 INFO - "script_repo_revision": "production", 07:05:33 INFO - "revision": "fe6609d22dfdd710b11e3ac7773aff89f7a8d12c", 07:05:33 INFO - "slavename": "talos-linux64-ix-028", 07:05:33 INFO - "repo_path": "mozilla-central" 07:05:33 INFO - } 07:05:33 INFO - Finding installer, test and symbols from parent task. 07:05:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpgidOYARVOZFGyK2-5FwA'}, attempt #1 07:05:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpgidOYARVOZFGyK2-5FwA'}, attempt #1 07:05:34 INFO - Task dependencies: Ph1H-2ZlRnGCNKdcz7C8dw 07:05:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw'}, attempt #1 07:05:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 07:05:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json 07:05:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip 07:05:35 INFO - Running post-action listener: _resource_record_post_action 07:05:35 INFO - [mozharness: 2017-08-06 14:05:35.270558Z] Finished read-buildbot-config step (success) 07:05:35 INFO - [mozharness: 2017-08-06 14:05:35.270786Z] Running download-and-extract step. 07:05:35 INFO - Running pre-action listener: _resource_record_pre_action 07:05:35 INFO - Running main action method: download_and_extract 07:05:35 INFO - mkdir: /builds/slave/test/build/tests 07:05:35 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')]} 07:05:35 INFO - trying https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json 07:05:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:05:35 INFO - Downloaded 989 bytes. 07:05:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:05:35 INFO - Using the following test package requirements: 07:05:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:05:35 INFO - u'common': [u'target.common.tests.zip'], 07:05:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:05:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:05:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:05:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:05:35 INFO - u'mozbase': [u'target.common.tests.zip'], 07:05:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:05:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:05:35 INFO - u'web-platform': [u'target.common.tests.zip', 07:05:35 INFO - u'target.web-platform.tests.tar.gz'], 07:05:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:05:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:05:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip 07:05:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:05:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip into memory 07:05:36 INFO - Content-Length response header: 54284831 07:05:36 INFO - Bytes received: 54284831 07:05:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:05:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip 07:05:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:05:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip into memory 07:05:48 INFO - Content-Length response header: 54284831 07:05:48 INFO - Bytes received: 54284831 07:06:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.talos.tests.zip 07:06:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:06:00 INFO - Fetch https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.talos.tests.zip into memory 07:06:01 INFO - Content-Length response header: 14496008 07:06:01 INFO - Bytes received: 14496008 07:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:01 INFO - trying https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 07:06:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:06:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:06:03 INFO - Downloaded 61880648 bytes. 07:06:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 07:06:03 INFO - mkdir: /builds/slave/test/properties 07:06:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:06:03 INFO - Writing to file /builds/slave/test/properties/build_url 07:06:03 INFO - Contents: 07:06:03 INFO - build_url:https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 07:06:03 INFO - Running post-action listener: _resource_record_post_action 07:06:03 INFO - Running post-action listener: set_extra_try_arguments 07:06:03 INFO - [mozharness: 2017-08-06 14:06:03.331118Z] Finished download-and-extract step (success) 07:06:03 INFO - [mozharness: 2017-08-06 14:06:03.331237Z] Running populate-webroot step. 07:06:03 INFO - Running pre-action listener: _resource_record_pre_action 07:06:03 INFO - Running main action method: populate_webroot 07:06:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:06:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:06:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:06:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:06:03 INFO - 'tests': ['damp', 'tps']}, 07:06:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:06:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:06:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:06:03 INFO - 'other-e10s': {'tests': ['a11yr', 07:06:03 INFO - 'ts_paint', 07:06:03 INFO - 'tpaint', 07:06:03 INFO - 'sessionrestore', 07:06:03 INFO - 'sessionrestore_many_windows', 07:06:03 INFO - 'sessionrestore_no_auto_restore', 07:06:03 INFO - 'tabpaint']}, 07:06:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:06:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 07:06:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:06:03 INFO - 'tsvgr_opacity', 07:06:03 INFO - 'tart', 07:06:03 INFO - 'tscrollx', 07:06:03 INFO - 'tsvg_static']}, 07:06:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:06:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:06:03 INFO - 'talos_options': ['--mitmproxy', 07:06:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:06:03 INFO - '--firstNonBlankPaint'], 07:06:03 INFO - 'tests': ['tp6_google', 07:06:03 INFO - 'tp6_youtube', 07:06:03 INFO - 'tp6_amazon', 07:06:03 INFO - 'tp6_facebook']}, 07:06:03 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:06:03 INFO - 'talos_options': ['--stylo', 07:06:03 INFO - '--mitmproxy', 07:06:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:06:03 INFO - '--firstNonBlankPaint'], 07:06:03 INFO - 'tests': ['tp6_google', 07:06:03 INFO - 'tp6_youtube', 07:06:03 INFO - 'tp6_amazon', 07:06:03 INFO - 'tp6_facebook']}, 07:06:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:06:03 INFO - 'talos_options': ['--stylo', 07:06:03 INFO - '--stylo-threads=1', 07:06:03 INFO - '--mitmproxy', 07:06:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:06:03 INFO - '--firstNonBlankPaint'], 07:06:03 INFO - 'tests': ['tp6_google', 07:06:03 INFO - 'tp6_youtube', 07:06:03 INFO - 'tp6_amazon', 07:06:03 INFO - 'tp6_facebook']}, 07:06:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:06:03 INFO - 'talos_options': ['--xperf_path', 07:06:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:03 INFO - 'tests': ['tp5n']}}} 07:06:03 INFO - Running post-action listener: _resource_record_post_action 07:06:03 INFO - [mozharness: 2017-08-06 14:06:03.340878Z] Finished populate-webroot step (success) 07:06:03 INFO - [mozharness: 2017-08-06 14:06:03.340968Z] Running create-virtualenv step. 07:06:03 INFO - Running pre-action listener: _resource_record_pre_action 07:06:03 INFO - Running main action method: create_virtualenv 07:06:03 INFO - Creating virtualenv /builds/slave/test/build/venv 07:06:03 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 07:06:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:06:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:06:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:03 INFO - Using real prefix '/usr' 07:06:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:06:03 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:05 INFO - Installing pip.................done. 07:06:05 INFO - Return code: 0 07:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:06:06 INFO - Reading from file tmpfile_stdout 07:06:06 INFO - Output received: 07:06:06 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) 07:06:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1284a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1424eb0>, '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 0x1425db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1426240>, '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': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', '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 07:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:06:06 INFO - Using env: {'DISPLAY': ':0', 07:06:06 INFO - 'HOME': '/home/cltbld', 07:06:06 INFO - 'LANG': 'en_US.UTF-8', 07:06:06 INFO - 'LANGUAGE': 'en_US:en', 07:06:06 INFO - 'LOGNAME': 'cltbld', 07:06:06 INFO - 'MAIL': '/var/mail/cltbld', 07:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:06 INFO - 'MOZ_NO_REMOTE': '1', 07:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:06 INFO - 'NO_EM_RESTART': '1', 07:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:06 INFO - 'PWD': '/builds/slave/test', 07:06:06 INFO - 'SHELL': '/bin/bash', 07:06:06 INFO - 'SHLVL': '1', 07:06:06 INFO - 'TERM': 'linux', 07:06:06 INFO - 'TMOUT': '86400', 07:06:06 INFO - 'USER': 'cltbld', 07:06:06 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', 07:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:06 INFO - '_': '/tools/buildbot/bin/python'} 07:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:06 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 07:06:06 INFO - Cleaning up... 07:06:06 INFO - Return code: 0 07:06:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1284a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1424eb0>, '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 0x1425db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1426240>, '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': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', '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 07:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:06:06 INFO - Using env: {'DISPLAY': ':0', 07:06:06 INFO - 'HOME': '/home/cltbld', 07:06:06 INFO - 'LANG': 'en_US.UTF-8', 07:06:06 INFO - 'LANGUAGE': 'en_US:en', 07:06:06 INFO - 'LOGNAME': 'cltbld', 07:06:06 INFO - 'MAIL': '/var/mail/cltbld', 07:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:06 INFO - 'MOZ_NO_REMOTE': '1', 07:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:06 INFO - 'NO_EM_RESTART': '1', 07:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:06 INFO - 'PWD': '/builds/slave/test', 07:06:06 INFO - 'SHELL': '/bin/bash', 07:06:06 INFO - 'SHLVL': '1', 07:06:06 INFO - 'TERM': 'linux', 07:06:06 INFO - 'TMOUT': '86400', 07:06:06 INFO - 'USER': 'cltbld', 07:06:06 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', 07:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:06 INFO - '_': '/tools/buildbot/bin/python'} 07:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:06 INFO - Downloading/unpacking psutil>=3.1.1 07:06:06 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 07:06:06 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 07:06:06 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 07:06:06 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 07:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:07 INFO - Installing collected packages: psutil 07:06:07 INFO - Running setup.py install for psutil 07:06:07 INFO - building 'psutil._psutil_linux' extension 07:06:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:06:07 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 07:06:08 INFO - building 'psutil._psutil_posix' extension 07:06:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:06:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:06:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:08 INFO - Successfully installed psutil 07:06:08 INFO - Cleaning up... 07:06:08 INFO - Return code: 0 07:06:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1284a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1424eb0>, '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 0x1425db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1426240>, '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': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', '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 07:06:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:06:08 INFO - Using env: {'DISPLAY': ':0', 07:06:08 INFO - 'HOME': '/home/cltbld', 07:06:08 INFO - 'LANG': 'en_US.UTF-8', 07:06:08 INFO - 'LANGUAGE': 'en_US:en', 07:06:08 INFO - 'LOGNAME': 'cltbld', 07:06:08 INFO - 'MAIL': '/var/mail/cltbld', 07:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:08 INFO - 'MOZ_NO_REMOTE': '1', 07:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:08 INFO - 'NO_EM_RESTART': '1', 07:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:08 INFO - 'PWD': '/builds/slave/test', 07:06:08 INFO - 'SHELL': '/bin/bash', 07:06:08 INFO - 'SHLVL': '1', 07:06:08 INFO - 'TERM': 'linux', 07:06:08 INFO - 'TMOUT': '86400', 07:06:08 INFO - 'USER': 'cltbld', 07:06:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', 07:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:08 INFO - '_': '/tools/buildbot/bin/python'} 07:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:06:09 INFO - Installing collected packages: mozsystemmonitor 07:06:09 INFO - Running setup.py install for mozsystemmonitor 07:06:09 INFO - Successfully installed mozsystemmonitor 07:06:09 INFO - Cleaning up... 07:06:09 INFO - Return code: 0 07:06:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:06:09 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')]} 07:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:09 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')]} 07:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:09 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 0x10b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1284a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1424eb0>, '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 0x1425db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1426240>, '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': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', '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 07:06:09 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 07:06:09 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 07:06:09 INFO - Using env: {'DISPLAY': ':0', 07:06:09 INFO - 'HOME': '/home/cltbld', 07:06:09 INFO - 'LANG': 'en_US.UTF-8', 07:06:09 INFO - 'LANGUAGE': 'en_US:en', 07:06:09 INFO - 'LOGNAME': 'cltbld', 07:06:09 INFO - 'MAIL': '/var/mail/cltbld', 07:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:09 INFO - 'MOZ_NO_REMOTE': '1', 07:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:09 INFO - 'NO_EM_RESTART': '1', 07:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:09 INFO - 'PWD': '/builds/slave/test', 07:06:09 INFO - 'SHELL': '/bin/bash', 07:06:09 INFO - 'SHLVL': '1', 07:06:09 INFO - 'TERM': 'linux', 07:06:09 INFO - 'TMOUT': '86400', 07:06:09 INFO - 'USER': 'cltbld', 07:06:09 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', 07:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:09 INFO - '_': '/tools/buildbot/bin/python'} 07:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:09 INFO - Downloading/unpacking jsonschema==2.5.1 07:06:09 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 07:06:09 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 07:06:09 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 07:06:09 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 07:06:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:11 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:11 INFO - warning: no files found matching '*.txt' 07:06:11 INFO - no previously-included directories found matching 'build' 07:06:11 INFO - no previously-included directories found matching 'dist' 07:06:11 INFO - no previously-included directories found matching '.git*' 07:06:11 INFO - Installing collected packages: jsonschema, functools32 07:06:11 INFO - Running setup.py install for functools32 07:06:11 INFO - warning: no files found matching '*.txt' 07:06:11 INFO - no previously-included directories found matching 'build' 07:06:11 INFO - no previously-included directories found matching 'dist' 07:06:11 INFO - no previously-included directories found matching '.git*' 07:06:11 INFO - Successfully installed jsonschema functools32 07:06:11 INFO - Cleaning up... 07:06:11 INFO - Return code: 0 07:06:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1284a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1424eb0>, '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 0x1425db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1426240>, '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': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', '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 07:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:06:11 INFO - Using env: {'DISPLAY': ':0', 07:06:11 INFO - 'HOME': '/home/cltbld', 07:06:11 INFO - 'LANG': 'en_US.UTF-8', 07:06:11 INFO - 'LANGUAGE': 'en_US:en', 07:06:11 INFO - 'LOGNAME': 'cltbld', 07:06:11 INFO - 'MAIL': '/var/mail/cltbld', 07:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:11 INFO - 'MOZ_NO_REMOTE': '1', 07:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:11 INFO - 'NO_EM_RESTART': '1', 07:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:11 INFO - 'PWD': '/builds/slave/test', 07:06:11 INFO - 'SHELL': '/bin/bash', 07:06:11 INFO - 'SHLVL': '1', 07:06:11 INFO - 'TERM': 'linux', 07:06:11 INFO - 'TMOUT': '86400', 07:06:11 INFO - 'USER': 'cltbld', 07:06:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', 07:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:11 INFO - '_': '/tools/buildbot/bin/python'} 07:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:06:11 INFO - Cleaning up... 07:06:11 INFO - Return code: 0 07:06:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1284a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1424eb0>, '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 0x1425db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1426240>, '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': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', '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 07:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:06:11 INFO - Using env: {'DISPLAY': ':0', 07:06:11 INFO - 'HOME': '/home/cltbld', 07:06:11 INFO - 'LANG': 'en_US.UTF-8', 07:06:11 INFO - 'LANGUAGE': 'en_US:en', 07:06:11 INFO - 'LOGNAME': 'cltbld', 07:06:11 INFO - 'MAIL': '/var/mail/cltbld', 07:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:11 INFO - 'MOZ_NO_REMOTE': '1', 07:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:11 INFO - 'NO_EM_RESTART': '1', 07:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:11 INFO - 'PWD': '/builds/slave/test', 07:06:11 INFO - 'SHELL': '/bin/bash', 07:06:11 INFO - 'SHLVL': '1', 07:06:11 INFO - 'TERM': 'linux', 07:06:11 INFO - 'TMOUT': '86400', 07:06:11 INFO - 'USER': 'cltbld', 07:06:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', 07:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:11 INFO - '_': '/tools/buildbot/bin/python'} 07:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:11 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:12 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:06:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:13 INFO - Downloading docopt-0.6.1.tar.gz 07:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:13 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:13 INFO - Running setup.py install for blobuploader 07:06:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:06:13 INFO - Running setup.py install for requests 07:06:13 INFO - Running setup.py install for docopt 07:06:14 INFO - Successfully installed blobuploader requests docopt 07:06:14 INFO - Cleaning up... 07:06:14 INFO - Return code: 0 07:06:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1284a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1424eb0>, '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 0x1425db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1426240>, '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': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', '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 07:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:06:14 INFO - Using env: {'DISPLAY': ':0', 07:06:14 INFO - 'HOME': '/home/cltbld', 07:06:14 INFO - 'LANG': 'en_US.UTF-8', 07:06:14 INFO - 'LANGUAGE': 'en_US:en', 07:06:14 INFO - 'LOGNAME': 'cltbld', 07:06:14 INFO - 'MAIL': '/var/mail/cltbld', 07:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:14 INFO - 'MOZ_NO_REMOTE': '1', 07:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:14 INFO - 'NO_EM_RESTART': '1', 07:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:14 INFO - 'PWD': '/builds/slave/test', 07:06:14 INFO - 'SHELL': '/bin/bash', 07:06:14 INFO - 'SHLVL': '1', 07:06:14 INFO - 'TERM': 'linux', 07:06:14 INFO - 'TMOUT': '86400', 07:06:14 INFO - 'USER': 'cltbld', 07:06:14 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', 07:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:14 INFO - '_': '/tools/buildbot/bin/python'} 07:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:14 INFO - Running setup.py (path:/tmp/pip-KNoLdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:14 INFO - Running setup.py (path:/tmp/pip-IJBodN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:14 INFO - Running setup.py (path:/tmp/pip-CVUnwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:14 INFO - Running setup.py (path:/tmp/pip-kRa3O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:14 INFO - Running setup.py (path:/tmp/pip-jaEGUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:14 INFO - Running setup.py (path:/tmp/pip-XCi9EW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:14 INFO - Running setup.py (path:/tmp/pip-luVx8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:14 INFO - Running setup.py (path:/tmp/pip-oOfF2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:14 INFO - Running setup.py (path:/tmp/pip-w8UP5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:14 INFO - Running setup.py (path:/tmp/pip-7nhHOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:15 INFO - Running setup.py (path:/tmp/pip-Dmf5jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:15 INFO - Running setup.py (path:/tmp/pip-DM2EmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:15 INFO - Running setup.py (path:/tmp/pip-aFHI9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:15 INFO - Running setup.py (path:/tmp/pip-3Vs_P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:15 INFO - Running setup.py (path:/tmp/pip-x2jcRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:15 INFO - Running setup.py (path:/tmp/pip-WlVyDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:15 INFO - Running setup.py (path:/tmp/pip-d5vSmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:15 INFO - Running setup.py install for manifestparser 07:06:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:06:15 INFO - Running setup.py install for mozcrash 07:06:15 INFO - Running setup.py install for mozdebug 07:06:15 INFO - Running setup.py install for mozdevice 07:06:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:06:15 INFO - Running setup.py install for mozfile 07:06:16 INFO - Running setup.py install for mozhttpd 07:06:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Running setup.py install for mozinfo 07:06:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Running setup.py install for mozInstall 07:06:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Running setup.py install for mozleak 07:06:16 INFO - Running setup.py install for mozlog 07:06:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Running setup.py install for moznetwork 07:06:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Running setup.py install for mozprocess 07:06:16 INFO - Running setup.py install for mozprofile 07:06:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Running setup.py install for mozrunner 07:06:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Running setup.py install for mozscreenshot 07:06:17 INFO - Running setup.py install for moztest 07:06:17 INFO - Running setup.py install for mozversion 07:06:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:17 INFO - Cleaning up... 07:06:17 INFO - Return code: 0 07:06:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1284a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1424eb0>, '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 0x1425db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1426240>, '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': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', '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 07:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:06:17 INFO - Using env: {'DISPLAY': ':0', 07:06:17 INFO - 'HOME': '/home/cltbld', 07:06:17 INFO - 'LANG': 'en_US.UTF-8', 07:06:17 INFO - 'LANGUAGE': 'en_US:en', 07:06:17 INFO - 'LOGNAME': 'cltbld', 07:06:17 INFO - 'MAIL': '/var/mail/cltbld', 07:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:17 INFO - 'MOZ_NO_REMOTE': '1', 07:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:17 INFO - 'NO_EM_RESTART': '1', 07:06:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:17 INFO - 'PWD': '/builds/slave/test', 07:06:17 INFO - 'SHELL': '/bin/bash', 07:06:17 INFO - 'SHLVL': '1', 07:06:17 INFO - 'TERM': 'linux', 07:06:17 INFO - 'TMOUT': '86400', 07:06:17 INFO - 'USER': 'cltbld', 07:06:17 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', 07:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:17 INFO - '_': '/tools/buildbot/bin/python'} 07:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:17 INFO - Running setup.py (path:/tmp/pip-lNC_nH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:17 INFO - Running setup.py (path:/tmp/pip-hYc9sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:17 INFO - Running setup.py (path:/tmp/pip-iy8Vm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:17 INFO - Running setup.py (path:/tmp/pip-ewS6Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:17 INFO - Running setup.py (path:/tmp/pip-PxUVam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:17 INFO - Running setup.py (path:/tmp/pip-jFspdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:18 INFO - Running setup.py (path:/tmp/pip-oGSmXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:18 INFO - Running setup.py (path:/tmp/pip-Jo57kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:18 INFO - Running setup.py (path:/tmp/pip-wH0R0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:18 INFO - Running setup.py (path:/tmp/pip-dN9xFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:18 INFO - Running setup.py (path:/tmp/pip-jqhndE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:18 INFO - Running setup.py (path:/tmp/pip-D4dh0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:18 INFO - Running setup.py (path:/tmp/pip-C6JDE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:18 INFO - Running setup.py (path:/tmp/pip-1vG3jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:18 INFO - Running setup.py (path:/tmp/pip-8CRtVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:18 INFO - Running setup.py (path:/tmp/pip-qr9iC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:18 INFO - Running setup.py (path:/tmp/pip-12zqFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:06:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:19 INFO - Downloading blessings-1.6.tar.gz 07:06:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:19 INFO - Installing collected packages: blessings 07:06:19 INFO - Running setup.py install for blessings 07:06:20 INFO - Successfully installed blessings 07:06:20 INFO - Cleaning up... 07:06:20 INFO - Return code: 0 07:06:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:20 INFO - Reading from file tmpfile_stdout 07:06:20 INFO - Current package versions: 07:06:20 INFO - argparse == 1.2.1 07:06:20 INFO - blessings == 1.6 07:06:20 INFO - blobuploader == 1.2.4 07:06:20 INFO - docopt == 0.6.1 07:06:20 INFO - functools32 == 3.2.3-2 07:06:20 INFO - jsonschema == 2.5.1 07:06:20 INFO - manifestparser == 1.1 07:06:20 INFO - mozInstall == 1.13 07:06:20 INFO - mozcrash == 1.0 07:06:20 INFO - mozdebug == 0.1 07:06:20 INFO - mozdevice == 0.51 07:06:20 INFO - mozfile == 1.2 07:06:20 INFO - mozhttpd == 0.7 07:06:20 INFO - mozinfo == 0.10 07:06:20 INFO - mozleak == 0.1 07:06:20 INFO - mozlog == 3.5 07:06:20 INFO - moznetwork == 0.27 07:06:20 INFO - mozprocess == 0.25 07:06:20 INFO - mozprofile == 0.28 07:06:20 INFO - mozrunner == 6.13 07:06:20 INFO - mozscreenshot == 0.1 07:06:20 INFO - mozsystemmonitor == 0.3 07:06:20 INFO - moztest == 0.8 07:06:20 INFO - mozversion == 1.4 07:06:20 INFO - psutil == 3.1.1 07:06:20 INFO - requests == 1.2.3 07:06:20 INFO - wsgiref == 0.1.2 07:06:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1284a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1424eb0>, '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 0x1425db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1426240>, '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': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', '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 07:06:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:06:20 INFO - Using env: {'DISPLAY': ':0', 07:06:20 INFO - 'HOME': '/home/cltbld', 07:06:20 INFO - 'LANG': 'en_US.UTF-8', 07:06:20 INFO - 'LANGUAGE': 'en_US:en', 07:06:20 INFO - 'LOGNAME': 'cltbld', 07:06:20 INFO - 'MAIL': '/var/mail/cltbld', 07:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:20 INFO - 'MOZ_NO_REMOTE': '1', 07:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:20 INFO - 'NO_EM_RESTART': '1', 07:06:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:20 INFO - 'PWD': '/builds/slave/test', 07:06:20 INFO - 'SHELL': '/bin/bash', 07:06:20 INFO - 'SHLVL': '1', 07:06:20 INFO - 'TERM': 'linux', 07:06:20 INFO - 'TMOUT': '86400', 07:06:20 INFO - 'USER': 'cltbld', 07:06:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', 07:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:20 INFO - '_': '/tools/buildbot/bin/python'} 07:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:06:20 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:06:21 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)) 07:06:21 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)) 07:06:21 INFO - Installing collected packages: simplejson 07:06:21 INFO - Running setup.py install for simplejson 07:06:21 INFO - building 'simplejson._speedups' extension 07:06:21 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 07:06:22 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 07:06:22 INFO - Successfully installed simplejson 07:06:22 INFO - Cleaning up... 07:06:22 INFO - Return code: 0 07:06:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1284a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1427d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1424eb0>, '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 0x1425db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1426240>, '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': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', '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 07:06:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:06:22 INFO - Using env: {'DISPLAY': ':0', 07:06:22 INFO - 'HOME': '/home/cltbld', 07:06:22 INFO - 'LANG': 'en_US.UTF-8', 07:06:22 INFO - 'LANGUAGE': 'en_US:en', 07:06:22 INFO - 'LOGNAME': 'cltbld', 07:06:22 INFO - 'MAIL': '/var/mail/cltbld', 07:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:22 INFO - 'MOZ_NO_REMOTE': '1', 07:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:22 INFO - 'NO_EM_RESTART': '1', 07:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:22 INFO - 'PWD': '/builds/slave/test', 07:06:22 INFO - 'SHELL': '/bin/bash', 07:06:22 INFO - 'SHLVL': '1', 07:06:22 INFO - 'TERM': 'linux', 07:06:22 INFO - 'TMOUT': '86400', 07:06:22 INFO - 'USER': 'cltbld', 07:06:22 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', 07:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:22 INFO - '_': '/tools/buildbot/bin/python'} 07:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:06:23 INFO - Cleaning up... 07:06:23 INFO - Return code: 0 07:06:23 INFO - Running post-action listener: _resource_record_post_action 07:06:23 INFO - Running post-action listener: _start_resource_monitoring 07:06:23 INFO - Starting resource monitoring. 07:06:23 INFO - [mozharness: 2017-08-06 14:06:23.090576Z] Finished create-virtualenv step (success) 07:06:23 INFO - [mozharness: 2017-08-06 14:06:23.091098Z] Running install step. 07:06:23 INFO - Running pre-action listener: _resource_record_pre_action 07:06:23 INFO - Running main action method: install 07:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:23 INFO - Reading from file tmpfile_stdout 07:06:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:06:23 INFO - Reading from file tmpfile_stdout 07:06:23 INFO - Output received: 07:06:23 INFO - Usage: mozinstall [options] installer 07:06:23 INFO - Options: 07:06:23 INFO - -h, --help show this help message and exit 07:06:23 INFO - -d DEST, --destination=DEST 07:06:23 INFO - Directory to install application into. [default: 07:06:23 INFO - "/builds/slave/test"] 07:06:23 INFO - --app=APP Application being installed. [default: firefox] 07:06:23 INFO - mkdir: /builds/slave/test/build/application 07:06:23 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'] 07:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:06:41 INFO - Reading from file tmpfile_stdout 07:06:41 INFO - Output received: 07:06:41 INFO - /builds/slave/test/build/application/firefox/firefox 07:06:41 INFO - Running post-action listener: _resource_record_post_action 07:06:41 INFO - [mozharness: 2017-08-06 14:06:41.404908Z] Finished install step (success) 07:06:41 INFO - [mozharness: 2017-08-06 14:06:41.405058Z] Running setup-mitmproxy step. 07:06:41 INFO - Running pre-action listener: _resource_record_pre_action 07:06:41 INFO - Running main action method: setup_mitmproxy 07:06:41 INFO - Skipping: mitmproxy is not required 07:06:41 INFO - Running post-action listener: _resource_record_post_action 07:06:41 INFO - [mozharness: 2017-08-06 14:06:41.405812Z] Finished setup-mitmproxy step (success) 07:06:41 INFO - [mozharness: 2017-08-06 14:06:41.406032Z] Running run-tests step. 07:06:41 INFO - Running pre-action listener: _resource_record_pre_action 07:06:41 INFO - Running pre-action listener: _set_gcov_prefix 07:06:41 INFO - Running main action method: run_tests 07:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:06:41 INFO - Python 2.7.3 07:06:41 INFO - Return code: 0 07:06:41 INFO - grabbing minidump binary from tooltool 07:06: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')]} 07:06:41 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 0x1424eb0>, '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 0x1425db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1426240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:06:41 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 07:06:41 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 07:06:41 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 07:06:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:06:41 INFO - Return code: 0 07:06:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:06:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:06:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:06:41 INFO - ENV: RUST_BACKTRACE is now 1 07:06:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:06:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 07:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 07:06:41 INFO - Using env: {'DISPLAY': ':0', 07:06:41 INFO - 'HOME': '/home/cltbld', 07:06:41 INFO - 'LANG': 'en_US.UTF-8', 07:06:41 INFO - 'LANGUAGE': 'en_US:en', 07:06:41 INFO - 'LOGNAME': 'cltbld', 07:06:41 INFO - 'MAIL': '/var/mail/cltbld', 07:06:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:06:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:41 INFO - 'MOZ_NO_REMOTE': '1', 07:06:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:41 INFO - 'NO_EM_RESTART': '1', 07:06:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:41 INFO - 'PWD': '/builds/slave/test', 07:06:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:06:41 INFO - 'RUST_BACKTRACE': '1', 07:06:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:06:41 INFO - 'SHELL': '/bin/bash', 07:06:41 INFO - 'SHLVL': '1', 07:06:41 INFO - 'TERM': 'linux', 07:06:41 INFO - 'TMOUT': '86400', 07:06:41 INFO - 'USER': 'cltbld', 07:06:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040', 07:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:41 INFO - '_': '/tools/buildbot/bin/python'} 07:06:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 07:06:41 INFO - mozversion application_buildid: 20170806090558 07:06:41 INFO - mozversion application_changeset: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c 07:06:41 INFO - mozversion application_display_name: Nightly 07:06:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:06:41 INFO - mozversion application_name: Firefox 07:06:41 INFO - mozversion application_remotingname: firefox 07:06:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:06:41 INFO - mozversion application_vendor: Mozilla 07:06:41 INFO - mozversion application_version: 57.0a1 07:06:41 INFO - mozversion platform_buildid: 20170806090558 07:06:41 INFO - mozversion platform_changeset: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c 07:06:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:06:41 INFO - mozversion platform_version: 57.0a1 07:06:41 INFO - using testdate: 1502028401 07:06:41 INFO - actual date: 1502028401 07:06:41 INFO - starting webserver on 'localhost:45531' 07:06:41 INFO - SUITE-START | Running 2 tests 07:06:41 INFO - TEST-START | dromaeo_css 07:06:41 INFO - Initialising browser for dromaeo_css test... 07:06:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45531/getInfo.html -profile /tmp/tmpDhd8R_/profile 07:06:41 INFO - TEST-INFO | started process 15576 (/builds/slave/test/build/application/firefox/firefox http://localhost:45531/getInfo.html) 07:06:47 INFO - TEST-INFO | 15576: exit 0 07:06:48 INFO - Browser initialized. 07:06:48 INFO - Running cycle 1/1 for dromaeo_css test... 07:06:48 INFO - TEST-INFO | started process 15786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDhd8R_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:06:48 INFO - PID 15786 | 07:06:48 INFO - PID 15786 | (/builds/slave/test/build/application/firefox/firefox:15834): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:06:48 INFO - PID 15786 | 07:06:59 INFO - PID 15786 | RSS: Main: 171175936 07:06:59 INFO - PID 15786 | 07:09:58 INFO - PID 15786 | Cycle 1(1): loaded http://localhost:45531/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45531/tests/dromaeo/cssquery-ext.html) 07:10:00 INFO - PID 15786 | RSS: Main: 173780992 07:10:00 INFO - PID 15786 | 07:13:02 INFO - PID 15786 | Cycle 1(1): loaded http://localhost:45531/tests/dromaeo/cssquery-ext.html (next: http://localhost:45531/tests/dromaeo/cssquery-jquery.html) 07:13:03 INFO - PID 15786 | RSS: Main: 171237376 07:13:03 INFO - PID 15786 | 07:16:05 INFO - PID 15786 | Cycle 1(1): loaded http://localhost:45531/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45531/tests/dromaeo/cssquery-mootools.html) 07:16:05 INFO - PID 15786 | RSS: Main: 172515328 07:16:05 INFO - PID 15786 | 07:19:07 INFO - PID 15786 | Cycle 1(1): loaded http://localhost:45531/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45531/tests/dromaeo/cssquery-prototype.html) 07:19:08 INFO - PID 15786 | RSS: Main: 171638784 07:19:08 INFO - PID 15786 | 07:22:11 INFO - PID 15786 | Cycle 1(1): loaded http://localhost:45531/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45531/tests/dromaeo/cssquery-yui.html) 07:22:12 INFO - PID 15786 | RSS: Main: 172867584 07:22:12 INFO - PID 15786 | 07:25:14 INFO - PID 15786 | Cycle 1(1): loaded http://localhost:45531/tests/dromaeo/cssquery-yui.html (next: http://localhost:45531/tests/dromaeo/cssquery-dojo.html) 07:25:14 INFO - PID 15786 | RSS: Main: 175443968 07:25:14 INFO - PID 15786 | 07:25:14 INFO - PID 15786 | __start_tp_report 07:25:14 INFO - PID 15786 | _x_x_mozilla_page_load 07:25:14 INFO - PID 15786 | _x_x_mozilla_page_load_details 07:25:14 INFO - PID 15786 | |i|pagename|runs| 07:25:14 INFO - PID 15786 | |0;dojo.html;3094.675059118794;3173.0480855743276;3186.601674790651;3200.247941733692;3211.293515426607;6189.4738947189435;6244.9063264050965;6302.747890084397;6339.524535659827;6372.681365931702;6265.718042688079;6331.905021424683;6337.207849018872;6337.556371054028;6347.047942808581;5745.971270143644;5775.509081728037;5781.248437703092;5784.2480477537865;5798.043322851746;5735.397783232763;5793.217915581406;5811.4479124483105;5836.212111364954;5843.912341314863;5784.045632470637;5794.942050579503;5810.970945145289;5817.825465236049;5832.650040997532;5768.7980920668;5773.33606635236;5786.768529258846;5799.710014499258;5836.328822185461;5735.684537350444;5744.879748449054;5767.538596912237;5826.941730582725;5852.326982397036;6058.909116363258;6174.765046990575;6184;6223.719932603044;6306.905396419057;6800.863982720367;6806.149231346082;6806.5916045036965;6807.353301436356;6807.863842723118;6886.655667216669;6906.551074180213;6912.447004239649;6919.065926099963;6929.237783843773;6278.340774218733;6297.181366422382;6310.211223597051;6389.936100638981;6390.201224846895;6791.558548694319;6882.518223724392;6970.268121847234;7054.047703559953;7066.258042905421;6612.239592446834;6714.630695311805;6715.6977935993;6719.126513553207;6721.4958878084335;6719.664016799238;6793.864122717518;6813.591184528944;6852.760153394607;6858.417034552019;6744.42672372844;6745.426638735762;6819.659017049128;6842.589444633239;6846.178458585002;6765.594064356154;6776.72893084281;6832.419244364185;6854.280300568468;6857.5199736018;5375.139977603565;5443.945560544423;5444;5458.536024437888;5513.9448605514235;4616.2613981763425;4647.604953578916;4667.813287468532;4671.252599584118;4702.858914232578;5794.391588883191;5800.88398232033;5810.88378232433;5816.912746308809;5846;6797.796066118024;6865.313468653195;6872.828179295558;6885.586864788129;6908.481863860231;5772.942270577324;5860.589758716934;5869.413058694096;5873.530117590582;5883.852903677443;5846.093855452412;5929.73316200772;5933.703314834241;5943.019401798655;5952.0179170436395;6554.049662798868;6626.801195964129;6632.137822083098;6649.63427011519;6654.301298363699;6607.537472376887;6735.98960155961;6794.592324460548;6878.58728476293;6893.345132212432;6422.518311126591;6477.4170324671;6512.05575191604;6512.05575191604;6519.380658837403;6602.6698665067515;6615.272320044887;6632.867342653217;6641.800745977628;6737.59574425536;6137;6790.966045169743;6808.046873437624;6810.216825065181;6876.5186436950935;6454.903176452451;6510.44661203803;6517.283098859027;6660.533762636569;6673.265940746417;6473.417392434703;6573.474122070127;6584.374484423972;6591.406773390418;6642.169728783902;6465;6473.223213214256;6502.707378168088;6510.804675859732;6522.412982831568;6547.541672083099;6566.11357466755;6595.241547221939;6605.966970165311;6632.535722499379;6386.201724784402;6389.233292004989;6392.105105285357;6394.872102558016;6396.520260980352 07:25:14 INFO - PID 15786 | |1;ext.html;756.2626439221759;815.9306458950989;852.8976522817262;869.3870821071146;873.414812075909;41184.176316473655;42058;42101.368479472796;42136.946576335606;42169.36745948813;38309.80845095771;38388.80805595968;38430.231395372146;38607.80696096516;38650;6854.177498700151;6908.861822763542;6954.026436298897;6962.651867406635;6965.094537710091;6801.931980680204;6891.827704307408;6897.6206308653;6898.793036208922;6899.448044156456;6892.035115083892;7681.731139410122;7730.226977302253;7763.301302882739;7772.961135194316;7667.156612772591;7716.305532502074;7723.266289702469;7736;7759.37924966007;7140.571565706075;7642.19756925526;7686.692532298702;7707.229277072248;7723.459357844953;38920.22159556821;39397.21205575901;39561.20877582432;39568.40647390291;39656.405153922715;3585.4084076127406;3623.547056617923;3633.418653015531;3636.7272454566014;3639.290338384016;31559;31686.683133168604;31711.365772684418;31842.522362164586;31886;4984.975075124601;5010.3737032870895;5021.347224860745;5033.119204139261;5063.443021267658;239195;243401;243926.99999999822;246411;246540;50928;50981.23528147081;51014.744926275875;51032.48967510278;51036;52903;52957.7352113237;53019.20471192935;53132.46867531275;53366.199507007426;16306.429274975319;16624.168791560372;16627.833721662628;16629.584260393585;16642.50072497827;13661.863381366258;13663;13665.385057672429;13715.519956801463;13717.931410342884;14517.78223326651;14526.273686315853;14565.669492881088;14652.26738663084;14761.77857332141;5974.761009559569;6010.656839798798;6016.195141457545;6068.241469816273;6114.449699527064;1010.6967909627083;1011.858339832424;1013.0983424751977;1013.437542164106;1026.9435181064964;23493.41266468352;23778.643320349864;23828.974537164187;24143.51712965766;24423.14518991827;1090.8418279349607;1108.8170451875512;1125.8930401611833;1132;1134.115389995788;12563.560275390317;12616.81074783879;12748.93625531885;12811.46262448512;12880.549180778627;221013;222529;222706;223041;224363;54966.450335496134;55276.447235527936;55566.72216638891;59175.40824591785;59331.703341483015;1495;1519.9816123197263;1531.8008658874276;1536.0169491525432;1536.2933050796535;28332.291692707848;28752.25587777993;28962;29231;29473.85263073671;39200.80399597984;39473.210535789694;39501.40747888727;39564.40653390144;39876.60123398729;212553;213403;213723;214606;214642;34918.825405872805;35713;35797.64202357943;36134.4579831308;36312.63687363092;44352;44733.88165295894;45351.31973020342;45457.09085818199;45770.542294576626;33190.33619327648;33476.330473389906;33513.66486335203;34065.82967085149;34112.31775364429;32514.51228231531;32772.83613581917;32809.343813124084;33128.50307245345;33217.50521226502;33662.83168584141;34833.47749783705;35463.29073418466;35564.644353556134;35602;32163.67836321607;32302.19244518906;32474.837625812666;32491.18772030718;32801.83599081989;23216.53566928686;23878.522429550965;23905.16331928374;23919.760802392448;24503.632445512976 07:25:14 INFO - PID 15786 | |2;jquery.html;587.9941200587992;589.6638915817982;593.5340757505357;594.3314517815006;596.3857227056133;22362.776372236272;23215.535689286226;23265.069397224113;23287.883560582217;23404;26710.5993410099;27132.59301110485;27206.727932720667;27212.863935680292;27216.183514494598;6476.643784591845;6624.73501059957;6626.834329141786;6627.271000189975;6635.270120286765;5973.790917317895;6397.296297407282;6465.997770345604;6470.547061705683;6546;6502.869942601145;6510.739570417178;6516.837079073014;6520.608763474207;6523.478121750249;6464.644444555547;6483;6487.967560162169;6505.804825855232;6522.510811689119;6018.1574579558455;6059.333473317975;6061.393860613947;6070.362611925729;6080.96959515204;28834;30253.69746302531;30491.54262686039;30674.84662576695;30772;1951.6389467948475;1970.8324792392664;1971.1819594868114;1976.3971988543487;1976.6046790641929;19808.80191198084;19991.600167996705;20057.8997105015;20140.798592014038;20171.193152274038;2318.2929206591984;2324.32594547581;2366.786989170983;2376.0733314007553;2378.3816207785926;147603.26198369046;151396;151442;151555;151595.24202378918;14747.483838065617;14882.776758348416;15127.16800575979;15151.469698560719;15679.294431750599;23896.283111506684;24071;24093.879530602233;24113.7588624115;24139.879300603738;10387.94806025965;10522.789544209072;10541.631042913461;10647.89352106469;10830.458477076114;9853.802923941481;9895.20838332946;9906.405615663083;9950.601975921027;10061.54723037465;8873.201411872833;9278.840144981878;9471.621135154655;9613.567389467491;9627.277954153467;2922.2840404100707;2929.560565915087;2939.412117576493;2954.3057381515328;3009.7291243787727;936.2603543200795;940.9059094090674;970.5632465390461;978.554757585297;979.774651830083;20218.696719549218;20273.898630506752;20342.288019919233;20541.48646283825;21074.367768966957;1040.9687709368732;1051.101308381323;1068.0387651113904;1076.0315715855793;1082.2532452607834;10978.341299522055;11558.884411155948;11580.710482237842;11622.302661840316;11709.88290117105;510186;516754;517171;555520;561257;125808;127104.36447817701;128165.35917320354;129279.35360323326;132138.33930830285;1218.4456072487174;1220.7619514194823;1226.9447874845653;1290.0904862072216;1300.2133709105856;22289.44276393103;22459.887700561394;22529.77470225277;22720.886395567915;22738.65892011654;60437.69781151066;60879.086813696944;61483.38516614777;61921;63362.683186583774;78512;78560;78646.6067669658;79060.60469697615;79123.20876791158;14903.403863845324;15296.235188240766;15567;15715.921420393282;15719.921400392925;25028.374290642878;25149.497010060062;25228.117015904354;25318.620220696335;25575.488490230462;18752.343667971556;19690;19804.801951980295;19991.500212494222;20072.698909516075;15752.684946301239;16563;17040;17810.198541065423;17999.730004050212;20184.697229541274;20604.175832966514;20654.07056682423;20782.376528704164;20812;15171.696566068396;15237;15321.6169595761;15392.461263855712;15464.226788660748;18928.148233329808;19064.237430502624;19323.51691207731;19602.705959410334;19619.313324034163 07:25:14 INFO - PID 15786 | |3;mootools.html;1286.9163504372216;1321.7885138377862;1322.8809407153353;1334.993325033374;1354.0656946706774;13811.654708632277;14293.999420040574;14517;14621.04963177394;14647.707045859077;14711.48509802157;15000.174990375524;15002.624934376647;15004.174770387624;15037.398504059853;2587.45663410684;2628.3823301524126;2629.8948042078296;2630.93422664433;2631.6578844750156;2502.5370306493264;2542.8601426921514;2565.961510577343;2605.283547024574;2607.2960300718796;2577.072253988563;2601.8829152688177;2638.7229340919216;2639.815212935095;2641.300055485298;2477.6035834266613;2513.5349960257413;2623.068810572248;2637.4197676511135;2638.2217245912598;2480.0575781203206;2491.8878650460592;2528.2288901884917;2535.2521006303186;2545.7963362930923;14034.789478157836;14161.079529830527;14170;14208.147511149364;14212.644683882882;7796.922030779676;8092.757217283491;8102.18978102191;8117.553534555597;8119.959400202961;5282.286891269706;5385.730713464351;5566.137248726453;5567.916481252744;5591.8042868499815;1697.1683874901332;1734.748461473092;1738.4795788528331;1793.1303317890813;1794.7128459446426;23409.88295058531;23637.87259146668;23641.645375319385;23668.408289792722;23676.526469470686;6599.670016499156;6634.834129146713;6687.331266873371;6855.7600483983815;6934.826629334307;16216.75674864878;16266.674666506604;16348.427805027004;16405.58986025359;16409.91795041017;7460.253974602496;7685.077790665156;7699.692012319444;7707.383409327241;7713.498622589514;7026.859462810715;7079.327463890922;7085.504014719023;7262.20115787263;7263.201047884729;5053.317802096743;5257.815976440883;5263.105272103751;5273.44628813969;5287.286216360819;1444.8266208055102;1471.764517677188;1485.784561238636;1488.8436714145075;1519.7340465418508;851.5571902610732;863.3524856357732;873.2533683700472;880.212210071982;885.2121611765534;7920.801979950432;8187.935568376073;8264.545450000187;8301.128381519975;8476.872846907301;939.3143005605809;964.4068897628049;987.7086259553449;995.4226548601794;1021.3004092196869;4488.506264310923;4507.594316511464;4557.407537020166;4571.565701258375;4655.6973796703105;19300.903495482715;19953.60092798136;19961.20155193805;19972.20111195565;19988.10053547594;18841.90579047096;19536.902315488616;19947.401577952685;19959.700604490943;20114.59770804605;10119.190464762802;10455.215858810467;10455.902130276212;10463.476826158814;10474.266801323987;7188.17336006366;7318.3047610476915;8464.83070338602;8699.521526316114;8883.42257753244;16117.798130299328;16498.092604906844;16603.252853621376;16740.330386784393;17011.319547218467;16534.503964881074;16622.58972448964;16658.000519968842;16800.32798688088;16853.831461685226;11407.885921140682;11510.53957841677;11515.30908145514;11539.538418463504;11563.88436115628;13401.731965360443;13408.731825363244;13429;13466.461341546621;13720.65698357549;9445.149936505748;10427.791444171226;10888.128949684165;10935.343879367263;11150.442477876237;10321.793564128526;10441.477926103817;10486.213533984828;10613.840792388275;10628.84056739134;9241.861372079558;9407.153356197976;9438.905610943802;9440.433573985583;9441.811163776823;7076.787696369117;7120.287971202838;7150.320719531636;7225.169105552718;7315.48791584584;6981.022656827947;7099.290070992859;7146.535475194096;7152.213256541881;7164.391026762783 07:25:14 INFO - PID 15786 | |4;prototype.html;500.2046745674377;501.7165301604593;523.1786095829548;527.7203082366348;531.9175527793193;6263.592866463677;6280.780172693957;6305.351752264049;6314.084457753623;6333.7783177588735;5893.58744887858;6145.863015342154;6150.292716337623;6161.353057928909;6170.969145154279;4901.754912254391;4917.7786999585105;4929.3591833061655;4979.203327467606;4984.501549845005;4929.901401971958;4963.25274417814;4999.550040496355;5032.622553308498;5067.79728810849;5149.021685879671;5204.3234379530795;5215.3741551013745;5242.580593552507;5246.24250875957;5229.790808367661;5233.973830130844;5256.448072952342;5265.341832270966;5270.972160428718;4796.976015119937;4841.7337046462435;4870.366852309213;4902.529241227618;4911.336969509106;6165.907511387333;6203.472704820096;6213.658248796314;6231.096491008779;6234.968825155891;6086.9391306087255;6099.298580663191;6107.908381374283;6132.877342453171;6168.784092556783;6561.967190164019;6570.5729127606555;6640.402363787282;6648.734050637969;6716;5334.493223143795;5367.865803354908;5369.650972686802;5378.273933019071;5384.596155288369;6932.90431532823;6966.582005079661;7053.612051337123;7082.822929426754;7095.361417472401;5462;5463.743339031966;5488.9725551372785;5495.368032676213;5530.170474428787;5607.784760173078;5623.718814059281;5675.382515983008;5680.77276908919;5714.7428365723645;6118.174046503754;6120.002397650328;6124.5100391968535;6136.140940268366;6152.415520525543;6714.932850671528;6728.629925354055;6734.205304798454;6741.4832062518235;6750.696218670073;1872.850171986238;1918.098493707955;1950.8244258016846;1984.1468168687602;1991.2234228650839;1371.9161862129006;1411.4495346814751;1451.6298343922444;1464.4947493114857;1486.8810495160362;5575.749091290902;5622.57830662702;5678.261825962681;5681.289838770153;5704.11586204139;6542.476601871839;6628;6731.360520750521;6744.898826517606;6775.356341147583;5709.716113554611;5758.309002919593;5782.508486778587;5823.650580965155;5838.941610583925;3588.2464682416985;3627.891163265106;3628.6915612172734;3642.399004164336;3647.6899463545897;6566.047923051131;6569.211694596584;6621.768238111739;6640.302768209365;6645.435138013323;6926.896096558556;6972.477064220204;6996.720131194696;7051.717931282794;7053.647317634098;6399.592089740249;6545.116409284686;6571.507136964651;6631.63526006055;6683.231428385603;6749.42629876466;6757.256701762703;6788.558743681645;6875.656217189221;6879.931200687929;6693.497987651043;6717.865642687021;6778.457723382019;6861.348171923659;6870.862582748417;6612;6621.470282377494;6627.966860165669;6642.778252547607;6647.800565983028;5020.297158397754;5040.49595040493;5073.518015788494;5080.593552515864;5097.1844504879045;6698;6754.129494964719;6760.797176084725;6866.279040700654;6895.6552172390175;6594.340565943367;6602.636854973022;6635.075828009823;6694.497912656473;6702.19573651165;6434.774782882577;6466.935330646634;6591.703373348115;6642.933570664231;6654.76708315226;6233.563650544418;6385.425311721968;6469.547131700736;6527.184101987252;6537.248216455168;6122.78570250057;6555.476721062451;6558.1802274715665;6643.966780166262;6654.567453115532;6293.307736148929;6440.806775796734;6464.41820236181;6510.153680021567;6515.478761699147 07:25:14 INFO - PID 15786 | |5;yui.html;898.7887846356109;913;927.856182291745;928.6146249306536;930.2046750028725;19174.137163827643;20117.396478105682;20123.59752804945;20150.89924550377;22964.311070667864;18007;18318.175682094305;22663.773362266373;22684;22727.31818045457;1039.2361614213567;1070.0262760887595;1071.1270314693538;1071.201954543862;1071.383954226319;1077.3697387028558;1077.6605369308643;1078.309881675728;1079.0180935348835;1079.2175672637354;1015.9593616255341;1101.7961677089763;1102.0357187460972;1106.955721771128;1107.601263545127;1095.1840878545534;1095.3373209208394;1095.8630171228597;1095.9178061645368;1096.6216655253925;782.9295363417319;788.2550989315099;790.2611058660113;791.0072858562525;792.8929594504725;20212.69680954787;20690.379288621367;20782.896085519627;20973.8951305244;20985.475363116046;21568.460788480257;21884.671729924063;21981.450463738376;22319.10723571055;22490.43773905649;16008.679826403406;16194.352225910949;16261.51215463538;16303;16570.75143872843;3606.6393360663988;3630.6913912317486;3645;3645;3648.543932008499;135498;136125;137108;138352;140417;16378.836211637969;17060.744088838677;17800;17962.1018949052;17977;32769.50845737316;32962.3407531848;33771.15572110717;33934;33961.150971225914;9155.771105722277;9212.170904618617;9218.354715169873;9310.301727370474;9352.812943741086;4252.532221455637;4260.616544511009;4288.292431748727;4315.266404711144;4337.479502459725;5272.578193744491;5353.7590808413715;5399.109146990702;5417.702026388586;5427.782888684487;1045.9738506537244;1068.951897164614;1076.3757020927842;1082.7617924056694;1083.4907593431233;558.2826068501955;569.6638982999967;570.338407447359;570.589175793428;573.2576313673802;10926.945365273281;11180.888191118147;11238;11268.267562608404;11304.830427543593;550.5402988504563;550.9063459211943;551.8261747549509;557.1447827584639;568.499720246189;4840.15297322967;5081.415637201695;5143;5172.922406163911;5952.672603006789;103135.4843225794;104571.4771426138;106433;106439;108979;91972.54013729889;92852;94169;95395;95502.52248738712;79134;81264;82395;84825.57587212024;86391.13608863957;12002.1598488105;12092.214006089576;12117.15179937396;12244.816327754912;12264.754704905674;37499.43750843794;37578.436323454625;37987.43018854775;38488;38993.220135597694;47427.288590670476;47826.760866195444;48339.27491087566;49239.75380123076;49341.76645583889;17097;17700.91149544244;17816.821831782036;17916.283348665907;17931.193096310435;19182.13680384414;19229.615407692047;19276.710849337553;19357.806421935602;19469.805301947366;17294.01118871346;17476.475705728848;17485.300587976337;17820.198091086193;17998.460046198634;17447.738283925497;17656.293748249926;17688.646227075646;18067.63864722672;18381.356652517632;17370.913145434697;17519.211635476688;17596.912015440354;17633.20650570753;17762.200700968227;13011.284379359226;13027.544035958696;13115.278659673428;13232.933835330761;13324.866751332362;13340.86659133435;13449.529266475627;13526.526571569948;13556.796648050484;13581.388837502138 07:25:14 INFO - PID 15786 | __end_tp_report 07:25:14 INFO - PID 15786 | __start_cc_report 07:25:14 INFO - PID 15786 | _x_x_mozilla_cycle_collect,369 07:25:14 INFO - PID 15786 | __end_cc_report 07:25:14 INFO - PID 15786 | __startTimestamp1502029514384__endTimestamp 07:25:14 INFO - PID 15786 | 07:25:14 INFO - PID 15786 | ------- Summary: start ------- 07:25:14 INFO - PID 15786 | Number of tests: 6 07:25:14 INFO - PID 15786 | 07:25:14 INFO - PID 15786 | [#0] dojo.html Cycles:165 Average:6226.25 Median:6454.90 stddev:746.15 (11.6%) stddev-sans-first:706.85 07:25:14 INFO - PID 15786 | Values: 3094.7 3173.0 3186.6 3200.2 3211.3 6189.5 6244.9 6302.7 6339.5 6372.7 6265.7 6331.9 6337.2 6337.6 6347.0 5746.0 5775.5 5781.2 5784.2 5798.0 5735.4 5793.2 5811.4 5836.2 5843.9 5784.0 5794.9 5811.0 5817.8 5832.7 5768.8 5773.3 5786.8 5799.7 5836.3 5735.7 5744.9 5767.5 5826.9 5852.3 6058.9 6174.8 6184.0 6223.7 6306.9 6800.9 6806.1 6806.6 6807.4 6807.9 6886.7 6906.6 6912.4 6919.1 6929.2 6278.3 6297.2 6310.2 6389.9 6390.2 6791.6 6882.5 6970.3 7054.0 7066.3 6612.2 6714.6 6715.7 6719.1 6721.5 6719.7 6793.9 6813.6 6852.8 6858.4 6744.4 6745.4 6819.7 6842.6 6846.2 6765.6 6776.7 6832.4 6854.3 6857.5 5375.1 5443.9 5444.0 5458.5 5513.9 4616.3 4647.6 4667.8 4671.3 4702.9 5794.4 5800.9 5810.9 5816.9 5846.0 6797.8 6865.3 6872.8 6885.6 6908.5 5772.9 5860.6 5869.4 5873.5 5883.9 5846.1 5929.7 5933.7 5943.0 5952.0 6554.0 6626.8 6632.1 6649.6 6654.3 6607.5 6736.0 6794.6 6878.6 6893.3 6422.5 6477.4 6512.1 6512.1 6519.4 6602.7 6615.3 6632.9 6641.8 6737.6 6137.0 6791.0 6808.0 6810.2 6876.5 6454.9 6510.4 6517.3 6660.5 6673.3 6473.4 6573.5 6584.4 6591.4 6642.2 6465.0 6473.2 6502.7 6510.8 6522.4 6547.5 6566.1 6595.2 6606.0 6632.5 6386.2 6389.2 6392.1 6394.9 6396.5 07:25:14 INFO - PID 15786 | 07:25:14 INFO - PID 15786 | [#1] ext.html Cycles:180 Average:39932.64 Median:35657.50 stddev:58947.88 (165.3%) stddev-sans-first:59039.85 07:25:14 INFO - PID 15786 | Values: 756.3 815.9 852.9 869.4 873.4 41184.2 42058.0 42101.4 42136.9 42169.4 38309.8 38388.8 38430.2 38607.8 38650.0 6854.2 6908.9 6954.0 6962.7 6965.1 6801.9 6891.8 6897.6 6898.8 6899.4 6892.0 7681.7 7730.2 7763.3 7773.0 7667.2 7716.3 7723.3 7736.0 7759.4 7140.6 7642.2 7686.7 7707.2 7723.5 38920.2 39397.2 39561.2 39568.4 39656.4 3585.4 3623.5 3633.4 3636.7 3639.3 31559.0 31686.7 31711.4 31842.5 31886.0 4985.0 5010.4 5021.3 5033.1 5063.4 239195.0 243401.0 243927.0 246411.0 246540.0 50928.0 50981.2 51014.7 51032.5 51036.0 52903.0 52957.7 53019.2 53132.5 53366.2 16306.4 16624.2 16627.8 16629.6 16642.5 13661.9 13663.0 13665.4 13715.5 13717.9 14517.8 14526.3 14565.7 14652.3 14761.8 5974.8 6010.7 6016.2 6068.2 6114.4 1010.7 1011.9 1013.1 1013.4 1026.9 23493.4 23778.6 23829.0 24143.5 24423.1 1090.8 1108.8 1125.9 1132.0 1134.1 12563.6 12616.8 12748.9 12811.5 12880.5 221013.0 222529.0 222706.0 223041.0 224363.0 54966.5 55276.4 55566.7 59175.4 59331.7 1495.0 1520.0 1531.8 1536.0 1536.3 28332.3 28752.3 28962.0 29231.0 29473.9 39200.8 39473.2 39501.4 39564.4 39876.6 212553.0 213403.0 213723.0 214606.0 214642.0 34918.8 35713.0 35797.6 36134.5 36312.6 44352.0 44733.9 45351.3 45457.1 45770.5 33190.3 33476.3 33513.7 34065.8 34112.3 32514.5 32772.8 32809.3 33128.5 33217.5 33662.8 34833.5 35463.3 35564.6 35602.0 32163.7 32302.2 32474.8 32491.2 32801.8 23216.5 23878.5 23905.2 23919.8 24503.6 07:25:14 INFO - PID 15786 | 07:25:14 INFO - PID 15786 | [#2] jquery.html Cycles:180 Average:37545.56 Median:23276.48 stddev:89961.96 (386.5%) stddev-sans-first:90171.53 07:25:14 INFO - PID 15786 | Values: 588.0 589.7 593.5 594.3 596.4 22362.8 23215.5 23265.1 23287.9 23404.0 26710.6 27132.6 27206.7 27212.9 27216.2 6476.6 6624.7 6626.8 6627.3 6635.3 5973.8 6397.3 6466.0 6470.5 6546.0 6502.9 6510.7 6516.8 6520.6 6523.5 6464.6 6483.0 6488.0 6505.8 6522.5 6018.2 6059.3 6061.4 6070.4 6081.0 28834.0 30253.7 30491.5 30674.8 30772.0 1951.6 1970.8 1971.2 1976.4 1976.6 19808.8 19991.6 20057.9 20140.8 20171.2 2318.3 2324.3 2366.8 2376.1 2378.4 147603.3 151396.0 151442.0 151555.0 151595.2 14747.5 14882.8 15127.2 15151.5 15679.3 23896.3 24071.0 24093.9 24113.8 24139.9 10387.9 10522.8 10541.6 10647.9 10830.5 9853.8 9895.2 9906.4 9950.6 10061.5 8873.2 9278.8 9471.6 9613.6 9627.3 2922.3 2929.6 2939.4 2954.3 3009.7 936.3 940.9 970.6 978.6 979.8 20218.7 20273.9 20342.3 20541.5 21074.4 1041.0 1051.1 1068.0 1076.0 1082.3 10978.3 11558.9 11580.7 11622.3 11709.9 510186.0 516754.0 517171.0 555520.0 561257.0 125808.0 127104.4 128165.4 129279.4 132138.3 1218.4 1220.8 1226.9 1290.1 1300.2 22289.4 22459.9 22529.8 22720.9 22738.7 60437.7 60879.1 61483.4 61921.0 63362.7 78512.0 78560.0 78646.6 79060.6 79123.2 14903.4 15296.2 15567.0 15715.9 15719.9 25028.4 25149.5 25228.1 25318.6 25575.5 18752.3 19690.0 19804.8 19991.5 20072.7 15752.7 16563.0 17040.0 17810.2 17999.7 20184.7 20604.2 20654.1 20782.4 20812.0 15171.7 15237.0 15321.6 15392.5 15464.2 18928.1 19064.2 19323.5 19602.7 19619.3 07:25:14 INFO - PID 15786 | 07:25:14 INFO - PID 15786 | [#3] mootools.html Cycles:180 Average:8801.66 Median:2531.74 stddev:6049.39 (238.9%) stddev-sans-first:6040.00 07:25:14 INFO - PID 15786 | Values: 1286.9 1321.8 1322.9 1335.0 1354.1 13811.7 14294.0 14517.0 14621.0 14647.7 14711.5 15000.2 15002.6 15004.2 15037.4 2587.5 2628.4 2629.9 2630.9 2631.7 2502.5 2542.9 2566.0 2605.3 2607.3 2577.1 2601.9 2638.7 2639.8 2641.3 2477.6 2513.5 2623.1 2637.4 2638.2 2480.1 2491.9 2528.2 2535.3 2545.8 14034.8 14161.1 14170.0 14208.1 14212.6 7796.9 8092.8 8102.2 8117.6 8120.0 5282.3 5385.7 5566.1 5567.9 5591.8 1697.2 1734.7 1738.5 1793.1 1794.7 23409.9 23637.9 23641.6 23668.4 23676.5 6599.7 6634.8 6687.3 6855.8 6934.8 16216.8 16266.7 16348.4 16405.6 16409.9 7460.3 7685.1 7699.7 7707.4 7713.5 7026.9 7079.3 7085.5 7262.2 7263.2 5053.3 5257.8 5263.1 5273.4 5287.3 1444.8 1471.8 1485.8 1488.8 1519.7 851.6 863.4 873.3 880.2 885.2 7920.8 8187.9 8264.5 8301.1 8476.9 939.3 964.4 987.7 995.4 1021.3 4488.5 4507.6 4557.4 4571.6 4655.7 19300.9 19953.6 19961.2 19972.2 19988.1 18841.9 19536.9 19947.4 19959.7 20114.6 10119.2 10455.2 10455.9 10463.5 10474.3 7188.2 7318.3 8464.8 8699.5 8883.4 16117.8 16498.1 16603.3 16740.3 17011.3 16534.5 16622.6 16658.0 16800.3 16853.8 11407.9 11510.5 11515.3 11539.5 11563.9 13401.7 13408.7 13429.0 13466.5 13720.7 9445.1 10427.8 10888.1 10935.3 11150.4 10321.8 10441.5 10486.2 10613.8 10628.8 9241.9 9407.2 9438.9 9440.4 9441.8 7076.8 7120.3 7150.3 7225.2 7315.5 6981.0 7099.3 7146.5 7152.2 7164.4 07:25:14 INFO - PID 15786 | 07:25:14 INFO - PID 15786 | [#4] prototype.html Cycles:180 Average:5653.41 Median:6169.88 stddev:1524.44 (24.7%) stddev-sans-first:1478.83 07:25:14 INFO - PID 15786 | Values: 500.2 501.7 523.2 527.7 531.9 6263.6 6280.8 6305.4 6314.1 6333.8 5893.6 6145.9 6150.3 6161.4 6171.0 4901.8 4917.8 4929.4 4979.2 4984.5 4929.9 4963.3 4999.6 5032.6 5067.8 5149.0 5204.3 5215.4 5242.6 5246.2 5229.8 5234.0 5256.4 5265.3 5271.0 4797.0 4841.7 4870.4 4902.5 4911.3 6165.9 6203.5 6213.7 6231.1 6235.0 6086.9 6099.3 6107.9 6132.9 6168.8 6562.0 6570.6 6640.4 6648.7 6716.0 5334.5 5367.9 5369.7 5378.3 5384.6 6932.9 6966.6 7053.6 7082.8 7095.4 5462.0 5463.7 5489.0 5495.4 5530.2 5607.8 5623.7 5675.4 5680.8 5714.7 6118.2 6120.0 6124.5 6136.1 6152.4 6714.9 6728.6 6734.2 6741.5 6750.7 1872.9 1918.1 1950.8 1984.1 1991.2 1371.9 1411.4 1451.6 1464.5 1486.9 5575.7 5622.6 5678.3 5681.3 5704.1 6542.5 6628.0 6731.4 6744.9 6775.4 5709.7 5758.3 5782.5 5823.7 5838.9 3588.2 3627.9 3628.7 3642.4 3647.7 6566.0 6569.2 6621.8 6640.3 6645.4 6926.9 6972.5 6996.7 7051.7 7053.6 6399.6 6545.1 6571.5 6631.6 6683.2 6749.4 6757.3 6788.6 6875.7 6879.9 6693.5 6717.9 6778.5 6861.3 6870.9 6612.0 6621.5 6628.0 6642.8 6647.8 5020.3 5040.5 5073.5 5080.6 5097.2 6698.0 6754.1 6760.8 6866.3 6895.7 6594.3 6602.6 6635.1 6694.5 6702.2 6434.8 6466.9 6591.7 6642.9 6654.8 6233.6 6385.4 6469.5 6527.2 6537.2 6122.8 6555.5 6558.2 6644.0 6654.6 6293.3 6440.8 6464.4 6510.2 6515.5 07:25:14 INFO - PID 15786 | 07:25:14 INFO - PID 15786 | [#5] yui.html Cycles:180 Average:23169.39 Median:19317.26 stddev:31800.10 (164.6%) stddev-sans-first:31845.33 07:25:14 INFO - PID 15786 | Values: 898.8 913.0 927.9 928.6 930.2 19174.1 20117.4 20123.6 20150.9 22964.3 18007.0 18318.2 22663.8 22684.0 22727.3 1039.2 1070.0 1071.1 1071.2 1071.4 1077.4 1077.7 1078.3 1079.0 1079.2 1016.0 1101.8 1102.0 1107.0 1107.6 1095.2 1095.3 1095.9 1095.9 1096.6 782.9 788.3 790.3 791.0 792.9 20212.7 20690.4 20782.9 20973.9 20985.5 21568.5 21884.7 21981.5 22319.1 22490.4 16008.7 16194.4 16261.5 16303.0 16570.8 3606.6 3630.7 3645.0 3645.0 3648.5 135498.0 136125.0 137108.0 138352.0 140417.0 16378.8 17060.7 17800.0 17962.1 17977.0 32769.5 32962.3 33771.2 33934.0 33961.2 9155.8 9212.2 9218.4 9310.3 9352.8 4252.5 4260.6 4288.3 4315.3 4337.5 5272.6 5353.8 5399.1 5417.7 5427.8 1046.0 1069.0 1076.4 1082.8 1083.5 558.3 569.7 570.3 570.6 573.3 10926.9 11180.9 11238.0 11268.3 11304.8 550.5 550.9 551.8 557.1 568.5 4840.2 5081.4 5143.0 5172.9 5952.7 103135.5 104571.5 106433.0 106439.0 108979.0 91972.5 92852.0 94169.0 95395.0 95502.5 79134.0 81264.0 82395.0 84825.6 86391.1 12002.2 12092.2 12117.2 12244.8 12264.8 37499.4 37578.4 37987.4 38488.0 38993.2 47427.3 47826.8 48339.3 49239.8 49341.8 17097.0 17700.9 17816.8 17916.3 17931.2 19182.1 19229.6 19276.7 19357.8 19469.8 17294.0 17476.5 17485.3 17820.2 17998.5 17447.7 17656.3 17688.6 18067.6 18381.4 17370.9 17519.2 17596.9 17633.2 17762.2 13011.3 13027.5 13115.3 13232.9 13324.9 13340.9 13449.5 13526.5 13556.8 13581.4 07:25:14 INFO - PID 15786 | -------- Summary: end -------- 07:25:14 INFO - PID 15786 | 07:25:15 INFO - TEST-INFO | 15786: exit 0 07:25:15 INFO - TEST-OK | dromaeo_css | took 1113286ms 07:25:15 INFO - TEST-START | kraken 07:25:15 INFO - Initialising browser for kraken test... 07:25:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45531/getInfo.html -profile /tmp/tmpkwhZum/profile 07:25:15 INFO - TEST-INFO | started process 16147 (/builds/slave/test/build/application/firefox/firefox http://localhost:45531/getInfo.html) 07:25:20 INFO - TEST-INFO | 16147: exit 0 07:25:20 INFO - Browser initialized. 07:25:20 INFO - Running cycle 1/1 for kraken test... 07:25:20 INFO - TEST-INFO | started process 16352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkwhZum/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:21 INFO - PID 16352 | 07:25:21 INFO - PID 16352 | (/builds/slave/test/build/application/firefox/firefox:16399): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:25:21 INFO - PID 16352 | 07:25:32 INFO - PID 16352 | RSS: Main: 171749376 07:25:32 INFO - PID 16352 | 07:25:34 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:45531/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45531/tests/kraken/driver.html?testName=audio-beat-detection) 07:25:35 INFO - PID 16352 | RSS: Main: 176357376 07:25:35 INFO - PID 16352 | 07:25:38 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:45531/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45531/tests/kraken/driver.html?testName=audio-dft) 07:25:39 INFO - PID 16352 | RSS: Main: 176754688 07:25:39 INFO - PID 16352 | 07:25:42 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:45531/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45531/tests/kraken/driver.html?testName=audio-fft) 07:25:42 INFO - PID 16352 | RSS: Main: 171466752 07:25:42 INFO - PID 16352 | 07:25:44 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:45531/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45531/tests/kraken/driver.html?testName=audio-oscillator) 07:25:45 INFO - PID 16352 | RSS: Main: 171454464 07:25:45 INFO - PID 16352 | 07:25:47 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:45531/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45531/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:25:48 INFO - PID 16352 | RSS: Main: 171868160 07:25:48 INFO - PID 16352 | 07:25:51 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:45531/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45531/tests/kraken/driver.html?testName=imaging-darkroom) 07:25:51 INFO - PID 16352 | RSS: Main: 174379008 07:25:51 INFO - PID 16352 | 07:25:55 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:45531/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45531/tests/kraken/driver.html?testName=imaging-desaturate) 07:25:56 INFO - PID 16352 | RSS: Main: 174751744 07:25:56 INFO - PID 16352 | 07:25:58 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:45531/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45531/tests/kraken/driver.html?testName=json-parse-financial) 07:25:59 INFO - PID 16352 | RSS: Main: 174858240 07:25:59 INFO - PID 16352 | 07:26:01 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:45531/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45531/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:01 INFO - PID 16352 | RSS: Main: 174747648 07:26:01 INFO - PID 16352 | 07:26:03 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:45531/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45531/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:04 INFO - PID 16352 | RSS: Main: 175284224 07:26:04 INFO - PID 16352 | 07:26:06 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:45531/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45531/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:06 INFO - PID 16352 | RSS: Main: 172040192 07:26:06 INFO - PID 16352 | 07:26:09 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:45531/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:10 INFO - PID 16352 | RSS: Main: 172707840 07:26:10 INFO - PID 16352 | 07:26:13 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:45531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:14 INFO - PID 16352 | RSS: Main: 172630016 07:26:14 INFO - PID 16352 | 07:26:15 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:45531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45531/tests/kraken/driver.html?testName=ai-astar) 07:26:16 INFO - PID 16352 | RSS: Main: 174047232 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | __start_tp_report 07:26:16 INFO - PID 16352 | _x_x_mozilla_page_load 07:26:16 INFO - PID 16352 | _x_x_mozilla_page_load_details 07:26:16 INFO - PID 16352 | |i|pagename|runs| 07:26:16 INFO - PID 16352 | |0;ai-astar;98;108;100;106;106;108;109;98;109;111 07:26:16 INFO - PID 16352 | |1;audio-beat-detection;145;117;157;166;117;148;145;122;173;118 07:26:16 INFO - PID 16352 | |2;audio-dft;164;166;166;162;174;163;163;165;169;163 07:26:16 INFO - PID 16352 | |3;audio-fft;76;75;74;178;75;74;74;92;100;75 07:26:16 INFO - PID 16352 | |4;audio-oscillator;79;79;131;78;78;79;135;79;79;126 07:26:16 INFO - PID 16352 | |5;imaging-gaussian-blur;115;115;113;113;114;114;114;114;114;114 07:26:16 INFO - PID 16352 | |6;imaging-darkroom;151;151;150;152;154;150;154;151;151;152 07:26:16 INFO - PID 16352 | |7;imaging-desaturate;95;94;94;95;94;94;95;94;94;94 07:26:16 INFO - PID 16352 | |8;json-parse-financial;56;55;55;55;55;55;56;56;55;56 07:26:16 INFO - PID 16352 | |9;json-stringify-tinderbox;55;54;54;53;54;54;54;53;54;55 07:26:16 INFO - PID 16352 | |10;stanford-crypto-aes;79;90;84;78;79;78;79;82;78;77 07:26:16 INFO - PID 16352 | |11;stanford-crypto-ccm;133;145;131;146;124;127;135;135;134;166 07:26:16 INFO - PID 16352 | |12;stanford-crypto-pbkdf2;196;177;175;180;177;174;175;176;174;174 07:26:16 INFO - PID 16352 | |13;stanford-crypto-sha256-iterative;74;68;64;68;64;64;64;66;66;68 07:26:16 INFO - PID 16352 | __end_tp_report 07:26:16 INFO - PID 16352 | __start_cc_report 07:26:16 INFO - PID 16352 | _x_x_mozilla_cycle_collect,957 07:26:16 INFO - PID 16352 | __end_cc_report 07:26:16 INFO - PID 16352 | __startTimestamp1502029576095__endTimestamp 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | ------- Summary: start ------- 07:26:16 INFO - PID 16352 | Number of tests: 14 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | [#0] ai-astar Cycles:10 Average:105.30 Median:109.00 stddev:4.83 (4.4%) stddev-sans-first:4.34 07:26:16 INFO - PID 16352 | Values: 98.0 108.0 100.0 106.0 106.0 108.0 109.0 98.0 109.0 111.0 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:146.50 stddev:21.15 (14.4%) stddev-sans-first:22.38 07:26:16 INFO - PID 16352 | Values: 145.0 117.0 157.0 166.0 117.0 148.0 145.0 122.0 173.0 118.0 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.50 stddev:3.63 (2.2%) stddev-sans-first:3.81 07:26:16 INFO - PID 16352 | Values: 164.0 166.0 166.0 162.0 174.0 163.0 163.0 165.0 169.0 163.0 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | [#3] audio-fft Cycles:10 Average:89.30 Median:75.00 stddev:32.46 (43.3%) stddev-sans-first:34.07 07:26:16 INFO - PID 16352 | Values: 76.0 75.0 74.0 178.0 75.0 74.0 74.0 92.0 100.0 75.0 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:79.00 stddev:25.19 (31.9%) stddev-sans-first:26.10 07:26:16 INFO - PID 16352 | Values: 79.0 79.0 131.0 78.0 78.0 79.0 135.0 79.0 79.0 126.0 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 07:26:16 INFO - PID 16352 | Values: 115.0 115.0 113.0 113.0 114.0 114.0 114.0 114.0 114.0 114.0 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.50 stddev:1.43 (0.9%) stddev-sans-first:1.50 07:26:16 INFO - PID 16352 | Values: 151.0 151.0 150.0 152.0 154.0 150.0 154.0 151.0 151.0 152.0 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:26:16 INFO - PID 16352 | Values: 95.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 07:26:16 INFO - PID 16352 | Values: 56.0 55.0 55.0 55.0 55.0 55.0 56.0 56.0 55.0 56.0 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.60 07:26:16 INFO - PID 16352 | Values: 55.0 54.0 54.0 53.0 54.0 54.0 54.0 53.0 54.0 55.0 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:79.00 stddev:3.98 (5.0%) stddev-sans-first:4.19 07:26:16 INFO - PID 16352 | Values: 79.0 90.0 84.0 78.0 79.0 78.0 79.0 82.0 78.0 77.0 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:135.00 stddev:12.11 (9.0%) stddev-sans-first:12.73 07:26:16 INFO - PID 16352 | Values: 133.0 145.0 131.0 146.0 124.0 127.0 135.0 135.0 134.0 166.0 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.80 Median:176.50 stddev:6.66 (3.8%) stddev-sans-first:1.99 07:26:16 INFO - PID 16352 | Values: 196.0 177.0 175.0 180.0 177.0 174.0 175.0 176.0 174.0 174.0 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:3.13 (4.7%) stddev-sans-first:1.86 07:26:16 INFO - PID 16352 | Values: 74.0 68.0 64.0 68.0 64.0 64.0 64.0 66.0 66.0 68.0 07:26:16 INFO - PID 16352 | -------- Summary: end -------- 07:26:16 INFO - PID 16352 | 07:26:16 INFO - PID 16352 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:26:16 INFO - TEST-INFO | 16352: exit 0 07:26:16 INFO - TEST-OK | kraken | took 61722ms 07:26:16 INFO - SUITE-END | took 1175s 07:26:17 INFO - Completed test suite (00:19:35) 07:26:17 INFO - javascript benchmark 07:26:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8611.217106087342, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.675059118794, 3173.0480855743276, 3186.601674790651, 3200.247941733692, 3211.293515426607, 6189.4738947189435, 6244.9063264050965, 6302.747890084397, 6339.524535659827, 6372.681365931702, 6265.718042688079, 6331.905021424683, 6337.207849018872, 6337.556371054028, 6347.047942808581, 5745.971270143644, 5775.509081728037, 5781.248437703092, 5784.2480477537865, 5798.043322851746, 5735.397783232763, 5793.217915581406, 5811.4479124483105, 5836.212111364954, 5843.912341314863, 5784.045632470637, 5794.942050579503, 5810.970945145289, 5817.825465236049, 5832.650040997532, 5768.7980920668, 5773.33606635236, 5786.768529258846, 5799.710014499258, 5836.328822185461, 5735.684537350444, 5744.879748449054, 5767.538596912237, 5826.941730582725, 5852.326982397036, 6058.909116363258, 6174.765046990575, 6184.0, 6223.719932603044, 6306.905396419057, 6800.863982720367, 6806.149231346082, 6806.5916045036965, 6807.353301436356, 6807.863842723118, 6886.655667216669, 6906.551074180213, 6912.447004239649, 6919.065926099963, 6929.237783843773, 6278.340774218733, 6297.181366422382, 6310.211223597051, 6389.936100638981, 6390.201224846895, 6791.558548694319, 6882.518223724392, 6970.268121847234, 7054.047703559953, 7066.258042905421, 6612.239592446834, 6714.630695311805, 6715.6977935993, 6719.126513553207, 6721.4958878084335, 6719.664016799238, 6793.864122717518, 6813.591184528944, 6852.760153394607, 6858.417034552019, 6744.42672372844, 6745.426638735762, 6819.659017049128, 6842.589444633239, 6846.178458585002, 6765.594064356154, 6776.72893084281, 6832.419244364185, 6854.280300568468, 6857.5199736018, 5375.139977603565, 5443.945560544423, 5444.0, 5458.536024437888, 5513.9448605514235, 4616.2613981763425, 4647.604953578916, 4667.813287468532, 4671.252599584118, 4702.858914232578, 5794.391588883191, 5800.88398232033, 5810.88378232433, 5816.912746308809, 5846.0, 6797.796066118024, 6865.313468653195, 6872.828179295558, 6885.586864788129, 6908.481863860231, 5772.942270577324, 5860.589758716934, 5869.413058694096, 5873.530117590582, 5883.852903677443, 5846.093855452412, 5929.73316200772, 5933.703314834241, 5943.019401798655, 5952.0179170436395, 6554.049662798868, 6626.801195964129, 6632.137822083098, 6649.63427011519, 6654.301298363699, 6607.537472376887, 6735.98960155961, 6794.592324460548, 6878.58728476293, 6893.345132212432, 6422.518311126591, 6477.4170324671, 6512.05575191604, 6512.05575191604, 6519.380658837403, 6602.6698665067515, 6615.272320044887, 6632.867342653217, 6641.800745977628, 6737.59574425536, 6137.0, 6790.966045169743, 6808.046873437624, 6810.216825065181, 6876.5186436950935, 6454.903176452451, 6510.44661203803, 6517.283098859027, 6660.533762636569, 6673.265940746417, 6473.417392434703, 6573.474122070127, 6584.374484423972, 6591.406773390418, 6642.169728783902, 6465.0, 6473.223213214256, 6502.707378168088, 6510.804675859732, 6522.412982831568, 6547.541672083099, 6566.11357466755, 6595.241547221939, 6605.966970165311, 6632.535722499379, 6386.201724784402, 6389.233292004989, 6392.105105285357, 6394.872102558016, 6396.520260980352], "value": 6169.542899554175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.2626439221759, 815.9306458950989, 852.8976522817262, 869.3870821071146, 873.414812075909, 41184.176316473655, 42058.0, 42101.368479472796, 42136.946576335606, 42169.36745948813, 38309.80845095771, 38388.80805595968, 38430.231395372146, 38607.80696096516, 38650.0, 6854.177498700151, 6908.861822763542, 6954.026436298897, 6962.651867406635, 6965.094537710091, 6801.931980680204, 6891.827704307408, 6897.6206308653, 6898.793036208922, 6899.448044156456, 6892.035115083892, 7681.731139410122, 7730.226977302253, 7763.301302882739, 7772.961135194316, 7667.156612772591, 7716.305532502074, 7723.266289702469, 7736.0, 7759.37924966007, 7140.571565706075, 7642.19756925526, 7686.692532298702, 7707.229277072248, 7723.459357844953, 38920.22159556821, 39397.21205575901, 39561.20877582432, 39568.40647390291, 39656.405153922715, 3585.4084076127406, 3623.547056617923, 3633.418653015531, 3636.7272454566014, 3639.290338384016, 31559.0, 31686.683133168604, 31711.365772684418, 31842.522362164586, 31886.0, 4984.975075124601, 5010.3737032870895, 5021.347224860745, 5033.119204139261, 5063.443021267658, 239195.0, 243401.0, 243926.99999999822, 246411.0, 246540.0, 50928.0, 50981.23528147081, 51014.744926275875, 51032.48967510278, 51036.0, 52903.0, 52957.7352113237, 53019.20471192935, 53132.46867531275, 53366.199507007426, 16306.429274975319, 16624.168791560372, 16627.833721662628, 16629.584260393585, 16642.50072497827, 13661.863381366258, 13663.0, 13665.385057672429, 13715.519956801463, 13717.931410342884, 14517.78223326651, 14526.273686315853, 14565.669492881088, 14652.26738663084, 14761.77857332141, 5974.761009559569, 6010.656839798798, 6016.195141457545, 6068.241469816273, 6114.449699527064, 1010.6967909627083, 1011.858339832424, 1013.0983424751977, 1013.437542164106, 1026.9435181064964, 23493.41266468352, 23778.643320349864, 23828.974537164187, 24143.51712965766, 24423.14518991827, 1090.8418279349607, 1108.8170451875512, 1125.8930401611833, 1132.0, 1134.115389995788, 12563.560275390317, 12616.81074783879, 12748.93625531885, 12811.46262448512, 12880.549180778627, 221013.0, 222529.0, 222706.0, 223041.0, 224363.0, 54966.450335496134, 55276.447235527936, 55566.72216638891, 59175.40824591785, 59331.703341483015, 1495.0, 1519.9816123197263, 1531.8008658874276, 1536.0169491525432, 1536.2933050796535, 28332.291692707848, 28752.25587777993, 28962.0, 29231.0, 29473.85263073671, 39200.80399597984, 39473.210535789694, 39501.40747888727, 39564.40653390144, 39876.60123398729, 212553.0, 213403.0, 213723.0, 214606.0, 214642.0, 34918.825405872805, 35713.0, 35797.64202357943, 36134.4579831308, 36312.63687363092, 44352.0, 44733.88165295894, 45351.31973020342, 45457.09085818199, 45770.542294576626, 33190.33619327648, 33476.330473389906, 33513.66486335203, 34065.82967085149, 34112.31775364429, 32514.51228231531, 32772.83613581917, 32809.343813124084, 33128.50307245345, 33217.50521226502, 33662.83168584141, 34833.47749783705, 35463.29073418466, 35564.644353556134, 35602.0, 32163.67836321607, 32302.19244518906, 32474.837625812666, 32491.18772030718, 32801.83599081989, 23216.53566928686, 23878.522429550965, 23905.16331928374, 23919.760802392448, 24503.632445512976], "value": 17592.042931272186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.9941200587992, 589.6638915817982, 593.5340757505357, 594.3314517815006, 596.3857227056133, 22362.776372236272, 23215.535689286226, 23265.069397224113, 23287.883560582217, 23404.0, 26710.5993410099, 27132.59301110485, 27206.727932720667, 27212.863935680292, 27216.183514494598, 6476.643784591845, 6624.73501059957, 6626.834329141786, 6627.271000189975, 6635.270120286765, 5973.790917317895, 6397.296297407282, 6465.997770345604, 6470.547061705683, 6546.0, 6502.869942601145, 6510.739570417178, 6516.837079073014, 6520.608763474207, 6523.478121750249, 6464.644444555547, 6483.0, 6487.967560162169, 6505.804825855232, 6522.510811689119, 6018.1574579558455, 6059.333473317975, 6061.393860613947, 6070.362611925729, 6080.96959515204, 28834.0, 30253.69746302531, 30491.54262686039, 30674.84662576695, 30772.0, 1951.6389467948475, 1970.8324792392664, 1971.1819594868114, 1976.3971988543487, 1976.6046790641929, 19808.80191198084, 19991.600167996705, 20057.8997105015, 20140.798592014038, 20171.193152274038, 2318.2929206591984, 2324.32594547581, 2366.786989170983, 2376.0733314007553, 2378.3816207785926, 147603.26198369046, 151396.0, 151442.0, 151555.0, 151595.24202378918, 14747.483838065617, 14882.776758348416, 15127.16800575979, 15151.469698560719, 15679.294431750599, 23896.283111506684, 24071.0, 24093.879530602233, 24113.7588624115, 24139.879300603738, 10387.94806025965, 10522.789544209072, 10541.631042913461, 10647.89352106469, 10830.458477076114, 9853.802923941481, 9895.20838332946, 9906.405615663083, 9950.601975921027, 10061.54723037465, 8873.201411872833, 9278.840144981878, 9471.621135154655, 9613.567389467491, 9627.277954153467, 2922.2840404100707, 2929.560565915087, 2939.412117576493, 2954.3057381515328, 3009.7291243787727, 936.2603543200795, 940.9059094090674, 970.5632465390461, 978.554757585297, 979.774651830083, 20218.696719549218, 20273.898630506752, 20342.288019919233, 20541.48646283825, 21074.367768966957, 1040.9687709368732, 1051.101308381323, 1068.0387651113904, 1076.0315715855793, 1082.2532452607834, 10978.341299522055, 11558.884411155948, 11580.710482237842, 11622.302661840316, 11709.88290117105, 510186.0, 516754.0, 517171.0, 555520.0, 561257.0, 125808.0, 127104.36447817701, 128165.35917320354, 129279.35360323326, 132138.33930830285, 1218.4456072487174, 1220.7619514194823, 1226.9447874845653, 1290.0904862072216, 1300.2133709105856, 22289.44276393103, 22459.887700561394, 22529.77470225277, 22720.886395567915, 22738.65892011654, 60437.69781151066, 60879.086813696944, 61483.38516614777, 61921.0, 63362.683186583774, 78512.0, 78560.0, 78646.6067669658, 79060.60469697615, 79123.20876791158, 14903.403863845324, 15296.235188240766, 15567.0, 15715.921420393282, 15719.921400392925, 25028.374290642878, 25149.497010060062, 25228.117015904354, 25318.620220696335, 25575.488490230462, 18752.343667971556, 19690.0, 19804.801951980295, 19991.500212494222, 20072.698909516075, 15752.684946301239, 16563.0, 17040.0, 17810.198541065423, 17999.730004050212, 20184.697229541274, 20604.175832966514, 20654.07056682423, 20782.376528704164, 20812.0, 15171.696566068396, 15237.0, 15321.6169595761, 15392.461263855712, 15464.226788660748, 18928.148233329808, 19064.237430502624, 19323.51691207731, 19602.705959410334, 19619.313324034163], "value": 12515.4366627408, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.9163504372216, 1321.7885138377862, 1322.8809407153353, 1334.993325033374, 1354.0656946706774, 13811.654708632277, 14293.999420040574, 14517.0, 14621.04963177394, 14647.707045859077, 14711.48509802157, 15000.174990375524, 15002.624934376647, 15004.174770387624, 15037.398504059853, 2587.45663410684, 2628.3823301524126, 2629.8948042078296, 2630.93422664433, 2631.6578844750156, 2502.5370306493264, 2542.8601426921514, 2565.961510577343, 2605.283547024574, 2607.2960300718796, 2577.072253988563, 2601.8829152688177, 2638.7229340919216, 2639.815212935095, 2641.300055485298, 2477.6035834266613, 2513.5349960257413, 2623.068810572248, 2637.4197676511135, 2638.2217245912598, 2480.0575781203206, 2491.8878650460592, 2528.2288901884917, 2535.2521006303186, 2545.7963362930923, 14034.789478157836, 14161.079529830527, 14170.0, 14208.147511149364, 14212.644683882882, 7796.922030779676, 8092.757217283491, 8102.18978102191, 8117.553534555597, 8119.959400202961, 5282.286891269706, 5385.730713464351, 5566.137248726453, 5567.916481252744, 5591.8042868499815, 1697.1683874901332, 1734.748461473092, 1738.4795788528331, 1793.1303317890813, 1794.7128459446426, 23409.88295058531, 23637.87259146668, 23641.645375319385, 23668.408289792722, 23676.526469470686, 6599.670016499156, 6634.834129146713, 6687.331266873371, 6855.7600483983815, 6934.826629334307, 16216.75674864878, 16266.674666506604, 16348.427805027004, 16405.58986025359, 16409.91795041017, 7460.253974602496, 7685.077790665156, 7699.692012319444, 7707.383409327241, 7713.498622589514, 7026.859462810715, 7079.327463890922, 7085.504014719023, 7262.20115787263, 7263.201047884729, 5053.317802096743, 5257.815976440883, 5263.105272103751, 5273.44628813969, 5287.286216360819, 1444.8266208055102, 1471.764517677188, 1485.784561238636, 1488.8436714145075, 1519.7340465418508, 851.5571902610732, 863.3524856357732, 873.2533683700472, 880.212210071982, 885.2121611765534, 7920.801979950432, 8187.935568376073, 8264.545450000187, 8301.128381519975, 8476.872846907301, 939.3143005605809, 964.4068897628049, 987.7086259553449, 995.4226548601794, 1021.3004092196869, 4488.506264310923, 4507.594316511464, 4557.407537020166, 4571.565701258375, 4655.6973796703105, 19300.903495482715, 19953.60092798136, 19961.20155193805, 19972.20111195565, 19988.10053547594, 18841.90579047096, 19536.902315488616, 19947.401577952685, 19959.700604490943, 20114.59770804605, 10119.190464762802, 10455.215858810467, 10455.902130276212, 10463.476826158814, 10474.266801323987, 7188.17336006366, 7318.3047610476915, 8464.83070338602, 8699.521526316114, 8883.42257753244, 16117.798130299328, 16498.092604906844, 16603.252853621376, 16740.330386784393, 17011.319547218467, 16534.503964881074, 16622.58972448964, 16658.000519968842, 16800.32798688088, 16853.831461685226, 11407.885921140682, 11510.53957841677, 11515.30908145514, 11539.538418463504, 11563.88436115628, 13401.731965360443, 13408.731825363244, 13429.0, 13466.461341546621, 13720.65698357549, 9445.149936505748, 10427.791444171226, 10888.128949684165, 10935.343879367263, 11150.442477876237, 10321.793564128526, 10441.477926103817, 10486.213533984828, 10613.840792388275, 10628.84056739134, 9241.861372079558, 9407.153356197976, 9438.905610943802, 9440.433573985583, 9441.811163776823, 7076.787696369117, 7120.287971202838, 7150.320719531636, 7225.169105552718, 7315.48791584584, 6981.022656827947, 7099.290070992859, 7146.535475194096, 7152.213256541881, 7164.391026762783], "value": 6381.135716254053, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.2046745674377, 501.7165301604593, 523.1786095829548, 527.7203082366348, 531.9175527793193, 6263.592866463677, 6280.780172693957, 6305.351752264049, 6314.084457753623, 6333.7783177588735, 5893.58744887858, 6145.863015342154, 6150.292716337623, 6161.353057928909, 6170.969145154279, 4901.754912254391, 4917.7786999585105, 4929.3591833061655, 4979.203327467606, 4984.501549845005, 4929.901401971958, 4963.25274417814, 4999.550040496355, 5032.622553308498, 5067.79728810849, 5149.021685879671, 5204.3234379530795, 5215.3741551013745, 5242.580593552507, 5246.24250875957, 5229.790808367661, 5233.973830130844, 5256.448072952342, 5265.341832270966, 5270.972160428718, 4796.976015119937, 4841.7337046462435, 4870.366852309213, 4902.529241227618, 4911.336969509106, 6165.907511387333, 6203.472704820096, 6213.658248796314, 6231.096491008779, 6234.968825155891, 6086.9391306087255, 6099.298580663191, 6107.908381374283, 6132.877342453171, 6168.784092556783, 6561.967190164019, 6570.5729127606555, 6640.402363787282, 6648.734050637969, 6716.0, 5334.493223143795, 5367.865803354908, 5369.650972686802, 5378.273933019071, 5384.596155288369, 6932.90431532823, 6966.582005079661, 7053.612051337123, 7082.822929426754, 7095.361417472401, 5462.0, 5463.743339031966, 5488.9725551372785, 5495.368032676213, 5530.170474428787, 5607.784760173078, 5623.718814059281, 5675.382515983008, 5680.77276908919, 5714.7428365723645, 6118.174046503754, 6120.002397650328, 6124.5100391968535, 6136.140940268366, 6152.415520525543, 6714.932850671528, 6728.629925354055, 6734.205304798454, 6741.4832062518235, 6750.696218670073, 1872.850171986238, 1918.098493707955, 1950.8244258016846, 1984.1468168687602, 1991.2234228650839, 1371.9161862129006, 1411.4495346814751, 1451.6298343922444, 1464.4947493114857, 1486.8810495160362, 5575.749091290902, 5622.57830662702, 5678.261825962681, 5681.289838770153, 5704.11586204139, 6542.476601871839, 6628.0, 6731.360520750521, 6744.898826517606, 6775.356341147583, 5709.716113554611, 5758.309002919593, 5782.508486778587, 5823.650580965155, 5838.941610583925, 3588.2464682416985, 3627.891163265106, 3628.6915612172734, 3642.399004164336, 3647.6899463545897, 6566.047923051131, 6569.211694596584, 6621.768238111739, 6640.302768209365, 6645.435138013323, 6926.896096558556, 6972.477064220204, 6996.720131194696, 7051.717931282794, 7053.647317634098, 6399.592089740249, 6545.116409284686, 6571.507136964651, 6631.63526006055, 6683.231428385603, 6749.42629876466, 6757.256701762703, 6788.558743681645, 6875.656217189221, 6879.931200687929, 6693.497987651043, 6717.865642687021, 6778.457723382019, 6861.348171923659, 6870.862582748417, 6612.0, 6621.470282377494, 6627.966860165669, 6642.778252547607, 6647.800565983028, 5020.297158397754, 5040.49595040493, 5073.518015788494, 5080.593552515864, 5097.1844504879045, 6698.0, 6754.129494964719, 6760.797176084725, 6866.279040700654, 6895.6552172390175, 6594.340565943367, 6602.636854973022, 6635.075828009823, 6694.497912656473, 6702.19573651165, 6434.774782882577, 6466.935330646634, 6591.703373348115, 6642.933570664231, 6654.76708315226, 6233.563650544418, 6385.425311721968, 6469.547131700736, 6527.184101987252, 6537.248216455168, 6122.78570250057, 6555.476721062451, 6558.1802274715665, 6643.966780166262, 6654.567453115532, 6293.307736148929, 6440.806775796734, 6464.41820236181, 6510.153680021567, 6515.478761699147], "value": 5215.414538833506, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [898.7887846356109, 913.0, 927.856182291745, 928.6146249306536, 930.2046750028725, 19174.137163827643, 20117.396478105682, 20123.59752804945, 20150.89924550377, 22964.311070667864, 18007.0, 18318.175682094305, 22663.773362266373, 22684.0, 22727.31818045457, 1039.2361614213567, 1070.0262760887595, 1071.1270314693538, 1071.201954543862, 1071.383954226319, 1077.3697387028558, 1077.6605369308643, 1078.309881675728, 1079.0180935348835, 1079.2175672637354, 1015.9593616255341, 1101.7961677089763, 1102.0357187460972, 1106.955721771128, 1107.601263545127, 1095.1840878545534, 1095.3373209208394, 1095.8630171228597, 1095.9178061645368, 1096.6216655253925, 782.9295363417319, 788.2550989315099, 790.2611058660113, 791.0072858562525, 792.8929594504725, 20212.69680954787, 20690.379288621367, 20782.896085519627, 20973.8951305244, 20985.475363116046, 21568.460788480257, 21884.671729924063, 21981.450463738376, 22319.10723571055, 22490.43773905649, 16008.679826403406, 16194.352225910949, 16261.51215463538, 16303.0, 16570.75143872843, 3606.6393360663988, 3630.6913912317486, 3645.0, 3645.0, 3648.543932008499, 135498.0, 136125.0, 137108.0, 138352.0, 140417.0, 16378.836211637969, 17060.744088838677, 17800.0, 17962.1018949052, 17977.0, 32769.50845737316, 32962.3407531848, 33771.15572110717, 33934.0, 33961.150971225914, 9155.771105722277, 9212.170904618617, 9218.354715169873, 9310.301727370474, 9352.812943741086, 4252.532221455637, 4260.616544511009, 4288.292431748727, 4315.266404711144, 4337.479502459725, 5272.578193744491, 5353.7590808413715, 5399.109146990702, 5417.702026388586, 5427.782888684487, 1045.9738506537244, 1068.951897164614, 1076.3757020927842, 1082.7617924056694, 1083.4907593431233, 558.2826068501955, 569.6638982999967, 570.338407447359, 570.589175793428, 573.2576313673802, 10926.945365273281, 11180.888191118147, 11238.0, 11268.267562608404, 11304.830427543593, 550.5402988504563, 550.9063459211943, 551.8261747549509, 557.1447827584639, 568.499720246189, 4840.15297322967, 5081.415637201695, 5143.0, 5172.922406163911, 5952.672603006789, 103135.4843225794, 104571.4771426138, 106433.0, 106439.0, 108979.0, 91972.54013729889, 92852.0, 94169.0, 95395.0, 95502.52248738712, 79134.0, 81264.0, 82395.0, 84825.57587212024, 86391.13608863957, 12002.1598488105, 12092.214006089576, 12117.15179937396, 12244.816327754912, 12264.754704905674, 37499.43750843794, 37578.436323454625, 37987.43018854775, 38488.0, 38993.220135597694, 47427.288590670476, 47826.760866195444, 48339.27491087566, 49239.75380123076, 49341.76645583889, 17097.0, 17700.91149544244, 17816.821831782036, 17916.283348665907, 17931.193096310435, 19182.13680384414, 19229.615407692047, 19276.710849337553, 19357.806421935602, 19469.805301947366, 17294.01118871346, 17476.475705728848, 17485.300587976337, 17820.198091086193, 17998.460046198634, 17447.738283925497, 17656.293748249926, 17688.646227075646, 18067.63864722672, 18381.356652517632, 17370.913145434697, 17519.211635476688, 17596.912015440354, 17633.20650570753, 17762.200700968227, 13011.284379359226, 13027.544035958696, 13115.278659673428, 13232.933835330761, 13324.866751332362, 13340.86659133435, 13449.529266475627, 13526.526571569948, 13556.796648050484, 13581.388837502138], "value": 9019.002134003867, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 100.0, 106.0, 106.0, 108.0, 109.0, 98.0, 109.0, 111.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 157.0, 166.0, 117.0, 148.0, 145.0, 122.0, 173.0, 118.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 166.0, 162.0, 174.0, 163.0, 163.0, 165.0, 169.0, 163.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 178.0, 75.0, 74.0, 74.0, 92.0, 100.0, 75.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 131.0, 78.0, 78.0, 79.0, 135.0, 79.0, 79.0, 126.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 152.0, 154.0, 150.0, 154.0, 151.0, 151.0, 152.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 56.0, 55.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 53.0, 54.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 90.0, 84.0, 78.0, 79.0, 78.0, 79.0, 82.0, 78.0, 77.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 145.0, 131.0, 146.0, 124.0, 127.0, 135.0, 135.0, 134.0, 166.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 177.0, 175.0, 180.0, 177.0, 174.0, 175.0, 176.0, 174.0, 174.0], "value": 177.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 68.0, 64.0, 68.0, 64.0, 64.0, 64.0, 66.0, 66.0, 68.0], "value": 66.6, "unit": "score"}]}]} 07:26:17 INFO - Return code: 0 07:26:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:26:17 INFO - # TBPL SUCCESS # 07:26:17 INFO - Running post-action listener: _package_coverage_data 07:26:17 INFO - Running post-action listener: _resource_record_post_action 07:26:17 INFO - [mozharness: 2017-08-06 14:26:17.393837Z] Finished run-tests step (success) 07:26:17 INFO - Running post-run listener: _resource_record_post_run 07:26:17 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 143360; Write bytes: 431529984; Read time: 40; Write time: 330096 07:26:17 INFO - TinderboxPrint: CPU usage
13.1% 07:26:17 INFO - TinderboxPrint: I/O read bytes / time
143,360 / 40 07:26:17 INFO - TinderboxPrint: I/O write bytes / time
431,529,984 / 330,096 07:26:17 INFO - TinderboxPrint: CPU idle
8,268.2 (86.8%) 07:26:17 INFO - TinderboxPrint: CPU user
1,203.7 (12.6%) 07:26:17 INFO - TinderboxPrint: Swap in / out
0 / 0 07:26:17 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106176512; Read time: 0; Write time: 99952 07:26:17 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:26:17 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 143360; Write bytes: 323596288; Read time: 40; Write time: 230052 07:26:18 INFO - Running post-run listener: _upload_blobber_files 07:26:18 INFO - Blob upload gear active. 07:26:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:26:18 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 07:26:18 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:26:18 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:26:18 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:26:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:26:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:19 INFO - (blobuploader) - INFO - Done attempting. 07:26:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:26:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:26:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:20 INFO - (blobuploader) - INFO - Done attempting. 07:26:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:26:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:23 INFO - (blobuploader) - INFO - Done attempting. 07:26:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:26:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:26:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:24 INFO - (blobuploader) - INFO - Done attempting. 07:26:24 INFO - (blobuploader) - INFO - Iteration through files over. 07:26:24 INFO - Return code: 0 07:26:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:26:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:26:24 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b63c479fb651b05d3cc1b39bf80f880d177d1af1e9a2ea271b9397bd6da50a4eebf4784a40e95ff030a50dfa81d2343fe07d4453635fc6a5d94c0d352c609ee9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1abd6c561dbbb8ba4aba80b8c20374e6630a85ef7038749984b4945fb66c0b927dae8a1046b328419d72686602b1dfe780acac8e21f902f8ff5b20a30b4a63f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8719830afd862cde9ef46a54883d42019e62c96104acb0e725e99d2fbe76c58e38cab5e3ce4a90c959de603d897040d35e5479486844828d69d2ca585bf2dc59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f0918aeb449ab7a78d7377ef5cc916fa6e5da258febe6134654fa7ce33ee5ab9f8c24e18e24f0e66752f64eec9a1dee6839c0f7f42a6042fb43028975b2605c"} 07:26:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:26:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:26:24 INFO - Contents: 07:26:24 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b63c479fb651b05d3cc1b39bf80f880d177d1af1e9a2ea271b9397bd6da50a4eebf4784a40e95ff030a50dfa81d2343fe07d4453635fc6a5d94c0d352c609ee9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1abd6c561dbbb8ba4aba80b8c20374e6630a85ef7038749984b4945fb66c0b927dae8a1046b328419d72686602b1dfe780acac8e21f902f8ff5b20a30b4a63f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8719830afd862cde9ef46a54883d42019e62c96104acb0e725e99d2fbe76c58e38cab5e3ce4a90c959de603d897040d35e5479486844828d69d2ca585bf2dc59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f0918aeb449ab7a78d7377ef5cc916fa6e5da258febe6134654fa7ce33ee5ab9f8c24e18e24f0e66752f64eec9a1dee6839c0f7f42a6042fb43028975b2605c"} 07:26:24 INFO - Running post-run listener: copy_logs_to_upload_dir 07:26:24 INFO - Copying logs to upload dir... 07:26:24 INFO - mkdir: /builds/slave/test/build/upload/logs 07:26:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.748788 ========= master_lag: 0.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-06 07:26:24.675422) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 07:26:24.680529) ========= 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=836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b63c479fb651b05d3cc1b39bf80f880d177d1af1e9a2ea271b9397bd6da50a4eebf4784a40e95ff030a50dfa81d2343fe07d4453635fc6a5d94c0d352c609ee9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1abd6c561dbbb8ba4aba80b8c20374e6630a85ef7038749984b4945fb66c0b927dae8a1046b328419d72686602b1dfe780acac8e21f902f8ff5b20a30b4a63f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8719830afd862cde9ef46a54883d42019e62c96104acb0e725e99d2fbe76c58e38cab5e3ce4a90c959de603d897040d35e5479486844828d69d2ca585bf2dc59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f0918aeb449ab7a78d7377ef5cc916fa6e5da258febe6134654fa7ce33ee5ab9f8c24e18e24f0e66752f64eec9a1dee6839c0f7f42a6042fb43028975b2605c"} build_url:https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b63c479fb651b05d3cc1b39bf80f880d177d1af1e9a2ea271b9397bd6da50a4eebf4784a40e95ff030a50dfa81d2343fe07d4453635fc6a5d94c0d352c609ee9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1abd6c561dbbb8ba4aba80b8c20374e6630a85ef7038749984b4945fb66c0b927dae8a1046b328419d72686602b1dfe780acac8e21f902f8ff5b20a30b4a63f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8719830afd862cde9ef46a54883d42019e62c96104acb0e725e99d2fbe76c58e38cab5e3ce4a90c959de603d897040d35e5479486844828d69d2ca585bf2dc59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f0918aeb449ab7a78d7377ef5cc916fa6e5da258febe6134654fa7ce33ee5ab9f8c24e18e24f0e66752f64eec9a1dee6839c0f7f42a6042fb43028975b2605c"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 07:26:24.768780) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:26:24.773284) ========= 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=836cfdc75598d54cb747368e000001a9-1502015120.304465-1733588040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:26:24.800434) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 07:26:24.800735) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 07:26:24.801044) ========= ========= Total master_lag: 0.66 =========