builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1502028331.4 results: success (0) revision: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.398134) ========= 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.398527) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.398815) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.424481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.424752) ========= 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=ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549 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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-08-06 07:05:31 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131288 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.572543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.572836) ========= 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=ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023499 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.642613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:31.642914) ========= 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=ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-06 07:05:32,121 truncating revision to first 12 chars 2017-08-06 07:05:32,121 Setting DEBUG logging. 2017-08-06 07:05:32,121 attempt 1/10 2017-08-06 07:05:32,121 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,574 unpacking tar archive at: mozilla-central-fe6609d22dfd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.774976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:32.440060) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:32.440352) ========= script_repo_revision: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:32.440717) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:32.440996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 07:05:32.452071) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-06 07:05:32.452356) ========= /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=ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:05:33 INFO - MultiFileLogger online at 20170806 07:05:33 in /builds/slave/test 07:05:33 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:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:05:33 INFO - {'append_to_log': False, 07:05:33 INFO - 'base_work_dir': '/builds/slave/test', 07:05:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:05:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:05:33 INFO - 'branch': 'Firefox-Non-PGO', 07:05:33 INFO - 'buildbot_json_path': 'buildprops.json', 07:05:33 INFO - 'code_coverage': False, 07:05:33 INFO - 'config_files': ('talos/linux_config.py',), 07:05:33 INFO - 'default_actions': ('clobber', 07:05:33 INFO - 'read-buildbot-config', 07:05:33 INFO - 'download-and-extract', 07:05:33 INFO - 'populate-webroot', 07:05:33 INFO - 'create-virtualenv', 07:05:33 INFO - 'install', 07:05:33 INFO - 'setup-mitmproxy', 07:05:33 INFO - 'run-tests'), 07:05:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:05:33 INFO - 'disable_ccov_upload': False, 07:05:33 INFO - 'download_minidump_stackwalk': True, 07:05:33 INFO - 'download_symbols': 'ondemand', 07:05:33 INFO - 'enable_stylo': False, 07:05:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:05:33 INFO - 'tooltool.py': '/tools/tooltool.py', 07:05:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:05:33 INFO - '/tools/misc-python/virtualenv.py')}, 07:05:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:05:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:05:33 INFO - 'gecko_profile': False, 07:05:33 INFO - 'gecko_profile_interval': 0, 07:05:33 INFO - 'installer_path': 'installer.exe', 07:05:33 INFO - 'log_level': 'info', 07:05:33 INFO - 'log_name': 'talos', 07:05:33 INFO - 'log_to_console': True, 07:05:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:05:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:05:33 INFO - 'opt_config_files': (), 07:05:33 INFO - 'pip_index': False, 07:05:33 INFO - 'suite': 'dromaeojs-e10s', 07:05:33 INFO - 'system_bits': '32', 07:05:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:05:33 INFO - 'title': 'talos-linux64-ix-029', 07:05:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:05:33 INFO - 'use_talos_json': True, 07:05:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:05:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:05:33 INFO - 'work_dir': 'build'} 07:05:33 INFO - [mozharness: 2017-08-06 14:05:33.037850Z] Running clobber step. 07:05:33 INFO - Running pre-action listener: _resource_record_pre_action 07:05:33 INFO - Running main action method: clobber 07:05:33 INFO - rmtree: /builds/slave/test/build 07:05:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:05:34 INFO - Running post-action listener: _resource_record_post_action 07:05:34 INFO - [mozharness: 2017-08-06 14:05:34.583333Z] Finished clobber step (success) 07:05:34 INFO - [mozharness: 2017-08-06 14:05:34.583433Z] Running read-buildbot-config step. 07:05:34 INFO - Running pre-action listener: _resource_record_pre_action 07:05:34 INFO - Running main action method: read_buildbot_config 07:05:34 INFO - Using buildbot properties: 07:05:34 INFO - { 07:05:34 INFO - "project": "", 07:05:34 INFO - "product": "firefox", 07:05:34 INFO - "who": "archaeopteryx@coole-files.de", 07:05:34 INFO - "installer_path": "public/build/target.tar.bz2", 07:05:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:05:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:05:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:05:34 INFO - "stage_platform": "linux64", 07:05:34 INFO - "basedir": "/builds/slave/test", 07:05:34 INFO - "buildnumber": 758, 07:05:34 INFO - "platform": "ubuntu64_hw", 07:05:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:05:34 INFO - "slavebuilddir": "test", 07:05:34 INFO - "taskId": "DpgidOYARVOZFGyK2-5FwA", 07:05:34 INFO - "branch": "mozilla-central", 07:05:34 INFO - "script_repo_revision": "production", 07:05:34 INFO - "revision": "fe6609d22dfdd710b11e3ac7773aff89f7a8d12c", 07:05:34 INFO - "slavename": "talos-linux64-ix-029", 07:05:34 INFO - "repo_path": "mozilla-central" 07:05:34 INFO - } 07:05:34 INFO - Finding installer, test and symbols from parent task. 07:05:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpgidOYARVOZFGyK2-5FwA'}, attempt #1 07:05:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpgidOYARVOZFGyK2-5FwA'}, attempt #1 07:05:35 INFO - Task dependencies: Ph1H-2ZlRnGCNKdcz7C8dw 07:05:35 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.926761Z] Finished read-buildbot-config step (success) 07:05:35 INFO - [mozharness: 2017-08-06 14:05:35.926981Z] 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:36 INFO - Downloaded 989 bytes. 07:05:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:05:36 INFO - Using the following test package requirements: 07:05:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:05:36 INFO - u'common': [u'target.common.tests.zip'], 07:05:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:05:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:05:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:05:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:05:36 INFO - u'mozbase': [u'target.common.tests.zip'], 07:05:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:05:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:05:36 INFO - u'web-platform': [u'target.common.tests.zip', 07:05:36 INFO - u'target.web-platform.tests.tar.gz'], 07:05:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:05:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:05:36 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:36 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:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip into memory 07:05:38 INFO - Content-Length response header: 54284831 07:05:38 INFO - Bytes received: 54284831 07:05:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:05:49 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:49 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:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip into memory 07:05:50 INFO - Content-Length response header: 54284831 07:05:50 INFO - Bytes received: 54284831 07:06:02 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:02 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:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.talos.tests.zip into memory 07:06:02 INFO - Content-Length response header: 14496008 07:06:02 INFO - Bytes received: 14496008 07:06:03 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:03 INFO - trying https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 07:06:03 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:03 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:04 INFO - Downloaded 61880648 bytes. 07:06:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 07:06:04 INFO - mkdir: /builds/slave/test/properties 07:06:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:06:04 INFO - Writing to file /builds/slave/test/properties/build_url 07:06:04 INFO - Contents: 07:06:04 INFO - build_url:https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 07:06:04 INFO - Running post-action listener: _resource_record_post_action 07:06:04 INFO - Running post-action listener: set_extra_try_arguments 07:06:04 INFO - [mozharness: 2017-08-06 14:06:04.392287Z] Finished download-and-extract step (success) 07:06:04 INFO - [mozharness: 2017-08-06 14:06:04.392385Z] Running populate-webroot step. 07:06:04 INFO - Running pre-action listener: _resource_record_pre_action 07:06:04 INFO - Running main action method: populate_webroot 07:06:04 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:06:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:06:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:06:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:06:04 INFO - 'tests': ['damp', 'tps']}, 07:06:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:06:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:06:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:06:04 INFO - 'other-e10s': {'tests': ['a11yr', 07:06:04 INFO - 'ts_paint', 07:06:04 INFO - 'tpaint', 07:06:04 INFO - 'sessionrestore', 07:06:04 INFO - 'sessionrestore_many_windows', 07:06:04 INFO - 'sessionrestore_no_auto_restore', 07:06:04 INFO - 'tabpaint']}, 07:06:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:06:04 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 07:06:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:06:04 INFO - 'tsvgr_opacity', 07:06:04 INFO - 'tart', 07:06:04 INFO - 'tscrollx', 07:06:04 INFO - 'tsvg_static']}, 07:06:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:06:04 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:06:04 INFO - 'talos_options': ['--mitmproxy', 07:06:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:06:04 INFO - '--firstNonBlankPaint'], 07:06:04 INFO - 'tests': ['tp6_google', 07:06:04 INFO - 'tp6_youtube', 07:06:04 INFO - 'tp6_amazon', 07:06:04 INFO - 'tp6_facebook']}, 07:06:04 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:06:04 INFO - 'talos_options': ['--stylo', 07:06:04 INFO - '--mitmproxy', 07:06:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:06:04 INFO - '--firstNonBlankPaint'], 07:06:04 INFO - 'tests': ['tp6_google', 07:06:04 INFO - 'tp6_youtube', 07:06:04 INFO - 'tp6_amazon', 07:06:04 INFO - 'tp6_facebook']}, 07:06:04 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:06:04 INFO - 'talos_options': ['--stylo', 07:06:04 INFO - '--stylo-threads=1', 07:06:04 INFO - '--mitmproxy', 07:06:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:06:04 INFO - '--firstNonBlankPaint'], 07:06:04 INFO - 'tests': ['tp6_google', 07:06:04 INFO - 'tp6_youtube', 07:06:04 INFO - 'tp6_amazon', 07:06:04 INFO - 'tp6_facebook']}, 07:06:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:06:04 INFO - 'talos_options': ['--xperf_path', 07:06:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:04 INFO - 'tests': ['tp5n']}}} 07:06:04 INFO - Running post-action listener: _resource_record_post_action 07:06:04 INFO - [mozharness: 2017-08-06 14:06:04.400735Z] Finished populate-webroot step (success) 07:06:04 INFO - [mozharness: 2017-08-06 14:06:04.400824Z] Running create-virtualenv step. 07:06:04 INFO - Running pre-action listener: _resource_record_pre_action 07:06:04 INFO - Running main action method: create_virtualenv 07:06:04 INFO - Creating virtualenv /builds/slave/test/build/venv 07:06:04 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:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:06:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:06:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:04 INFO - Using real prefix '/usr' 07:06:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:06:04 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:06 INFO - Installing pip.................done. 07:06:06 INFO - Return code: 0 07:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:06:07 INFO - Reading from file tmpfile_stdout 07:06:07 INFO - Output received: 07:06:07 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:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:06:07 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:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:07 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:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf42d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3feb0>, '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 0xf40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf41240>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', '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:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:06:07 INFO - Using env: {'DISPLAY': ':0', 07:06:07 INFO - 'HOME': '/home/cltbld', 07:06:07 INFO - 'LANG': 'en_US.UTF-8', 07:06:07 INFO - 'LANGUAGE': 'en_US:en', 07:06:07 INFO - 'LOGNAME': 'cltbld', 07:06:07 INFO - 'MAIL': '/var/mail/cltbld', 07:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:07 INFO - 'MOZ_NO_REMOTE': '1', 07:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:07 INFO - 'NO_EM_RESTART': '1', 07:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:07 INFO - 'PWD': '/builds/slave/test', 07:06:07 INFO - 'SHELL': '/bin/bash', 07:06:07 INFO - 'SHLVL': '1', 07:06:07 INFO - 'TERM': 'linux', 07:06:07 INFO - 'TMOUT': '86400', 07:06:07 INFO - 'USER': 'cltbld', 07:06:07 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', 07:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:07 INFO - '_': '/tools/buildbot/bin/python'} 07:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:07 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:07 INFO - Cleaning up... 07:06:07 INFO - Return code: 0 07:06:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:06:07 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:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:07 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:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf42d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3feb0>, '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 0xf40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf41240>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', '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:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:06:07 INFO - Using env: {'DISPLAY': ':0', 07:06:07 INFO - 'HOME': '/home/cltbld', 07:06:07 INFO - 'LANG': 'en_US.UTF-8', 07:06:07 INFO - 'LANGUAGE': 'en_US:en', 07:06:07 INFO - 'LOGNAME': 'cltbld', 07:06:07 INFO - 'MAIL': '/var/mail/cltbld', 07:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:07 INFO - 'MOZ_NO_REMOTE': '1', 07:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:07 INFO - 'NO_EM_RESTART': '1', 07:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:07 INFO - 'PWD': '/builds/slave/test', 07:06:07 INFO - 'SHELL': '/bin/bash', 07:06:07 INFO - 'SHLVL': '1', 07:06:07 INFO - 'TERM': 'linux', 07:06:07 INFO - 'TMOUT': '86400', 07:06:07 INFO - 'USER': 'cltbld', 07:06:07 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', 07:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:07 INFO - '_': '/tools/buildbot/bin/python'} 07:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:07 INFO - Downloading/unpacking psutil>=3.1.1 07:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 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 - Installing collected packages: psutil 07:06:08 INFO - Running setup.py install for psutil 07:06:08 INFO - building 'psutil._psutil_linux' extension 07:06:08 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:09 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:09 INFO - building 'psutil._psutil_posix' extension 07:06:09 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:09 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:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:09 INFO - Successfully installed psutil 07:06:09 INFO - Cleaning up... 07:06:09 INFO - Return code: 0 07:06:09 INFO - Installing mozsystemmonitor==0.3 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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf42d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3feb0>, '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 0xf40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf41240>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', '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', 'mozsystemmonitor==0.3'] 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 mozsystemmonitor==0.3 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': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', 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 mozsystemmonitor==0.3 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:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:10 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:10 INFO - Installing collected packages: mozsystemmonitor 07:06:10 INFO - Running setup.py install for mozsystemmonitor 07:06:10 INFO - Successfully installed mozsystemmonitor 07:06:10 INFO - Cleaning up... 07:06:10 INFO - Return code: 0 07:06:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf42d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3feb0>, '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 0xf40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf41240>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', '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:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:06:10 INFO - Using env: {'DISPLAY': ':0', 07:06:10 INFO - 'HOME': '/home/cltbld', 07:06:10 INFO - 'LANG': 'en_US.UTF-8', 07:06:10 INFO - 'LANGUAGE': 'en_US:en', 07:06:10 INFO - 'LOGNAME': 'cltbld', 07:06:10 INFO - 'MAIL': '/var/mail/cltbld', 07:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:10 INFO - 'MOZ_NO_REMOTE': '1', 07:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:10 INFO - 'NO_EM_RESTART': '1', 07:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:10 INFO - 'PWD': '/builds/slave/test', 07:06:10 INFO - 'SHELL': '/bin/bash', 07:06:10 INFO - 'SHLVL': '1', 07:06:10 INFO - 'TERM': 'linux', 07:06:10 INFO - 'TMOUT': '86400', 07:06:10 INFO - 'USER': 'cltbld', 07:06:10 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', 07:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:10 INFO - '_': '/tools/buildbot/bin/python'} 07:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:11 INFO - Downloading/unpacking 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:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:12 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:12 INFO - warning: no files found matching '*.txt' 07:06:12 INFO - no previously-included directories found matching 'build' 07:06:12 INFO - no previously-included directories found matching 'dist' 07:06:12 INFO - no previously-included directories found matching '.git*' 07:06:12 INFO - Installing collected packages: jsonschema, functools32 07:06:12 INFO - Running setup.py install for functools32 07:06:12 INFO - warning: no files found matching '*.txt' 07:06:12 INFO - no previously-included directories found matching 'build' 07:06:12 INFO - no previously-included directories found matching 'dist' 07:06:12 INFO - no previously-included directories found matching '.git*' 07:06:12 INFO - Successfully installed jsonschema functools32 07:06:12 INFO - Cleaning up... 07:06:12 INFO - Return code: 0 07:06:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf42d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3feb0>, '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 0xf40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf41240>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', '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:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:06:12 INFO - Using env: {'DISPLAY': ':0', 07:06:12 INFO - 'HOME': '/home/cltbld', 07:06:12 INFO - 'LANG': 'en_US.UTF-8', 07:06:12 INFO - 'LANGUAGE': 'en_US:en', 07:06:12 INFO - 'LOGNAME': 'cltbld', 07:06:12 INFO - 'MAIL': '/var/mail/cltbld', 07:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:12 INFO - 'MOZ_NO_REMOTE': '1', 07:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:12 INFO - 'NO_EM_RESTART': '1', 07:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:12 INFO - 'PWD': '/builds/slave/test', 07:06:12 INFO - 'SHELL': '/bin/bash', 07:06:12 INFO - 'SHLVL': '1', 07:06:12 INFO - 'TERM': 'linux', 07:06:12 INFO - 'TMOUT': '86400', 07:06:12 INFO - 'USER': 'cltbld', 07:06:12 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', 07:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:12 INFO - '_': '/tools/buildbot/bin/python'} 07:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:06:12 INFO - Cleaning up... 07:06:12 INFO - Return code: 0 07:06:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf42d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3feb0>, '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 0xf40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf41240>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', '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:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:06:12 INFO - Using env: {'DISPLAY': ':0', 07:06:12 INFO - 'HOME': '/home/cltbld', 07:06:12 INFO - 'LANG': 'en_US.UTF-8', 07:06:12 INFO - 'LANGUAGE': 'en_US:en', 07:06:12 INFO - 'LOGNAME': 'cltbld', 07:06:12 INFO - 'MAIL': '/var/mail/cltbld', 07:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:12 INFO - 'MOZ_NO_REMOTE': '1', 07:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:12 INFO - 'NO_EM_RESTART': '1', 07:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:12 INFO - 'PWD': '/builds/slave/test', 07:06:12 INFO - 'SHELL': '/bin/bash', 07:06:12 INFO - 'SHLVL': '1', 07:06:12 INFO - 'TERM': 'linux', 07:06:12 INFO - 'TMOUT': '86400', 07:06:12 INFO - 'USER': 'cltbld', 07:06:12 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', 07:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:12 INFO - '_': '/tools/buildbot/bin/python'} 07:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:12 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:14 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:14 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:14 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:14 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:14 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:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:06:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:14 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:14 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:14 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:14 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:14 INFO - Downloading docopt-0.6.1.tar.gz 07:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:14 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:14 INFO - Running setup.py install for blobuploader 07:06:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:06:14 INFO - Running setup.py install for requests 07:06:15 INFO - Running setup.py install for docopt 07:06:15 INFO - Successfully installed blobuploader requests docopt 07:06:15 INFO - Cleaning up... 07:06:15 INFO - Return code: 0 07:06:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:15 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:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:15 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:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:15 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 0xbd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf42d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3feb0>, '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 0xf40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf41240>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', '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:15 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:15 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:15 INFO - Using env: {'DISPLAY': ':0', 07:06:15 INFO - 'HOME': '/home/cltbld', 07:06:15 INFO - 'LANG': 'en_US.UTF-8', 07:06:15 INFO - 'LANGUAGE': 'en_US:en', 07:06:15 INFO - 'LOGNAME': 'cltbld', 07:06:15 INFO - 'MAIL': '/var/mail/cltbld', 07:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:15 INFO - 'MOZ_NO_REMOTE': '1', 07:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:15 INFO - 'NO_EM_RESTART': '1', 07:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:15 INFO - 'PWD': '/builds/slave/test', 07:06:15 INFO - 'SHELL': '/bin/bash', 07:06:15 INFO - 'SHLVL': '1', 07:06:15 INFO - 'TERM': 'linux', 07:06:15 INFO - 'TMOUT': '86400', 07:06:15 INFO - 'USER': 'cltbld', 07:06:15 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', 07:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:15 INFO - '_': '/tools/buildbot/bin/python'} 07:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:15 INFO - Running setup.py (path:/tmp/pip-kpQhvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:15 INFO - Running setup.py (path:/tmp/pip-c4u0Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:15 INFO - Running setup.py (path:/tmp/pip-MOR3Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:15 INFO - Running setup.py (path:/tmp/pip-I8I195-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:15 INFO - Running setup.py (path:/tmp/pip-I4DHvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:15 INFO - Running setup.py (path:/tmp/pip-CouBde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:15 INFO - Running setup.py (path:/tmp/pip-h2lTaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:15 INFO - Running setup.py (path:/tmp/pip-skWgw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:16 INFO - Running setup.py (path:/tmp/pip-Uh9CnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:16 INFO - Running setup.py (path:/tmp/pip-JpkkIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:16 INFO - Running setup.py (path:/tmp/pip-nfsKFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:16 INFO - Running setup.py (path:/tmp/pip-cCMiKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:16 INFO - Running setup.py (path:/tmp/pip-zg27Ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:16 INFO - Running setup.py (path:/tmp/pip-p3Q_HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:16 INFO - Running setup.py (path:/tmp/pip-4b13Ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:16 INFO - Running setup.py (path:/tmp/pip-2CKhsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:16 INFO - Running setup.py (path:/tmp/pip-ugkbY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:16 INFO - Running setup.py install for manifestparser 07:06:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:06:16 INFO - Running setup.py install for mozcrash 07:06:16 INFO - Running setup.py install for mozdebug 07:06:16 INFO - Running setup.py install for mozdevice 07:06:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Running setup.py install for mozfile 07:06:17 INFO - Running setup.py install for mozhttpd 07:06:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Running setup.py install for mozinfo 07:06:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Running setup.py install for mozInstall 07:06:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Running setup.py install for mozleak 07:06:17 INFO - Running setup.py install for mozlog 07:06:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Running setup.py install for moznetwork 07:06:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:06:17 INFO - Running setup.py install for mozprocess 07:06:17 INFO - Running setup.py install for mozprofile 07:06:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:06:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:06:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:06:18 INFO - Running setup.py install for mozrunner 07:06:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:06:18 INFO - Running setup.py install for mozscreenshot 07:06:18 INFO - Running setup.py install for moztest 07:06:18 INFO - Running setup.py install for mozversion 07:06:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:06:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:18 INFO - Cleaning up... 07:06:18 INFO - Return code: 0 07:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:18 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 0xbd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf42d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3feb0>, '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 0xf40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf41240>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', '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:18 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:18 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:18 INFO - Using env: {'DISPLAY': ':0', 07:06:18 INFO - 'HOME': '/home/cltbld', 07:06:18 INFO - 'LANG': 'en_US.UTF-8', 07:06:18 INFO - 'LANGUAGE': 'en_US:en', 07:06:18 INFO - 'LOGNAME': 'cltbld', 07:06:18 INFO - 'MAIL': '/var/mail/cltbld', 07:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:18 INFO - 'MOZ_NO_REMOTE': '1', 07:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:18 INFO - 'NO_EM_RESTART': '1', 07:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:18 INFO - 'PWD': '/builds/slave/test', 07:06:18 INFO - 'SHELL': '/bin/bash', 07:06:18 INFO - 'SHLVL': '1', 07:06:18 INFO - 'TERM': 'linux', 07:06:18 INFO - 'TMOUT': '86400', 07:06:18 INFO - 'USER': 'cltbld', 07:06:18 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', 07:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:18 INFO - '_': '/tools/buildbot/bin/python'} 07:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:18 INFO - Running setup.py (path:/tmp/pip-UqYBJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:18 INFO - Running setup.py (path:/tmp/pip-L9d_C9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:18 INFO - Running setup.py (path:/tmp/pip-CId50v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:18 INFO - Running setup.py (path:/tmp/pip-cWTh28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:18 INFO - Running setup.py (path:/tmp/pip-_0oFVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:19 INFO - Running setup.py (path:/tmp/pip-KkUD15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:19 INFO - Running setup.py (path:/tmp/pip-p5zLeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:19 INFO - Running setup.py (path:/tmp/pip-haSdqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:19 INFO - Running setup.py (path:/tmp/pip-sWubM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:19 INFO - Running setup.py (path:/tmp/pip-H0PtuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:19 INFO - Running setup.py (path:/tmp/pip-EH3jB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:19 INFO - Running setup.py (path:/tmp/pip-KlD5uR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:19 INFO - Running setup.py (path:/tmp/pip-r10wKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:19 INFO - Running setup.py (path:/tmp/pip-OaRhM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:19 INFO - Running setup.py (path:/tmp/pip-qdSewW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:19 INFO - Running setup.py (path:/tmp/pip-L40Kp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:19 INFO - Running setup.py (path:/tmp/pip-zigfcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:06:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:20 INFO - Downloading blessings-1.6.tar.gz 07:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:21 INFO - Installing collected packages: blessings 07:06:21 INFO - Running setup.py install for blessings 07:06:21 INFO - Successfully installed blessings 07:06:21 INFO - Cleaning up... 07:06:21 INFO - Return code: 0 07:06:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:06:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:21 INFO - Reading from file tmpfile_stdout 07:06:21 INFO - Current package versions: 07:06:21 INFO - argparse == 1.2.1 07:06:21 INFO - blessings == 1.6 07:06:21 INFO - blobuploader == 1.2.4 07:06:21 INFO - docopt == 0.6.1 07:06:21 INFO - functools32 == 3.2.3-2 07:06:21 INFO - jsonschema == 2.5.1 07:06:21 INFO - manifestparser == 1.1 07:06:21 INFO - mozInstall == 1.13 07:06:21 INFO - mozcrash == 1.0 07:06:21 INFO - mozdebug == 0.1 07:06:21 INFO - mozdevice == 0.51 07:06:21 INFO - mozfile == 1.2 07:06:21 INFO - mozhttpd == 0.7 07:06:21 INFO - mozinfo == 0.10 07:06:21 INFO - mozleak == 0.1 07:06:21 INFO - mozlog == 3.5 07:06:21 INFO - moznetwork == 0.27 07:06:21 INFO - mozprocess == 0.25 07:06:21 INFO - mozprofile == 0.28 07:06:21 INFO - mozrunner == 6.13 07:06:21 INFO - mozscreenshot == 0.1 07:06:21 INFO - mozsystemmonitor == 0.3 07:06:21 INFO - moztest == 0.8 07:06:21 INFO - mozversion == 1.4 07:06:21 INFO - psutil == 3.1.1 07:06:21 INFO - requests == 1.2.3 07:06:21 INFO - wsgiref == 0.1.2 07:06:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:21 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:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:21 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:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf42d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3feb0>, '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 0xf40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf41240>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', '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:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:06:21 INFO - Using env: {'DISPLAY': ':0', 07:06:21 INFO - 'HOME': '/home/cltbld', 07:06:21 INFO - 'LANG': 'en_US.UTF-8', 07:06:21 INFO - 'LANGUAGE': 'en_US:en', 07:06:21 INFO - 'LOGNAME': 'cltbld', 07:06:21 INFO - 'MAIL': '/var/mail/cltbld', 07:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:21 INFO - 'MOZ_NO_REMOTE': '1', 07:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:21 INFO - 'NO_EM_RESTART': '1', 07:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:21 INFO - 'PWD': '/builds/slave/test', 07:06:21 INFO - 'SHELL': '/bin/bash', 07:06:21 INFO - 'SHLVL': '1', 07:06:21 INFO - 'TERM': 'linux', 07:06:21 INFO - 'TMOUT': '86400', 07:06:21 INFO - 'USER': 'cltbld', 07:06:21 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', 07:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:21 INFO - '_': '/tools/buildbot/bin/python'} 07:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:06:21 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:06:22 INFO - Installing collected packages: simplejson 07:06:22 INFO - Running setup.py install for simplejson 07:06:22 INFO - building 'simplejson._speedups' extension 07:06:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 07:06:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 07:06:23 INFO - Successfully installed simplejson 07:06:23 INFO - Cleaning up... 07:06:23 INFO - Return code: 0 07:06:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf42d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3feb0>, '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 0xf40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf41240>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', '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:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:06:23 INFO - Using env: {'DISPLAY': ':0', 07:06:23 INFO - 'HOME': '/home/cltbld', 07:06:23 INFO - 'LANG': 'en_US.UTF-8', 07:06:23 INFO - 'LANGUAGE': 'en_US:en', 07:06:23 INFO - 'LOGNAME': 'cltbld', 07:06:23 INFO - 'MAIL': '/var/mail/cltbld', 07:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:23 INFO - 'MOZ_NO_REMOTE': '1', 07:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:23 INFO - 'NO_EM_RESTART': '1', 07:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:23 INFO - 'PWD': '/builds/slave/test', 07:06:23 INFO - 'SHELL': '/bin/bash', 07:06:23 INFO - 'SHLVL': '1', 07:06:23 INFO - 'TERM': 'linux', 07:06:23 INFO - 'TMOUT': '86400', 07:06:23 INFO - 'USER': 'cltbld', 07:06:23 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', 07:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:23 INFO - '_': '/tools/buildbot/bin/python'} 07:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:06:24 INFO - Cleaning up... 07:06:24 INFO - Return code: 0 07:06:24 INFO - Running post-action listener: _resource_record_post_action 07:06:24 INFO - Running post-action listener: _start_resource_monitoring 07:06:24 INFO - Starting resource monitoring. 07:06:24 INFO - [mozharness: 2017-08-06 14:06:24.156901Z] Finished create-virtualenv step (success) 07:06:24 INFO - [mozharness: 2017-08-06 14:06:24.157549Z] Running install step. 07:06:24 INFO - Running pre-action listener: _resource_record_pre_action 07:06:24 INFO - Running main action method: install 07:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:24 INFO - Reading from file tmpfile_stdout 07:06:24 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:06:24 INFO - Reading from file tmpfile_stdout 07:06:24 INFO - Output received: 07:06:24 INFO - Usage: mozinstall [options] installer 07:06:24 INFO - Options: 07:06:24 INFO - -h, --help show this help message and exit 07:06:24 INFO - -d DEST, --destination=DEST 07:06:24 INFO - Directory to install application into. [default: 07:06:24 INFO - "/builds/slave/test"] 07:06:24 INFO - --app=APP Application being installed. [default: firefox] 07:06:24 INFO - mkdir: /builds/slave/test/build/application 07:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:06:24 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:42 INFO - Reading from file tmpfile_stdout 07:06:42 INFO - Output received: 07:06:42 INFO - /builds/slave/test/build/application/firefox/firefox 07:06:42 INFO - Running post-action listener: _resource_record_post_action 07:06:42 INFO - [mozharness: 2017-08-06 14:06:42.471787Z] Finished install step (success) 07:06:42 INFO - [mozharness: 2017-08-06 14:06:42.472069Z] Running setup-mitmproxy step. 07:06:42 INFO - Running pre-action listener: _resource_record_pre_action 07:06:42 INFO - Running main action method: setup_mitmproxy 07:06:42 INFO - Skipping: mitmproxy is not required 07:06:42 INFO - Running post-action listener: _resource_record_post_action 07:06:42 INFO - [mozharness: 2017-08-06 14:06:42.473288Z] Finished setup-mitmproxy step (success) 07:06:42 INFO - [mozharness: 2017-08-06 14:06:42.473528Z] Running run-tests step. 07:06:42 INFO - Running pre-action listener: _resource_record_pre_action 07:06:42 INFO - Running pre-action listener: _set_gcov_prefix 07:06:42 INFO - Running main action method: run_tests 07:06:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:06:42 INFO - Python 2.7.3 07:06:42 INFO - Return code: 0 07:06:42 INFO - grabbing minidump binary from tooltool 07:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3feb0>, '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 0xf40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf41240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:06:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:06:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:06:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:06:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:06:42 INFO - Return code: 0 07:06:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:06:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:06:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:06:42 INFO - ENV: RUST_BACKTRACE is now 1 07:06:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:06:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:06:42 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-029', '--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:42 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-029 --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:42 INFO - Using env: {'DISPLAY': ':0', 07:06:42 INFO - 'HOME': '/home/cltbld', 07:06:42 INFO - 'LANG': 'en_US.UTF-8', 07:06:42 INFO - 'LANGUAGE': 'en_US:en', 07:06:42 INFO - 'LOGNAME': 'cltbld', 07:06:42 INFO - 'MAIL': '/var/mail/cltbld', 07:06:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:06:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:42 INFO - 'MOZ_NO_REMOTE': '1', 07:06:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:42 INFO - 'NO_EM_RESTART': '1', 07:06:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:42 INFO - 'PWD': '/builds/slave/test', 07:06:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:06:42 INFO - 'RUST_BACKTRACE': '1', 07:06:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:06:42 INFO - 'SHELL': '/bin/bash', 07:06:42 INFO - 'SHLVL': '1', 07:06:42 INFO - 'TERM': 'linux', 07:06:42 INFO - 'TMOUT': '86400', 07:06:42 INFO - 'USER': 'cltbld', 07:06:42 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549', 07:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:42 INFO - '_': '/tools/buildbot/bin/python'} 07:06:42 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-029', '--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:42 INFO - mozversion application_buildid: 20170806090558 07:06:42 INFO - mozversion application_changeset: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c 07:06:42 INFO - mozversion application_display_name: Nightly 07:06:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:06:42 INFO - mozversion application_name: Firefox 07:06:42 INFO - mozversion application_remotingname: firefox 07:06:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:06:42 INFO - mozversion application_vendor: Mozilla 07:06:42 INFO - mozversion application_version: 57.0a1 07:06:42 INFO - mozversion platform_buildid: 20170806090558 07:06:42 INFO - mozversion platform_changeset: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c 07:06:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:06:42 INFO - mozversion platform_version: 57.0a1 07:06:42 INFO - using testdate: 1502028402 07:06:42 INFO - actual date: 1502028402 07:06:42 INFO - starting webserver on 'localhost:38865' 07:06:42 INFO - SUITE-START | Running 2 tests 07:06:42 INFO - TEST-START | dromaeo_css 07:06:42 INFO - Initialising browser for dromaeo_css test... 07:06:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38865/getInfo.html -profile /tmp/tmploqZTF/profile 07:06:42 INFO - TEST-INFO | started process 13545 (/builds/slave/test/build/application/firefox/firefox http://localhost:38865/getInfo.html) 07:06:49 INFO - TEST-INFO | 13545: exit 0 07:06:49 INFO - Browser initialized. 07:06:49 INFO - Running cycle 1/1 for dromaeo_css test... 07:06:49 INFO - TEST-INFO | started process 13752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmploqZTF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:06:50 INFO - PID 13752 | 07:06:50 INFO - PID 13752 | (/builds/slave/test/build/application/firefox/firefox:13801): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:06:50 INFO - PID 13752 | 07:07:00 INFO - PID 13752 | RSS: Main: 171024384 07:07:00 INFO - PID 13752 | 07:10:00 INFO - PID 13752 | Cycle 1(1): loaded http://localhost:38865/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38865/tests/dromaeo/cssquery-ext.html) 07:10:01 INFO - PID 13752 | RSS: Main: 173510656 07:10:01 INFO - PID 13752 | 07:13:03 INFO - PID 13752 | Cycle 1(1): loaded http://localhost:38865/tests/dromaeo/cssquery-ext.html (next: http://localhost:38865/tests/dromaeo/cssquery-jquery.html) 07:13:04 INFO - PID 13752 | RSS: Main: 170590208 07:13:04 INFO - PID 13752 | 07:16:06 INFO - PID 13752 | Cycle 1(1): loaded http://localhost:38865/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38865/tests/dromaeo/cssquery-mootools.html) 07:16:06 INFO - PID 13752 | RSS: Main: 172527616 07:16:06 INFO - PID 13752 | 07:19:08 INFO - PID 13752 | Cycle 1(1): loaded http://localhost:38865/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38865/tests/dromaeo/cssquery-prototype.html) 07:19:09 INFO - PID 13752 | RSS: Main: 169553920 07:19:09 INFO - PID 13752 | 07:22:12 INFO - PID 13752 | Cycle 1(1): loaded http://localhost:38865/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38865/tests/dromaeo/cssquery-yui.html) 07:22:13 INFO - PID 13752 | RSS: Main: 174579712 07:22:13 INFO - PID 13752 | 07:25:15 INFO - PID 13752 | Cycle 1(1): loaded http://localhost:38865/tests/dromaeo/cssquery-yui.html (next: http://localhost:38865/tests/dromaeo/cssquery-dojo.html) 07:25:15 INFO - PID 13752 | RSS: Main: 174952448 07:25:15 INFO - PID 13752 | 07:25:15 INFO - PID 13752 | __start_tp_report 07:25:15 INFO - PID 13752 | _x_x_mozilla_page_load 07:25:15 INFO - PID 13752 | _x_x_mozilla_page_load_details 07:25:15 INFO - PID 13752 | |i|pagename|runs| 07:25:15 INFO - PID 13752 | |0;dojo.html;3164.1140480665413;3172.762042846786;3181.904542863714;3201.487761958087;3247.8700851965923;6243.625382477055;6320.873582528347;6323.525735569833;6366.522510811685;6390.392912673288;6172.567920245585;6306.180196574439;6319.905201421982;6345.428911397973;6349.492040636749;5774.422557744234;5774.566907481945;5798.391168927265;5810.651360918338;5873.177755114288;5857.4435428634215;5868.2371291732015;5876.5298776098025;5893.233879595647;5927.911081333762;5595.776168953278;5688.744006519716;5775.971120144414;5782.306123265214;5787.594868359217;5714.942850571482;5737.856553586152;5761.423857614247;5820.1560773688;5865.88268234633;5710.2862142232225;5736.684482353469;5781.595288329819;5784.739686714108;5799.797007104731;6121.877562448726;6217.347178546278;6221.129041934133;6240.157578726859;6293.46505547029;6698.062271282024;6743.359380858859;6750.898736518956;6840.247572766992;6851.246362900077;6873.48448866337;6897.310268973113;6899.413549848218;6907.34380233877;6907.896381554281;6323.30443651198;6383.265924418705;6419.646919419477;6420;6422.036694495816;6909.1018167637885;7005.684744186524;7019;7098.5385949914125;7127.429805615642;6518.250401203923;6611.239707433707;6626.734930602722;6698.531102822755;6752.898706519406;6798.456123510107;6804.931950680529;6825.726970921108;6836.350546698056;6836.5214434989075;6750.6624668767345;6807.659617019228;6824.658767061726;6837.521373503807;6850.6574671266235;6761.628110453874;6768.796936091925;6795.422389096982;6882.311768823178;6894.517383783187;5328.786848526093;5406.216098665672;5431.891362172734;5435.320584926884;5450.727463626803;4673.439187297546;4674.065186962621;4676.625869930397;4689.20283551797;4694.624430045588;5770.596058275881;5850.3564607893095;5850.912236316459;5851.093080572518;5855.092460668518;6725.361090696376;6728.327167283331;6762.763303284361;6767.560108593024;6791.252962174157;5823.5341172706085;5830.271216097988;5888.293404791452;5913.05391137416;5920.674362909996;5878.118282257696;5957.582969192115;6009.248843894513;6074.848128796727;6080.513558915364;6563.310852360529;6573.441257493071;6641;6651.833704157435;6653.201615806038;6875.209350924708;6897.3447522485285;6913.792586222421;6928.930710692828;6934.167899851848;6542.607443553402;6625.701843416961;6633.3035031321015;6646.60120392778;6656.933430665631;6609.339066093352;6636;6637.568558043712;6725.4619630430425;6733.865322693617;6708.563943343667;6740.764073257608;6798.7280508779095;6801.863962720817;6811.046453496416;6536.444402225864;6591.143151390289;6607.0419789131265;6609.900851487136;6629.303923088007;6528.086067950396;6578.309277525791;6584.374484423972;6585.934140658724;6611.438027767694;6461.903071454026;6554.180727409074;6558.04908288286;6607.900881486878;6638.53530252897;6471.061696053952;6609.966950165219;6627.237867645283;6706.362895524917;6711.563748356341;6308.211473565804;6405.551611387158;6489.7404103835315;6501.739930402731;6524.739010439529 07:25:15 INFO - PID 13752 | |1;ext.html;801.2708435323857;842.966281348746;868.0668281597284;869.7564681889071;1183.05946772316;33129.17177070572;44780;45485.77257113718;45566;45631.54368456314;45615.543844561544;45924.77037614807;46092.76953615227;46151;46223;7487.962560187191;7784.455088143832;7934.920650793505;8092.514449133071;8108.878366824502;7914.525128492309;8003.399745019147;8031.237032481905;8034.116247212802;8036.678532858678;8037.27664510194;8050.557219352933;8069.959650201741;8078.8788168177525;8093.4334596578265;7982.321502672251;8012.839743205103;8014.438989270753;8023.919760802405;8024.398170137263;7919.485233459806;7951.721689740832;7960.721374751856;7987.880181797278;7991.800204994864;41412.58587414117;41567.584324156676;41573.584264157274;41669.583304166874;41687.374689379685;3589.569251689788;3634.745567810254;3638.8362523686233;3639.763415377992;3644.1071937375245;32714.345713085604;32873.50689739656;32876.17809554756;33156;33171.33657326864;4958.107540642683;5125.205593133071;5125.513076257749;5145.819896303648;5159.5614372778355;197599.99999999857;197907.99999999857;198452;198809;199082;52263.21605175926;52574.21138682923;52579.73710131425;52583.737081315114;52596.73701631468;59038.704806476555;59042.40957590455;59078;59128.52178695567;59169.40830591725;17017.064061476736;17121.743173852403;17166.742498862528;17171.57071073208;17222.05278709683;12514.687132821753;12656.6835829105;12660.177088489403;14096.929515352358;14244.07413518118;15158.393664253526;15377.538673839803;15413.537593871977;15424;15559.45541906028;5916.674582897982;5925.73334199962;6005.879882402328;6097.451229389376;6205.782797602153;1000.4197565412044;1016.6848277033995;1018.3024628129755;1024.4467987286782;1026.071405378134;23733.525329493314;23912.521749564912;23954;23996;24003.15988940379;1125.150511363915;1128.0975219824109;1130.1862658885589;1131.3042478875432;1131.6548452721834;12605.117641765171;12634.873651263553;12675.492980280686;12692.619221423372;12698.682532936751;240154;240830;241968;242389;242953;57444;58603;58936.70531647314;58947.41052589505;58958.41041589529;1451.520998070634;1460.6129375715443;1512.1154124837094;1512.6218445388654;1518.4685360123867;23550.764492354858;23639.172628957906;23677.289681309587;23956.88021559881;23964.88017559901;40413;40484.3927341096;40676.576319828666;40823.79588102041;40907.159177836475;195528;196466;196889;197539;197959;37781;38481.4227786589;40641.18717625572;40749.59250407458;40783.184336312515;49151;50639.49360506348;50727.49272507375;50972.74513627408;51204.231936521726;35681.64318356783;35700.107497312776;35868.28263434769;36271.63728362683;37119.25761484701;35547.64452355443;36076.45885311775;36104.63895361013;36171.63828361788;36188.819055904554;39928.60071399249;39971;39989.60010399975;40246.59753402429;40328;33986.980390588324;34458.31083378368;34956.82521587376;35187;35510.82244588864;24410.389740256636;25225.49549008973;25783.613245801702;26088.478230434906;26375 07:25:15 INFO - PID 13752 | |2;jquery.html;576.2940398012436;584.1121495327101;586.3286536915232;586.5952492779983;601.9819405417837;22378.664320035212;23251.767482325173;23966.28101156966;23983.280501584937;24093.75906240935;26934.326641833915;27510.17469475914;27530.862345688292;27532.724672753266;27671.169864904034;6686.531942764021;6868.519203655721;6870.965645171792;6878.174619045722;6880.827979300508;6192;6707.228668703113;6708.530402871801;6747.763828266012;6857.451403887677;6633.800985970429;6654.234763002244;6675.332466753334;6683.097781799468;6687.230968438643;6656.567323123982;6658.533902626818;6667.533272670915;6682.665866706645;6683.2982536833415;6194.039923811816;6206.379362063803;6211.0372892201785;6229.314775374705;6234.1583886175695;29664;30597.235069123228;31175.84412077925;31326.843365783254;31361.686383136104;1906.3804263614381;1952.541152829084;1954.1890115602007;1955.735975643284;1961.852861035428;19974.201031958703;20598.897005515028;20792.16831326745;20804.791952080588;20835;2424.7090349158216;2457.33651913984;2524.1544082732307;2530.936726581832;2548.9490210195877;144262;144278.27860860628;147449.99999999892;147779;148455;14353.6411589709;15007.924960375129;15044;15305.311260993281;15732.370705171894;22796.658050129263;24218.63672044921;24258.878705606712;24354.512909741705;24497.26508204757;10287.27989040775;10557.841632375521;10641.840372394421;10678.57285708563;10810.513526891309;9834.360766550151;9892.802143957224;9996.800063998679;10063.39619622825;10074.798504029879;9353.672621458216;9568.61725530971;9619.134277915022;9751.609935602639;9867.555959981819;2684.355754618877;2705.2830999785074;2738.4659991301905;2774.6471849598724;2820.6856943091784;950.8763860698065;979.637534112383;989.5893204320271;993.2252842782641;994.1102713071905;19746.30169015636;20188.69716954247;20281.594368112554;20574.485637859172;20716.378508644764;1032.83990981398;1040.6773900090845;1043.7442826507554;1049.5906596427399;1050.805600963809;11259.930306620858;11319.603813866475;11355.602553910574;11364;11515.654530364103;490969;534781;539393;545245;547816;122136.38931805461;123817.38091309486;126096;126519;131161;1224.240970598217;1291.2510743768403;1296.1769276509485;1297.4874924404808;1303.5763376902544;20940.58118837645;21088;21138.38995996373;21238.150473980866;21580.784192157877;59888.70055649694;60518.394816051274;60627;60949.69525152346;61752.38247617646;77086.53251700244;77707;77827;78379.60810195912;79368;14710.41158353654;14953.925230373778;15029.323680434189;15039.624009399853;15073.698526029637;23781.762182377955;23825.285241442783;23921.880390597937;24085.27744167678;24193.51612967766;18339.449816505527;18628;18708.7193692092;18783.90608046951;18786.342478013205;17027.574310642332;17116;17497.95012299266;17780.110994450486;17905.731414028538;17904.28382864671;19099.713504297168;19316;19505.219791208194;19534.21863125516;13754.862451375759;14769.926150369609;14858.925705371405;14906.776398353817;14944.925275373553;18561.721574176667;18845.623087538446;18884.15021324071;18995.24019039223;19155.712664310326 07:25:15 INFO - PID 13752 | |3;mootools.html;1359.4630121102166;1417.808595839562;1426.2797287369876;1429.378220474094;1434.376046419808;13546.458141674333;14087;14094.506692265773;14104.929475352621;14123.788143177848;13966.650833729162;14416.855831441682;14830.55508334749;14842.777358339607;14904.031237969524;2622.895084196635;2670.0921686626543;2673.7459941305547;2675.411409489909;2676.5985102234627;2410.602250628644;2479.9752002479927;2528.6586310847983;2573.961390579143;2581.4449893272945;2536.112360673768;2545.6308835218974;2549.069589599792;2549.7322781107996;2558.3731985663444;2443.8044956403533;2470.049031123013;2483.751624837511;2483.838550494212;2516.207394670673;2420.201333559921;2423.4183795889035;2438.8170887183355;2459.9877000614883;2513.736057713932;13797.862021379759;14020.22888741119;14041.297935103205;14042.36809343582;14052.086614370033;7609.885851712229;7867.8033049173655;7871.842563148705;7877.094134174586;7879.290863822283;5058.114829904752;5184.974075129638;5213.218017297398;5263.184206448007;5312.309399778004;1824.2885274742728;1827.9268829246814;1844.4466660001947;1874.6625607390665;1877.71834224866;21207.3637790865;21269.68095478569;21412.678809817866;21415.892920535454;21429.14283428661;6206.193194884727;6422.100905873182;6426.8714625707225;6585.715785421797;6610.8016759497295;16106.597335066717;16117.355305787873;16149.273282702306;16160.83839161617;16169.353225870833;7439.479236453504;7594.582297973554;7597.2022937590755;7604;7632;6910.2744211858035;7057.505974581833;7092.078029856086;7135.215126336099;7141.82145446368;4929.3345398371475;5156.561692256125;5160.92258616121;5209.973950130225;5266;1384.9099808512415;1437;1487.7768334749874;1497.288787825796;1552.8369521200336;901.1664210605164;907.0793144957873;909.8134882349102;918.545320066558;924.5793164110314;7866.567338796307;8108.675652973815;8114.837703245902;8151.714689985822;8253.968253968254;969.3505351414569;990.1534188268927;990.7424069741775;998.8901220865699;1000.9399436033862;4504.932426013613;4530.207213737583;5128.692278463304;5151.124308867502;5224.477552244745;19108.617827643367;19683.31108411199;19705.90147049284;19712;19736.210551577777;18414.723779143325;19122.61754764897;19217.61564768697;19381.612367752565;19415.3204637837;10722.249442538947;10810.67567972962;10870.239083264254;10876.891231087746;10901.182411319025;7889.84220315579;8022.9598852005365;8038.316743076904;8181.959090204511;8189;16522.173891305145;16807.32770689159;16933.15334233259;16936.237869295666;16960.915195423942;16996.830031699526;17080;17103.230354633823;17216.483505494856;17403.216855241797;10346.22403319769;10479.895201047892;10502.842457362993;10508.527116279938;10513.421761803174;12904.677383065124;12975.351232438528;13002.739945201232;13087.803682944574;13119.672008199872;10068.446235456828;10201.74495637615;10234.539445724811;10308.175345972455;10515.579376825148;10096.141827944413;10122.392656440637;10127.594896204364;10196.235282354002;10353.223508236762;9282.907170928474;9535.141837234682;9549.856752148862;9553;9555.761105972406;7114.537555058904;7232.168300645493;7233.168185658506;7247.420206383582;7340.265973402617;7198.568085914652;7271.41828653717;7327.377172940147;7331;7351.448641351813 07:25:15 INFO - PID 13752 | |4;prototype.html;486.33857953183684;496.159010477241;498.68831980012493;516.3081470829089;519.9133810336399;6087.356413768285;6147.661878596676;6212.254529456472;6220.471259942905;6230.314665386803;5791.681457519835;5970.328308073736;6025.367336429677;6032.69836508175;6049.334573196956;4824.951750482485;4834.274858771195;4873.634477414191;4897.534734200263;4900.803967841282;4764.332993380929;4831.806727730886;4868.14807408702;4874.025194961005;4875.463698993126;4859.635527335447;4862.270659401082;4886.045581767286;4892.975535122319;4897.951020489785;4797.976010119962;4875.146849301358;4881.389826271716;4898.387701537308;4917.606591472691;4330;4337.826486940518;4366.104948485553;4368.104538569585;4412.205802955466;5869.207656966298;5966.363055289236;5979.431953964367;6025.216721826135;6059.242594675666;5521.861953451196;5600.439956004367;5613.578981576398;5698.6865722385255;5736.827895163152;6429.646369449679;6437.935620643781;6448.613083215022;6480.6435646039445;6530.281669016452;4844.8304309349005;4873.561379475864;4876.926846097276;4880.585150262232;4885.316055752198;6807.625580593016;6813.318668133196;6860.622665753382;6895.655217239168;6898.551594146365;4939.3084968104495;4961.107000739829;4976.701397916064;4984.22744474607;4986.12742770021;5010.223415370623;5012.774425150877;5016.172331565251;5030.170021946338;5079.492050794891;5555.833325000256;5652.830415087554;5660.745266463019;5672.461116193955;5683.403242659544;6407.839804004844;6498.447631951337;6501.44737697301;6519.674016299166;6544.967275163689;1624.398972380227;1695.6439147778858;1696.575856035991;1698.728203487436;1706.598949246926;1206.6018213989537;1208.7159517513378;1210.564196889119;1211.2429731417865;1220.0727447140237;5599.160125981054;5676.971615141981;5683.914741278884;5690.4025077367105;5693.800716974886;6475.287718350977;6616.4045235929;6641.203055633258;6655.567388119756;6686.465082793365;5636.887262254732;5698.344690360579;5705;5724.79963201286;5745.224394706661;3456.3432947740353;3507.4914137449928;3548.698360639323;3561.30554541867;3593.8921832345072;6460.609574457387;6460.773872914426;6486.44865186455;6499.707513161919;6570.784404885111;6850.897236541456;6921.48088893335;6924.376806087375;6932.341427564374;6938.687759050855;6435.646039467781;6443.226812782496;6487.805365839033;6493.220813502316;6521.836954076186;6691.565048272041;6703.698333575098;6724.394804467622;6741.898871517029;6762.797116086525;6509.316521765147;6579.736810527716;6655.600663960178;6688.565243259172;6700.664966751546;6367.840803979938;6426;6434.581752186093;6457.451116654949;6474.76620565904;4972.825951091694;4974;4978.6763860348965;4981.825636102719;5002.399712034579;6719.992001199859;6735.158105236846;6745.190577130776;6760.661966901537;6817.8636427270185;6367.376319038615;6423.357664233539;6462.676866156768;6503.6097834130105;6523.151990241238;6338.714757836001;6457.805306018402;6464.709088090953;6508.707108180049;6516.51126165549;6157.599756015845;6249.937500624936;6288.65412402304;6401.87196256063;6425.5502114851515;6396.3923427276195;6399.688258745137;6436.87354712914;6441.967790161019;6449.6130232186215;6210.813675589739;6252.374762523893;6320.968395157995;6334.018227174795;6359.395857393541 07:25:15 INFO - PID 13752 | |5;yui.html;890.7505898348461;911.4850109688026;924.8057907839353;928.8328100941828;941.1247539787996;19108.808911910877;20135.395938121845;20166.798332016675;20287.797122028776;22126.22558210463;22085.447863803412;22730.659040114413;22764.77235227647;22789.31632051037;22875.199368022124;1019.9694009179736;1043.0612448796069;1043.1602559939247;1047.7590154264485;1048.3395460859647;1025.830737928241;1070.882202957674;1074.9462526873665;1077.5258886090096;1077.9730506737317;1113.6770336602376;1125.8367536707171;1126.1272513801828;1127.10958342909;1129.1982692288484;1108.1633366808048;1113.8329250612392;1116.1126904111252;1117.932924024557;1124.9325040497556;813.6175997281268;814.9388795840276;817.1420008990596;820.5240960243045;822.0300045945781;20013.79986200134;20585;20809;20891.68662470064;21447.571048578942;21621.891890540603;21759.238426654993;22267.665985010237;22332.888335558382;22469.662955055686;17201.655966880717;17285.135743212788;17416.564585885328;17482.388116415863;17611.735823962652;3636.436352365361;3664.9450258246147;3665.8350374233223;3666.468362087509;3666.5966743658178;130779.34610326888;133819;134301;134802;135153.3242333792;17607;18166.818331816776;18455.630887382446;18538.721919171225;18654.44036678902;31135;32144.83927580347;32412.189695257337;32450.35099298001;32483.837580811945;8026.5986700664735;8980.46117232968;9153.176214140625;9344.439333640003;9378.343515953818;4365.017870979004;4466.888327791831;4478.552144785495;4480.596746292849;4481.081378317437;5320.52115309624;5464.371597266286;5469;5538.446155384429;5541.501264886099;1054.504382940017;1081.491698901515;1081.5565618096543;1099.1097211258907;1100.7963526747578;552.505507570722;564.5398999815137;567.7842419880419;569.4334137533181;583.072914066636;13123.60629181126;13286.800697989538;13377.866221337857;13961.581152565235;14305.85694143066;578.7308901360888;582.647498263553;586.003793550965;588.6232811000963;592.973316200772;5303.946960530422;5707;5932.940670593239;5938.703064846827;6070.659478472913;102157;102957;104015.47992260141;105439;105883;92069;93427.53286233525;93918.53040734753;93998.96533885256;96132;81349;81823;82034;82263.5886820562;83984.58007709922;11946.462409191434;12299.139060266054;12335.136540442083;12360.938195308965;12360.938195308965;38336.80831595824;38550.80724596359;38881;39986.80006599949;40861.38707919443;47485.52514474811;49737.75131124321;69747;70196.29803702101;73729.6313518429;18332.358367457076;18402.35591754336;18405.355812546495;18410.07949602488;18597.81402185961;17983.370582029565;20470.18119275272;20762.48093797667;20978.58042839165;21181.15275389029;18067.728984064986;18790.812091878906;18899.338523151622;18934.715979260596;19094;16638.75041874397;16838.915805420893;18934.43196704101;18980;19083.332083377016;17578.20898059565;18228.544286392946;18446.26214951387;18539.907300463412;18874.7168792471;13141.737165256833;13700.24648644334;13953.581392558239;14182.290885455479;14498.202598857164;14081.859181408465;14363.856361436252;14455;14929;15021.924890375478 07:25:15 INFO - PID 13752 | __end_tp_report 07:25:15 INFO - PID 13752 | __start_cc_report 07:25:15 INFO - PID 13752 | _x_x_mozilla_cycle_collect,345 07:25:15 INFO - PID 13752 | __end_cc_report 07:25:15 INFO - PID 13752 | __startTimestamp1502029515479__endTimestamp 07:25:15 INFO - PID 13752 | 07:25:15 INFO - PID 13752 | ------- Summary: start ------- 07:25:15 INFO - PID 13752 | Number of tests: 6 07:25:15 INFO - PID 13752 | 07:25:15 INFO - PID 13752 | [#0] dojo.html Cycles:165 Average:6246.97 Median:6524.74 stddev:749.01 (11.5%) stddev-sans-first:711.19 07:25:15 INFO - PID 13752 | Values: 3164.1 3172.8 3181.9 3201.5 3247.9 6243.6 6320.9 6323.5 6366.5 6390.4 6172.6 6306.2 6319.9 6345.4 6349.5 5774.4 5774.6 5798.4 5810.7 5873.2 5857.4 5868.2 5876.5 5893.2 5927.9 5595.8 5688.7 5776.0 5782.3 5787.6 5714.9 5737.9 5761.4 5820.2 5865.9 5710.3 5736.7 5781.6 5784.7 5799.8 6121.9 6217.3 6221.1 6240.2 6293.5 6698.1 6743.4 6750.9 6840.2 6851.2 6873.5 6897.3 6899.4 6907.3 6907.9 6323.3 6383.3 6419.6 6420.0 6422.0 6909.1 7005.7 7019.0 7098.5 7127.4 6518.3 6611.2 6626.7 6698.5 6752.9 6798.5 6804.9 6825.7 6836.4 6836.5 6750.7 6807.7 6824.7 6837.5 6850.7 6761.6 6768.8 6795.4 6882.3 6894.5 5328.8 5406.2 5431.9 5435.3 5450.7 4673.4 4674.1 4676.6 4689.2 4694.6 5770.6 5850.4 5850.9 5851.1 5855.1 6725.4 6728.3 6762.8 6767.6 6791.3 5823.5 5830.3 5888.3 5913.1 5920.7 5878.1 5957.6 6009.2 6074.8 6080.5 6563.3 6573.4 6641.0 6651.8 6653.2 6875.2 6897.3 6913.8 6928.9 6934.2 6542.6 6625.7 6633.3 6646.6 6656.9 6609.3 6636.0 6637.6 6725.5 6733.9 6708.6 6740.8 6798.7 6801.9 6811.0 6536.4 6591.1 6607.0 6609.9 6629.3 6528.1 6578.3 6584.4 6585.9 6611.4 6461.9 6554.2 6558.0 6607.9 6638.5 6471.1 6610.0 6627.2 6706.4 6711.6 6308.2 6405.6 6489.7 6501.7 6524.7 07:25:15 INFO - PID 13752 | 07:25:15 INFO - PID 13752 | [#1] ext.html Cycles:180 Average:39983.77 Median:20381.68 stddev:55356.58 (271.6%) stddev-sans-first:55433.69 07:25:15 INFO - PID 13752 | Values: 801.3 843.0 868.1 869.8 1183.1 33129.2 44780.0 45485.8 45566.0 45631.5 45615.5 45924.8 46092.8 46151.0 46223.0 7488.0 7784.5 7934.9 8092.5 8108.9 7914.5 8003.4 8031.2 8034.1 8036.7 8037.3 8050.6 8070.0 8078.9 8093.4 7982.3 8012.8 8014.4 8023.9 8024.4 7919.5 7951.7 7960.7 7987.9 7991.8 41412.6 41567.6 41573.6 41669.6 41687.4 3589.6 3634.7 3638.8 3639.8 3644.1 32714.3 32873.5 32876.2 33156.0 33171.3 4958.1 5125.2 5125.5 5145.8 5159.6 197600.0 197908.0 198452.0 198809.0 199082.0 52263.2 52574.2 52579.7 52583.7 52596.7 59038.7 59042.4 59078.0 59128.5 59169.4 17017.1 17121.7 17166.7 17171.6 17222.1 12514.7 12656.7 12660.2 14096.9 14244.1 15158.4 15377.5 15413.5 15424.0 15559.5 5916.7 5925.7 6005.9 6097.5 6205.8 1000.4 1016.7 1018.3 1024.4 1026.1 23733.5 23912.5 23954.0 23996.0 24003.2 1125.2 1128.1 1130.2 1131.3 1131.7 12605.1 12634.9 12675.5 12692.6 12698.7 240154.0 240830.0 241968.0 242389.0 242953.0 57444.0 58603.0 58936.7 58947.4 58958.4 1451.5 1460.6 1512.1 1512.6 1518.5 23550.8 23639.2 23677.3 23956.9 23964.9 40413.0 40484.4 40676.6 40823.8 40907.2 195528.0 196466.0 196889.0 197539.0 197959.0 37781.0 38481.4 40641.2 40749.6 40783.2 49151.0 50639.5 50727.5 50972.7 51204.2 35681.6 35700.1 35868.3 36271.6 37119.3 35547.6 36076.5 36104.6 36171.6 36188.8 39928.6 39971.0 39989.6 40246.6 40328.0 33987.0 34458.3 34956.8 35187.0 35510.8 24410.4 25225.5 25783.6 26088.5 26375.0 07:25:15 INFO - PID 13752 | 07:25:15 INFO - PID 13752 | [#2] jquery.html Cycles:180 Average:37199.54 Median:23803.52 stddev:89657.42 (376.7%) stddev-sans-first:89866.76 07:25:15 INFO - PID 13752 | Values: 576.3 584.1 586.3 586.6 602.0 22378.7 23251.8 23966.3 23983.3 24093.8 26934.3 27510.2 27530.9 27532.7 27671.2 6686.5 6868.5 6871.0 6878.2 6880.8 6192.0 6707.2 6708.5 6747.8 6857.5 6633.8 6654.2 6675.3 6683.1 6687.2 6656.6 6658.5 6667.5 6682.7 6683.3 6194.0 6206.4 6211.0 6229.3 6234.2 29664.0 30597.2 31175.8 31326.8 31361.7 1906.4 1952.5 1954.2 1955.7 1961.9 19974.2 20598.9 20792.2 20804.8 20835.0 2424.7 2457.3 2524.2 2530.9 2548.9 144262.0 144278.3 147450.0 147779.0 148455.0 14353.6 15007.9 15044.0 15305.3 15732.4 22796.7 24218.6 24258.9 24354.5 24497.3 10287.3 10557.8 10641.8 10678.6 10810.5 9834.4 9892.8 9996.8 10063.4 10074.8 9353.7 9568.6 9619.1 9751.6 9867.6 2684.4 2705.3 2738.5 2774.6 2820.7 950.9 979.6 989.6 993.2 994.1 19746.3 20188.7 20281.6 20574.5 20716.4 1032.8 1040.7 1043.7 1049.6 1050.8 11259.9 11319.6 11355.6 11364.0 11515.7 490969.0 534781.0 539393.0 545245.0 547816.0 122136.4 123817.4 126096.0 126519.0 131161.0 1224.2 1291.3 1296.2 1297.5 1303.6 20940.6 21088.0 21138.4 21238.2 21580.8 59888.7 60518.4 60627.0 60949.7 61752.4 77086.5 77707.0 77827.0 78379.6 79368.0 14710.4 14953.9 15029.3 15039.6 15073.7 23781.8 23825.3 23921.9 24085.3 24193.5 18339.4 18628.0 18708.7 18783.9 18786.3 17027.6 17116.0 17498.0 17780.1 17905.7 17904.3 19099.7 19316.0 19505.2 19534.2 13754.9 14769.9 14858.9 14906.8 14944.9 18561.7 18845.6 18884.2 18995.2 19155.7 07:25:15 INFO - PID 13752 | 07:25:15 INFO - PID 13752 | [#3] mootools.html Cycles:180 Average:8643.80 Median:2451.90 stddev:5836.20 (238.0%) stddev-sans-first:5826.91 07:25:15 INFO - PID 13752 | Values: 1359.5 1417.8 1426.3 1429.4 1434.4 13546.5 14087.0 14094.5 14104.9 14123.8 13966.7 14416.9 14830.6 14842.8 14904.0 2622.9 2670.1 2673.7 2675.4 2676.6 2410.6 2480.0 2528.7 2574.0 2581.4 2536.1 2545.6 2549.1 2549.7 2558.4 2443.8 2470.0 2483.8 2483.8 2516.2 2420.2 2423.4 2438.8 2460.0 2513.7 13797.9 14020.2 14041.3 14042.4 14052.1 7609.9 7867.8 7871.8 7877.1 7879.3 5058.1 5185.0 5213.2 5263.2 5312.3 1824.3 1827.9 1844.4 1874.7 1877.7 21207.4 21269.7 21412.7 21415.9 21429.1 6206.2 6422.1 6426.9 6585.7 6610.8 16106.6 16117.4 16149.3 16160.8 16169.4 7439.5 7594.6 7597.2 7604.0 7632.0 6910.3 7057.5 7092.1 7135.2 7141.8 4929.3 5156.6 5160.9 5210.0 5266.0 1384.9 1437.0 1487.8 1497.3 1552.8 901.2 907.1 909.8 918.5 924.6 7866.6 8108.7 8114.8 8151.7 8254.0 969.4 990.2 990.7 998.9 1000.9 4504.9 4530.2 5128.7 5151.1 5224.5 19108.6 19683.3 19705.9 19712.0 19736.2 18414.7 19122.6 19217.6 19381.6 19415.3 10722.2 10810.7 10870.2 10876.9 10901.2 7889.8 8023.0 8038.3 8182.0 8189.0 16522.2 16807.3 16933.2 16936.2 16960.9 16996.8 17080.0 17103.2 17216.5 17403.2 10346.2 10479.9 10502.8 10508.5 10513.4 12904.7 12975.4 13002.7 13087.8 13119.7 10068.4 10201.7 10234.5 10308.2 10515.6 10096.1 10122.4 10127.6 10196.2 10353.2 9282.9 9535.1 9549.9 9553.0 9555.8 7114.5 7232.2 7233.2 7247.4 7340.3 7198.6 7271.4 7327.4 7331.0 7351.4 07:25:15 INFO - PID 13752 | 07:25:15 INFO - PID 13752 | [#4] prototype.html Cycles:180 Average:5449.70 Median:6025.29 stddev:1540.79 (25.6%) stddev-sans-first:1499.40 07:25:15 INFO - PID 13752 | Values: 486.3 496.2 498.7 516.3 519.9 6087.4 6147.7 6212.3 6220.5 6230.3 5791.7 5970.3 6025.4 6032.7 6049.3 4825.0 4834.3 4873.6 4897.5 4900.8 4764.3 4831.8 4868.1 4874.0 4875.5 4859.6 4862.3 4886.0 4893.0 4898.0 4798.0 4875.1 4881.4 4898.4 4917.6 4330.0 4337.8 4366.1 4368.1 4412.2 5869.2 5966.4 5979.4 6025.2 6059.2 5521.9 5600.4 5613.6 5698.7 5736.8 6429.6 6437.9 6448.6 6480.6 6530.3 4844.8 4873.6 4876.9 4880.6 4885.3 6807.6 6813.3 6860.6 6895.7 6898.6 4939.3 4961.1 4976.7 4984.2 4986.1 5010.2 5012.8 5016.2 5030.2 5079.5 5555.8 5652.8 5660.7 5672.5 5683.4 6407.8 6498.4 6501.4 6519.7 6545.0 1624.4 1695.6 1696.6 1698.7 1706.6 1206.6 1208.7 1210.6 1211.2 1220.1 5599.2 5677.0 5683.9 5690.4 5693.8 6475.3 6616.4 6641.2 6655.6 6686.5 5636.9 5698.3 5705.0 5724.8 5745.2 3456.3 3507.5 3548.7 3561.3 3593.9 6460.6 6460.8 6486.4 6499.7 6570.8 6850.9 6921.5 6924.4 6932.3 6938.7 6435.6 6443.2 6487.8 6493.2 6521.8 6691.6 6703.7 6724.4 6741.9 6762.8 6509.3 6579.7 6655.6 6688.6 6700.7 6367.8 6426.0 6434.6 6457.5 6474.8 4972.8 4974.0 4978.7 4981.8 5002.4 6720.0 6735.2 6745.2 6760.7 6817.9 6367.4 6423.4 6462.7 6503.6 6523.2 6338.7 6457.8 6464.7 6508.7 6516.5 6157.6 6249.9 6288.7 6401.9 6425.6 6396.4 6399.7 6436.9 6442.0 6449.6 6210.8 6252.4 6321.0 6334.0 6359.4 07:25:15 INFO - PID 13752 | 07:25:15 INFO - PID 13752 | [#5] yui.html Cycles:180 Average:23725.65 Median:20378.99 stddev:31629.16 (155.2%) stddev-sans-first:31671.41 07:25:15 INFO - PID 13752 | Values: 890.8 911.5 924.8 928.8 941.1 19108.8 20135.4 20166.8 20287.8 22126.2 22085.4 22730.7 22764.8 22789.3 22875.2 1020.0 1043.1 1043.2 1047.8 1048.3 1025.8 1070.9 1074.9 1077.5 1078.0 1113.7 1125.8 1126.1 1127.1 1129.2 1108.2 1113.8 1116.1 1117.9 1124.9 813.6 814.9 817.1 820.5 822.0 20013.8 20585.0 20809.0 20891.7 21447.6 21621.9 21759.2 22267.7 22332.9 22469.7 17201.7 17285.1 17416.6 17482.4 17611.7 3636.4 3664.9 3665.8 3666.5 3666.6 130779.3 133819.0 134301.0 134802.0 135153.3 17607.0 18166.8 18455.6 18538.7 18654.4 31135.0 32144.8 32412.2 32450.4 32483.8 8026.6 8980.5 9153.2 9344.4 9378.3 4365.0 4466.9 4478.6 4480.6 4481.1 5320.5 5464.4 5469.0 5538.4 5541.5 1054.5 1081.5 1081.6 1099.1 1100.8 552.5 564.5 567.8 569.4 583.1 13123.6 13286.8 13377.9 13961.6 14305.9 578.7 582.6 586.0 588.6 593.0 5303.9 5707.0 5932.9 5938.7 6070.7 102157.0 102957.0 104015.5 105439.0 105883.0 92069.0 93427.5 93918.5 93999.0 96132.0 81349.0 81823.0 82034.0 82263.6 83984.6 11946.5 12299.1 12335.1 12360.9 12360.9 38336.8 38550.8 38881.0 39986.8 40861.4 47485.5 49737.8 69747.0 70196.3 73729.6 18332.4 18402.4 18405.4 18410.1 18597.8 17983.4 20470.2 20762.5 20978.6 21181.2 18067.7 18790.8 18899.3 18934.7 19094.0 16638.8 16838.9 18934.4 18980.0 19083.3 17578.2 18228.5 18446.3 18539.9 18874.7 13141.7 13700.2 13953.6 14182.3 14498.2 14081.9 14363.9 14455.0 14929.0 15021.9 07:25:15 INFO - PID 13752 | -------- Summary: end -------- 07:25:15 INFO - PID 13752 | 07:25:16 INFO - TEST-INFO | 13752: exit 0 07:25:16 INFO - TEST-OK | dromaeo_css | took 1113346ms 07:25:16 INFO - TEST-START | kraken 07:25:16 INFO - Initialising browser for kraken test... 07:25:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38865/getInfo.html -profile /tmp/tmp8YwOiu/profile 07:25:16 INFO - TEST-INFO | started process 14119 (/builds/slave/test/build/application/firefox/firefox http://localhost:38865/getInfo.html) 07:25:21 INFO - TEST-INFO | 14119: exit 0 07:25:21 INFO - Browser initialized. 07:25:21 INFO - Running cycle 1/1 for kraken test... 07:25:21 INFO - TEST-INFO | started process 14328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8YwOiu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:22 INFO - PID 14328 | 07:25:22 INFO - PID 14328 | (/builds/slave/test/build/application/firefox/firefox:14377): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:25:22 INFO - PID 14328 | 07:25:33 INFO - PID 14328 | RSS: Main: 171356160 07:25:33 INFO - PID 14328 | 07:25:35 INFO - PID 14328 | Cycle 1(1): loaded http://localhost:38865/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38865/tests/kraken/driver.html?testName=audio-beat-detection) 07:25:36 INFO - PID 14328 | RSS: Main: 177569792 07:25:36 INFO - PID 14328 | 07:25:39 INFO - PID 14328 | Cycle 1(1): loaded http://localhost:38865/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38865/tests/kraken/driver.html?testName=audio-dft) 07:25:40 INFO - PID 14328 | RSS: Main: 177668096 07:25:40 INFO - PID 14328 | 07:25:42 INFO - PID 14328 | Cycle 1(1): loaded http://localhost:38865/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38865/tests/kraken/driver.html?testName=audio-fft) 07:25:43 INFO - PID 14328 | RSS: Main: 171425792 07:25:43 INFO - PID 14328 | 07:25:45 INFO - PID 14328 | Cycle 1(1): loaded http://localhost:38865/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38865/tests/kraken/driver.html?testName=audio-oscillator) 07:25:46 INFO - PID 14328 | RSS: Main: 172576768 07:25:46 INFO - PID 14328 | 07:25:48 INFO - PID 14328 | Cycle 1(1): loaded http://localhost:38865/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38865/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:25:49 INFO - PID 14328 | RSS: Main: 172756992 07:25:49 INFO - PID 14328 | 07:25:52 INFO - PID 14328 | Cycle 1(1): loaded http://localhost:38865/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38865/tests/kraken/driver.html?testName=imaging-darkroom) 07:25:52 INFO - PID 14328 | RSS: Main: 174612480 07:25:52 INFO - PID 14328 | 07:25:56 INFO - PID 14328 | Cycle 1(1): loaded http://localhost:38865/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38865/tests/kraken/driver.html?testName=imaging-desaturate) 07:25:56 INFO - PID 14328 | RSS: Main: 175181824 07:25:56 INFO - PID 14328 | 07:25:59 INFO - PID 14328 | Cycle 1(1): loaded http://localhost:38865/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38865/tests/kraken/driver.html?testName=json-parse-financial) 07:26:00 INFO - PID 14328 | RSS: Main: 175136768 07:26:00 INFO - PID 14328 | 07:26:02 INFO - PID 14328 | Cycle 1(1): loaded http://localhost:38865/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38865/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:02 INFO - PID 14328 | RSS: Main: 175276032 07:26:02 INFO - PID 14328 | 07:26:04 INFO - PID 14328 | Cycle 1(1): loaded http://localhost:38865/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38865/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:05 INFO - PID 14328 | RSS: Main: 175415296 07:26:05 INFO - PID 14328 | 07:26:07 INFO - PID 14328 | Cycle 1(1): loaded http://localhost:38865/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38865/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:07 INFO - PID 14328 | RSS: Main: 172490752 07:26:07 INFO - PID 14328 | 07:26:10 INFO - PID 14328 | Cycle 1(1): loaded http://localhost:38865/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38865/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:11 INFO - PID 14328 | RSS: Main: 173158400 07:26:11 INFO - PID 14328 | 07:26:14 INFO - PID 14328 | Cycle 1(1): loaded http://localhost:38865/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38865/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:14 INFO - PID 14328 | RSS: Main: 172589056 07:26:14 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | Cycle 1(1): loaded http://localhost:38865/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38865/tests/kraken/driver.html?testName=ai-astar) 07:26:16 INFO - PID 14328 | RSS: Main: 174108672 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | __start_tp_report 07:26:16 INFO - PID 14328 | _x_x_mozilla_page_load 07:26:16 INFO - PID 14328 | _x_x_mozilla_page_load_details 07:26:16 INFO - PID 14328 | |i|pagename|runs| 07:26:16 INFO - PID 14328 | |0;ai-astar;100;108;103;108;106;108;107;99;107;110 07:26:16 INFO - PID 14328 | |1;audio-beat-detection;139;117;139;171;123;148;153;118;169;118 07:26:16 INFO - PID 14328 | |2;audio-dft;166;166;164;164;163;163;164;173;165;163 07:26:16 INFO - PID 14328 | |3;audio-fft;74;74;75;179;74;75;78;75;148;78 07:26:16 INFO - PID 14328 | |4;audio-oscillator;78;80;137;81;79;78;132;78;78;132 07:26:16 INFO - PID 14328 | |5;imaging-gaussian-blur;114;115;114;114;114;114;114;115;114;115 07:26:16 INFO - PID 14328 | |6;imaging-darkroom;151;152;150;151;151;152;151;151;151;150 07:26:16 INFO - PID 14328 | |7;imaging-desaturate;94;94;94;94;94;95;94;94;94;93 07:26:16 INFO - PID 14328 | |8;json-parse-financial;56;55;55;56;55;56;55;56;54;55 07:26:16 INFO - PID 14328 | |9;json-stringify-tinderbox;53;54;54;53;54;54;54;53;53;54 07:26:16 INFO - PID 14328 | |10;stanford-crypto-aes;78;89;80;79;77;86;79;77;87;79 07:26:16 INFO - PID 14328 | |11;stanford-crypto-ccm;138;130;128;130;120;124;130;123;125;161 07:26:16 INFO - PID 14328 | |12;stanford-crypto-pbkdf2;185;176;169;172;175;201;177;174;174;168 07:26:16 INFO - PID 14328 | |13;stanford-crypto-sha256-iterative;68;66;65;66;64;66;65;67;65;64 07:26:16 INFO - PID 14328 | __end_tp_report 07:26:16 INFO - PID 14328 | __start_cc_report 07:26:16 INFO - PID 14328 | _x_x_mozilla_cycle_collect,973 07:26:16 INFO - PID 14328 | __end_cc_report 07:26:16 INFO - PID 14328 | __startTimestamp1502029576932__endTimestamp 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | ------- Summary: start ------- 07:26:16 INFO - PID 14328 | Number of tests: 14 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | [#0] ai-astar Cycles:10 Average:105.60 Median:108.00 stddev:3.69 (3.4%) stddev-sans-first:3.31 07:26:16 INFO - PID 14328 | Values: 100.0 108.0 103.0 108.0 106.0 108.0 107.0 99.0 107.0 110.0 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:143.50 stddev:20.60 (14.4%) stddev-sans-first:21.85 07:26:16 INFO - PID 14328 | Values: 139.0 117.0 139.0 171.0 123.0 148.0 153.0 118.0 169.0 118.0 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.50 stddev:3.00 (1.8%) stddev-sans-first:3.16 07:26:16 INFO - PID 14328 | Values: 166.0 166.0 164.0 164.0 163.0 163.0 164.0 173.0 165.0 163.0 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.00 stddev:37.90 (50.5%) stddev-sans-first:39.57 07:26:16 INFO - PID 14328 | Values: 74.0 74.0 75.0 179.0 74.0 75.0 78.0 75.0 148.0 78.0 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:78.00 stddev:26.53 (34.0%) stddev-sans-first:27.39 07:26:16 INFO - PID 14328 | Values: 78.0 80.0 137.0 81.0 79.0 78.0 132.0 78.0 78.0 132.0 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:26:16 INFO - PID 14328 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 114.0 115.0 114.0 115.0 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 07:26:16 INFO - PID 14328 | Values: 151.0 152.0 150.0 151.0 151.0 152.0 151.0 151.0 151.0 150.0 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 07:26:16 INFO - PID 14328 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 93.0 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:0.67 (1.2%) stddev-sans-first:0.67 07:26:16 INFO - PID 14328 | Values: 56.0 55.0 55.0 56.0 55.0 56.0 55.0 56.0 54.0 55.0 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | [#9] json-stringify-tinderbox Cycles:10 Average:53.60 Median:54.00 stddev:0.52 (1.0%) stddev-sans-first:0.50 07:26:16 INFO - PID 14328 | Values: 53.0 54.0 54.0 53.0 54.0 54.0 54.0 53.0 53.0 54.0 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:79.50 stddev:4.46 (5.6%) stddev-sans-first:4.59 07:26:16 INFO - PID 14328 | Values: 78.0 89.0 80.0 79.0 77.0 86.0 79.0 77.0 87.0 79.0 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:130.00 stddev:11.69 (9.0%) stddev-sans-first:12.12 07:26:16 INFO - PID 14328 | Values: 138.0 130.0 128.0 130.0 120.0 124.0 130.0 123.0 125.0 161.0 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:175.50 stddev:9.62 (5.5%) stddev-sans-first:9.77 07:26:16 INFO - PID 14328 | Values: 185.0 176.0 169.0 172.0 175.0 201.0 177.0 174.0 174.0 168.0 07:26:16 INFO - PID 14328 | 07:26:16 INFO - PID 14328 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.00 07:26:16 INFO - PID 14328 | Values: 68.0 66.0 65.0 66.0 64.0 66.0 65.0 67.0 65.0 64.0 07:26:16 INFO - PID 14328 | -------- Summary: end -------- 07:26:16 INFO - PID 14328 | 07:26:17 INFO - PID 14328 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:26:17 INFO - TEST-INFO | 14328: exit 0 07:26:17 INFO - TEST-OK | kraken | took 61473ms 07:26:17 INFO - SUITE-END | took 1174s 07:26:18 INFO - Completed test suite (00:19:35) 07:26:18 INFO - javascript benchmark 07:26:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8633.910194125514, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3164.1140480665413, 3172.762042846786, 3181.904542863714, 3201.487761958087, 3247.8700851965923, 6243.625382477055, 6320.873582528347, 6323.525735569833, 6366.522510811685, 6390.392912673288, 6172.567920245585, 6306.180196574439, 6319.905201421982, 6345.428911397973, 6349.492040636749, 5774.422557744234, 5774.566907481945, 5798.391168927265, 5810.651360918338, 5873.177755114288, 5857.4435428634215, 5868.2371291732015, 5876.5298776098025, 5893.233879595647, 5927.911081333762, 5595.776168953278, 5688.744006519716, 5775.971120144414, 5782.306123265214, 5787.594868359217, 5714.942850571482, 5737.856553586152, 5761.423857614247, 5820.1560773688, 5865.88268234633, 5710.2862142232225, 5736.684482353469, 5781.595288329819, 5784.739686714108, 5799.797007104731, 6121.877562448726, 6217.347178546278, 6221.129041934133, 6240.157578726859, 6293.46505547029, 6698.062271282024, 6743.359380858859, 6750.898736518956, 6840.247572766992, 6851.246362900077, 6873.48448866337, 6897.310268973113, 6899.413549848218, 6907.34380233877, 6907.896381554281, 6323.30443651198, 6383.265924418705, 6419.646919419477, 6420.0, 6422.036694495816, 6909.1018167637885, 7005.684744186524, 7019.0, 7098.5385949914125, 7127.429805615642, 6518.250401203923, 6611.239707433707, 6626.734930602722, 6698.531102822755, 6752.898706519406, 6798.456123510107, 6804.931950680529, 6825.726970921108, 6836.350546698056, 6836.5214434989075, 6750.6624668767345, 6807.659617019228, 6824.658767061726, 6837.521373503807, 6850.6574671266235, 6761.628110453874, 6768.796936091925, 6795.422389096982, 6882.311768823178, 6894.517383783187, 5328.786848526093, 5406.216098665672, 5431.891362172734, 5435.320584926884, 5450.727463626803, 4673.439187297546, 4674.065186962621, 4676.625869930397, 4689.20283551797, 4694.624430045588, 5770.596058275881, 5850.3564607893095, 5850.912236316459, 5851.093080572518, 5855.092460668518, 6725.361090696376, 6728.327167283331, 6762.763303284361, 6767.560108593024, 6791.252962174157, 5823.5341172706085, 5830.271216097988, 5888.293404791452, 5913.05391137416, 5920.674362909996, 5878.118282257696, 5957.582969192115, 6009.248843894513, 6074.848128796727, 6080.513558915364, 6563.310852360529, 6573.441257493071, 6641.0, 6651.833704157435, 6653.201615806038, 6875.209350924708, 6897.3447522485285, 6913.792586222421, 6928.930710692828, 6934.167899851848, 6542.607443553402, 6625.701843416961, 6633.3035031321015, 6646.60120392778, 6656.933430665631, 6609.339066093352, 6636.0, 6637.568558043712, 6725.4619630430425, 6733.865322693617, 6708.563943343667, 6740.764073257608, 6798.7280508779095, 6801.863962720817, 6811.046453496416, 6536.444402225864, 6591.143151390289, 6607.0419789131265, 6609.900851487136, 6629.303923088007, 6528.086067950396, 6578.309277525791, 6584.374484423972, 6585.934140658724, 6611.438027767694, 6461.903071454026, 6554.180727409074, 6558.04908288286, 6607.900881486878, 6638.53530252897, 6471.061696053952, 6609.966950165219, 6627.237867645283, 6706.362895524917, 6711.563748356341, 6308.211473565804, 6405.551611387158, 6489.7404103835315, 6501.739930402731, 6524.739010439529], "value": 6189.963126117109, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.2708435323857, 842.966281348746, 868.0668281597284, 869.7564681889071, 1183.05946772316, 33129.17177070572, 44780.0, 45485.77257113718, 45566.0, 45631.54368456314, 45615.543844561544, 45924.77037614807, 46092.76953615227, 46151.0, 46223.0, 7487.962560187191, 7784.455088143832, 7934.920650793505, 8092.514449133071, 8108.878366824502, 7914.525128492309, 8003.399745019147, 8031.237032481905, 8034.116247212802, 8036.678532858678, 8037.27664510194, 8050.557219352933, 8069.959650201741, 8078.8788168177525, 8093.4334596578265, 7982.321502672251, 8012.839743205103, 8014.438989270753, 8023.919760802405, 8024.398170137263, 7919.485233459806, 7951.721689740832, 7960.721374751856, 7987.880181797278, 7991.800204994864, 41412.58587414117, 41567.584324156676, 41573.584264157274, 41669.583304166874, 41687.374689379685, 3589.569251689788, 3634.745567810254, 3638.8362523686233, 3639.763415377992, 3644.1071937375245, 32714.345713085604, 32873.50689739656, 32876.17809554756, 33156.0, 33171.33657326864, 4958.107540642683, 5125.205593133071, 5125.513076257749, 5145.819896303648, 5159.5614372778355, 197599.99999999857, 197907.99999999857, 198452.0, 198809.0, 199082.0, 52263.21605175926, 52574.21138682923, 52579.73710131425, 52583.737081315114, 52596.73701631468, 59038.704806476555, 59042.40957590455, 59078.0, 59128.52178695567, 59169.40830591725, 17017.064061476736, 17121.743173852403, 17166.742498862528, 17171.57071073208, 17222.05278709683, 12514.687132821753, 12656.6835829105, 12660.177088489403, 14096.929515352358, 14244.07413518118, 15158.393664253526, 15377.538673839803, 15413.537593871977, 15424.0, 15559.45541906028, 5916.674582897982, 5925.73334199962, 6005.879882402328, 6097.451229389376, 6205.782797602153, 1000.4197565412044, 1016.6848277033995, 1018.3024628129755, 1024.4467987286782, 1026.071405378134, 23733.525329493314, 23912.521749564912, 23954.0, 23996.0, 24003.15988940379, 1125.150511363915, 1128.0975219824109, 1130.1862658885589, 1131.3042478875432, 1131.6548452721834, 12605.117641765171, 12634.873651263553, 12675.492980280686, 12692.619221423372, 12698.682532936751, 240154.0, 240830.0, 241968.0, 242389.0, 242953.0, 57444.0, 58603.0, 58936.70531647314, 58947.41052589505, 58958.41041589529, 1451.520998070634, 1460.6129375715443, 1512.1154124837094, 1512.6218445388654, 1518.4685360123867, 23550.764492354858, 23639.172628957906, 23677.289681309587, 23956.88021559881, 23964.88017559901, 40413.0, 40484.3927341096, 40676.576319828666, 40823.79588102041, 40907.159177836475, 195528.0, 196466.0, 196889.0, 197539.0, 197959.0, 37781.0, 38481.4227786589, 40641.18717625572, 40749.59250407458, 40783.184336312515, 49151.0, 50639.49360506348, 50727.49272507375, 50972.74513627408, 51204.231936521726, 35681.64318356783, 35700.107497312776, 35868.28263434769, 36271.63728362683, 37119.25761484701, 35547.64452355443, 36076.45885311775, 36104.63895361013, 36171.63828361788, 36188.819055904554, 39928.60071399249, 39971.0, 39989.60010399975, 40246.59753402429, 40328.0, 33986.980390588324, 34458.31083378368, 34956.82521587376, 35187.0, 35510.82244588864, 24410.389740256636, 25225.49549008973, 25783.613245801702, 26088.478230434906, 26375.0], "value": 18243.978797652962, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.2940398012436, 584.1121495327101, 586.3286536915232, 586.5952492779983, 601.9819405417837, 22378.664320035212, 23251.767482325173, 23966.28101156966, 23983.280501584937, 24093.75906240935, 26934.326641833915, 27510.17469475914, 27530.862345688292, 27532.724672753266, 27671.169864904034, 6686.531942764021, 6868.519203655721, 6870.965645171792, 6878.174619045722, 6880.827979300508, 6192.0, 6707.228668703113, 6708.530402871801, 6747.763828266012, 6857.451403887677, 6633.800985970429, 6654.234763002244, 6675.332466753334, 6683.097781799468, 6687.230968438643, 6656.567323123982, 6658.533902626818, 6667.533272670915, 6682.665866706645, 6683.2982536833415, 6194.039923811816, 6206.379362063803, 6211.0372892201785, 6229.314775374705, 6234.1583886175695, 29664.0, 30597.235069123228, 31175.84412077925, 31326.843365783254, 31361.686383136104, 1906.3804263614381, 1952.541152829084, 1954.1890115602007, 1955.735975643284, 1961.852861035428, 19974.201031958703, 20598.897005515028, 20792.16831326745, 20804.791952080588, 20835.0, 2424.7090349158216, 2457.33651913984, 2524.1544082732307, 2530.936726581832, 2548.9490210195877, 144262.0, 144278.27860860628, 147449.99999999892, 147779.0, 148455.0, 14353.6411589709, 15007.924960375129, 15044.0, 15305.311260993281, 15732.370705171894, 22796.658050129263, 24218.63672044921, 24258.878705606712, 24354.512909741705, 24497.26508204757, 10287.27989040775, 10557.841632375521, 10641.840372394421, 10678.57285708563, 10810.513526891309, 9834.360766550151, 9892.802143957224, 9996.800063998679, 10063.39619622825, 10074.798504029879, 9353.672621458216, 9568.61725530971, 9619.134277915022, 9751.609935602639, 9867.555959981819, 2684.355754618877, 2705.2830999785074, 2738.4659991301905, 2774.6471849598724, 2820.6856943091784, 950.8763860698065, 979.637534112383, 989.5893204320271, 993.2252842782641, 994.1102713071905, 19746.30169015636, 20188.69716954247, 20281.594368112554, 20574.485637859172, 20716.378508644764, 1032.83990981398, 1040.6773900090845, 1043.7442826507554, 1049.5906596427399, 1050.805600963809, 11259.930306620858, 11319.603813866475, 11355.602553910574, 11364.0, 11515.654530364103, 490969.0, 534781.0, 539393.0, 545245.0, 547816.0, 122136.38931805461, 123817.38091309486, 126096.0, 126519.0, 131161.0, 1224.240970598217, 1291.2510743768403, 1296.1769276509485, 1297.4874924404808, 1303.5763376902544, 20940.58118837645, 21088.0, 21138.38995996373, 21238.150473980866, 21580.784192157877, 59888.70055649694, 60518.394816051274, 60627.0, 60949.69525152346, 61752.38247617646, 77086.53251700244, 77707.0, 77827.0, 78379.60810195912, 79368.0, 14710.41158353654, 14953.925230373778, 15029.323680434189, 15039.624009399853, 15073.698526029637, 23781.762182377955, 23825.285241442783, 23921.880390597937, 24085.27744167678, 24193.51612967766, 18339.449816505527, 18628.0, 18708.7193692092, 18783.90608046951, 18786.342478013205, 17027.574310642332, 17116.0, 17497.95012299266, 17780.110994450486, 17905.731414028538, 17904.28382864671, 19099.713504297168, 19316.0, 19505.219791208194, 19534.21863125516, 13754.862451375759, 14769.926150369609, 14858.925705371405, 14906.776398353817, 14944.925275373553, 18561.721574176667, 18845.623087538446, 18884.15021324071, 18995.24019039223, 19155.712664310326], "value": 12460.490940344738, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.4630121102166, 1417.808595839562, 1426.2797287369876, 1429.378220474094, 1434.376046419808, 13546.458141674333, 14087.0, 14094.506692265773, 14104.929475352621, 14123.788143177848, 13966.650833729162, 14416.855831441682, 14830.55508334749, 14842.777358339607, 14904.031237969524, 2622.895084196635, 2670.0921686626543, 2673.7459941305547, 2675.411409489909, 2676.5985102234627, 2410.602250628644, 2479.9752002479927, 2528.6586310847983, 2573.961390579143, 2581.4449893272945, 2536.112360673768, 2545.6308835218974, 2549.069589599792, 2549.7322781107996, 2558.3731985663444, 2443.8044956403533, 2470.049031123013, 2483.751624837511, 2483.838550494212, 2516.207394670673, 2420.201333559921, 2423.4183795889035, 2438.8170887183355, 2459.9877000614883, 2513.736057713932, 13797.862021379759, 14020.22888741119, 14041.297935103205, 14042.36809343582, 14052.086614370033, 7609.885851712229, 7867.8033049173655, 7871.842563148705, 7877.094134174586, 7879.290863822283, 5058.114829904752, 5184.974075129638, 5213.218017297398, 5263.184206448007, 5312.309399778004, 1824.2885274742728, 1827.9268829246814, 1844.4466660001947, 1874.6625607390665, 1877.71834224866, 21207.3637790865, 21269.68095478569, 21412.678809817866, 21415.892920535454, 21429.14283428661, 6206.193194884727, 6422.100905873182, 6426.8714625707225, 6585.715785421797, 6610.8016759497295, 16106.597335066717, 16117.355305787873, 16149.273282702306, 16160.83839161617, 16169.353225870833, 7439.479236453504, 7594.582297973554, 7597.2022937590755, 7604.0, 7632.0, 6910.2744211858035, 7057.505974581833, 7092.078029856086, 7135.215126336099, 7141.82145446368, 4929.3345398371475, 5156.561692256125, 5160.92258616121, 5209.973950130225, 5266.0, 1384.9099808512415, 1437.0, 1487.7768334749874, 1497.288787825796, 1552.8369521200336, 901.1664210605164, 907.0793144957873, 909.8134882349102, 918.545320066558, 924.5793164110314, 7866.567338796307, 8108.675652973815, 8114.837703245902, 8151.714689985822, 8253.968253968254, 969.3505351414569, 990.1534188268927, 990.7424069741775, 998.8901220865699, 1000.9399436033862, 4504.932426013613, 4530.207213737583, 5128.692278463304, 5151.124308867502, 5224.477552244745, 19108.617827643367, 19683.31108411199, 19705.90147049284, 19712.0, 19736.210551577777, 18414.723779143325, 19122.61754764897, 19217.61564768697, 19381.612367752565, 19415.3204637837, 10722.249442538947, 10810.67567972962, 10870.239083264254, 10876.891231087746, 10901.182411319025, 7889.84220315579, 8022.9598852005365, 8038.316743076904, 8181.959090204511, 8189.0, 16522.173891305145, 16807.32770689159, 16933.15334233259, 16936.237869295666, 16960.915195423942, 16996.830031699526, 17080.0, 17103.230354633823, 17216.483505494856, 17403.216855241797, 10346.22403319769, 10479.895201047892, 10502.842457362993, 10508.527116279938, 10513.421761803174, 12904.677383065124, 12975.351232438528, 13002.739945201232, 13087.803682944574, 13119.672008199872, 10068.446235456828, 10201.74495637615, 10234.539445724811, 10308.175345972455, 10515.579376825148, 10096.141827944413, 10122.392656440637, 10127.594896204364, 10196.235282354002, 10353.223508236762, 9282.907170928474, 9535.141837234682, 9549.856752148862, 9553.0, 9555.761105972406, 7114.537555058904, 7232.168300645493, 7233.168185658506, 7247.420206383582, 7340.265973402617, 7198.568085914652, 7271.41828653717, 7327.377172940147, 7331.0, 7351.448641351813], "value": 6325.318907694495, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.33857953183684, 496.159010477241, 498.68831980012493, 516.3081470829089, 519.9133810336399, 6087.356413768285, 6147.661878596676, 6212.254529456472, 6220.471259942905, 6230.314665386803, 5791.681457519835, 5970.328308073736, 6025.367336429677, 6032.69836508175, 6049.334573196956, 4824.951750482485, 4834.274858771195, 4873.634477414191, 4897.534734200263, 4900.803967841282, 4764.332993380929, 4831.806727730886, 4868.14807408702, 4874.025194961005, 4875.463698993126, 4859.635527335447, 4862.270659401082, 4886.045581767286, 4892.975535122319, 4897.951020489785, 4797.976010119962, 4875.146849301358, 4881.389826271716, 4898.387701537308, 4917.606591472691, 4330.0, 4337.826486940518, 4366.104948485553, 4368.104538569585, 4412.205802955466, 5869.207656966298, 5966.363055289236, 5979.431953964367, 6025.216721826135, 6059.242594675666, 5521.861953451196, 5600.439956004367, 5613.578981576398, 5698.6865722385255, 5736.827895163152, 6429.646369449679, 6437.935620643781, 6448.613083215022, 6480.6435646039445, 6530.281669016452, 4844.8304309349005, 4873.561379475864, 4876.926846097276, 4880.585150262232, 4885.316055752198, 6807.625580593016, 6813.318668133196, 6860.622665753382, 6895.655217239168, 6898.551594146365, 4939.3084968104495, 4961.107000739829, 4976.701397916064, 4984.22744474607, 4986.12742770021, 5010.223415370623, 5012.774425150877, 5016.172331565251, 5030.170021946338, 5079.492050794891, 5555.833325000256, 5652.830415087554, 5660.745266463019, 5672.461116193955, 5683.403242659544, 6407.839804004844, 6498.447631951337, 6501.44737697301, 6519.674016299166, 6544.967275163689, 1624.398972380227, 1695.6439147778858, 1696.575856035991, 1698.728203487436, 1706.598949246926, 1206.6018213989537, 1208.7159517513378, 1210.564196889119, 1211.2429731417865, 1220.0727447140237, 5599.160125981054, 5676.971615141981, 5683.914741278884, 5690.4025077367105, 5693.800716974886, 6475.287718350977, 6616.4045235929, 6641.203055633258, 6655.567388119756, 6686.465082793365, 5636.887262254732, 5698.344690360579, 5705.0, 5724.79963201286, 5745.224394706661, 3456.3432947740353, 3507.4914137449928, 3548.698360639323, 3561.30554541867, 3593.8921832345072, 6460.609574457387, 6460.773872914426, 6486.44865186455, 6499.707513161919, 6570.784404885111, 6850.897236541456, 6921.48088893335, 6924.376806087375, 6932.341427564374, 6938.687759050855, 6435.646039467781, 6443.226812782496, 6487.805365839033, 6493.220813502316, 6521.836954076186, 6691.565048272041, 6703.698333575098, 6724.394804467622, 6741.898871517029, 6762.797116086525, 6509.316521765147, 6579.736810527716, 6655.600663960178, 6688.565243259172, 6700.664966751546, 6367.840803979938, 6426.0, 6434.581752186093, 6457.451116654949, 6474.76620565904, 4972.825951091694, 4974.0, 4978.6763860348965, 4981.825636102719, 5002.399712034579, 6719.992001199859, 6735.158105236846, 6745.190577130776, 6760.661966901537, 6817.8636427270185, 6367.376319038615, 6423.357664233539, 6462.676866156768, 6503.6097834130105, 6523.151990241238, 6338.714757836001, 6457.805306018402, 6464.709088090953, 6508.707108180049, 6516.51126165549, 6157.599756015845, 6249.937500624936, 6288.65412402304, 6401.87196256063, 6425.5502114851515, 6396.3923427276195, 6399.688258745137, 6436.87354712914, 6441.967790161019, 6449.6130232186215, 6210.813675589739, 6252.374762523893, 6320.968395157995, 6334.018227174795, 6359.395857393541], "value": 4994.278924342547, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.7505898348461, 911.4850109688026, 924.8057907839353, 928.8328100941828, 941.1247539787996, 19108.808911910877, 20135.395938121845, 20166.798332016675, 20287.797122028776, 22126.22558210463, 22085.447863803412, 22730.659040114413, 22764.77235227647, 22789.31632051037, 22875.199368022124, 1019.9694009179736, 1043.0612448796069, 1043.1602559939247, 1047.7590154264485, 1048.3395460859647, 1025.830737928241, 1070.882202957674, 1074.9462526873665, 1077.5258886090096, 1077.9730506737317, 1113.6770336602376, 1125.8367536707171, 1126.1272513801828, 1127.10958342909, 1129.1982692288484, 1108.1633366808048, 1113.8329250612392, 1116.1126904111252, 1117.932924024557, 1124.9325040497556, 813.6175997281268, 814.9388795840276, 817.1420008990596, 820.5240960243045, 822.0300045945781, 20013.79986200134, 20585.0, 20809.0, 20891.68662470064, 21447.571048578942, 21621.891890540603, 21759.238426654993, 22267.665985010237, 22332.888335558382, 22469.662955055686, 17201.655966880717, 17285.135743212788, 17416.564585885328, 17482.388116415863, 17611.735823962652, 3636.436352365361, 3664.9450258246147, 3665.8350374233223, 3666.468362087509, 3666.5966743658178, 130779.34610326888, 133819.0, 134301.0, 134802.0, 135153.3242333792, 17607.0, 18166.818331816776, 18455.630887382446, 18538.721919171225, 18654.44036678902, 31135.0, 32144.83927580347, 32412.189695257337, 32450.35099298001, 32483.837580811945, 8026.5986700664735, 8980.46117232968, 9153.176214140625, 9344.439333640003, 9378.343515953818, 4365.017870979004, 4466.888327791831, 4478.552144785495, 4480.596746292849, 4481.081378317437, 5320.52115309624, 5464.371597266286, 5469.0, 5538.446155384429, 5541.501264886099, 1054.504382940017, 1081.491698901515, 1081.5565618096543, 1099.1097211258907, 1100.7963526747578, 552.505507570722, 564.5398999815137, 567.7842419880419, 569.4334137533181, 583.072914066636, 13123.60629181126, 13286.800697989538, 13377.866221337857, 13961.581152565235, 14305.85694143066, 578.7308901360888, 582.647498263553, 586.003793550965, 588.6232811000963, 592.973316200772, 5303.946960530422, 5707.0, 5932.940670593239, 5938.703064846827, 6070.659478472913, 102157.0, 102957.0, 104015.47992260141, 105439.0, 105883.0, 92069.0, 93427.53286233525, 93918.53040734753, 93998.96533885256, 96132.0, 81349.0, 81823.0, 82034.0, 82263.5886820562, 83984.58007709922, 11946.462409191434, 12299.139060266054, 12335.136540442083, 12360.938195308965, 12360.938195308965, 38336.80831595824, 38550.80724596359, 38881.0, 39986.80006599949, 40861.38707919443, 47485.52514474811, 49737.75131124321, 69747.0, 70196.29803702101, 73729.6313518429, 18332.358367457076, 18402.35591754336, 18405.355812546495, 18410.07949602488, 18597.81402185961, 17983.370582029565, 20470.18119275272, 20762.48093797667, 20978.58042839165, 21181.15275389029, 18067.728984064986, 18790.812091878906, 18899.338523151622, 18934.715979260596, 19094.0, 16638.75041874397, 16838.915805420893, 18934.43196704101, 18980.0, 19083.332083377016, 17578.20898059565, 18228.544286392946, 18446.26214951387, 18539.907300463412, 18874.7168792471, 13141.737165256833, 13700.24648644334, 13953.581392558239, 14182.290885455479, 14498.202598857164, 14081.859181408465, 14363.856361436252, 14455.0, 14929.0, 15021.924890375478], "value": 9317.89761713536, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 103.0, 108.0, 106.0, 108.0, 107.0, 99.0, 107.0, 110.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 117.0, 139.0, 171.0, 123.0, 148.0, 153.0, 118.0, 169.0, 118.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 164.0, 164.0, 163.0, 163.0, 164.0, 173.0, 165.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 179.0, 74.0, 75.0, 78.0, 75.0, 148.0, 78.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 137.0, 81.0, 79.0, 78.0, 132.0, 78.0, 78.0, 132.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 150.0, 151.0, 151.0, 152.0, 151.0, 151.0, 151.0, 150.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 56.0, 55.0, 56.0, 55.0, 56.0, 54.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 53.0, 53.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 89.0, 80.0, 79.0, 77.0, 86.0, 79.0, 77.0, 87.0, 79.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 130.0, 128.0, 130.0, 120.0, 124.0, 130.0, 123.0, 125.0, 161.0], "value": 130.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 176.0, 169.0, 172.0, 175.0, 201.0, 177.0, 174.0, 174.0, 168.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 65.0, 66.0, 64.0, 66.0, 65.0, 67.0, 65.0, 64.0], "value": 65.6, "unit": "score"}]}]} 07:26:18 INFO - Return code: 0 07:26:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:26:18 INFO - # TBPL SUCCESS # 07:26:18 INFO - Running post-action listener: _package_coverage_data 07:26:18 INFO - Running post-action listener: _resource_record_post_action 07:26:18 INFO - [mozharness: 2017-08-06 14:26:18.241713Z] Finished run-tests step (success) 07:26:18 INFO - Running post-run listener: _resource_record_post_run 07:26:18 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 431763456; Read time: 280; Write time: 699384 07:26:18 INFO - TinderboxPrint: CPU usage
13.2% 07:26:18 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 280 07:26:18 INFO - TinderboxPrint: I/O write bytes / time
431,763,456 / 699,384 07:26:18 INFO - TinderboxPrint: CPU idle
8,266.8 (86.8%) 07:26:18 INFO - TinderboxPrint: CPU user
1,202.0 (12.6%) 07:26:18 INFO - TinderboxPrint: Swap in / out
0 / 0 07:26:18 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 106635264; Read time: 0; Write time: 188720 07:26:18 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:18 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 12288; Write bytes: 324104192; Read time: 280; Write time: 510628 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:19 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 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: perfherder-data.json: 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/dromaeojs-e10s_raw.log ... 07:26:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:26:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:21 INFO - (blobuploader) - INFO - Done attempting. 07:26:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:26:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:26:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:21 INFO - (blobuploader) - INFO - Done attempting. 07:26:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:26:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:26:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:25 INFO - (blobuploader) - INFO - Done attempting. 07:26:25 INFO - (blobuploader) - INFO - Iteration through files over. 07:26:25 INFO - Return code: 0 07:26:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:26:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:26:25 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5975cc38d1e19fdb767ddfd332c1ea29bd16d2ba80fe3d8dff58d026c93d68ecae7d0cd3e8fefb3e0e466c4b1746cdb7605eb31a8a97380d971f5579aac491f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/653381925b2d05ef28ef39187cda88fb4e95aca5e35af586337973ab2318e4c1c98a4277de4010894abdd6dbf301b129a676697477b46dfc85df6ce30fd5bee4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b8fed0976134f6549ebfdcef7e1b3d40480de1d7fca082e70f2f8f50f171c0de32e8362b01ec707b581d2dfaf0d647955f3d506290edc95788e67a78281af7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/664df6b63377dc3c4fac02cc3b478614177de1d5676ba23647ba5f7f7f34a241b293ee4d96cbbed31505479c164c33e498911720096067fc5887e22451bcab16"} 07:26:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:26:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:26:25 INFO - Contents: 07:26:25 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5975cc38d1e19fdb767ddfd332c1ea29bd16d2ba80fe3d8dff58d026c93d68ecae7d0cd3e8fefb3e0e466c4b1746cdb7605eb31a8a97380d971f5579aac491f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/653381925b2d05ef28ef39187cda88fb4e95aca5e35af586337973ab2318e4c1c98a4277de4010894abdd6dbf301b129a676697477b46dfc85df6ce30fd5bee4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b8fed0976134f6549ebfdcef7e1b3d40480de1d7fca082e70f2f8f50f171c0de32e8362b01ec707b581d2dfaf0d647955f3d506290edc95788e67a78281af7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/664df6b63377dc3c4fac02cc3b478614177de1d5676ba23647ba5f7f7f34a241b293ee4d96cbbed31505479c164c33e498911720096067fc5887e22451bcab16"} 07:26:25 INFO - Running post-run listener: copy_logs_to_upload_dir 07:26:25 INFO - Copying logs to upload dir... 07:26:25 INFO - mkdir: /builds/slave/test/build/upload/logs 07:26:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.197334 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-06 07:26:24.748139) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 07:26:24.752484) ========= 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=ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549 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/a5975cc38d1e19fdb767ddfd332c1ea29bd16d2ba80fe3d8dff58d026c93d68ecae7d0cd3e8fefb3e0e466c4b1746cdb7605eb31a8a97380d971f5579aac491f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/653381925b2d05ef28ef39187cda88fb4e95aca5e35af586337973ab2318e4c1c98a4277de4010894abdd6dbf301b129a676697477b46dfc85df6ce30fd5bee4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b8fed0976134f6549ebfdcef7e1b3d40480de1d7fca082e70f2f8f50f171c0de32e8362b01ec707b581d2dfaf0d647955f3d506290edc95788e67a78281af7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/664df6b63377dc3c4fac02cc3b478614177de1d5676ba23647ba5f7f7f34a241b293ee4d96cbbed31505479c164c33e498911720096067fc5887e22451bcab16"} build_url:https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 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/a5975cc38d1e19fdb767ddfd332c1ea29bd16d2ba80fe3d8dff58d026c93d68ecae7d0cd3e8fefb3e0e466c4b1746cdb7605eb31a8a97380d971f5579aac491f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/653381925b2d05ef28ef39187cda88fb4e95aca5e35af586337973ab2318e4c1c98a4277de4010894abdd6dbf301b129a676697477b46dfc85df6ce30fd5bee4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b8fed0976134f6549ebfdcef7e1b3d40480de1d7fca082e70f2f8f50f171c0de32e8362b01ec707b581d2dfaf0d647955f3d506290edc95788e67a78281af7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/664df6b63377dc3c4fac02cc3b478614177de1d5676ba23647ba5f7f7f34a241b293ee4d96cbbed31505479c164c33e498911720096067fc5887e22451bcab16"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 07:26:24.788552) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-08-06 07:26:24.788914) ========= 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=ba164b0a7b0ec7655860e956000001c1-1502015829.31773-67636549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 1.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-08-06 07:26:25.938057) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 07:26:25.944413) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 07:26:25.945422) ========= ========= Total master_lag: 1.35 =========