builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1502852731.43 results: success (0) revision: 4e93516e92e58d166ad37b8544c3230024afb587 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:31.434837) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:31.435317) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:31.435602) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:31.491169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:31.491501) ========= 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=0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 20: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% 54.9M=0s 2017-08-15 20:05:31 (54.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114968 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:31.630451) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:31.630865) ========= 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=0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017425 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:31.696062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-15 20:05:31.696423) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4e93516e92e58d166ad37b8544c3230024afb587 --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 4e93516e92e58d166ad37b8544c3230024afb587 --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=0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 20:05:31,834 truncating revision to first 12 chars 2017-08-15 20:05:31,834 Setting DEBUG logging. 2017-08-15 20:05:31,834 attempt 1/10 2017-08-15 20:05:31,834 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4e93516e92e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-15 20:05:33,026 unpacking tar archive at: mozilla-central-4e93516e92e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.461845 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-15 20:05:33.176517) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:33.176935) ========= script_repo_revision: 4e93516e92e58d166ad37b8544c3230024afb587 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:33.177365) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:33.177628) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:33.193042) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-15 20:05:33.193442) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:05:33 INFO - MultiFileLogger online at 20170815 20:05:33 in /builds/slave/test 20:05:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 20:05:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:05:33 INFO - {'append_to_log': False, 20:05:33 INFO - 'base_work_dir': '/builds/slave/test', 20:05:33 INFO - 'blob_upload_branch': 'Firefox', 20:05:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:05:33 INFO - 'branch': 'Firefox', 20:05:33 INFO - 'buildbot_json_path': 'buildprops.json', 20:05:33 INFO - 'code_coverage': False, 20:05:33 INFO - 'config_files': ('talos/linux_config.py',), 20:05:33 INFO - 'default_actions': ('clobber', 20:05:33 INFO - 'read-buildbot-config', 20:05:33 INFO - 'download-and-extract', 20:05:33 INFO - 'populate-webroot', 20:05:33 INFO - 'create-virtualenv', 20:05:33 INFO - 'install', 20:05:33 INFO - 'setup-mitmproxy', 20:05:33 INFO - 'run-tests'), 20:05:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:05:33 INFO - 'disable_ccov_upload': False, 20:05:33 INFO - 'download_minidump_stackwalk': True, 20:05:33 INFO - 'download_symbols': 'ondemand', 20:05:33 INFO - 'enable_stylo': False, 20:05:33 INFO - 'enable_webrender': False, 20:05:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:05:33 INFO - 'tooltool.py': '/tools/tooltool.py', 20:05:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:05:33 INFO - '/tools/misc-python/virtualenv.py')}, 20:05:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:05:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:05:33 INFO - 'gecko_profile': False, 20:05:33 INFO - 'gecko_profile_interval': 0, 20:05:33 INFO - 'installer_path': 'installer.exe', 20:05:33 INFO - 'log_level': 'info', 20:05:33 INFO - 'log_name': 'talos', 20:05:33 INFO - 'log_to_console': True, 20:05:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:05:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:05:33 INFO - 'opt_config_files': (), 20:05:33 INFO - 'pip_index': False, 20:05:33 INFO - 'suite': 'dromaeojs-e10s', 20:05:33 INFO - 'system_bits': '32', 20:05:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:05:33 INFO - 'title': 'talos-linux64-ix-058', 20:05:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:05:33 INFO - 'use_talos_json': True, 20:05:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:05:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:05:33 INFO - 'work_dir': 'build'} 20:05:33 INFO - [mozharness: 2017-08-16 03:05:33.443952Z] Running clobber step. 20:05:33 INFO - Running pre-action listener: _resource_record_pre_action 20:05:33 INFO - Running main action method: clobber 20:05:33 INFO - rmtree: /builds/slave/test/build 20:05:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:05:34 INFO - Running post-action listener: _resource_record_post_action 20:05:34 INFO - [mozharness: 2017-08-16 03:05:34.466870Z] Finished clobber step (success) 20:05:34 INFO - [mozharness: 2017-08-16 03:05:34.466972Z] Running read-buildbot-config step. 20:05:34 INFO - Running pre-action listener: _resource_record_pre_action 20:05:34 INFO - Running main action method: read_buildbot_config 20:05:34 INFO - Using buildbot properties: 20:05:34 INFO - { 20:05:34 INFO - "project": "", 20:05:34 INFO - "product": "firefox", 20:05:34 INFO - "who": "kwierso@gmail.com", 20:05:34 INFO - "installer_path": "public/build/target.tar.bz2", 20:05:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 20:05:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 20:05:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 20:05:34 INFO - "stage_platform": "linux64-stylo", 20:05:34 INFO - "basedir": "/builds/slave/test", 20:05:34 INFO - "buildnumber": 86, 20:05:34 INFO - "platform": "ubuntu64_hw_stylo", 20:05:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:05:34 INFO - "slavebuilddir": "test", 20:05:34 INFO - "taskId": "QDqSrvA6Q4Wdv-E7bfdHAw", 20:05:34 INFO - "branch": "mozilla-central", 20:05:34 INFO - "script_repo_revision": "production", 20:05:34 INFO - "revision": "4e93516e92e58d166ad37b8544c3230024afb587", 20:05:34 INFO - "slavename": "talos-linux64-ix-058", 20:05:34 INFO - "repo_path": "mozilla-central" 20:05:34 INFO - } 20:05:34 INFO - Finding installer, test and symbols from parent task. 20:05:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QDqSrvA6Q4Wdv-E7bfdHAw'}, attempt #1 20:05:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QDqSrvA6Q4Wdv-E7bfdHAw'}, attempt #1 20:05:35 INFO - Task dependencies: CfE8SazFTyCmvfD5YyBUnw 20:05:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw'}, attempt #1 20:05:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 20:05:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.test_packages.json 20:05:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.crashreporter-symbols.zip 20:05:35 INFO - Running post-action listener: _resource_record_post_action 20:05:35 INFO - [mozharness: 2017-08-16 03:05:35.815343Z] Finished read-buildbot-config step (success) 20:05:35 INFO - [mozharness: 2017-08-16 03:05:35.815563Z] Running download-and-extract step. 20:05:35 INFO - Running pre-action listener: _resource_record_pre_action 20:05:35 INFO - Running main action method: download_and_extract 20:05:35 INFO - mkdir: /builds/slave/test/build/tests 20: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')]} 20:05:35 INFO - trying https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.test_packages.json 20:05:35 INFO - Downloading https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:05:36 INFO - Downloaded 989 bytes. 20:05:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:05:36 INFO - Using the following test package requirements: 20:05:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:05:36 INFO - u'common': [u'target.common.tests.zip'], 20:05:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:05:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:05:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:05:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:05:36 INFO - u'mozbase': [u'target.common.tests.zip'], 20:05:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:05:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:05:36 INFO - u'web-platform': [u'target.common.tests.zip', 20:05:36 INFO - u'target.web-platform.tests.tar.gz'], 20:05:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:05:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 20:05:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip 20:05:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:05:36 INFO - Fetch https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip into memory 20:05:37 INFO - Content-Length response header: 54004333 20:05:37 INFO - Bytes received: 54004333 20:05:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 20:05:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip 20:05:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:05:48 INFO - Fetch https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip into memory 20:05:49 INFO - Content-Length response header: 54004333 20:05:49 INFO - Bytes received: 54004333 20:06:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.talos.tests.zip 20:06:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:06:01 INFO - Fetch https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.talos.tests.zip into memory 20:06:02 INFO - Content-Length response header: 14496050 20:06:02 INFO - Bytes received: 14496050 20:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:02 INFO - trying https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 20:06:02 INFO - Downloading https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:06:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:06:03 INFO - Downloaded 61853457 bytes. 20:06:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 20:06:03 INFO - mkdir: /builds/slave/test/properties 20:06:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:06:03 INFO - Writing to file /builds/slave/test/properties/build_url 20:06:03 INFO - Contents: 20:06:03 INFO - build_url:https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 20:06:03 INFO - Running post-action listener: _resource_record_post_action 20:06:03 INFO - Running post-action listener: set_extra_try_arguments 20:06:03 INFO - [mozharness: 2017-08-16 03:06:03.808719Z] Finished download-and-extract step (success) 20:06:03 INFO - [mozharness: 2017-08-16 03:06:03.808817Z] Running populate-webroot step. 20:06:03 INFO - Running pre-action listener: _resource_record_pre_action 20:06:03 INFO - Running main action method: populate_webroot 20:06:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:06:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:06:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:06:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:06:03 INFO - 'tests': ['damp', 'tps']}, 20:06:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:06:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 20:06:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 20:06:03 INFO - 'other-e10s': {'tests': ['a11yr', 20:06:03 INFO - 'ts_paint', 20:06:03 INFO - 'tpaint', 20:06:03 INFO - 'sessionrestore', 20:06:03 INFO - 'sessionrestore_many_windows', 20:06:03 INFO - 'sessionrestore_no_auto_restore', 20:06:03 INFO - 'tabpaint']}, 20:06:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 20:06:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 20:06:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:06:03 INFO - 'tsvgr_opacity', 20:06:03 INFO - 'tart', 20:06:03 INFO - 'tscrollx', 20:06:03 INFO - 'tsvg_static']}, 20:06:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:06:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:06:03 INFO - 'talos_options': ['--mitmproxy', 20:06:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:06:03 INFO - '--firstNonBlankPaint'], 20:06:03 INFO - 'tests': ['tp6_google', 20:06:03 INFO - 'tp6_youtube', 20:06:03 INFO - 'tp6_amazon', 20:06:03 INFO - 'tp6_facebook']}, 20:06:03 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:06:03 INFO - 'talos_options': ['--stylo', 20:06:03 INFO - '--mitmproxy', 20:06:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:06:03 INFO - '--firstNonBlankPaint'], 20:06:03 INFO - 'tests': ['tp6_google', 20:06:03 INFO - 'tp6_youtube', 20:06:03 INFO - 'tp6_amazon', 20:06:03 INFO - 'tp6_facebook']}, 20:06:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:06:03 INFO - 'talos_options': ['--stylo', 20:06:03 INFO - '--stylo-threads=1', 20:06:03 INFO - '--mitmproxy', 20:06:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:06:03 INFO - '--firstNonBlankPaint'], 20:06:03 INFO - 'tests': ['tp6_google', 20:06:03 INFO - 'tp6_youtube', 20:06:03 INFO - 'tp6_amazon', 20:06:03 INFO - 'tp6_facebook']}, 20:06:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:06:03 INFO - 'talos_options': ['--xperf_path', 20:06:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:03 INFO - 'tests': ['tp5n']}}} 20:06:03 INFO - Running post-action listener: _resource_record_post_action 20:06:03 INFO - [mozharness: 2017-08-16 03:06:03.817328Z] Finished populate-webroot step (success) 20:06:03 INFO - [mozharness: 2017-08-16 03:06:03.817418Z] Running create-virtualenv step. 20:06:03 INFO - Running pre-action listener: _resource_record_pre_action 20:06:03 INFO - Running main action method: create_virtualenv 20:06:03 INFO - Creating virtualenv /builds/slave/test/build/venv 20:06:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:06:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:06:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 20:06:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:03 INFO - Using real prefix '/usr' 20:06:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:06:04 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:06 INFO - Installing pip.................done. 20:06:06 INFO - Return code: 0 20:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:06:06 INFO - Reading from file tmpfile_stdout 20:06:06 INFO - Output received: 20:06:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:06:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bccc0>, '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 0x21bdcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21be160>, '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': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', '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 20:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:06:06 INFO - Using env: {'DISPLAY': ':0', 20:06:06 INFO - 'HOME': '/home/cltbld', 20:06:06 INFO - 'LANG': 'en_US.UTF-8', 20:06:06 INFO - 'LANGUAGE': 'en_US:en', 20:06:06 INFO - 'LOGNAME': 'cltbld', 20:06:06 INFO - 'MAIL': '/var/mail/cltbld', 20:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:06 INFO - 'MOZ_NO_REMOTE': '1', 20:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:06 INFO - 'NO_EM_RESTART': '1', 20:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:06 INFO - 'PWD': '/builds/slave/test', 20:06:06 INFO - 'SHELL': '/bin/bash', 20:06:06 INFO - 'SHLVL': '1', 20:06:06 INFO - 'TERM': 'linux', 20:06:06 INFO - 'TMOUT': '86400', 20:06:06 INFO - 'USER': 'cltbld', 20:06:06 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', 20:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:06 INFO - '_': '/tools/buildbot/bin/python'} 20:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:06:06 INFO - Cleaning up... 20:06:06 INFO - Return code: 0 20:06:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bccc0>, '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 0x21bdcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21be160>, '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': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', '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 20:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:06:06 INFO - Using env: {'DISPLAY': ':0', 20:06:06 INFO - 'HOME': '/home/cltbld', 20:06:06 INFO - 'LANG': 'en_US.UTF-8', 20:06:06 INFO - 'LANGUAGE': 'en_US:en', 20:06:06 INFO - 'LOGNAME': 'cltbld', 20:06:06 INFO - 'MAIL': '/var/mail/cltbld', 20:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:06 INFO - 'MOZ_NO_REMOTE': '1', 20:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:06 INFO - 'NO_EM_RESTART': '1', 20:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:06 INFO - 'PWD': '/builds/slave/test', 20:06:06 INFO - 'SHELL': '/bin/bash', 20:06:06 INFO - 'SHLVL': '1', 20:06:06 INFO - 'TERM': 'linux', 20:06:06 INFO - 'TMOUT': '86400', 20:06:06 INFO - 'USER': 'cltbld', 20:06:06 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', 20:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:06 INFO - '_': '/tools/buildbot/bin/python'} 20:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:07 INFO - Downloading/unpacking psutil>=3.1.1 20: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 20: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 20: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 20: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 20:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:08 INFO - Installing collected packages: psutil 20:06:08 INFO - Running setup.py install for psutil 20:06:08 INFO - building 'psutil._psutil_linux' extension 20: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 20:06:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:06:08 INFO - building 'psutil._psutil_posix' extension 20:06:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:06:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:06:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:08 INFO - Successfully installed psutil 20:06:08 INFO - Cleaning up... 20:06:08 INFO - Return code: 0 20:06:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bccc0>, '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 0x21bdcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21be160>, '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': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', '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 20:06:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:06:08 INFO - Using env: {'DISPLAY': ':0', 20:06:08 INFO - 'HOME': '/home/cltbld', 20:06:08 INFO - 'LANG': 'en_US.UTF-8', 20:06:08 INFO - 'LANGUAGE': 'en_US:en', 20:06:08 INFO - 'LOGNAME': 'cltbld', 20:06:08 INFO - 'MAIL': '/var/mail/cltbld', 20:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:08 INFO - 'MOZ_NO_REMOTE': '1', 20:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:08 INFO - 'NO_EM_RESTART': '1', 20:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:08 INFO - 'PWD': '/builds/slave/test', 20:06:08 INFO - 'SHELL': '/bin/bash', 20:06:08 INFO - 'SHLVL': '1', 20:06:08 INFO - 'TERM': 'linux', 20:06:08 INFO - 'TMOUT': '86400', 20:06:08 INFO - 'USER': 'cltbld', 20:06:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', 20:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:08 INFO - '_': '/tools/buildbot/bin/python'} 20:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 20: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 20: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 20: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 20: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 20:06:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20: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) 20:06:10 INFO - Installing collected packages: mozsystemmonitor 20:06:10 INFO - Running setup.py install for mozsystemmonitor 20:06:10 INFO - Successfully installed mozsystemmonitor 20:06:10 INFO - Cleaning up... 20:06:10 INFO - Return code: 0 20:06:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20: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')]} 20:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20: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')]} 20:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20: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 0x1f181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bccc0>, '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 0x21bdcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21be160>, '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': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', '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 20: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 20: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 20:06:10 INFO - Using env: {'DISPLAY': ':0', 20:06:10 INFO - 'HOME': '/home/cltbld', 20:06:10 INFO - 'LANG': 'en_US.UTF-8', 20:06:10 INFO - 'LANGUAGE': 'en_US:en', 20:06:10 INFO - 'LOGNAME': 'cltbld', 20:06:10 INFO - 'MAIL': '/var/mail/cltbld', 20:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:10 INFO - 'MOZ_NO_REMOTE': '1', 20:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:10 INFO - 'NO_EM_RESTART': '1', 20:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:10 INFO - 'PWD': '/builds/slave/test', 20:06:10 INFO - 'SHELL': '/bin/bash', 20:06:10 INFO - 'SHLVL': '1', 20:06:10 INFO - 'TERM': 'linux', 20:06:10 INFO - 'TMOUT': '86400', 20:06:10 INFO - 'USER': 'cltbld', 20:06:10 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', 20:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:10 INFO - '_': '/tools/buildbot/bin/python'} 20:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:10 INFO - Downloading/unpacking jsonschema==2.5.1 20:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20: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 20: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 20: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 20: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 20:06:11 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:11 INFO - warning: no files found matching '*.txt' 20:06:11 INFO - no previously-included directories found matching 'build' 20:06:11 INFO - no previously-included directories found matching 'dist' 20:06:11 INFO - no previously-included directories found matching '.git*' 20:06:11 INFO - Installing collected packages: jsonschema, functools32 20:06:11 INFO - Running setup.py install for functools32 20:06:12 INFO - warning: no files found matching '*.txt' 20:06:12 INFO - no previously-included directories found matching 'build' 20:06:12 INFO - no previously-included directories found matching 'dist' 20:06:12 INFO - no previously-included directories found matching '.git*' 20:06:12 INFO - Successfully installed jsonschema functools32 20:06:12 INFO - Cleaning up... 20:06:12 INFO - Return code: 0 20:06:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20: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')]} 20:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20: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')]} 20:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20: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 0x1f181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bccc0>, '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 0x21bdcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21be160>, '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': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', '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 20: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 20: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 20:06:12 INFO - Using env: {'DISPLAY': ':0', 20:06:12 INFO - 'HOME': '/home/cltbld', 20:06:12 INFO - 'LANG': 'en_US.UTF-8', 20:06:12 INFO - 'LANGUAGE': 'en_US:en', 20:06:12 INFO - 'LOGNAME': 'cltbld', 20:06:12 INFO - 'MAIL': '/var/mail/cltbld', 20:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:12 INFO - 'MOZ_NO_REMOTE': '1', 20:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:12 INFO - 'NO_EM_RESTART': '1', 20:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:12 INFO - 'PWD': '/builds/slave/test', 20:06:12 INFO - 'SHELL': '/bin/bash', 20:06:12 INFO - 'SHLVL': '1', 20:06:12 INFO - 'TERM': 'linux', 20:06:12 INFO - 'TMOUT': '86400', 20:06:12 INFO - 'USER': 'cltbld', 20:06:12 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', 20:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:12 INFO - '_': '/tools/buildbot/bin/python'} 20:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:06:12 INFO - Cleaning up... 20:06:12 INFO - Return code: 0 20:06:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20: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')]} 20:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20: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')]} 20:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20: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 0x1f181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bccc0>, '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 0x21bdcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21be160>, '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': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', '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 20: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 20: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 20:06:12 INFO - Using env: {'DISPLAY': ':0', 20:06:12 INFO - 'HOME': '/home/cltbld', 20:06:12 INFO - 'LANG': 'en_US.UTF-8', 20:06:12 INFO - 'LANGUAGE': 'en_US:en', 20:06:12 INFO - 'LOGNAME': 'cltbld', 20:06:12 INFO - 'MAIL': '/var/mail/cltbld', 20:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:12 INFO - 'MOZ_NO_REMOTE': '1', 20:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:12 INFO - 'NO_EM_RESTART': '1', 20:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:12 INFO - 'PWD': '/builds/slave/test', 20:06:12 INFO - 'SHELL': '/bin/bash', 20:06:12 INFO - 'SHLVL': '1', 20:06:12 INFO - 'TERM': 'linux', 20:06:12 INFO - 'TMOUT': '86400', 20:06:12 INFO - 'USER': 'cltbld', 20:06:12 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', 20:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:12 INFO - '_': '/tools/buildbot/bin/python'} 20:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:12 INFO - Downloading/unpacking blobuploader==1.2.4 20: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 20: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 20: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 20: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 20:06:13 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20: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 20: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 20: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 20: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 20:06:14 INFO - Downloading docopt-0.6.1.tar.gz 20:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:14 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:14 INFO - Running setup.py install for blobuploader 20:06:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:14 INFO - Running setup.py install for requests 20:06:14 INFO - Running setup.py install for docopt 20:06:14 INFO - Successfully installed blobuploader requests docopt 20:06:14 INFO - Cleaning up... 20:06:14 INFO - Return code: 0 20:06:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bccc0>, '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 0x21bdcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21be160>, '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': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', '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 20:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:06:14 INFO - Using env: {'DISPLAY': ':0', 20:06:14 INFO - 'HOME': '/home/cltbld', 20:06:14 INFO - 'LANG': 'en_US.UTF-8', 20:06:14 INFO - 'LANGUAGE': 'en_US:en', 20:06:14 INFO - 'LOGNAME': 'cltbld', 20:06:14 INFO - 'MAIL': '/var/mail/cltbld', 20:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:14 INFO - 'MOZ_NO_REMOTE': '1', 20:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:14 INFO - 'NO_EM_RESTART': '1', 20:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:14 INFO - 'PWD': '/builds/slave/test', 20:06:14 INFO - 'SHELL': '/bin/bash', 20:06:14 INFO - 'SHLVL': '1', 20:06:14 INFO - 'TERM': 'linux', 20:06:14 INFO - 'TMOUT': '86400', 20:06:14 INFO - 'USER': 'cltbld', 20:06:14 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', 20:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:14 INFO - '_': '/tools/buildbot/bin/python'} 20:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:15 INFO - Running setup.py (path:/tmp/pip-zzH2kD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:15 INFO - Running setup.py (path:/tmp/pip-rMrk39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:15 INFO - Running setup.py (path:/tmp/pip-FDRuCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:15 INFO - Running setup.py (path:/tmp/pip-fewG9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:15 INFO - Running setup.py (path:/tmp/pip-RXYhZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:15 INFO - Running setup.py (path:/tmp/pip-qVXhT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:15 INFO - Running setup.py (path:/tmp/pip-cn_CPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:15 INFO - Running setup.py (path:/tmp/pip-ZoR7rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:15 INFO - Running setup.py (path:/tmp/pip-GNaAzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:15 INFO - Running setup.py (path:/tmp/pip-FQGYpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:15 INFO - Running setup.py (path:/tmp/pip-OMoIo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:15 INFO - Running setup.py (path:/tmp/pip-LIYYzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:15 INFO - Running setup.py (path:/tmp/pip-MmiMaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:16 INFO - Running setup.py (path:/tmp/pip-Hz0klg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:16 INFO - Running setup.py (path:/tmp/pip-XQr5Y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:16 INFO - Running setup.py (path:/tmp/pip-_z44GU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:16 INFO - Running setup.py (path:/tmp/pip-Mi72pY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:16 INFO - Running setup.py install for manifestparser 20:06:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:16 INFO - Running setup.py install for mozcrash 20:06:16 INFO - Running setup.py install for mozdebug 20:06:16 INFO - Running setup.py install for mozdevice 20:06:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:16 INFO - Running setup.py install for mozfile 20:06:16 INFO - Running setup.py install for mozhttpd 20:06:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:16 INFO - Running setup.py install for mozinfo 20:06:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Running setup.py install for mozInstall 20:06:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Running setup.py install for mozleak 20:06:17 INFO - Running setup.py install for mozlog 20:06:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Running setup.py install for moznetwork 20:06:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Running setup.py install for mozprocess 20:06:17 INFO - Running setup.py install for mozprofile 20:06:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Running setup.py install for mozrunner 20:06:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Running setup.py install for mozscreenshot 20:06:17 INFO - Running setup.py install for moztest 20:06:18 INFO - Running setup.py install for mozversion 20:06:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:18 INFO - Cleaning up... 20:06:18 INFO - Return code: 0 20:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20: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')]} 20:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20: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')]} 20:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20: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 0x1f181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bccc0>, '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 0x21bdcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21be160>, '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': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', '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 20: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 20: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 20:06:18 INFO - Using env: {'DISPLAY': ':0', 20:06:18 INFO - 'HOME': '/home/cltbld', 20:06:18 INFO - 'LANG': 'en_US.UTF-8', 20:06:18 INFO - 'LANGUAGE': 'en_US:en', 20:06:18 INFO - 'LOGNAME': 'cltbld', 20:06:18 INFO - 'MAIL': '/var/mail/cltbld', 20:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:18 INFO - 'MOZ_NO_REMOTE': '1', 20:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:18 INFO - 'NO_EM_RESTART': '1', 20:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:18 INFO - 'PWD': '/builds/slave/test', 20:06:18 INFO - 'SHELL': '/bin/bash', 20:06:18 INFO - 'SHLVL': '1', 20:06:18 INFO - 'TERM': 'linux', 20:06:18 INFO - 'TMOUT': '86400', 20:06:18 INFO - 'USER': 'cltbld', 20:06:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', 20:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:18 INFO - '_': '/tools/buildbot/bin/python'} 20:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:18 INFO - Running setup.py (path:/tmp/pip-LhkTvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20: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)) 20:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:18 INFO - Running setup.py (path:/tmp/pip-JDWYmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20: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)) 20:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:18 INFO - Running setup.py (path:/tmp/pip-uhb3Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20: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)) 20:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:18 INFO - Running setup.py (path:/tmp/pip-wBhnQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20: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)) 20:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:18 INFO - Running setup.py (path:/tmp/pip-fFocLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:18 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)) 20:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:18 INFO - Running setup.py (path:/tmp/pip-Xnf7I1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:18 INFO - Running setup.py (path:/tmp/pip-RfssS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:18 INFO - Running setup.py (path:/tmp/pip-0DOdTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:18 INFO - Running setup.py (path:/tmp/pip-TVRVsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20: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)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:19 INFO - Running setup.py (path:/tmp/pip-lzRfIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20: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)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:19 INFO - Running setup.py (path:/tmp/pip-Ed0Ho_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20: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)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:19 INFO - Running setup.py (path:/tmp/pip-_Z9eS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20: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)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:19 INFO - Running setup.py (path:/tmp/pip-4cTxuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20: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)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:19 INFO - Running setup.py (path:/tmp/pip-GPRkE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20: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)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:19 INFO - Running setup.py (path:/tmp/pip-6NMbUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20: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)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:19 INFO - Running setup.py (path:/tmp/pip-PLgQYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20: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)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:19 INFO - Running setup.py (path:/tmp/pip-Ukavyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20: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)) 20: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)) 20: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)) 20: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)) 20: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)) 20: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)) 20: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)) 20:06:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20: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 20: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 20: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 20: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 20:06:20 INFO - Downloading blessings-1.6.tar.gz 20:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:20 INFO - Installing collected packages: blessings 20:06:20 INFO - Running setup.py install for blessings 20:06:20 INFO - Successfully installed blessings 20:06:20 INFO - Cleaning up... 20:06:20 INFO - Return code: 0 20:06:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:21 INFO - Reading from file tmpfile_stdout 20:06:21 INFO - Current package versions: 20:06:21 INFO - argparse == 1.2.1 20:06:21 INFO - blessings == 1.6 20:06:21 INFO - blobuploader == 1.2.4 20:06:21 INFO - docopt == 0.6.1 20:06:21 INFO - functools32 == 3.2.3-2 20:06:21 INFO - jsonschema == 2.5.1 20:06:21 INFO - manifestparser == 1.1 20:06:21 INFO - mozInstall == 1.13 20:06:21 INFO - mozcrash == 1.0 20:06:21 INFO - mozdebug == 0.1 20:06:21 INFO - mozdevice == 0.51 20:06:21 INFO - mozfile == 1.2 20:06:21 INFO - mozhttpd == 0.7 20:06:21 INFO - mozinfo == 0.10 20:06:21 INFO - mozleak == 0.1 20:06:21 INFO - mozlog == 3.5 20:06:21 INFO - moznetwork == 0.27 20:06:21 INFO - mozprocess == 0.25 20:06:21 INFO - mozprofile == 0.28 20:06:21 INFO - mozrunner == 6.13 20:06:21 INFO - mozscreenshot == 0.1 20:06:21 INFO - mozsystemmonitor == 0.3 20:06:21 INFO - moztest == 0.8 20:06:21 INFO - mozversion == 1.4 20:06:21 INFO - psutil == 3.1.1 20:06:21 INFO - requests == 1.2.3 20:06:21 INFO - wsgiref == 0.1.2 20:06:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20: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')]} 20:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20: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')]} 20:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20: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 0x1f181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bccc0>, '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 0x21bdcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21be160>, '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': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', '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 20: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 20: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 20:06:21 INFO - Using env: {'DISPLAY': ':0', 20:06:21 INFO - 'HOME': '/home/cltbld', 20:06:21 INFO - 'LANG': 'en_US.UTF-8', 20:06:21 INFO - 'LANGUAGE': 'en_US:en', 20:06:21 INFO - 'LOGNAME': 'cltbld', 20:06:21 INFO - 'MAIL': '/var/mail/cltbld', 20:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:21 INFO - 'MOZ_NO_REMOTE': '1', 20:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:21 INFO - 'NO_EM_RESTART': '1', 20:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:21 INFO - 'PWD': '/builds/slave/test', 20:06:21 INFO - 'SHELL': '/bin/bash', 20:06:21 INFO - 'SHLVL': '1', 20:06:21 INFO - 'TERM': 'linux', 20:06:21 INFO - 'TMOUT': '86400', 20:06:21 INFO - 'USER': 'cltbld', 20:06:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', 20:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:21 INFO - '_': '/tools/buildbot/bin/python'} 20:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20: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)) 20: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)) 20: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)) 20: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)) 20: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)) 20: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)) 20: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)) 20: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)) 20: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)) 20:06:21 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 20: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 20: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 20: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 20: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 20:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 20: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)) 20: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)) 20:06:22 INFO - Installing collected packages: simplejson 20:06:22 INFO - Running setup.py install for simplejson 20:06:22 INFO - building 'simplejson._speedups' extension 20: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 20: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 20:06:23 INFO - Successfully installed simplejson 20:06:23 INFO - Cleaning up... 20:06:23 INFO - Return code: 0 20:06:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20: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')]} 20:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20: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')]} 20:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20: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 0x1f181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bccc0>, '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 0x21bdcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21be160>, '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': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', '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 20: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 20: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 20:06:23 INFO - Using env: {'DISPLAY': ':0', 20:06:23 INFO - 'HOME': '/home/cltbld', 20:06:23 INFO - 'LANG': 'en_US.UTF-8', 20:06:23 INFO - 'LANGUAGE': 'en_US:en', 20:06:23 INFO - 'LOGNAME': 'cltbld', 20:06:23 INFO - 'MAIL': '/var/mail/cltbld', 20:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:23 INFO - 'MOZ_NO_REMOTE': '1', 20:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:23 INFO - 'NO_EM_RESTART': '1', 20:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:23 INFO - 'PWD': '/builds/slave/test', 20:06:23 INFO - 'SHELL': '/bin/bash', 20:06:23 INFO - 'SHLVL': '1', 20:06:23 INFO - 'TERM': 'linux', 20:06:23 INFO - 'TMOUT': '86400', 20:06:23 INFO - 'USER': 'cltbld', 20:06:23 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', 20:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:23 INFO - '_': '/tools/buildbot/bin/python'} 20:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:06:23 INFO - Cleaning up... 20:06:23 INFO - Return code: 0 20:06:23 INFO - Running post-action listener: _resource_record_post_action 20:06:23 INFO - Running post-action listener: _start_resource_monitoring 20:06:23 INFO - Starting resource monitoring. 20:06:23 INFO - [mozharness: 2017-08-16 03:06:23.880361Z] Finished create-virtualenv step (success) 20:06:23 INFO - [mozharness: 2017-08-16 03:06:23.880822Z] Running install step. 20:06:23 INFO - Running pre-action listener: _resource_record_pre_action 20:06:23 INFO - Running main action method: install 20:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:24 INFO - Reading from file tmpfile_stdout 20:06:24 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:24 INFO - Reading from file tmpfile_stdout 20:06:24 INFO - Output received: 20:06:24 INFO - Usage: mozinstall [options] installer 20:06:24 INFO - Options: 20:06:24 INFO - -h, --help show this help message and exit 20:06:24 INFO - -d DEST, --destination=DEST 20:06:24 INFO - Directory to install application into. [default: 20:06:24 INFO - "/builds/slave/test"] 20:06:24 INFO - --app=APP Application being installed. [default: firefox] 20:06:24 INFO - mkdir: /builds/slave/test/build/application 20: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'] 20: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 20:06:42 INFO - Reading from file tmpfile_stdout 20:06:42 INFO - Output received: 20:06:42 INFO - /builds/slave/test/build/application/firefox/firefox 20:06:42 INFO - Running post-action listener: _resource_record_post_action 20:06:42 INFO - [mozharness: 2017-08-16 03:06:42.282721Z] Finished install step (success) 20:06:42 INFO - [mozharness: 2017-08-16 03:06:42.283068Z] Running setup-mitmproxy step. 20:06:42 INFO - Running pre-action listener: _resource_record_pre_action 20:06:42 INFO - Running main action method: setup_mitmproxy 20:06:42 INFO - Skipping: mitmproxy is not required 20:06:42 INFO - Running post-action listener: _resource_record_post_action 20:06:42 INFO - [mozharness: 2017-08-16 03:06:42.284695Z] Finished setup-mitmproxy step (success) 20:06:42 INFO - [mozharness: 2017-08-16 03:06:42.285009Z] Running run-tests step. 20:06:42 INFO - Running pre-action listener: _resource_record_pre_action 20:06:42 INFO - Running pre-action listener: _set_gcov_prefix 20:06:42 INFO - Running main action method: run_tests 20:06:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:06:42 INFO - Python 2.7.3 20:06:42 INFO - Return code: 0 20:06:42 INFO - grabbing minidump binary from tooltool 20: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')]} 20: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 0x21bccc0>, '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 0x21bdcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21be160>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20: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 20: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 20: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 20:06:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:06:42 INFO - Return code: 0 20:06:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:06:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:06:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:06:42 INFO - ENV: RUST_BACKTRACE is now full 20:06:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:06:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:06:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 20:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 20:06:42 INFO - Using env: {'DISPLAY': ':0', 20:06:42 INFO - 'HOME': '/home/cltbld', 20:06:42 INFO - 'LANG': 'en_US.UTF-8', 20:06:42 INFO - 'LANGUAGE': 'en_US:en', 20:06:42 INFO - 'LOGNAME': 'cltbld', 20:06:42 INFO - 'MAIL': '/var/mail/cltbld', 20:06:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:06:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:42 INFO - 'MOZ_NO_REMOTE': '1', 20:06:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:42 INFO - 'NO_EM_RESTART': '1', 20:06:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:42 INFO - 'PWD': '/builds/slave/test', 20:06:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:06:42 INFO - 'RUST_BACKTRACE': 'full', 20:06:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:06:42 INFO - 'SHELL': '/bin/bash', 20:06:42 INFO - 'SHLVL': '1', 20:06:42 INFO - 'STYLO_FORCE_ENABLED': '1', 20:06:42 INFO - 'TERM': 'linux', 20:06:42 INFO - 'TMOUT': '86400', 20:06:42 INFO - 'USER': 'cltbld', 20:06:42 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122', 20:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:42 INFO - '_': '/tools/buildbot/bin/python'} 20:06:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 20:06:42 INFO - mozversion application_buildid: 20170816020308 20:06:42 INFO - mozversion application_changeset: 4e93516e92e58d166ad37b8544c3230024afb587 20:06:42 INFO - mozversion application_display_name: Nightly 20:06:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:06:42 INFO - mozversion application_name: Firefox 20:06:42 INFO - mozversion application_remotingname: firefox 20:06:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:06:42 INFO - mozversion application_vendor: Mozilla 20:06:42 INFO - mozversion application_version: 57.0a1 20:06:42 INFO - mozversion platform_buildid: 20170816020308 20:06:42 INFO - mozversion platform_changeset: 4e93516e92e58d166ad37b8544c3230024afb587 20:06:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:06:42 INFO - mozversion platform_version: 57.0a1 20:06:42 INFO - using testdate: 1502852802 20:06:42 INFO - actual date: 1502852802 20:06:42 INFO - starting webserver on 'localhost:32966' 20:06:42 INFO - SUITE-START | Running 2 tests 20:06:42 INFO - TEST-START | dromaeo_css 20:06:42 INFO - Initialising browser for dromaeo_css test... 20:06:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:32966/getInfo.html -profile /tmp/tmp3JvDdS/profile 20:06:42 INFO - TEST-INFO | started process 22817 (/builds/slave/test/build/application/firefox/firefox http://localhost:32966/getInfo.html) 20:06:48 INFO - TEST-INFO | 22817: exit 0 20:06:48 INFO - Browser initialized. 20:06:48 INFO - Running cycle 1/1 for dromaeo_css test... 20:06:48 INFO - TEST-INFO | started process 23008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3JvDdS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:49 INFO - PID 23008 | 20:06:49 INFO - PID 23008 | (/builds/slave/test/build/application/firefox/firefox:23062): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:06:49 INFO - PID 23008 | 20:07:00 INFO - PID 23008 | RSS: Main: 171102208 20:07:00 INFO - PID 23008 | 20:09:58 INFO - PID 23008 | Cycle 1(1): loaded http://localhost:32966/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32966/tests/dromaeo/cssquery-ext.html) 20:10:00 INFO - PID 23008 | RSS: Main: 175648768 20:10:00 INFO - PID 23008 | 20:13:02 INFO - PID 23008 | Cycle 1(1): loaded http://localhost:32966/tests/dromaeo/cssquery-ext.html (next: http://localhost:32966/tests/dromaeo/cssquery-jquery.html) 20:13:03 INFO - PID 23008 | RSS: Main: 172920832 20:13:03 INFO - PID 23008 | 20:16:04 INFO - PID 23008 | Cycle 1(1): loaded http://localhost:32966/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32966/tests/dromaeo/cssquery-mootools.html) 20:16:05 INFO - PID 23008 | RSS: Main: 174751744 20:16:05 INFO - PID 23008 | 20:19:07 INFO - PID 23008 | Cycle 1(1): loaded http://localhost:32966/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32966/tests/dromaeo/cssquery-prototype.html) 20:19:08 INFO - PID 23008 | RSS: Main: 173506560 20:19:08 INFO - PID 23008 | 20:22:11 INFO - PID 23008 | Cycle 1(1): loaded http://localhost:32966/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32966/tests/dromaeo/cssquery-yui.html) 20:22:12 INFO - PID 23008 | RSS: Main: 176857088 20:22:12 INFO - PID 23008 | 20:25:14 INFO - PID 23008 | Cycle 1(1): loaded http://localhost:32966/tests/dromaeo/cssquery-yui.html (next: http://localhost:32966/tests/dromaeo/cssquery-dojo.html) 20:25:14 INFO - PID 23008 | RSS: Main: 176766976 20:25:14 INFO - PID 23008 | 20:25:14 INFO - PID 23008 | __start_tp_report 20:25:14 INFO - PID 23008 | _x_x_mozilla_page_load 20:25:14 INFO - PID 23008 | _x_x_mozilla_page_load_details 20:25:14 INFO - PID 23008 | |i|pagename|runs| 20:25:14 INFO - PID 23008 | |0;dojo.html;3103.8448077596126;3103.95344069839;3136.980481343564;3138.0428969164404;3140.952885706715;6029.819105426839;6057.485113765335;6108.358622344656;6133.50931925446;6160.845978850531;6143.201383820108;6143.938560614392;6256.280527739312;6265.24817021958;6298.401651843067;5637.154426835967;5645.717714114277;5650.180723795047;5694.601377903548;5707.172459993299;5503.944960550403;5559.638623489481;5623;5716.7141642917895;5733.226014488053;5501;5513.807016754395;5531.502164805167;5557.888842223173;5620.4098569650005;5613.522850557708;5675.432456754292;5705.229793977802;5708.7145642718115;5713.200151978726;5612.831615051514;5628.493435590775;5629.8592535186535;5670.518005969498;5684.573656975744;5931.614445061057;6009.639421634716;6099.237595300588;6102.938970610281;6189.81430557084;6580.638064906429;6597.934020659828;6619.93380066198;6637.867242655168;6724.562903411263;6635.601863888182;6753.4259587935085;6775.762848300285;6790.422814060761;6794.830129246809;6160.969195153995;6230.4392604665345;6246.593971391845;6249.031400133033;6253.312135665074;6863.450923926074;6869;6936.757213497604;6963.512554121163;6975.128108986377;6392.169018027626;6515.087887695727;6520.347965203537;6521.576097553644;6526.869462610816;6591.967040164768;6697.22981857083;6701.899471507932;6702.631355275409;6705.832354191184;6629.071929929813;6658.700358483879;6697.9665101675155;6698;6710.16122984627;6663.200415950117;6674.566153200027;6750.29121942189;6753.831154221086;6755.459563234929;5348.1175606025345;5419.701916394557;5435.42927992563;5445.863853403696;5502.504774570308;4669.813207471731;4692.178868697964;4719.1741445247635;4743.051389722069;4743.454502732161;5713.371529131792;5738.483536481736;5790.739416726257;5797.623154494944;5817.563682723812;6523.902141467882;6541.724363749118;6566.540342176002;6616.900746488806;6633.038209459602;5525.309336332958;5587.106063029977;5661.773529058792;5687.3459552152035;5737.311522617312;5938.465538101592;5949.583529153005;5953.434423729739;5969.343372229051;5970.492508136857;6411.647359395185;6536.934630653727;6544.770933017321;6553.279139294674;6556.704948277339;6639.468842492685;6654.83362915931;6731.932680673131;6767.627780471925;6768.593884366954;6219.0982307566055;6317;6409.551331406757;6409.8718025640155;6483.157189565326;6491.610503369624;6538.967305163444;6551.344865513601;6556;6556.147700798866;6670.833229169116;6738.561993470409;6761.121054262914;6772.52592318533;6790.626515541692;6456.12842266288;6466.321036291121;6539.771108011197;6554.410103090745;6589.868202635825;6344.904826427515;6447.948716682336;6451.70967306463;6541.378569035934;6557.278699342973;6261.8747625046335;6312.873742525032;6350.079238510298;6373.7131829066875;6384.07430922523;6392.456641185551;6414;6508.576942498722;6522.05430212626;6547.0179473079415;6299.496040316855;6318.526110541636;6360.618362898241;6380.425761681471;6392.776252831129 20:25:14 INFO - PID 23008 | |1;ext.html;774.3727580659667;826.8263664630429;846.407514739682;856.0412338181238;1160.709822544364;30007.399852002945;30751.84624076879;39696.99999999996;40643.796781016055;40720.59279407205;40688;40891.38662920051;41141.38287925676;41170.38244426336;41249.38125928106;7551.28262815033;7702.383809295243;7706.922930770705;7710.344620707218;7713.460057795956;7534.8116297092465;7660.387169026464;7666.769996900074;7668.769936901902;7672.309492145706;7639.541627502367;7693.038370203724;7731.806704832368;7740.535567865918;7769.844603107935;7682.807929801744;7693.346065584432;7724.150343462215;7741.22587741227;7752.186020467826;7545.50954187976;7574.8485030299635;7598.354139898115;7624.199459056775;7629.923700762977;36599.26801463983;36854.815725921464;37118.62881371179;37162.814185929165;37337.439938400676;3559.893203203908;3598.118460977051;3601.0457228834116;3602.0994751312173;3602.2075143468396;30222.244443889078;30237;30238.244043899078;30243.69756302453;30275;4996.25056241563;4998.425181104183;5004.024215278022;5024.723640199788;5030.723310217936;183153;183478;185158;186055.06972465187;186171;46736.76631616888;46744.5325546747;46800.5319946803;46852.297215541796;46916.2962555562;49227;49247;49273.50726492761;49274.26088608674;49275;15138;15385.615359616098;15410.383584656489;15460.226988650522;15474.148921809183;12767.233965962072;12815.102942793916;12817.935910320575;12819.615411537668;12827.294498802656;12722.61832145037;12735.172213806072;12811.743765124646;12833.52414472329;12852.164609300366;5463.69949652765;5482.972585137049;5488.835334939959;5512.586556008316;5542.91685624716;997.7206382212992;1001.8447140693204;1009.4700282351824;1013.4476710192815;1033.6537260017978;22787.022794014836;23275.53448931046;23284.06863725466;23298.65052024221;23455;1112.9387883666313;1113.2596823112701;1113.5991043224433;1116.3804088730833;1118.6140781430393;11752.529898803952;12273.754524909451;12416.689582760504;12417.813732794015;12538.686532836751;216829;216876;217623;233022;235663;54879.451205488236;55229.447705523235;55280.723596382566;55508.72245638746;55668.443315567136;1481.3259966715118;1527.8319384867655;1528.9755863571434;1533.3210134902042;1540.8844336674795;27701.722982769916;27987;28513.572296415154;28570.42859142847;29059.7094029057;50724.49275507198;51348;51379.486205138965;51390.22914656358;51420.22869656883;202805;204114;204247;205327;205349;35547;35687.78809907121;35705;36939.44590831194;37746.62253377431;46810.531894680615;47467;47601.52398475971;47873.76063119662;48153.27770083521;34399;34891.65108348986;34900.301993959474;35204.823975879954;36048.81975590105;34807.82596087003;34894.65105348914;35015.299694005465;35081.82459087688;35450.82274588611;36655;37826.43260351152;38125.2374952505;38307.808460957516;38382.23235535329;33744.83127584346;33871.3225735479;34133.48799767956;34358.31283374369;34746.65253347434;24250;24719.752802471747;24868.502629947663;25264.494710106064;25302.49395012126 20:25:14 INFO - PID 23008 | |2;jquery.html;556.8079012740603;557.7350758389765;560.1373884218301;570.3811364669335;574.5403677058353;20934;21618.35144945652;21714.782852171473;21913.890430547825;22451.887740561317;27173.45653086937;27636.447271054618;27664.723352766516;27715.307117322078;27872.3031924202;6889.6555172241315;7056.329648683392;7070.469714771387;7071.045408869788;7074.575525468463;6305.464035556983;6639.203295604534;6880.449564034865;6902.240753517109;6906.171259448874;6855.725770969155;6859.142607174103;6860.245373008965;6860.485463590226;6864.1762988441205;6854.246032936398;6860.588364698134;6861.416779573742;6867.896981545256;6868.381845633917;6715.932840671629;6717.361850624183;6736.427403670645;6746.595204287759;6790.626515541643;30866.691333086605;30976;32187;32460.513092303398;32669.18327041819;1925.8459323254106;1943.7278780970535;1947.0362170725582;1950.4441234248313;1959.549303660152;20325.288614898556;21442.89278553613;21456.678149827763;21475.140994360365;21477.140914363565;2385.415573184581;2531.4683916377585;2543.26245388837;2599.051346258602;2612.164107485605;139753;143191;143560;143589;143688.28155859362;21838.563228735336;22294;22465.052371659553;22811.771882281297;23761.405964851016;43638;43765.78117109394;43807.561924380985;43919;43935;12245.938770306091;12438.129330946927;12522.624321270376;12620.36898155107;12630.92760869673;10178.694639160836;10187.439690817077;10203.591856325813;10236.692899213036;10308.536115874804;11605.361705106301;11980.940095299467;12130.818037729441;12139.210951288138;12224.144309898222;4009.7393669411395;4027.3737896960192;4390.824367025347;4527.456705195332;4573.49691533931;943.2595412601075;963.2342287881152;976.8473201622012;991.4596544883057;993.6869885985891;19704.81771093739;20156.29452969139;20387.184512619624;20668.069936852877;20707.4823129423;1009.9747506312401;1021.0963297481782;1026.6612018034032;1028.4189432970497;1030.4744580264119;11288.604898828502;13621.523246686318;14091.78862317066;14738.189399582912;14895.70208595822;505229;509444;511339;524369;528072;123776;124379.3781031089;126096.36951815183;127248;128059;1112.9276597021167;1157.6700640317638;1235.215638069832;1237.6348977051791;1292.0374321130819;20951;21047.913138758962;21250.14999400007;21503.784962150803;21822;59365.40634593599;59422.87424012962;60160;60375.698121509115;61410;70022.94965575419;73598.63200683962;74542.62728686322;74586;74926;14198.077124986843;14302.356393962506;14538.85461145375;14573;14590.124592524058;22968.4257893554;23067.307980760605;23101;23274.883625581762;23393.883030584737;17679.911600441916;17782.288708452033;18092.90953545224;18685.439436816916;18808.811911880704;17367.30530778755;18029.368972085915;18047.368342107962;18051.548711282325;18130;19413.61172776565;19605.82365058101;19906.800931990496;20224.292149774687;20255.189792408728;15155.924220378827;15248.085114893142;15288.923555382597;15300.387984480496;15336.693266134838;17815.554611134827;18612.162452689932;18870.811291886905;18999.955002474442;19009.33467328692 20:25:14 INFO - PID 23008 | |3;mootools.html;1310.4037662863398;1362.1214316765686;1376.8554301798317;1377.8759911607954;1380.6893448973988;13771.724565508684;14158;14741.48404805832;14745.115293082423;14769.852301476982;15053.322600482978;15333.233338333066;15353.078815271063;15373.23133843309;15377.69244615107;2254.3800454874918;2276.7609401012905;2280.2019293247395;2281.155972290255;2285.954280914381;2619.109502769058;2691.5155272051024;2781.040541013347;2782.6382570265837;2787.818791778528;2711.6068170115323;2734.220747087071;2748.5877118432195;2752.215618548714;2756.710545392735;2661.361273294415;2691.7039125696156;2705.418335057962;2712.9864350678317;2713.6200931869357;2569.331973686836;2621.3708709909483;2625.921222363332;2629.224378808256;2634.8287361321454;14420.062695924837;14503.70992580153;14507.927460362736;14512.201828899406;14512.782308265385;7677.155512893577;7945.324647404977;7953.164917683675;7958.403119765982;7965.6813727450835;4918.139325618038;5149;5243.554297884684;5253.474652534716;5255.684658920439;1872.9906350468298;1928.7974762650001;1928.9035548222532;1963.4404194804413;1970.802919708032;23639.409014774767;23954.76045239543;24028.159014434586;24109.15617953363;24127.396815079588;6480.967595161994;6481.351864813575;6487.416132547999;6615.735370585219;6657.53397262187;16254.349826006828;16287.104209268604;16367;16421.26104325284;16439.589010274838;7564.319211270902;7691.269329413697;7695.653695583712;7726.420518461138;7753.4960227585025;7059.082319298458;7136;7207.351338379571;7214.098237720285;7271.418286537064;4936.308916751657;5111.744412779346;5131.7690703918415;5138.203578445347;5145.331106956071;1482.303317440801;1506.5329747778223;1509.222750283605;1528.465037236958;1536.063001569042;760.851633931378;793.3613441179906;808.8665370213848;810.2383759266271;829.1128492512953;8120.715774947848;8316.126806685332;8437.789055273544;8500.574971251537;8564.48613083217;977.7066879935991;1005.2309982863115;1012.4785735346155;1013.2653825976108;1020.1175982774846;5136.768845401966;5197.8440646780655;5248;5252.868678283074;5373.516383525502;19603.803961960482;19629.607407851763;19701.901490492743;20261;20472.59054818925;18345;18818.341358052676;18858;20141;20454.693179602316;10596.152307815357;10624.415657138778;10805.189610779224;10832.079273261703;11116.499272598257;8226.753197404087;8231.09457959612;8339.791505212175;8403.453775504573;8429.452085614415;16630.916845415697;16930.746038809182;17254.137293135544;17568.56078598045;17699.20353584066;17093.401730939357;17304.740428893325;17692;18152.364667236583;18263.54341141482;11519.654410367368;11558.42207889619;11804.17370784037;11804.17370784037;11806.291622502677;13203.801942970671;13381.464741410235;13383.397747101599;13390.866091338961;13439.260840653858;10826.296290741077;10862.402567858528;10864.674059778219;10908.400037997986;11122.777544449227;10307.226957978031;10421.583136674448;10463.319884207502;10560.471976401303;10705.89294107049;9650.517474126125;9692.515374231401;9744.561494732896;9774.804503910023;9786.902130978599;7300.379467745302;7307.890381644386;7343.963280183565;7383.187849336461;7434.293742094493;7207.351338379571;7289.088863892013;7306.890396643948;7326.597037162794;7352.448566357438 20:25:14 INFO - PID 23008 | |4;prototype.html;497.5972189086946;499.93083960716893;516.8578640873759;520.6563667979135;520.8203169906384;6084.72618732157;6151.661658608775;6161.260648722154;6231.6572588507615;6284.62292262464;5917.053271476565;6005.789797357093;6005.849853753658;6073.362296958822;6082.969585152068;4897.167481528139;4911.189653707134;4912.38595175603;4921.163402221631;4955.355803745508;4932.210846264598;4937.296632661744;4940.802367905279;4959.454460009396;4996.5503104720565;4829.4446138693975;4853.223484242522;4922.3354847095725;4930.186519224341;4933.506649335056;4935.5804756595735;4950.455449900508;4955.578775804025;4971.875703107415;5000.324956130912;4423.447069116361;4428.070105277896;4446.244138496463;4456.398386217884;4474.127545128701;6010.639361638316;6044.4888777805545;6045.848853778691;6046.365131661156;6055.848603784896;5650.3219613646625;5689.6586204827845;5710.428957104298;5769.999999999958;5770.682612456313;6418.486521078303;6422.820703751626;6464.22429308486;6536.084948107269;6615.702293396808;4879.8780030499165;4893.75531223441;4913.189323761575;4935.506449355072;4945.530174633404;6787.626680532618;6844.965775171092;6926.134233220848;6981.930180698178;6984;4988.6507944444265;4995.825146119869;5038.949610503848;5050.949490505048;5061.190209566452;5070.543651071422;5088.720120393414;5100.107481190851;5100.872478188001;5108.7190204538365;5692.345380281321;5715.628484148517;5726.627769194989;5742.339630942495;5747.166660834156;6427.903581446282;6526;6537.477001839841;6571.80284591463;6693.933060669428;1667.65813008333;1710.435556266429;1757.1916918217762;1757.2795153986804;1767.5139336682257;1210.6005018343926;1220.3837062283667;1225.6751960730414;1229.5081967213007;1236.9505219791288;5668.26312579362;5673.574481913873;5681.34664513578;5737.3648510175235;5765.88468230633;6612;6627.768028118992;6678.23200331968;6695.966520167465;6710.564442801249;5664.773409063674;5692.9146062809095;5715.399883012307;5800.24596802413;5814.360420353758;3552.5204097446513;3561.9821900890847;3578.874739384109;3593.083763640307;3593.730470214692;6481.902771458432;6509.7361228395475;6533.901991470132;6554.230357803462;6573.934260657428;6863;6884.65576721162;6923.826904327331;6927.238003819576;6953.930460695429;6468.611883287018;6547;6583.090903637987;6583.63789991555;6619.3877041402775;6606.4384527315715;6649.966750166218;6682.298358672464;6740.831479212863;6781;6582.637954912526;6625.701843417154;6682.599044057372;6724.8991265132045;6740.6966686498245;6426.196725409324;6433.678316084271;6437.227532696106;6470.417662410406;6570.273336565272;4927.581155601671;4943.134951383566;4943.456219815889;4971.1797553403285;4972.701637901738;6737.730490780314;6770.187577490733;6772.679327531281;6775.86448271022;6788.2193547742645;6534.738610455719;6536.248331441945;6538.542302038812;6545.869082618226;6578.638174900235;6521.836954076186;6528.543001989815;6535.509836762167;6545.2800191979795;6574.704138313692;6160.322364539987;6266.436020758154;6286.779962701284;6424.678766061772;6458.483321334376;6375.6174629522375;6427.164468619049;6533.236026272974;6554.442872355903;6573.57271777333;6302.485325340327;6302.684865756785;6316.673498565353;6339.3343698912795;6405.807825765234 20:25:14 INFO - PID 23008 | |5;yui.html;900.85586306191;923.0769230769231;933.6685476655787;938.4838338913596;938.7981583959447;18567.164477598508;19605.117769700362;19614.313499027536;19636.803631963678;20481.28315508954;19902.303419380325;20789.896050519725;20881.269155579557;20884.89557552214;21008.57982840346;1029.4595337447824;1067.770429357688;1069.0645685025602;1071.7749272652752;1073.1039581949042;1011.1354791653141;1035.3011717090972;1068.278911734576;1070.8340207267886;1072.3565860483686;1112.6383925224295;1114.1142791480752;1116.9553217871276;1117.3798541809292;1117.5585643670786;1111.6720567432626;1112.7329440934197;1112.933224006562;1113.0372228022743;1113.4043286841502;810.9026916770025;810.9553974531399;811.342812322021;811.4644334739044;812.8780682897553;18932.053397330215;19065.523361915923;19088.14103365338;19687.31094411703;20827.8958605206;21316.36050918475;22080.88959555208;22180;22428;22647.547049059092;17273.464998531297;17322.133893305283;17375.30498780047;17444.302227910994;17678.46964591064;3702.185519185775;3727.7763334200035;3730.8694195703292;3730.981345093257;3733.1600389912323;131852.34073829665;132843.33578332048;133217.33391333077;134632;137187.31406342905;16975.236114374882;17046.82953170477;17436;17619;17733.7339939901;31450.685493144774;32531.18672033171;33208.3358332832;33229;33286;7404.148522919825;7414.925850741532;7645.426593005435;8764.737057888273;9084.137006984325;3965.2466031453932;4264.0832221072615;4266.0827921996915;4268.722533035343;4270.7864606769535;5282.102042652758;5374.435684253175;5420.728963551806;5424.457554244623;5468.152436372368;1047.512906498482;1053.146950969717;1065.0414626835754;1072.292287090532;1073.7208325835338;646.4698946863526;655.570601256178;662.258270736778;666.3037126203129;669.8894682377353;11688.590899318484;11924.821127683092;12511.436985335682;12572.685682858002;13824.360343811994;693.6081114170478;705.1115594351154;705.9470539709542;714.1608609883366;716.781381678593;5527.723613819293;5558.916616250759;5648.802291919763;5938.257717785277;5946.405359464019;104319;107600.4619976895;110727.44636276767;111808;113373;98177;98606;100013.49993250133;102050.97949020415;103025;89275;89827.55086224657;90025.54987225153;91083.54458227799;92154;12649.114561980574;13025.609231722685;13039.348032598142;13039.739205215652;13192.142510736772;39391.40912886366;40352.1929561413;40582.02351438767;41373.79313103415;41482.37776433295;52040.47959520508;52894.471055290494;53024;53037.20444193418;53986.46013539814;18790.624187516445;18924;18979.43061708151;19064.42806715801;19071.18823711745;21365.572688546454;21903;21903.233386831384;21959.890200548896;22098.558028839656;19220.519487012378;19241.4227573173;19792.20831166795;19849.206031758567;19895.10472028733;17117.74323385175;17605.559861003578;17783.911080444515;17866.91066544659;18491.537711557317;17888;18812.623747525246;19212.71180932315;19940.800591994474;20013.09941052627;14201.857981420053;14300.21348825783;14315.498957536853;14353;14429.567112986628;14079.507217247346;14106.858931410965;14209.147451152963;14322.856771432569;15183.696326073195 20:25:14 INFO - PID 23008 | __end_tp_report 20:25:14 INFO - PID 23008 | __start_cc_report 20:25:14 INFO - PID 23008 | _x_x_mozilla_cycle_collect,362 20:25:14 INFO - PID 23008 | __end_cc_report 20:25:14 INFO - PID 23008 | __startTimestamp1502853914583__endTimestamp 20:25:14 INFO - PID 23008 | 20:25:14 INFO - PID 23008 | ------- Summary: start ------- 20:25:14 INFO - PID 23008 | Number of tests: 6 20:25:14 INFO - PID 23008 | 20:25:14 INFO - PID 23008 | [#0] dojo.html Cycles:165 Average:6118.54 Median:6350.08 stddev:728.34 (11.5%) stddev-sans-first:691.11 20:25:14 INFO - PID 23008 | Values: 3103.8 3104.0 3137.0 3138.0 3141.0 6029.8 6057.5 6108.4 6133.5 6160.8 6143.2 6143.9 6256.3 6265.2 6298.4 5637.2 5645.7 5650.2 5694.6 5707.2 5503.9 5559.6 5623.0 5716.7 5733.2 5501.0 5513.8 5531.5 5557.9 5620.4 5613.5 5675.4 5705.2 5708.7 5713.2 5612.8 5628.5 5629.9 5670.5 5684.6 5931.6 6009.6 6099.2 6102.9 6189.8 6580.6 6597.9 6619.9 6637.9 6724.6 6635.6 6753.4 6775.8 6790.4 6794.8 6161.0 6230.4 6246.6 6249.0 6253.3 6863.5 6869.0 6936.8 6963.5 6975.1 6392.2 6515.1 6520.3 6521.6 6526.9 6592.0 6697.2 6701.9 6702.6 6705.8 6629.1 6658.7 6698.0 6698.0 6710.2 6663.2 6674.6 6750.3 6753.8 6755.5 5348.1 5419.7 5435.4 5445.9 5502.5 4669.8 4692.2 4719.2 4743.1 4743.5 5713.4 5738.5 5790.7 5797.6 5817.6 6523.9 6541.7 6566.5 6616.9 6633.0 5525.3 5587.1 5661.8 5687.3 5737.3 5938.5 5949.6 5953.4 5969.3 5970.5 6411.6 6536.9 6544.8 6553.3 6556.7 6639.5 6654.8 6731.9 6767.6 6768.6 6219.1 6317.0 6409.6 6409.9 6483.2 6491.6 6539.0 6551.3 6556.0 6556.1 6670.8 6738.6 6761.1 6772.5 6790.6 6456.1 6466.3 6539.8 6554.4 6589.9 6344.9 6447.9 6451.7 6541.4 6557.3 6261.9 6312.9 6350.1 6373.7 6384.1 6392.5 6414.0 6508.6 6522.1 6547.0 6299.5 6318.5 6360.6 6380.4 6392.8 20:25:14 INFO - PID 23008 | 20:25:14 INFO - PID 23008 | [#1] ext.html Cycles:180 Average:38145.71 Median:3599.58 stddev:53140.92 (1476.3%) stddev-sans-first:53215.91 20:25:14 INFO - PID 23008 | Values: 774.4 826.8 846.4 856.0 1160.7 30007.4 30751.8 39697.0 40643.8 40720.6 40688.0 40891.4 41141.4 41170.4 41249.4 7551.3 7702.4 7706.9 7710.3 7713.5 7534.8 7660.4 7666.8 7668.8 7672.3 7639.5 7693.0 7731.8 7740.5 7769.8 7682.8 7693.3 7724.2 7741.2 7752.2 7545.5 7574.8 7598.4 7624.2 7629.9 36599.3 36854.8 37118.6 37162.8 37337.4 3559.9 3598.1 3601.0 3602.1 3602.2 30222.2 30237.0 30238.2 30243.7 30275.0 4996.3 4998.4 5004.0 5024.7 5030.7 183153.0 183478.0 185158.0 186055.1 186171.0 46736.8 46744.5 46800.5 46852.3 46916.3 49227.0 49247.0 49273.5 49274.3 49275.0 15138.0 15385.6 15410.4 15460.2 15474.1 12767.2 12815.1 12817.9 12819.6 12827.3 12722.6 12735.2 12811.7 12833.5 12852.2 5463.7 5483.0 5488.8 5512.6 5542.9 997.7 1001.8 1009.5 1013.4 1033.7 22787.0 23275.5 23284.1 23298.7 23455.0 1112.9 1113.3 1113.6 1116.4 1118.6 11752.5 12273.8 12416.7 12417.8 12538.7 216829.0 216876.0 217623.0 233022.0 235663.0 54879.5 55229.4 55280.7 55508.7 55668.4 1481.3 1527.8 1529.0 1533.3 1540.9 27701.7 27987.0 28513.6 28570.4 29059.7 50724.5 51348.0 51379.5 51390.2 51420.2 202805.0 204114.0 204247.0 205327.0 205349.0 35547.0 35687.8 35705.0 36939.4 37746.6 46810.5 47467.0 47601.5 47873.8 48153.3 34399.0 34891.7 34900.3 35204.8 36048.8 34807.8 34894.7 35015.3 35081.8 35450.8 36655.0 37826.4 38125.2 38307.8 38382.2 33744.8 33871.3 34133.5 34358.3 34746.7 24250.0 24719.8 24868.5 25264.5 25302.5 20:25:14 INFO - PID 23008 | 20:25:14 INFO - PID 23008 | [#2] jquery.html Cycles:180 Average:37536.48 Median:21666.57 stddev:86811.35 (400.7%) stddev-sans-first:87010.48 20:25:14 INFO - PID 23008 | Values: 556.8 557.7 560.1 570.4 574.5 20934.0 21618.4 21714.8 21913.9 22451.9 27173.5 27636.4 27664.7 27715.3 27872.3 6889.7 7056.3 7070.5 7071.0 7074.6 6305.5 6639.2 6880.4 6902.2 6906.2 6855.7 6859.1 6860.2 6860.5 6864.2 6854.2 6860.6 6861.4 6867.9 6868.4 6715.9 6717.4 6736.4 6746.6 6790.6 30866.7 30976.0 32187.0 32460.5 32669.2 1925.8 1943.7 1947.0 1950.4 1959.5 20325.3 21442.9 21456.7 21475.1 21477.1 2385.4 2531.5 2543.3 2599.1 2612.2 139753.0 143191.0 143560.0 143589.0 143688.3 21838.6 22294.0 22465.1 22811.8 23761.4 43638.0 43765.8 43807.6 43919.0 43935.0 12245.9 12438.1 12522.6 12620.4 12630.9 10178.7 10187.4 10203.6 10236.7 10308.5 11605.4 11980.9 12130.8 12139.2 12224.1 4009.7 4027.4 4390.8 4527.5 4573.5 943.3 963.2 976.8 991.5 993.7 19704.8 20156.3 20387.2 20668.1 20707.5 1010.0 1021.1 1026.7 1028.4 1030.5 11288.6 13621.5 14091.8 14738.2 14895.7 505229.0 509444.0 511339.0 524369.0 528072.0 123776.0 124379.4 126096.4 127248.0 128059.0 1112.9 1157.7 1235.2 1237.6 1292.0 20951.0 21047.9 21250.1 21503.8 21822.0 59365.4 59422.9 60160.0 60375.7 61410.0 70022.9 73598.6 74542.6 74586.0 74926.0 14198.1 14302.4 14538.9 14573.0 14590.1 22968.4 23067.3 23101.0 23274.9 23393.9 17679.9 17782.3 18092.9 18685.4 18808.8 17367.3 18029.4 18047.4 18051.5 18130.0 19413.6 19605.8 19906.8 20224.3 20255.2 15155.9 15248.1 15288.9 15300.4 15336.7 17815.6 18612.2 18870.8 19000.0 19009.3 20:25:14 INFO - PID 23008 | 20:25:14 INFO - PID 23008 | [#3] mootools.html Cycles:180 Average:8932.38 Median:23991.46 stddev:6133.54 (25.6%) stddev-sans-first:6124.01 20:25:14 INFO - PID 23008 | Values: 1310.4 1362.1 1376.9 1377.9 1380.7 13771.7 14158.0 14741.5 14745.1 14769.9 15053.3 15333.2 15353.1 15373.2 15377.7 2254.4 2276.8 2280.2 2281.2 2286.0 2619.1 2691.5 2781.0 2782.6 2787.8 2711.6 2734.2 2748.6 2752.2 2756.7 2661.4 2691.7 2705.4 2713.0 2713.6 2569.3 2621.4 2625.9 2629.2 2634.8 14420.1 14503.7 14507.9 14512.2 14512.8 7677.2 7945.3 7953.2 7958.4 7965.7 4918.1 5149.0 5243.6 5253.5 5255.7 1873.0 1928.8 1928.9 1963.4 1970.8 23639.4 23954.8 24028.2 24109.2 24127.4 6481.0 6481.4 6487.4 6615.7 6657.5 16254.3 16287.1 16367.0 16421.3 16439.6 7564.3 7691.3 7695.7 7726.4 7753.5 7059.1 7136.0 7207.4 7214.1 7271.4 4936.3 5111.7 5131.8 5138.2 5145.3 1482.3 1506.5 1509.2 1528.5 1536.1 760.9 793.4 808.9 810.2 829.1 8120.7 8316.1 8437.8 8500.6 8564.5 977.7 1005.2 1012.5 1013.3 1020.1 5136.8 5197.8 5248.0 5252.9 5373.5 19603.8 19629.6 19701.9 20261.0 20472.6 18345.0 18818.3 18858.0 20141.0 20454.7 10596.2 10624.4 10805.2 10832.1 11116.5 8226.8 8231.1 8339.8 8403.5 8429.5 16630.9 16930.7 17254.1 17568.6 17699.2 17093.4 17304.7 17692.0 18152.4 18263.5 11519.7 11558.4 11804.2 11804.2 11806.3 13203.8 13381.5 13383.4 13390.9 13439.3 10826.3 10862.4 10864.7 10908.4 11122.8 10307.2 10421.6 10463.3 10560.5 10705.9 9650.5 9692.5 9744.6 9774.8 9786.9 7300.4 7307.9 7344.0 7383.2 7434.3 7207.4 7289.1 7306.9 7326.6 7352.4 20:25:14 INFO - PID 23008 | 20:25:14 INFO - PID 23008 | [#4] prototype.html Cycles:180 Average:5493.86 Median:6046.11 stddev:1543.33 (25.5%) stddev-sans-first:1501.41 20:25:14 INFO - PID 23008 | Values: 497.6 499.9 516.9 520.7 520.8 6084.7 6151.7 6161.3 6231.7 6284.6 5917.1 6005.8 6005.8 6073.4 6083.0 4897.2 4911.2 4912.4 4921.2 4955.4 4932.2 4937.3 4940.8 4959.5 4996.6 4829.4 4853.2 4922.3 4930.2 4933.5 4935.6 4950.5 4955.6 4971.9 5000.3 4423.4 4428.1 4446.2 4456.4 4474.1 6010.6 6044.5 6045.8 6046.4 6055.8 5650.3 5689.7 5710.4 5770.0 5770.7 6418.5 6422.8 6464.2 6536.1 6615.7 4879.9 4893.8 4913.2 4935.5 4945.5 6787.6 6845.0 6926.1 6981.9 6984.0 4988.7 4995.8 5038.9 5050.9 5061.2 5070.5 5088.7 5100.1 5100.9 5108.7 5692.3 5715.6 5726.6 5742.3 5747.2 6427.9 6526.0 6537.5 6571.8 6693.9 1667.7 1710.4 1757.2 1757.3 1767.5 1210.6 1220.4 1225.7 1229.5 1237.0 5668.3 5673.6 5681.3 5737.4 5765.9 6612.0 6627.8 6678.2 6696.0 6710.6 5664.8 5692.9 5715.4 5800.2 5814.4 3552.5 3562.0 3578.9 3593.1 3593.7 6481.9 6509.7 6533.9 6554.2 6573.9 6863.0 6884.7 6923.8 6927.2 6953.9 6468.6 6547.0 6583.1 6583.6 6619.4 6606.4 6650.0 6682.3 6740.8 6781.0 6582.6 6625.7 6682.6 6724.9 6740.7 6426.2 6433.7 6437.2 6470.4 6570.3 4927.6 4943.1 4943.5 4971.2 4972.7 6737.7 6770.2 6772.7 6775.9 6788.2 6534.7 6536.2 6538.5 6545.9 6578.6 6521.8 6528.5 6535.5 6545.3 6574.7 6160.3 6266.4 6286.8 6424.7 6458.5 6375.6 6427.2 6533.2 6554.4 6573.6 6302.5 6302.7 6316.7 6339.3 6405.8 20:25:14 INFO - PID 23008 | 20:25:14 INFO - PID 23008 | [#5] yui.html Cycles:180 Average:24017.08 Median:19739.76 stddev:32619.47 (165.2%) stddev-sans-first:32664.80 20:25:14 INFO - PID 23008 | Values: 900.9 923.1 933.7 938.5 938.8 18567.2 19605.1 19614.3 19636.8 20481.3 19902.3 20789.9 20881.3 20884.9 21008.6 1029.5 1067.8 1069.1 1071.8 1073.1 1011.1 1035.3 1068.3 1070.8 1072.4 1112.6 1114.1 1117.0 1117.4 1117.6 1111.7 1112.7 1112.9 1113.0 1113.4 810.9 811.0 811.3 811.5 812.9 18932.1 19065.5 19088.1 19687.3 20827.9 21316.4 22080.9 22180.0 22428.0 22647.5 17273.5 17322.1 17375.3 17444.3 17678.5 3702.2 3727.8 3730.9 3731.0 3733.2 131852.3 132843.3 133217.3 134632.0 137187.3 16975.2 17046.8 17436.0 17619.0 17733.7 31450.7 32531.2 33208.3 33229.0 33286.0 7404.1 7414.9 7645.4 8764.7 9084.1 3965.2 4264.1 4266.1 4268.7 4270.8 5282.1 5374.4 5420.7 5424.5 5468.2 1047.5 1053.1 1065.0 1072.3 1073.7 646.5 655.6 662.3 666.3 669.9 11688.6 11924.8 12511.4 12572.7 13824.4 693.6 705.1 705.9 714.2 716.8 5527.7 5558.9 5648.8 5938.3 5946.4 104319.0 107600.5 110727.4 111808.0 113373.0 98177.0 98606.0 100013.5 102051.0 103025.0 89275.0 89827.6 90025.5 91083.5 92154.0 12649.1 13025.6 13039.3 13039.7 13192.1 39391.4 40352.2 40582.0 41373.8 41482.4 52040.5 52894.5 53024.0 53037.2 53986.5 18790.6 18924.0 18979.4 19064.4 19071.2 21365.6 21903.0 21903.2 21959.9 22098.6 19220.5 19241.4 19792.2 19849.2 19895.1 17117.7 17605.6 17783.9 17866.9 18491.5 17888.0 18812.6 19212.7 19940.8 20013.1 14201.9 14300.2 14315.5 14353.0 14429.6 14079.5 14106.9 14209.1 14322.9 15183.7 20:25:14 INFO - PID 23008 | -------- Summary: end -------- 20:25:14 INFO - PID 23008 | 20:25:15 INFO - TEST-INFO | 23008: exit 0 20:25:15 INFO - TEST-OK | dromaeo_css | took 1112700ms 20:25:15 INFO - TEST-START | kraken 20:25:15 INFO - Initialising browser for kraken test... 20:25:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:32966/getInfo.html -profile /tmp/tmp3FROb1/profile 20:25:15 INFO - TEST-INFO | started process 23389 (/builds/slave/test/build/application/firefox/firefox http://localhost:32966/getInfo.html) 20:25:21 INFO - TEST-INFO | 23389: exit 0 20:25:21 INFO - Browser initialized. 20:25:21 INFO - Running cycle 1/1 for kraken test... 20:25:21 INFO - TEST-INFO | started process 23580 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3FROb1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:22 INFO - PID 23580 | 20:25:22 INFO - PID 23580 | (/builds/slave/test/build/application/firefox/firefox:23635): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:25:22 INFO - PID 23580 | 20:25:32 INFO - PID 23580 | RSS: Main: 167473152 20:25:32 INFO - PID 23580 | 20:25:35 INFO - PID 23580 | Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32966/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:36 INFO - PID 23580 | RSS: Main: 174194688 20:25:36 INFO - PID 23580 | 20:25:38 INFO - PID 23580 | Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32966/tests/kraken/driver.html?testName=audio-dft) 20:25:39 INFO - PID 23580 | RSS: Main: 177741824 20:25:39 INFO - PID 23580 | 20:25:42 INFO - PID 23580 | Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32966/tests/kraken/driver.html?testName=audio-fft) 20:25:43 INFO - PID 23580 | RSS: Main: 171843584 20:25:43 INFO - PID 23580 | 20:25:45 INFO - PID 23580 | Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32966/tests/kraken/driver.html?testName=audio-oscillator) 20:25:46 INFO - PID 23580 | RSS: Main: 172408832 20:25:46 INFO - PID 23580 | 20:25:48 INFO - PID 23580 | Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32966/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:25:48 INFO - PID 23580 | RSS: Main: 172519424 20:25:48 INFO - PID 23580 | 20:25:52 INFO - PID 23580 | Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32966/tests/kraken/driver.html?testName=imaging-darkroom) 20:25:52 INFO - PID 23580 | RSS: Main: 173809664 20:25:52 INFO - PID 23580 | 20:25:56 INFO - PID 23580 | Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32966/tests/kraken/driver.html?testName=imaging-desaturate) 20:25:56 INFO - PID 23580 | RSS: Main: 174030848 20:25:56 INFO - PID 23580 | 20:25:59 INFO - PID 23580 | Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32966/tests/kraken/driver.html?testName=json-parse-financial) 20:26:00 INFO - PID 23580 | RSS: Main: 174485504 20:26:00 INFO - PID 23580 | 20:26:02 INFO - PID 23580 | Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32966/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:26:02 INFO - PID 23580 | RSS: Main: 174280704 20:26:02 INFO - PID 23580 | 20:26:04 INFO - PID 23580 | Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:26:05 INFO - PID 23580 | RSS: Main: 174231552 20:26:05 INFO - PID 23580 | 20:26:07 INFO - PID 23580 | Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:08 INFO - PID 23580 | RSS: Main: 173961216 20:26:08 INFO - PID 23580 | 20:26:10 INFO - PID 23580 | Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:11 INFO - PID 23580 | RSS: Main: 174673920 20:26:11 INFO - PID 23580 | 20:26:14 INFO - PID 23580 | Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:15 INFO - PID 23580 | RSS: Main: 174751744 20:26:15 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | Cycle 1(1): loaded http://localhost:32966/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32966/tests/kraken/driver.html?testName=ai-astar) 20:26:17 INFO - PID 23580 | RSS: Main: 176136192 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | __start_tp_report 20:26:17 INFO - PID 23580 | _x_x_mozilla_page_load 20:26:17 INFO - PID 23580 | _x_x_mozilla_page_load_details 20:26:17 INFO - PID 23580 | |i|pagename|runs| 20:26:17 INFO - PID 23580 | |0;ai-astar;99;109;101;109;116;111;111;100;111;109 20:26:17 INFO - PID 23580 | |1;audio-beat-detection;143;125;146;188;120;169;157;122;177;125 20:26:17 INFO - PID 23580 | |2;audio-dft;163;163;165;163;163;161;169;168;170;167 20:26:17 INFO - PID 23580 | |3;audio-fft;79;85;76;173;77;77;77;76;166;82 20:26:17 INFO - PID 23580 | |4;audio-oscillator;79;79;142;80;79;84;133;85;84;128 20:26:17 INFO - PID 23580 | |5;imaging-gaussian-blur;114;114;115;116;119;114;113;114;113;124 20:26:17 INFO - PID 23580 | |6;imaging-darkroom;154;150;151;152;151;153;152;150;151;152 20:26:17 INFO - PID 23580 | |7;imaging-desaturate;99;95;94;101;94;94;94;96;103;97 20:26:17 INFO - PID 23580 | |8;json-parse-financial;62;52;57;53;56;53;54;59;53;58 20:26:17 INFO - PID 23580 | |9;json-stringify-tinderbox;54;54;54;54;56;54;53;54;60;56 20:26:17 INFO - PID 23580 | |10;stanford-crypto-aes;81;79;92;83;84;78;76;82;83;80 20:26:17 INFO - PID 23580 | |11;stanford-crypto-ccm;126;130;125;125;122;123;124;130;136;162 20:26:17 INFO - PID 23580 | |12;stanford-crypto-pbkdf2;193;176;176;181;198;191;180;180;187;177 20:26:17 INFO - PID 23580 | |13;stanford-crypto-sha256-iterative;71;78;74;70;73;71;76;76;72;75 20:26:17 INFO - PID 23580 | __end_tp_report 20:26:17 INFO - PID 23580 | __start_cc_report 20:26:17 INFO - PID 23580 | _x_x_mozilla_cycle_collect,983 20:26:17 INFO - PID 23580 | __end_cc_report 20:26:17 INFO - PID 23580 | __startTimestamp1502853977485__endTimestamp 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | ------- Summary: start ------- 20:26:17 INFO - PID 23580 | Number of tests: 14 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | [#0] ai-astar Cycles:10 Average:107.60 Median:111.00 stddev:5.64 (5.1%) stddev-sans-first:5.05 20:26:17 INFO - PID 23580 | Values: 99.0 109.0 101.0 109.0 116.0 111.0 111.0 100.0 111.0 109.0 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:151.50 stddev:24.73 (16.3%) stddev-sans-first:26.18 20:26:17 INFO - PID 23580 | Values: 143.0 125.0 146.0 188.0 120.0 169.0 157.0 122.0 177.0 125.0 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | [#2] audio-dft Cycles:10 Average:165.20 Median:166.00 stddev:3.08 (1.9%) stddev-sans-first:3.17 20:26:17 INFO - PID 23580 | Values: 163.0 163.0 165.0 163.0 163.0 161.0 169.0 168.0 170.0 167.0 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | [#3] audio-fft Cycles:10 Average:96.80 Median:77.00 stddev:38.46 (49.9%) stddev-sans-first:40.25 20:26:17 INFO - PID 23580 | Values: 79.0 85.0 76.0 173.0 77.0 77.0 77.0 76.0 166.0 82.0 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:79.50 stddev:25.87 (32.5%) stddev-sans-first:26.58 20:26:17 INFO - PID 23580 | Values: 79.0 79.0 142.0 80.0 79.0 84.0 133.0 85.0 84.0 128.0 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:114.50 stddev:3.44 (3.0%) stddev-sans-first:3.60 20:26:17 INFO - PID 23580 | Values: 114.0 114.0 115.0 116.0 119.0 114.0 113.0 114.0 113.0 124.0 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:152.00 stddev:1.26 (0.8%) stddev-sans-first:1.00 20:26:17 INFO - PID 23580 | Values: 154.0 150.0 151.0 152.0 151.0 153.0 152.0 150.0 151.0 152.0 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:94.50 stddev:3.27 (3.5%) stddev-sans-first:3.36 20:26:17 INFO - PID 23580 | Values: 99.0 95.0 94.0 101.0 94.0 94.0 94.0 96.0 103.0 97.0 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.50 stddev:3.27 (5.8%) stddev-sans-first:2.55 20:26:17 INFO - PID 23580 | Values: 62.0 52.0 57.0 53.0 56.0 53.0 54.0 59.0 53.0 58.0 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:54.00 stddev:2.02 (3.7%) stddev-sans-first:2.12 20:26:17 INFO - PID 23580 | Values: 54.0 54.0 54.0 54.0 56.0 54.0 53.0 54.0 60.0 56.0 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.50 stddev:4.37 (5.3%) stddev-sans-first:4.62 20:26:17 INFO - PID 23580 | Values: 81.0 79.0 92.0 83.0 84.0 78.0 76.0 82.0 83.0 80.0 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:128.00 stddev:11.90 (9.3%) stddev-sans-first:12.52 20:26:17 INFO - PID 23580 | Values: 126.0 130.0 125.0 125.0 122.0 123.0 124.0 130.0 136.0 162.0 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.90 Median:184.00 stddev:7.84 (4.3%) stddev-sans-first:7.59 20:26:17 INFO - PID 23580 | Values: 193.0 176.0 176.0 181.0 198.0 191.0 180.0 180.0 187.0 177.0 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.50 stddev:2.63 (3.5%) stddev-sans-first:2.62 20:26:17 INFO - PID 23580 | Values: 71.0 78.0 74.0 70.0 73.0 71.0 76.0 76.0 72.0 75.0 20:26:17 INFO - PID 23580 | -------- Summary: end -------- 20:26:17 INFO - PID 23580 | 20:26:17 INFO - PID 23580 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:26:18 INFO - TEST-INFO | 23580: exit 0 20:26:18 INFO - TEST-OK | kraken | took 62804ms 20:26:18 INFO - SUITE-END | took 1175s 20:26:18 INFO - Completed test suite (00:19:35) 20:26:18 INFO - javascript benchmark 20:26:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8674.124560607183, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.8448077596126, 3103.95344069839, 3136.980481343564, 3138.0428969164404, 3140.952885706715, 6029.819105426839, 6057.485113765335, 6108.358622344656, 6133.50931925446, 6160.845978850531, 6143.201383820108, 6143.938560614392, 6256.280527739312, 6265.24817021958, 6298.401651843067, 5637.154426835967, 5645.717714114277, 5650.180723795047, 5694.601377903548, 5707.172459993299, 5503.944960550403, 5559.638623489481, 5623.0, 5716.7141642917895, 5733.226014488053, 5501.0, 5513.807016754395, 5531.502164805167, 5557.888842223173, 5620.4098569650005, 5613.522850557708, 5675.432456754292, 5705.229793977802, 5708.7145642718115, 5713.200151978726, 5612.831615051514, 5628.493435590775, 5629.8592535186535, 5670.518005969498, 5684.573656975744, 5931.614445061057, 6009.639421634716, 6099.237595300588, 6102.938970610281, 6189.81430557084, 6580.638064906429, 6597.934020659828, 6619.93380066198, 6637.867242655168, 6724.562903411263, 6635.601863888182, 6753.4259587935085, 6775.762848300285, 6790.422814060761, 6794.830129246809, 6160.969195153995, 6230.4392604665345, 6246.593971391845, 6249.031400133033, 6253.312135665074, 6863.450923926074, 6869.0, 6936.757213497604, 6963.512554121163, 6975.128108986377, 6392.169018027626, 6515.087887695727, 6520.347965203537, 6521.576097553644, 6526.869462610816, 6591.967040164768, 6697.22981857083, 6701.899471507932, 6702.631355275409, 6705.832354191184, 6629.071929929813, 6658.700358483879, 6697.9665101675155, 6698.0, 6710.16122984627, 6663.200415950117, 6674.566153200027, 6750.29121942189, 6753.831154221086, 6755.459563234929, 5348.1175606025345, 5419.701916394557, 5435.42927992563, 5445.863853403696, 5502.504774570308, 4669.813207471731, 4692.178868697964, 4719.1741445247635, 4743.051389722069, 4743.454502732161, 5713.371529131792, 5738.483536481736, 5790.739416726257, 5797.623154494944, 5817.563682723812, 6523.902141467882, 6541.724363749118, 6566.540342176002, 6616.900746488806, 6633.038209459602, 5525.309336332958, 5587.106063029977, 5661.773529058792, 5687.3459552152035, 5737.311522617312, 5938.465538101592, 5949.583529153005, 5953.434423729739, 5969.343372229051, 5970.492508136857, 6411.647359395185, 6536.934630653727, 6544.770933017321, 6553.279139294674, 6556.704948277339, 6639.468842492685, 6654.83362915931, 6731.932680673131, 6767.627780471925, 6768.593884366954, 6219.0982307566055, 6317.0, 6409.551331406757, 6409.8718025640155, 6483.157189565326, 6491.610503369624, 6538.967305163444, 6551.344865513601, 6556.0, 6556.147700798866, 6670.833229169116, 6738.561993470409, 6761.121054262914, 6772.52592318533, 6790.626515541692, 6456.12842266288, 6466.321036291121, 6539.771108011197, 6554.410103090745, 6589.868202635825, 6344.904826427515, 6447.948716682336, 6451.70967306463, 6541.378569035934, 6557.278699342973, 6261.8747625046335, 6312.873742525032, 6350.079238510298, 6373.7131829066875, 6384.07430922523, 6392.456641185551, 6414.0, 6508.576942498722, 6522.05430212626, 6547.0179473079415, 6299.496040316855, 6318.526110541636, 6360.618362898241, 6380.425761681471, 6392.776252831129], "value": 6063.644362859025, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.3727580659667, 826.8263664630429, 846.407514739682, 856.0412338181238, 1160.709822544364, 30007.399852002945, 30751.84624076879, 39696.99999999996, 40643.796781016055, 40720.59279407205, 40688.0, 40891.38662920051, 41141.38287925676, 41170.38244426336, 41249.38125928106, 7551.28262815033, 7702.383809295243, 7706.922930770705, 7710.344620707218, 7713.460057795956, 7534.8116297092465, 7660.387169026464, 7666.769996900074, 7668.769936901902, 7672.309492145706, 7639.541627502367, 7693.038370203724, 7731.806704832368, 7740.535567865918, 7769.844603107935, 7682.807929801744, 7693.346065584432, 7724.150343462215, 7741.22587741227, 7752.186020467826, 7545.50954187976, 7574.8485030299635, 7598.354139898115, 7624.199459056775, 7629.923700762977, 36599.26801463983, 36854.815725921464, 37118.62881371179, 37162.814185929165, 37337.439938400676, 3559.893203203908, 3598.118460977051, 3601.0457228834116, 3602.0994751312173, 3602.2075143468396, 30222.244443889078, 30237.0, 30238.244043899078, 30243.69756302453, 30275.0, 4996.25056241563, 4998.425181104183, 5004.024215278022, 5024.723640199788, 5030.723310217936, 183153.0, 183478.0, 185158.0, 186055.06972465187, 186171.0, 46736.76631616888, 46744.5325546747, 46800.5319946803, 46852.297215541796, 46916.2962555562, 49227.0, 49247.0, 49273.50726492761, 49274.26088608674, 49275.0, 15138.0, 15385.615359616098, 15410.383584656489, 15460.226988650522, 15474.148921809183, 12767.233965962072, 12815.102942793916, 12817.935910320575, 12819.615411537668, 12827.294498802656, 12722.61832145037, 12735.172213806072, 12811.743765124646, 12833.52414472329, 12852.164609300366, 5463.69949652765, 5482.972585137049, 5488.835334939959, 5512.586556008316, 5542.91685624716, 997.7206382212992, 1001.8447140693204, 1009.4700282351824, 1013.4476710192815, 1033.6537260017978, 22787.022794014836, 23275.53448931046, 23284.06863725466, 23298.65052024221, 23455.0, 1112.9387883666313, 1113.2596823112701, 1113.5991043224433, 1116.3804088730833, 1118.6140781430393, 11752.529898803952, 12273.754524909451, 12416.689582760504, 12417.813732794015, 12538.686532836751, 216829.0, 216876.0, 217623.0, 233022.0, 235663.0, 54879.451205488236, 55229.447705523235, 55280.723596382566, 55508.72245638746, 55668.443315567136, 1481.3259966715118, 1527.8319384867655, 1528.9755863571434, 1533.3210134902042, 1540.8844336674795, 27701.722982769916, 27987.0, 28513.572296415154, 28570.42859142847, 29059.7094029057, 50724.49275507198, 51348.0, 51379.486205138965, 51390.22914656358, 51420.22869656883, 202805.0, 204114.0, 204247.0, 205327.0, 205349.0, 35547.0, 35687.78809907121, 35705.0, 36939.44590831194, 37746.62253377431, 46810.531894680615, 47467.0, 47601.52398475971, 47873.76063119662, 48153.27770083521, 34399.0, 34891.65108348986, 34900.301993959474, 35204.823975879954, 36048.81975590105, 34807.82596087003, 34894.65105348914, 35015.299694005465, 35081.82459087688, 35450.82274588611, 36655.0, 37826.43260351152, 38125.2374952505, 38307.808460957516, 38382.23235535329, 33744.83127584346, 33871.3225735479, 34133.48799767956, 34358.31283374369, 34746.65253347434, 24250.0, 24719.752802471747, 24868.502629947663, 25264.494710106064, 25302.49395012126], "value": 17462.775384313205, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.8079012740603, 557.7350758389765, 560.1373884218301, 570.3811364669335, 574.5403677058353, 20934.0, 21618.35144945652, 21714.782852171473, 21913.890430547825, 22451.887740561317, 27173.45653086937, 27636.447271054618, 27664.723352766516, 27715.307117322078, 27872.3031924202, 6889.6555172241315, 7056.329648683392, 7070.469714771387, 7071.045408869788, 7074.575525468463, 6305.464035556983, 6639.203295604534, 6880.449564034865, 6902.240753517109, 6906.171259448874, 6855.725770969155, 6859.142607174103, 6860.245373008965, 6860.485463590226, 6864.1762988441205, 6854.246032936398, 6860.588364698134, 6861.416779573742, 6867.896981545256, 6868.381845633917, 6715.932840671629, 6717.361850624183, 6736.427403670645, 6746.595204287759, 6790.626515541643, 30866.691333086605, 30976.0, 32187.0, 32460.513092303398, 32669.18327041819, 1925.8459323254106, 1943.7278780970535, 1947.0362170725582, 1950.4441234248313, 1959.549303660152, 20325.288614898556, 21442.89278553613, 21456.678149827763, 21475.140994360365, 21477.140914363565, 2385.415573184581, 2531.4683916377585, 2543.26245388837, 2599.051346258602, 2612.164107485605, 139753.0, 143191.0, 143560.0, 143589.0, 143688.28155859362, 21838.563228735336, 22294.0, 22465.052371659553, 22811.771882281297, 23761.405964851016, 43638.0, 43765.78117109394, 43807.561924380985, 43919.0, 43935.0, 12245.938770306091, 12438.129330946927, 12522.624321270376, 12620.36898155107, 12630.92760869673, 10178.694639160836, 10187.439690817077, 10203.591856325813, 10236.692899213036, 10308.536115874804, 11605.361705106301, 11980.940095299467, 12130.818037729441, 12139.210951288138, 12224.144309898222, 4009.7393669411395, 4027.3737896960192, 4390.824367025347, 4527.456705195332, 4573.49691533931, 943.2595412601075, 963.2342287881152, 976.8473201622012, 991.4596544883057, 993.6869885985891, 19704.81771093739, 20156.29452969139, 20387.184512619624, 20668.069936852877, 20707.4823129423, 1009.9747506312401, 1021.0963297481782, 1026.6612018034032, 1028.4189432970497, 1030.4744580264119, 11288.604898828502, 13621.523246686318, 14091.78862317066, 14738.189399582912, 14895.70208595822, 505229.0, 509444.0, 511339.0, 524369.0, 528072.0, 123776.0, 124379.3781031089, 126096.36951815183, 127248.0, 128059.0, 1112.9276597021167, 1157.6700640317638, 1235.215638069832, 1237.6348977051791, 1292.0374321130819, 20951.0, 21047.913138758962, 21250.14999400007, 21503.784962150803, 21822.0, 59365.40634593599, 59422.87424012962, 60160.0, 60375.698121509115, 61410.0, 70022.94965575419, 73598.63200683962, 74542.62728686322, 74586.0, 74926.0, 14198.077124986843, 14302.356393962506, 14538.85461145375, 14573.0, 14590.124592524058, 22968.4257893554, 23067.307980760605, 23101.0, 23274.883625581762, 23393.883030584737, 17679.911600441916, 17782.288708452033, 18092.90953545224, 18685.439436816916, 18808.811911880704, 17367.30530778755, 18029.368972085915, 18047.368342107962, 18051.548711282325, 18130.0, 19413.61172776565, 19605.82365058101, 19906.800931990496, 20224.292149774687, 20255.189792408728, 15155.924220378827, 15248.085114893142, 15288.923555382597, 15300.387984480496, 15336.693266134838, 17815.554611134827, 18612.162452689932, 18870.811291886905, 18999.955002474442, 19009.33467328692], "value": 13170.327554498546, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.4037662863398, 1362.1214316765686, 1376.8554301798317, 1377.8759911607954, 1380.6893448973988, 13771.724565508684, 14158.0, 14741.48404805832, 14745.115293082423, 14769.852301476982, 15053.322600482978, 15333.233338333066, 15353.078815271063, 15373.23133843309, 15377.69244615107, 2254.3800454874918, 2276.7609401012905, 2280.2019293247395, 2281.155972290255, 2285.954280914381, 2619.109502769058, 2691.5155272051024, 2781.040541013347, 2782.6382570265837, 2787.818791778528, 2711.6068170115323, 2734.220747087071, 2748.5877118432195, 2752.215618548714, 2756.710545392735, 2661.361273294415, 2691.7039125696156, 2705.418335057962, 2712.9864350678317, 2713.6200931869357, 2569.331973686836, 2621.3708709909483, 2625.921222363332, 2629.224378808256, 2634.8287361321454, 14420.062695924837, 14503.70992580153, 14507.927460362736, 14512.201828899406, 14512.782308265385, 7677.155512893577, 7945.324647404977, 7953.164917683675, 7958.403119765982, 7965.6813727450835, 4918.139325618038, 5149.0, 5243.554297884684, 5253.474652534716, 5255.684658920439, 1872.9906350468298, 1928.7974762650001, 1928.9035548222532, 1963.4404194804413, 1970.802919708032, 23639.409014774767, 23954.76045239543, 24028.159014434586, 24109.15617953363, 24127.396815079588, 6480.967595161994, 6481.351864813575, 6487.416132547999, 6615.735370585219, 6657.53397262187, 16254.349826006828, 16287.104209268604, 16367.0, 16421.26104325284, 16439.589010274838, 7564.319211270902, 7691.269329413697, 7695.653695583712, 7726.420518461138, 7753.4960227585025, 7059.082319298458, 7136.0, 7207.351338379571, 7214.098237720285, 7271.418286537064, 4936.308916751657, 5111.744412779346, 5131.7690703918415, 5138.203578445347, 5145.331106956071, 1482.303317440801, 1506.5329747778223, 1509.222750283605, 1528.465037236958, 1536.063001569042, 760.851633931378, 793.3613441179906, 808.8665370213848, 810.2383759266271, 829.1128492512953, 8120.715774947848, 8316.126806685332, 8437.789055273544, 8500.574971251537, 8564.48613083217, 977.7066879935991, 1005.2309982863115, 1012.4785735346155, 1013.2653825976108, 1020.1175982774846, 5136.768845401966, 5197.8440646780655, 5248.0, 5252.868678283074, 5373.516383525502, 19603.803961960482, 19629.607407851763, 19701.901490492743, 20261.0, 20472.59054818925, 18345.0, 18818.341358052676, 18858.0, 20141.0, 20454.693179602316, 10596.152307815357, 10624.415657138778, 10805.189610779224, 10832.079273261703, 11116.499272598257, 8226.753197404087, 8231.09457959612, 8339.791505212175, 8403.453775504573, 8429.452085614415, 16630.916845415697, 16930.746038809182, 17254.137293135544, 17568.56078598045, 17699.20353584066, 17093.401730939357, 17304.740428893325, 17692.0, 18152.364667236583, 18263.54341141482, 11519.654410367368, 11558.42207889619, 11804.17370784037, 11804.17370784037, 11806.291622502677, 13203.801942970671, 13381.464741410235, 13383.397747101599, 13390.866091338961, 13439.260840653858, 10826.296290741077, 10862.402567858528, 10864.674059778219, 10908.400037997986, 11122.777544449227, 10307.226957978031, 10421.583136674448, 10463.319884207502, 10560.471976401303, 10705.89294107049, 9650.517474126125, 9692.515374231401, 9744.561494732896, 9774.804503910023, 9786.902130978599, 7300.379467745302, 7307.890381644386, 7343.963280183565, 7383.187849336461, 7434.293742094493, 7207.351338379571, 7289.088863892013, 7306.890396643948, 7326.597037162794, 7352.448566357438], "value": 6472.255053486739, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.5972189086946, 499.93083960716893, 516.8578640873759, 520.6563667979135, 520.8203169906384, 6084.72618732157, 6151.661658608775, 6161.260648722154, 6231.6572588507615, 6284.62292262464, 5917.053271476565, 6005.789797357093, 6005.849853753658, 6073.362296958822, 6082.969585152068, 4897.167481528139, 4911.189653707134, 4912.38595175603, 4921.163402221631, 4955.355803745508, 4932.210846264598, 4937.296632661744, 4940.802367905279, 4959.454460009396, 4996.5503104720565, 4829.4446138693975, 4853.223484242522, 4922.3354847095725, 4930.186519224341, 4933.506649335056, 4935.5804756595735, 4950.455449900508, 4955.578775804025, 4971.875703107415, 5000.324956130912, 4423.447069116361, 4428.070105277896, 4446.244138496463, 4456.398386217884, 4474.127545128701, 6010.639361638316, 6044.4888777805545, 6045.848853778691, 6046.365131661156, 6055.848603784896, 5650.3219613646625, 5689.6586204827845, 5710.428957104298, 5769.999999999958, 5770.682612456313, 6418.486521078303, 6422.820703751626, 6464.22429308486, 6536.084948107269, 6615.702293396808, 4879.8780030499165, 4893.75531223441, 4913.189323761575, 4935.506449355072, 4945.530174633404, 6787.626680532618, 6844.965775171092, 6926.134233220848, 6981.930180698178, 6984.0, 4988.6507944444265, 4995.825146119869, 5038.949610503848, 5050.949490505048, 5061.190209566452, 5070.543651071422, 5088.720120393414, 5100.107481190851, 5100.872478188001, 5108.7190204538365, 5692.345380281321, 5715.628484148517, 5726.627769194989, 5742.339630942495, 5747.166660834156, 6427.903581446282, 6526.0, 6537.477001839841, 6571.80284591463, 6693.933060669428, 1667.65813008333, 1710.435556266429, 1757.1916918217762, 1757.2795153986804, 1767.5139336682257, 1210.6005018343926, 1220.3837062283667, 1225.6751960730414, 1229.5081967213007, 1236.9505219791288, 5668.26312579362, 5673.574481913873, 5681.34664513578, 5737.3648510175235, 5765.88468230633, 6612.0, 6627.768028118992, 6678.23200331968, 6695.966520167465, 6710.564442801249, 5664.773409063674, 5692.9146062809095, 5715.399883012307, 5800.24596802413, 5814.360420353758, 3552.5204097446513, 3561.9821900890847, 3578.874739384109, 3593.083763640307, 3593.730470214692, 6481.902771458432, 6509.7361228395475, 6533.901991470132, 6554.230357803462, 6573.934260657428, 6863.0, 6884.65576721162, 6923.826904327331, 6927.238003819576, 6953.930460695429, 6468.611883287018, 6547.0, 6583.090903637987, 6583.63789991555, 6619.3877041402775, 6606.4384527315715, 6649.966750166218, 6682.298358672464, 6740.831479212863, 6781.0, 6582.637954912526, 6625.701843417154, 6682.599044057372, 6724.8991265132045, 6740.6966686498245, 6426.196725409324, 6433.678316084271, 6437.227532696106, 6470.417662410406, 6570.273336565272, 4927.581155601671, 4943.134951383566, 4943.456219815889, 4971.1797553403285, 4972.701637901738, 6737.730490780314, 6770.187577490733, 6772.679327531281, 6775.86448271022, 6788.2193547742645, 6534.738610455719, 6536.248331441945, 6538.542302038812, 6545.869082618226, 6578.638174900235, 6521.836954076186, 6528.543001989815, 6535.509836762167, 6545.2800191979795, 6574.704138313692, 6160.322364539987, 6266.436020758154, 6286.779962701284, 6424.678766061772, 6458.483321334376, 6375.6174629522375, 6427.164468619049, 6533.236026272974, 6554.442872355903, 6573.57271777333, 6302.485325340327, 6302.684865756785, 6316.673498565353, 6339.3343698912795, 6405.807825765234], "value": 5039.56388756689, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.85586306191, 923.0769230769231, 933.6685476655787, 938.4838338913596, 938.7981583959447, 18567.164477598508, 19605.117769700362, 19614.313499027536, 19636.803631963678, 20481.28315508954, 19902.303419380325, 20789.896050519725, 20881.269155579557, 20884.89557552214, 21008.57982840346, 1029.4595337447824, 1067.770429357688, 1069.0645685025602, 1071.7749272652752, 1073.1039581949042, 1011.1354791653141, 1035.3011717090972, 1068.278911734576, 1070.8340207267886, 1072.3565860483686, 1112.6383925224295, 1114.1142791480752, 1116.9553217871276, 1117.3798541809292, 1117.5585643670786, 1111.6720567432626, 1112.7329440934197, 1112.933224006562, 1113.0372228022743, 1113.4043286841502, 810.9026916770025, 810.9553974531399, 811.342812322021, 811.4644334739044, 812.8780682897553, 18932.053397330215, 19065.523361915923, 19088.14103365338, 19687.31094411703, 20827.8958605206, 21316.36050918475, 22080.88959555208, 22180.0, 22428.0, 22647.547049059092, 17273.464998531297, 17322.133893305283, 17375.30498780047, 17444.302227910994, 17678.46964591064, 3702.185519185775, 3727.7763334200035, 3730.8694195703292, 3730.981345093257, 3733.1600389912323, 131852.34073829665, 132843.33578332048, 133217.33391333077, 134632.0, 137187.31406342905, 16975.236114374882, 17046.82953170477, 17436.0, 17619.0, 17733.7339939901, 31450.685493144774, 32531.18672033171, 33208.3358332832, 33229.0, 33286.0, 7404.148522919825, 7414.925850741532, 7645.426593005435, 8764.737057888273, 9084.137006984325, 3965.2466031453932, 4264.0832221072615, 4266.0827921996915, 4268.722533035343, 4270.7864606769535, 5282.102042652758, 5374.435684253175, 5420.728963551806, 5424.457554244623, 5468.152436372368, 1047.512906498482, 1053.146950969717, 1065.0414626835754, 1072.292287090532, 1073.7208325835338, 646.4698946863526, 655.570601256178, 662.258270736778, 666.3037126203129, 669.8894682377353, 11688.590899318484, 11924.821127683092, 12511.436985335682, 12572.685682858002, 13824.360343811994, 693.6081114170478, 705.1115594351154, 705.9470539709542, 714.1608609883366, 716.781381678593, 5527.723613819293, 5558.916616250759, 5648.802291919763, 5938.257717785277, 5946.405359464019, 104319.0, 107600.4619976895, 110727.44636276767, 111808.0, 113373.0, 98177.0, 98606.0, 100013.49993250133, 102050.97949020415, 103025.0, 89275.0, 89827.55086224657, 90025.54987225153, 91083.54458227799, 92154.0, 12649.114561980574, 13025.609231722685, 13039.348032598142, 13039.739205215652, 13192.142510736772, 39391.40912886366, 40352.1929561413, 40582.02351438767, 41373.79313103415, 41482.37776433295, 52040.47959520508, 52894.471055290494, 53024.0, 53037.20444193418, 53986.46013539814, 18790.624187516445, 18924.0, 18979.43061708151, 19064.42806715801, 19071.18823711745, 21365.572688546454, 21903.0, 21903.233386831384, 21959.890200548896, 22098.558028839656, 19220.519487012378, 19241.4227573173, 19792.20831166795, 19849.206031758567, 19895.10472028733, 17117.74323385175, 17605.559861003578, 17783.911080444515, 17866.91066544659, 18491.537711557317, 17888.0, 18812.623747525246, 19212.71180932315, 19940.800591994474, 20013.09941052627, 14201.857981420053, 14300.21348825783, 14315.498957536853, 14353.0, 14429.567112986628, 14079.507217247346, 14106.858931410965, 14209.147451152963, 14322.856771432569, 15183.696326073195], "value": 9363.389024014037, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 109.0, 101.0, 109.0, 116.0, 111.0, 111.0, 100.0, 111.0, 109.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 125.0, 146.0, 188.0, 120.0, 169.0, 157.0, 122.0, 177.0, 125.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 163.0, 163.0, 161.0, 169.0, 168.0, 170.0, 167.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 76.0, 173.0, 77.0, 77.0, 77.0, 76.0, 166.0, 82.0], "value": 96.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 142.0, 80.0, 79.0, 84.0, 133.0, 85.0, 84.0, 128.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 116.0, 119.0, 114.0, 113.0, 114.0, 113.0, 124.0], "value": 115.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 151.0, 152.0, 151.0, 153.0, 152.0, 150.0, 151.0, 152.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 95.0, 94.0, 101.0, 94.0, 94.0, 94.0, 96.0, 103.0, 97.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 52.0, 57.0, 53.0, 56.0, 53.0, 54.0, 59.0, 53.0, 58.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 56.0, 54.0, 53.0, 54.0, 60.0, 56.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 92.0, 83.0, 84.0, 78.0, 76.0, 82.0, 83.0, 80.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 130.0, 125.0, 125.0, 122.0, 123.0, 124.0, 130.0, 136.0, 162.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 176.0, 176.0, 181.0, 198.0, 191.0, 180.0, 180.0, 187.0, 177.0], "value": 183.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 78.0, 74.0, 70.0, 73.0, 71.0, 76.0, 76.0, 72.0, 75.0], "value": 73.6, "unit": "score"}]}]} 20:26:18 INFO - Return code: 0 20:26:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:26:18 INFO - # TBPL SUCCESS # 20:26:18 INFO - Running post-action listener: _package_coverage_data 20:26:18 INFO - Running post-action listener: _resource_record_post_action 20:26:18 INFO - [mozharness: 2017-08-16 03:26:18.784146Z] Finished run-tests step (success) 20:26:18 INFO - Running post-run listener: _resource_record_post_run 20:26:18 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 432668672; Read time: 12; Write time: 282480 20:26:18 INFO - TinderboxPrint: CPU usage
13.1% 20:26:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:26:18 INFO - TinderboxPrint: I/O write bytes / time
432,668,672 / 282,480 20:26:18 INFO - TinderboxPrint: CPU idle
8,266.6 (86.8%) 20:26:18 INFO - TinderboxPrint: CPU user
1,202.0 (12.6%) 20:26:18 INFO - TinderboxPrint: Swap in / out
0 / 0 20:26:18 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106590208; Read time: 0; Write time: 96152 20: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 20:26:18 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 325054464; Read time: 0; Write time: 186296 20:26:19 INFO - Running post-run listener: _upload_blobber_files 20:26:19 INFO - Blob upload gear active. 20:26:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:19 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 20:26:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:26:19 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:26:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:26:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:20 INFO - (blobuploader) - INFO - Done attempting. 20:26:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:26:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:26:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:27 INFO - (blobuploader) - INFO - Done attempting. 20:26:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:26:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:26:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:28 INFO - (blobuploader) - INFO - Done attempting. 20:26:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:26:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:26:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:29 INFO - (blobuploader) - INFO - Done attempting. 20:26:29 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:29 INFO - Return code: 0 20:26:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:29 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4b110d8d3ee238a09e5e5ffcabe0eec887f0424f4c4a1021dcacdd7e7a2562b0e33479b55b9acdb73840f6323af469380a572fe4788001580f27aa946e5c82c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77a3937a5f403f5d9c858996e4b2207c79c6fffd688f21f712e7469d6b8547024bffa049e38db327fb6a2e04fefa086b28785a0c2e02aeb119c850dc0c59088d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb1eae646db7c431d2586903ff3b87cf1f3a91734f5a1f302515ab19fee20d3ee68d49b48188e82860c7beca89f2c43a578b12559121d465deb330a161176c88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd96cb66f438711f3d79a935c359a4053faf54f884b1d0feef6a6c8238539769429f3f59f2974e88b23af8f94ffb308028467ab5147801acc0d1f9547a059231"} 20:26:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:29 INFO - Contents: 20:26:29 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4b110d8d3ee238a09e5e5ffcabe0eec887f0424f4c4a1021dcacdd7e7a2562b0e33479b55b9acdb73840f6323af469380a572fe4788001580f27aa946e5c82c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77a3937a5f403f5d9c858996e4b2207c79c6fffd688f21f712e7469d6b8547024bffa049e38db327fb6a2e04fefa086b28785a0c2e02aeb119c850dc0c59088d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb1eae646db7c431d2586903ff3b87cf1f3a91734f5a1f302515ab19fee20d3ee68d49b48188e82860c7beca89f2c43a578b12559121d465deb330a161176c88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd96cb66f438711f3d79a935c359a4053faf54f884b1d0feef6a6c8238539769429f3f59f2974e88b23af8f94ffb308028467ab5147801acc0d1f9547a059231"} 20:26:29 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:29 INFO - Copying logs to upload dir... 20:26:29 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.266018 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-15 20:26:29.503087) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:29.508433) ========= 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=0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4b110d8d3ee238a09e5e5ffcabe0eec887f0424f4c4a1021dcacdd7e7a2562b0e33479b55b9acdb73840f6323af469380a572fe4788001580f27aa946e5c82c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77a3937a5f403f5d9c858996e4b2207c79c6fffd688f21f712e7469d6b8547024bffa049e38db327fb6a2e04fefa086b28785a0c2e02aeb119c850dc0c59088d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb1eae646db7c431d2586903ff3b87cf1f3a91734f5a1f302515ab19fee20d3ee68d49b48188e82860c7beca89f2c43a578b12559121d465deb330a161176c88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd96cb66f438711f3d79a935c359a4053faf54f884b1d0feef6a6c8238539769429f3f59f2974e88b23af8f94ffb308028467ab5147801acc0d1f9547a059231"} build_url:https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4b110d8d3ee238a09e5e5ffcabe0eec887f0424f4c4a1021dcacdd7e7a2562b0e33479b55b9acdb73840f6323af469380a572fe4788001580f27aa946e5c82c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77a3937a5f403f5d9c858996e4b2207c79c6fffd688f21f712e7469d6b8547024bffa049e38db327fb6a2e04fefa086b28785a0c2e02aeb119c850dc0c59088d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb1eae646db7c431d2586903ff3b87cf1f3a91734f5a1f302515ab19fee20d3ee68d49b48188e82860c7beca89f2c43a578b12559121d465deb330a161176c88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd96cb66f438711f3d79a935c359a4053faf54f884b1d0feef6a6c8238539769429f3f59f2974e88b23af8f94ffb308028467ab5147801acc0d1f9547a059231"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:29.538234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:29.538645) ========= 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=0e2a256762fed810e2f0f810000001b3-1502852464.855776-1144212122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:29.620139) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:26:29.623478) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:26:29.623783) ========= ========= Total master_lag: 0.23 =========