builder: cedar_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1501130480.26 results: success (0) revision: 7deedfaa7b688199f953ff60cd974bcafbe1479d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-26 21:41:20.263792) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-26 21:41:20.264404) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-26 21:41:20.264680) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-26 21:41:20.327486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 21:41:20.327825) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-26 21:41:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.7M=0s 2017-07-26 21:41:20 (35.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.190536 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 21:41:20.561126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 21:41:20.561444) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017280 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 21:41:20.617854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 21:41:20.618158) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 7deedfaa7b688199f953ff60cd974bcafbe1479d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/cedar --rev 7deedfaa7b688199f953ff60cd974bcafbe1479d --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=d6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-26 21:41:20,947 truncating revision to first 12 chars 2017-07-26 21:41:20,947 Setting DEBUG logging. 2017-07-26 21:41:20,947 attempt 1/10 2017-07-26 21:41:20,947 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/7deedfaa7b68?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-26 21:41:21,400 unpacking tar archive at: cedar-7deedfaa7b68/testing/mozharness/ program finished with exit code 0 elapsedTime=0.780239 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 21:41:21.410784) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-26 21:41:21.411166) ========= script_repo_revision: 7deedfaa7b688199f953ff60cd974bcafbe1479d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-26 21:41:21.411528) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-26 21:41:21.411834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-26 21:41:21.420292) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-07-26 21:41:21.420647) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=d6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:41:21 INFO - MultiFileLogger online at 20170726 21:41:21 in /builds/slave/test 21:41:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 21:41:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:41:21 INFO - {'append_to_log': False, 21:41:21 INFO - 'base_work_dir': '/builds/slave/test', 21:41:21 INFO - 'blob_upload_branch': 'Cedar', 21:41:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:41:21 INFO - 'branch': 'Cedar', 21:41:21 INFO - 'buildbot_json_path': 'buildprops.json', 21:41:21 INFO - 'code_coverage': False, 21:41:21 INFO - 'config_files': ('talos/linux_config.py',), 21:41:21 INFO - 'default_actions': ('clobber', 21:41:21 INFO - 'read-buildbot-config', 21:41:21 INFO - 'download-and-extract', 21:41:21 INFO - 'populate-webroot', 21:41:21 INFO - 'create-virtualenv', 21:41:21 INFO - 'install', 21:41:21 INFO - 'setup-mitmproxy', 21:41:21 INFO - 'run-tests'), 21:41:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:41:21 INFO - 'disable_ccov_upload': False, 21:41:21 INFO - 'download_minidump_stackwalk': True, 21:41:21 INFO - 'download_symbols': 'ondemand', 21:41:21 INFO - 'enable_stylo': False, 21:41:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:41:21 INFO - 'tooltool.py': '/tools/tooltool.py', 21:41:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:41:21 INFO - '/tools/misc-python/virtualenv.py')}, 21:41:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:41:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:41:21 INFO - 'gecko_profile': False, 21:41:21 INFO - 'gecko_profile_interval': 0, 21:41:21 INFO - 'installer_path': 'installer.exe', 21:41:21 INFO - 'log_level': 'info', 21:41:21 INFO - 'log_name': 'talos', 21:41:21 INFO - 'log_to_console': True, 21:41:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:41:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:41:21 INFO - 'opt_config_files': (), 21:41:21 INFO - 'pip_index': False, 21:41:21 INFO - 'suite': 'dromaeojs-e10s', 21:41:21 INFO - 'system_bits': '32', 21:41:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:41:21 INFO - 'title': 'talos-linux64-ix-034', 21:41:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:41:21 INFO - 'use_talos_json': True, 21:41:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:41:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:41:21 INFO - 'work_dir': 'build'} 21:41:21 INFO - [mozharness: 2017-07-27 04:41:21.974891Z] Running clobber step. 21:41:21 INFO - Running pre-action listener: _resource_record_pre_action 21:41:21 INFO - Running main action method: clobber 21:41:21 INFO - rmtree: /builds/slave/test/build 21:41:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:41:22 INFO - Running post-action listener: _resource_record_post_action 21:41:22 INFO - [mozharness: 2017-07-27 04:41:22.961121Z] Finished clobber step (success) 21:41:22 INFO - [mozharness: 2017-07-27 04:41:22.961224Z] Running read-buildbot-config step. 21:41:22 INFO - Running pre-action listener: _resource_record_pre_action 21:41:22 INFO - Running main action method: read_buildbot_config 21:41:22 INFO - Using buildbot properties: 21:41:22 INFO - { 21:41:22 INFO - "project": "", 21:41:22 INFO - "product": "firefox", 21:41:22 INFO - "who": "mconley@mozilla.com", 21:41:22 INFO - "installer_path": "public/build/target.tar.bz2", 21:41:22 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs-e10s", 21:41:22 INFO - "repository": "https://hg.mozilla.org/projects/cedar", 21:41:22 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs-e10s", 21:41:22 INFO - "stage_platform": "linux64", 21:41:22 INFO - "basedir": "/builds/slave/test", 21:41:22 INFO - "buildnumber": 15, 21:41:22 INFO - "platform": "ubuntu64_hw", 21:41:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:41:22 INFO - "slavebuilddir": "test", 21:41:22 INFO - "taskId": "XSftDjVeRoi1X2VHrG1gCg", 21:41:22 INFO - "branch": "cedar", 21:41:22 INFO - "script_repo_revision": "default", 21:41:22 INFO - "revision": "7deedfaa7b688199f953ff60cd974bcafbe1479d", 21:41:22 INFO - "slavename": "talos-linux64-ix-034", 21:41:22 INFO - "repo_path": "projects/cedar" 21:41:22 INFO - } 21:41:22 INFO - Finding installer, test and symbols from parent task. 21:41:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XSftDjVeRoi1X2VHrG1gCg'}, attempt #1 21:41:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XSftDjVeRoi1X2VHrG1gCg'}, attempt #1 21:41:23 INFO - Task dependencies: B4JtmHcKS0CU_UWMXvqOvA 21:41:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA'}, attempt #1 21:41:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.tar.bz2 21:41:24 INFO - Set test_url: https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/test_packages.json 21:41:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.crashreporter-symbols.zip 21:41:24 INFO - Running post-action listener: _resource_record_post_action 21:41:24 INFO - [mozharness: 2017-07-27 04:41:24.283417Z] Finished read-buildbot-config step (success) 21:41:24 INFO - [mozharness: 2017-07-27 04:41:24.283641Z] Running download-and-extract step. 21:41:24 INFO - Running pre-action listener: _resource_record_pre_action 21:41:24 INFO - Running main action method: download_and_extract 21:41:24 INFO - mkdir: /builds/slave/test/build/tests 21:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:24 INFO - trying https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.test_packages.json 21:41:24 INFO - Downloading https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:41:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:41:24 INFO - Downloaded 989 bytes. 21:41:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:41:24 INFO - Using the following test package requirements: 21:41:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:41:24 INFO - u'common': [u'target.common.tests.zip'], 21:41:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:41:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:41:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:41:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:41:24 INFO - u'mozbase': [u'target.common.tests.zip'], 21:41:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:41:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:41:24 INFO - u'web-platform': [u'target.common.tests.zip', 21:41:24 INFO - u'target.web-platform.tests.tar.gz'], 21:41:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:41:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:41:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.common.tests.zip 21:41:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:41:24 INFO - Fetch https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.common.tests.zip into memory 21:41:26 INFO - Content-Length response header: 72526363 21:41:26 INFO - Bytes received: 72526363 21:41:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:41:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.common.tests.zip 21:41:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:41:38 INFO - Fetch https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.common.tests.zip into memory 21:41:39 INFO - Content-Length response header: 72526363 21:41:39 INFO - Bytes received: 72526363 21:41:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.talos.tests.zip 21:41:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:41:54 INFO - Fetch https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.talos.tests.zip into memory 21:41:54 INFO - Content-Length response header: 14496448 21:41:54 INFO - Bytes received: 14496448 21:41:55 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')]} 21:41:55 INFO - trying https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.tar.bz2 21:41:55 INFO - Downloading https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:41:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:41:56 INFO - Downloaded 62100132 bytes. 21:41:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.tar.bz2 21:41:56 INFO - mkdir: /builds/slave/test/properties 21:41:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:41:56 INFO - Writing to file /builds/slave/test/properties/build_url 21:41:56 INFO - Contents: 21:41:56 INFO - build_url:https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.tar.bz2 21:41:56 INFO - Running post-action listener: _resource_record_post_action 21:41:56 INFO - Running post-action listener: set_extra_try_arguments 21:41:56 INFO - [mozharness: 2017-07-27 04:41:56.191450Z] Finished download-and-extract step (success) 21:41:56 INFO - [mozharness: 2017-07-27 04:41:56.191549Z] Running populate-webroot step. 21:41:56 INFO - Running pre-action listener: _resource_record_pre_action 21:41:56 INFO - Running main action method: populate_webroot 21:41:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:41:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:41:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:41:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:41:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:41:56 INFO - 'tests': ['damp', 'tps']}, 21:41:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:41:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:41:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:41:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 21:41:56 INFO - 'other-e10s': {'tests': ['a11yr', 21:41:56 INFO - 'ts_paint', 21:41:56 INFO - 'tpaint', 21:41:56 INFO - 'sessionrestore', 21:41:56 INFO - 'sessionrestore_many_windows', 21:41:56 INFO - 'sessionrestore_no_auto_restore', 21:41:56 INFO - 'tabpaint']}, 21:41:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 21:41:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 21:41:56 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:41:56 INFO - 'talos_options': ['--mitmproxy', 21:41:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:41:56 INFO - '--firstNonBlankPaint'], 21:41:56 INFO - 'tests': ['quantum_pageload_google', 21:41:56 INFO - 'quantum_pageload_youtube', 21:41:56 INFO - 'quantum_pageload_amazon', 21:41:56 INFO - 'quantum_pageload_facebook']}, 21:41:56 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:41:56 INFO - 'talos_options': ['--stylo', 21:41:56 INFO - '--mitmproxy', 21:41:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:41:56 INFO - '--firstNonBlankPaint'], 21:41:56 INFO - 'tests': ['quantum_pageload_google', 21:41:56 INFO - 'quantum_pageload_youtube', 21:41:56 INFO - 'quantum_pageload_amazon', 21:41:56 INFO - 'quantum_pageload_facebook']}, 21:41:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:41:56 INFO - 'tsvgr_opacity', 21:41:56 INFO - 'tart', 21:41:56 INFO - 'tscrollx', 21:41:56 INFO - 'cart', 21:41:56 INFO - 'tsvg_static']}, 21:41:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:41:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:41:56 INFO - 'talos_options': ['--xperf_path', 21:41:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:41:56 INFO - 'tests': ['tp5n']}}} 21:41:56 INFO - Running post-action listener: _resource_record_post_action 21:41:56 INFO - [mozharness: 2017-07-27 04:41:56.198890Z] Finished populate-webroot step (success) 21:41:56 INFO - [mozharness: 2017-07-27 04:41:56.198981Z] Running create-virtualenv step. 21:41:56 INFO - Running pre-action listener: _resource_record_pre_action 21:41:56 INFO - Running main action method: create_virtualenv 21:41:56 INFO - Creating virtualenv /builds/slave/test/build/venv 21:41:56 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 21:41:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:41:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 21:41:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:41:56 INFO - Using real prefix '/usr' 21:41:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:41:56 INFO - Installing distribute.............................................................................................................................................................................................done. 21:41:58 INFO - Installing pip.................done. 21:41:58 INFO - Return code: 0 21:41:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:41:59 INFO - Reading from file tmpfile_stdout 21:41:59 INFO - Output received: 21:41:59 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) 21:41:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:41:59 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')]} 21:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:59 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')]} 21:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:59 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 0x11261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1495d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1492eb0>, '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 0x1493db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', '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 21:41:59 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 21:41:59 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 21:41:59 INFO - Using env: {'DISPLAY': ':0', 21:41:59 INFO - 'HOME': '/home/cltbld', 21:41:59 INFO - 'LANG': 'en_US.UTF-8', 21:41:59 INFO - 'LANGUAGE': 'en_US:en', 21:41:59 INFO - 'LOGNAME': 'cltbld', 21:41:59 INFO - 'MAIL': '/var/mail/cltbld', 21:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:59 INFO - 'MOZ_NO_REMOTE': '1', 21:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:59 INFO - 'NO_EM_RESTART': '1', 21:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:59 INFO - 'PWD': '/builds/slave/test', 21:41:59 INFO - 'SHELL': '/bin/bash', 21:41:59 INFO - 'SHLVL': '1', 21:41:59 INFO - 'TERM': 'linux', 21:41:59 INFO - 'TMOUT': '86400', 21:41:59 INFO - 'USER': 'cltbld', 21:41:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', 21:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:59 INFO - '_': '/tools/buildbot/bin/python'} 21:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:59 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 21:41:59 INFO - Cleaning up... 21:41:59 INFO - Return code: 0 21:41:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:41:59 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')]} 21:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:59 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')]} 21:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:59 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 0x11261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1495d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1492eb0>, '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 0x1493db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', '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 21:41:59 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 21:41:59 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 21:41:59 INFO - Using env: {'DISPLAY': ':0', 21:41:59 INFO - 'HOME': '/home/cltbld', 21:41:59 INFO - 'LANG': 'en_US.UTF-8', 21:41:59 INFO - 'LANGUAGE': 'en_US:en', 21:41:59 INFO - 'LOGNAME': 'cltbld', 21:41:59 INFO - 'MAIL': '/var/mail/cltbld', 21:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:59 INFO - 'MOZ_NO_REMOTE': '1', 21:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:59 INFO - 'NO_EM_RESTART': '1', 21:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:59 INFO - 'PWD': '/builds/slave/test', 21:41:59 INFO - 'SHELL': '/bin/bash', 21:41:59 INFO - 'SHLVL': '1', 21:41:59 INFO - 'TERM': 'linux', 21:41:59 INFO - 'TMOUT': '86400', 21:41:59 INFO - 'USER': 'cltbld', 21:41:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', 21:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:59 INFO - '_': '/tools/buildbot/bin/python'} 21:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:59 INFO - Downloading/unpacking psutil>=3.1.1 21:41:59 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 21:41:59 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 21:41:59 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 21:41:59 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 21:42:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:42:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:42:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:42:00 INFO - Installing collected packages: psutil 21:42:00 INFO - Running setup.py install for psutil 21:42:00 INFO - building 'psutil._psutil_linux' extension 21:42:00 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 21:42:02 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 21:42:02 INFO - building 'psutil._psutil_posix' extension 21:42:02 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 21:42:02 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 21:42:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:42:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:42:02 INFO - Successfully installed psutil 21:42:02 INFO - Cleaning up... 21:42:02 INFO - Return code: 0 21:42:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:42: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')]} 21:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42: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')]} 21:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:02 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 0x11261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1495d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1492eb0>, '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 0x1493db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', '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 21:42:02 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 21:42:02 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 21:42:02 INFO - Using env: {'DISPLAY': ':0', 21:42:02 INFO - 'HOME': '/home/cltbld', 21:42:02 INFO - 'LANG': 'en_US.UTF-8', 21:42:02 INFO - 'LANGUAGE': 'en_US:en', 21:42:02 INFO - 'LOGNAME': 'cltbld', 21:42:02 INFO - 'MAIL': '/var/mail/cltbld', 21:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:02 INFO - 'MOZ_NO_REMOTE': '1', 21:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:02 INFO - 'NO_EM_RESTART': '1', 21:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:02 INFO - 'PWD': '/builds/slave/test', 21:42:02 INFO - 'SHELL': '/bin/bash', 21:42:02 INFO - 'SHLVL': '1', 21:42:02 INFO - 'TERM': 'linux', 21:42:02 INFO - 'TMOUT': '86400', 21:42:02 INFO - 'USER': 'cltbld', 21:42:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', 21:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:02 INFO - '_': '/tools/buildbot/bin/python'} 21:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:42:02 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 21:42:02 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 21:42:02 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 21:42:02 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 21:42:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:42:03 INFO - Installing collected packages: mozsystemmonitor 21:42:03 INFO - Running setup.py install for mozsystemmonitor 21:42:03 INFO - Successfully installed mozsystemmonitor 21:42:03 INFO - Cleaning up... 21:42:03 INFO - Return code: 0 21:42:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:03 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 0x11261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1495d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1492eb0>, '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 0x1493db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', '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 21:42:03 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 21:42:03 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 21:42:03 INFO - Using env: {'DISPLAY': ':0', 21:42:03 INFO - 'HOME': '/home/cltbld', 21:42:03 INFO - 'LANG': 'en_US.UTF-8', 21:42:03 INFO - 'LANGUAGE': 'en_US:en', 21:42:03 INFO - 'LOGNAME': 'cltbld', 21:42:03 INFO - 'MAIL': '/var/mail/cltbld', 21:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:03 INFO - 'MOZ_NO_REMOTE': '1', 21:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:03 INFO - 'NO_EM_RESTART': '1', 21:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:03 INFO - 'PWD': '/builds/slave/test', 21:42:03 INFO - 'SHELL': '/bin/bash', 21:42:03 INFO - 'SHLVL': '1', 21:42:03 INFO - 'TERM': 'linux', 21:42:03 INFO - 'TMOUT': '86400', 21:42:03 INFO - 'USER': 'cltbld', 21:42:03 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', 21:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:03 INFO - '_': '/tools/buildbot/bin/python'} 21:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:04 INFO - Downloading/unpacking jsonschema==2.5.1 21:42:04 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 21:42:04 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 21:42:04 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 21:42:04 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 21:42:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:42:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:42:05 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 21:42:05 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 21:42:05 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 21:42:05 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 21:42:05 INFO - Downloading functools32-3.2.3-2.tar.gz 21:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:42:05 INFO - warning: no files found matching '*.txt' 21:42:05 INFO - no previously-included directories found matching 'build' 21:42:05 INFO - no previously-included directories found matching 'dist' 21:42:05 INFO - no previously-included directories found matching '.git*' 21:42:05 INFO - Installing collected packages: jsonschema, functools32 21:42:05 INFO - Running setup.py install for functools32 21:42:05 INFO - warning: no files found matching '*.txt' 21:42:05 INFO - no previously-included directories found matching 'build' 21:42:05 INFO - no previously-included directories found matching 'dist' 21:42:05 INFO - no previously-included directories found matching '.git*' 21:42:05 INFO - Successfully installed jsonschema functools32 21:42:05 INFO - Cleaning up... 21:42:05 INFO - Return code: 0 21:42:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:42:05 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')]} 21:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:05 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')]} 21:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:05 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 0x11261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1495d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1492eb0>, '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 0x1493db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', '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 21:42:05 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 21:42:05 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 21:42:05 INFO - Using env: {'DISPLAY': ':0', 21:42:05 INFO - 'HOME': '/home/cltbld', 21:42:05 INFO - 'LANG': 'en_US.UTF-8', 21:42:05 INFO - 'LANGUAGE': 'en_US:en', 21:42:05 INFO - 'LOGNAME': 'cltbld', 21:42:05 INFO - 'MAIL': '/var/mail/cltbld', 21:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:05 INFO - 'MOZ_NO_REMOTE': '1', 21:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:05 INFO - 'NO_EM_RESTART': '1', 21:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:05 INFO - 'PWD': '/builds/slave/test', 21:42:05 INFO - 'SHELL': '/bin/bash', 21:42:05 INFO - 'SHLVL': '1', 21:42:05 INFO - 'TERM': 'linux', 21:42:05 INFO - 'TMOUT': '86400', 21:42:05 INFO - 'USER': 'cltbld', 21:42:05 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', 21:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:05 INFO - '_': '/tools/buildbot/bin/python'} 21:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:42:05 INFO - Cleaning up... 21:42:05 INFO - Return code: 0 21:42:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:42:05 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')]} 21:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:05 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')]} 21:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:05 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 0x11261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1495d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1492eb0>, '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 0x1493db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', '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 21:42:05 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 21:42:05 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 21:42:05 INFO - Using env: {'DISPLAY': ':0', 21:42:05 INFO - 'HOME': '/home/cltbld', 21:42:05 INFO - 'LANG': 'en_US.UTF-8', 21:42:05 INFO - 'LANGUAGE': 'en_US:en', 21:42:05 INFO - 'LOGNAME': 'cltbld', 21:42:05 INFO - 'MAIL': '/var/mail/cltbld', 21:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:05 INFO - 'MOZ_NO_REMOTE': '1', 21:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:05 INFO - 'NO_EM_RESTART': '1', 21:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:05 INFO - 'PWD': '/builds/slave/test', 21:42:05 INFO - 'SHELL': '/bin/bash', 21:42:05 INFO - 'SHLVL': '1', 21:42:05 INFO - 'TERM': 'linux', 21:42:05 INFO - 'TMOUT': '86400', 21:42:05 INFO - 'USER': 'cltbld', 21:42:05 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', 21:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:05 INFO - '_': '/tools/buildbot/bin/python'} 21:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:06 INFO - Downloading/unpacking blobuploader==1.2.4 21:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:07 INFO - Downloading blobuploader-1.2.4.tar.gz 21:42:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:42:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:42: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 21:42: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 21:42: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 21:42: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 21:42:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:42:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:42: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 21:42: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 21:42: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 21:42: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 21:42:07 INFO - Downloading docopt-0.6.1.tar.gz 21:42:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:42:07 INFO - Installing collected packages: blobuploader, requests, docopt 21:42:07 INFO - Running setup.py install for blobuploader 21:42:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:42:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:42:07 INFO - Running setup.py install for requests 21:42:08 INFO - Running setup.py install for docopt 21:42:08 INFO - Successfully installed blobuploader requests docopt 21:42:08 INFO - Cleaning up... 21:42:08 INFO - Return code: 0 21:42:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:42: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')]} 21:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42: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')]} 21:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:08 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 0x11261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1495d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1492eb0>, '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 0x1493db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', '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 21:42:08 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 21:42:08 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 21:42:08 INFO - Using env: {'DISPLAY': ':0', 21:42:08 INFO - 'HOME': '/home/cltbld', 21:42:08 INFO - 'LANG': 'en_US.UTF-8', 21:42:08 INFO - 'LANGUAGE': 'en_US:en', 21:42:08 INFO - 'LOGNAME': 'cltbld', 21:42:08 INFO - 'MAIL': '/var/mail/cltbld', 21:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:08 INFO - 'MOZ_NO_REMOTE': '1', 21:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:08 INFO - 'NO_EM_RESTART': '1', 21:42:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:08 INFO - 'PWD': '/builds/slave/test', 21:42:08 INFO - 'SHELL': '/bin/bash', 21:42:08 INFO - 'SHLVL': '1', 21:42:08 INFO - 'TERM': 'linux', 21:42:08 INFO - 'TMOUT': '86400', 21:42:08 INFO - 'USER': 'cltbld', 21:42:08 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', 21:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:08 INFO - '_': '/tools/buildbot/bin/python'} 21:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:42:08 INFO - Running setup.py (path:/tmp/pip-uQ0cLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:42:08 INFO - Running setup.py (path:/tmp/pip-x2HGlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:42:08 INFO - Running setup.py (path:/tmp/pip-p6SeZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:42:08 INFO - Running setup.py (path:/tmp/pip-h8f5vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:42:08 INFO - Running setup.py (path:/tmp/pip-EM1Qdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:42:08 INFO - Running setup.py (path:/tmp/pip-_mCvBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:42:09 INFO - Running setup.py (path:/tmp/pip-HqTxjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:42:09 INFO - Running setup.py (path:/tmp/pip-OYBtnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:42:09 INFO - Running setup.py (path:/tmp/pip-JxwxTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:42:09 INFO - Running setup.py (path:/tmp/pip-m9Lumt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:42:09 INFO - Running setup.py (path:/tmp/pip-lByxvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:42:09 INFO - Running setup.py (path:/tmp/pip-Iz9PWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:42:09 INFO - Running setup.py (path:/tmp/pip-pCOVUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:42:09 INFO - Running setup.py (path:/tmp/pip-wZzuGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:09 INFO - Running setup.py (path:/tmp/pip-QbidC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:42:09 INFO - Running setup.py (path:/tmp/pip-YUiOm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:42:09 INFO - Running setup.py (path:/tmp/pip-F_mx5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:42:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:42:09 INFO - Running setup.py install for manifestparser 21:42:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:42:09 INFO - Running setup.py install for mozcrash 21:42:10 INFO - Running setup.py install for mozdebug 21:42:10 INFO - Running setup.py install for mozdevice 21:42:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:42:10 INFO - Running setup.py install for mozfile 21:42:10 INFO - Running setup.py install for mozhttpd 21:42:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:42:10 INFO - Running setup.py install for mozinfo 21:42:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:42:10 INFO - Running setup.py install for mozInstall 21:42:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:42:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:42:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:42:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:42:10 INFO - Running setup.py install for mozleak 21:42:10 INFO - Running setup.py install for mozlog 21:42:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:42:10 INFO - Running setup.py install for moznetwork 21:42:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:42:10 INFO - Running setup.py install for mozprocess 21:42:11 INFO - Running setup.py install for mozprofile 21:42:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:42:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:42:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:42:11 INFO - Running setup.py install for mozrunner 21:42:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:42:11 INFO - Running setup.py install for mozscreenshot 21:42:11 INFO - Running setup.py install for moztest 21:42:11 INFO - Running setup.py install for mozversion 21:42:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:42:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:42:11 INFO - Cleaning up... 21:42:11 INFO - Return code: 0 21:42:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:11 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 0x11261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1495d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1492eb0>, '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 0x1493db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', '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 21:42:11 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 21:42:11 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 21:42:11 INFO - Using env: {'DISPLAY': ':0', 21:42:11 INFO - 'HOME': '/home/cltbld', 21:42:11 INFO - 'LANG': 'en_US.UTF-8', 21:42:11 INFO - 'LANGUAGE': 'en_US:en', 21:42:11 INFO - 'LOGNAME': 'cltbld', 21:42:11 INFO - 'MAIL': '/var/mail/cltbld', 21:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:11 INFO - 'MOZ_NO_REMOTE': '1', 21:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:11 INFO - 'NO_EM_RESTART': '1', 21:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:11 INFO - 'PWD': '/builds/slave/test', 21:42:11 INFO - 'SHELL': '/bin/bash', 21:42:11 INFO - 'SHLVL': '1', 21:42:11 INFO - 'TERM': 'linux', 21:42:11 INFO - 'TMOUT': '86400', 21:42:11 INFO - 'USER': 'cltbld', 21:42:11 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', 21:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:11 INFO - '_': '/tools/buildbot/bin/python'} 21:42:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:42:11 INFO - Running setup.py (path:/tmp/pip-iVG7KV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:42:11 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)) 21:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:42:11 INFO - Running setup.py (path:/tmp/pip-G8S2gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:42:11 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)) 21:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:42:11 INFO - Running setup.py (path:/tmp/pip-q5ee87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:42:12 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)) 21:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:42:12 INFO - Running setup.py (path:/tmp/pip-m1uPu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:42:12 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)) 21:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:42:12 INFO - Running setup.py (path:/tmp/pip-BEqDrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:42:12 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)) 21:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:42:12 INFO - Running setup.py (path:/tmp/pip-W6jUwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:42:12 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)) 21:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:42:12 INFO - Running setup.py (path:/tmp/pip-yb47z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:42:12 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)) 21:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:42:12 INFO - Running setup.py (path:/tmp/pip-MPH2uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:42:12 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)) 21:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:42:12 INFO - Running setup.py (path:/tmp/pip-AYp3ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:42:12 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)) 21:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:42:12 INFO - Running setup.py (path:/tmp/pip-IuoEjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:42:12 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)) 21:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:42:12 INFO - Running setup.py (path:/tmp/pip-q7f7m2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:42:12 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)) 21:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:42:12 INFO - Running setup.py (path:/tmp/pip-IvX357-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:42:12 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)) 21:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:42:12 INFO - Running setup.py (path:/tmp/pip-2iuKfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:42:12 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)) 21:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:42:12 INFO - Running setup.py (path:/tmp/pip-CE_Fu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:42:12 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)) 21:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:12 INFO - Running setup.py (path:/tmp/pip-kG9Gxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:12 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)) 21:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:42:12 INFO - Running setup.py (path:/tmp/pip-E4fdZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:42:12 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)) 21:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:42:12 INFO - Running setup.py (path:/tmp/pip-hCByZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:42:13 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)) 21:42:13 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)) 21:42:13 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)) 21:42:13 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)) 21:42:13 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)) 21:42:13 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)) 21:42:13 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)) 21:42:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:42: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 21:42: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 21:42: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 21:42: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 21:42:14 INFO - Downloading blessings-1.6.tar.gz 21:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:42:14 INFO - Installing collected packages: blessings 21:42:14 INFO - Running setup.py install for blessings 21:42:14 INFO - Successfully installed blessings 21:42:14 INFO - Cleaning up... 21:42:14 INFO - Return code: 0 21:42:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:42:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:42:14 INFO - Reading from file tmpfile_stdout 21:42:14 INFO - Current package versions: 21:42:14 INFO - argparse == 1.2.1 21:42:14 INFO - blessings == 1.6 21:42:14 INFO - blobuploader == 1.2.4 21:42:14 INFO - docopt == 0.6.1 21:42:14 INFO - functools32 == 3.2.3-2 21:42:14 INFO - jsonschema == 2.5.1 21:42:14 INFO - manifestparser == 1.1 21:42:14 INFO - mozInstall == 1.13 21:42:14 INFO - mozcrash == 1.0 21:42:14 INFO - mozdebug == 0.1 21:42:14 INFO - mozdevice == 0.51 21:42:14 INFO - mozfile == 1.2 21:42:14 INFO - mozhttpd == 0.7 21:42:14 INFO - mozinfo == 0.10 21:42:14 INFO - mozleak == 0.1 21:42:14 INFO - mozlog == 3.5 21:42:14 INFO - moznetwork == 0.27 21:42:14 INFO - mozprocess == 0.25 21:42:14 INFO - mozprofile == 0.28 21:42:14 INFO - mozrunner == 6.13 21:42:14 INFO - mozscreenshot == 0.1 21:42:14 INFO - mozsystemmonitor == 0.3 21:42:14 INFO - moztest == 0.8 21:42:14 INFO - mozversion == 1.4 21:42:14 INFO - psutil == 3.1.1 21:42:14 INFO - requests == 1.2.3 21:42:14 INFO - wsgiref == 0.1.2 21:42:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:42: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')]} 21:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42: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')]} 21:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:14 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 0x11261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1495d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1492eb0>, '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 0x1493db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', '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 21:42:14 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 21:42:14 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 21:42:14 INFO - Using env: {'DISPLAY': ':0', 21:42:14 INFO - 'HOME': '/home/cltbld', 21:42:14 INFO - 'LANG': 'en_US.UTF-8', 21:42:14 INFO - 'LANGUAGE': 'en_US:en', 21:42:14 INFO - 'LOGNAME': 'cltbld', 21:42:14 INFO - 'MAIL': '/var/mail/cltbld', 21:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:14 INFO - 'MOZ_NO_REMOTE': '1', 21:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:14 INFO - 'NO_EM_RESTART': '1', 21:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:14 INFO - 'PWD': '/builds/slave/test', 21:42:14 INFO - 'SHELL': '/bin/bash', 21:42:14 INFO - 'SHLVL': '1', 21:42:14 INFO - 'TERM': 'linux', 21:42:14 INFO - 'TMOUT': '86400', 21:42:14 INFO - 'USER': 'cltbld', 21:42:14 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', 21:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:14 INFO - '_': '/tools/buildbot/bin/python'} 21:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:14 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)) 21:42:14 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)) 21:42:14 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)) 21:42:14 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)) 21:42:14 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)) 21:42:14 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)) 21:42:14 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)) 21:42:14 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)) 21:42:14 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)) 21:42:14 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 21:42: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 21:42: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 21:42: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 21:42: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 21:42:15 INFO - Downloading marionette_driver-1.4.0.tar.gz 21:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 21:42:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 21:42:15 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 21:42:15 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 21:42:15 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 21:42:15 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 21:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 21:42:16 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)) 21:42:16 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)) 21:42:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 21:42:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 21:42:16 INFO - Installing collected packages: marionette-driver, simplejson 21:42:16 INFO - Running setup.py install for marionette-driver 21:42:16 INFO - Running setup.py install for simplejson 21:42:16 INFO - building 'simplejson._speedups' extension 21:42:16 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 21:42:17 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 21:42:17 INFO - Successfully installed marionette-driver simplejson 21:42:17 INFO - Cleaning up... 21:42:17 INFO - Return code: 0 21:42:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:17 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 0x11261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1495d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1492eb0>, '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 0x1493db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', '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 21:42:17 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 21:42:17 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 21:42:17 INFO - Using env: {'DISPLAY': ':0', 21:42:17 INFO - 'HOME': '/home/cltbld', 21:42:17 INFO - 'LANG': 'en_US.UTF-8', 21:42:17 INFO - 'LANGUAGE': 'en_US:en', 21:42:17 INFO - 'LOGNAME': 'cltbld', 21:42:17 INFO - 'MAIL': '/var/mail/cltbld', 21:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:17 INFO - 'MOZ_NO_REMOTE': '1', 21:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:17 INFO - 'NO_EM_RESTART': '1', 21:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:17 INFO - 'PWD': '/builds/slave/test', 21:42:17 INFO - 'SHELL': '/bin/bash', 21:42:17 INFO - 'SHLVL': '1', 21:42:17 INFO - 'TERM': 'linux', 21:42:17 INFO - 'TMOUT': '86400', 21:42:17 INFO - 'USER': 'cltbld', 21:42:17 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', 21:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:17 INFO - '_': '/tools/buildbot/bin/python'} 21:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:42:17 INFO - Cleaning up... 21:42:17 INFO - Return code: 0 21:42:17 INFO - Running post-action listener: _resource_record_post_action 21:42:17 INFO - Running post-action listener: _start_resource_monitoring 21:42:17 INFO - Starting resource monitoring. 21:42:17 INFO - [mozharness: 2017-07-27 04:42:17.668372Z] Finished create-virtualenv step (success) 21:42:17 INFO - [mozharness: 2017-07-27 04:42:17.669321Z] Running install step. 21:42:17 INFO - Running pre-action listener: _resource_record_pre_action 21:42:17 INFO - Running main action method: install 21:42:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:42:17 INFO - Reading from file tmpfile_stdout 21:42:17 INFO - Detecting whether we're running mozinstall >=1.0... 21:42:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:42:18 INFO - Reading from file tmpfile_stdout 21:42:18 INFO - Output received: 21:42:18 INFO - Usage: mozinstall [options] installer 21:42:18 INFO - Options: 21:42:18 INFO - -h, --help show this help message and exit 21:42:18 INFO - -d DEST, --destination=DEST 21:42:18 INFO - Directory to install application into. [default: 21:42:18 INFO - "/builds/slave/test"] 21:42:18 INFO - --app=APP Application being installed. [default: firefox] 21:42:18 INFO - mkdir: /builds/slave/test/build/application 21:42:18 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'] 21:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:42:36 INFO - Reading from file tmpfile_stdout 21:42:36 INFO - Output received: 21:42:36 INFO - /builds/slave/test/build/application/firefox/firefox 21:42:36 INFO - Running post-action listener: _resource_record_post_action 21:42:36 INFO - [mozharness: 2017-07-27 04:42:36.014600Z] Finished install step (success) 21:42:36 INFO - [mozharness: 2017-07-27 04:42:36.014854Z] Running setup-mitmproxy step. 21:42:36 INFO - Running pre-action listener: _resource_record_pre_action 21:42:36 INFO - Running main action method: setup_mitmproxy 21:42:36 INFO - Skipping: mitmproxy is not required 21:42:36 INFO - Running post-action listener: _resource_record_post_action 21:42:36 INFO - [mozharness: 2017-07-27 04:42:36.015995Z] Finished setup-mitmproxy step (success) 21:42:36 INFO - [mozharness: 2017-07-27 04:42:36.016220Z] Running run-tests step. 21:42:36 INFO - Running pre-action listener: _resource_record_pre_action 21:42:36 INFO - Running pre-action listener: _set_gcov_prefix 21:42:36 INFO - Running main action method: run_tests 21:42:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:42:36 INFO - Python 2.7.3 21:42:36 INFO - Return code: 0 21:42:36 INFO - grabbing minidump binary from tooltool 21:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:36 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 0x1492eb0>, '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 0x1493db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1494240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:42:36 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 21:42:36 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 21:42:36 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 21:42:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:42:36 INFO - Return code: 0 21:42:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:42:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:42:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:42:36 INFO - ENV: RUST_BACKTRACE is now 1 21:42:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:42:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:42:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 21:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 21:42:36 INFO - Using env: {'DISPLAY': ':0', 21:42:36 INFO - 'HOME': '/home/cltbld', 21:42:36 INFO - 'LANG': 'en_US.UTF-8', 21:42:36 INFO - 'LANGUAGE': 'en_US:en', 21:42:36 INFO - 'LOGNAME': 'cltbld', 21:42:36 INFO - 'MAIL': '/var/mail/cltbld', 21:42:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:42:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:36 INFO - 'MOZ_NO_REMOTE': '1', 21:42:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:36 INFO - 'NO_EM_RESTART': '1', 21:42:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:36 INFO - 'PWD': '/builds/slave/test', 21:42:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:42:36 INFO - 'RUST_BACKTRACE': '1', 21:42:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:42:36 INFO - 'SHELL': '/bin/bash', 21:42:36 INFO - 'SHLVL': '1', 21:42:36 INFO - 'TERM': 'linux', 21:42:36 INFO - 'TMOUT': '86400', 21:42:36 INFO - 'USER': 'cltbld', 21:42:36 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730', 21:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:36 INFO - '_': '/tools/buildbot/bin/python'} 21:42:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 21:42:36 INFO - mozversion application_buildid: 20170727035226 21:42:36 INFO - mozversion application_changeset: 7deedfaa7b688199f953ff60cd974bcafbe1479d 21:42:36 INFO - mozversion application_display_name: Nightly 21:42:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:42:36 INFO - mozversion application_name: Firefox 21:42:36 INFO - mozversion application_remotingname: firefox 21:42:36 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 21:42:36 INFO - mozversion application_vendor: Mozilla 21:42:36 INFO - mozversion application_version: 56.0a1 21:42:36 INFO - mozversion platform_buildid: 20170727035226 21:42:36 INFO - mozversion platform_changeset: 7deedfaa7b688199f953ff60cd974bcafbe1479d 21:42:36 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 21:42:36 INFO - mozversion platform_version: 56.0a1 21:42:36 INFO - using testdate: 1501130556 21:42:36 INFO - actual date: 1501130556 21:42:36 INFO - starting webserver on 'localhost:52565' 21:42:36 INFO - SUITE-START | Running 2 tests 21:42:36 INFO - TEST-START | dromaeo_css 21:42:36 INFO - Initialising browser for dromaeo_css test... 21:42:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52565/getInfo.html -profile /tmp/tmplQheNK/profile 21:42:36 INFO - TEST-INFO | started process 3364 (/builds/slave/test/build/application/firefox/firefox http://localhost:52565/getInfo.html) 21:42:44 INFO - TEST-INFO | 3364: exit 0 21:42:45 INFO - Browser initialized. 21:42:45 INFO - Running cycle 1/1 for dromaeo_css test... 21:42:45 INFO - TEST-INFO | started process 3573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplQheNK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:42:46 INFO - PID 3573 | 21:42:46 INFO - PID 3573 | (/builds/slave/test/build/application/firefox/firefox:3621): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:42:46 INFO - PID 3573 | 21:42:56 INFO - PID 3573 | RSS: Main: 170508288 21:42:56 INFO - PID 3573 | 21:45:56 INFO - PID 3573 | Cycle 1(1): loaded http://localhost:52565/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52565/tests/dromaeo/cssquery-ext.html) 21:45:57 INFO - PID 3573 | RSS: Main: 172285952 21:45:57 INFO - PID 3573 | 21:48:59 INFO - PID 3573 | Cycle 1(1): loaded http://localhost:52565/tests/dromaeo/cssquery-ext.html (next: http://localhost:52565/tests/dromaeo/cssquery-jquery.html) 21:48:59 INFO - PID 3573 | RSS: Main: 170557440 21:48:59 INFO - PID 3573 | 21:52:01 INFO - PID 3573 | Cycle 1(1): loaded http://localhost:52565/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52565/tests/dromaeo/cssquery-mootools.html) 21:52:02 INFO - PID 3573 | RSS: Main: 169627648 21:52:02 INFO - PID 3573 | 21:55:03 INFO - PID 3573 | Cycle 1(1): loaded http://localhost:52565/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52565/tests/dromaeo/cssquery-prototype.html) 21:55:04 INFO - PID 3573 | RSS: Main: 171040768 21:55:04 INFO - PID 3573 | 21:58:08 INFO - PID 3573 | Cycle 1(1): loaded http://localhost:52565/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52565/tests/dromaeo/cssquery-yui.html) 21:58:08 INFO - PID 3573 | RSS: Main: 171241472 21:58:08 INFO - PID 3573 | 22:01:10 INFO - PID 3573 | Cycle 1(1): loaded http://localhost:52565/tests/dromaeo/cssquery-yui.html (next: http://localhost:52565/tests/dromaeo/cssquery-dojo.html) 22:01:10 INFO - PID 3573 | RSS: Main: 174350336 22:01:10 INFO - PID 3573 | 22:01:10 INFO - PID 3573 | __start_tp_report 22:01:10 INFO - PID 3573 | _x_x_mozilla_page_load 22:01:10 INFO - PID 3573 | _x_x_mozilla_page_load_details 22:01:10 INFO - PID 3573 | |i|pagename|runs| 22:01:10 INFO - PID 3573 | |0;dojo.html;3082.3372974810413;3100.379924015196;3100.581421508096;3119.532070189471;3162.841857907104;6181.721822517986;6184.907226391608;6207.068939659053;6241.843953901155;6252.280987686412;6099.634021958675;6174.382561743834;6199.845003874905;6218.191635087433;6235;5585.692786896719;5623.156526521014;5635.6618602883955;5640.182173584828;5671.574631902603;5655.462731040545;5657;5669.262995810539;5676.403977582357;5768.567357448187;5721.885562288772;5742.79900203493;5759.5968282220265;5805.187273781674;5808.796692115777;5650.576206784466;5668.26312579362;5722.37053924068;5743.167240750068;5762.683052432115;5452.1276595744885;5473.233747275384;5553.944460555384;5615.578831587647;5659.40576239493;6131.754729810802;6141.416565426277;6168.9691551541955;6212.782552610682;6236.594621349598;6484.967575162094;6637.203535575713;6699;6711.228208756007;6711.865762684719;6600.273969863311;6626.56927299724;6662.167229096363;6664.433523150489;6676;6152.230971128609;6159.445649891486;6160.476359509447;6163.291221509494;6164.013757798731;6788.728450862009;6796.320367963263;6802;6802.591844489347;6802.6258555779905;6404.647744374011;6461.741530338733;6471.6764161791725;6486.059521369375;6559.606423614503;6686.398224159849;6696.866062678817;6700.430463410567;6708.161479815023;6732.596044237263;6604;6626.536142470077;6684.097646817715;6706.26231114577;6715.697793599202;6643.767468138689;6648.767293144813;6725.6973436195485;6738.326167383222;6747.763828265987;5251.711155886386;5292.947070529322;5293.126634105406;5300.893982120413;5322.467753224724;4191.580841915784;4549;4624;4627.213373726475;4633.235516139799;5548.223248745179;5613.158026296088;5716.657000579979;5730.541556675456;5749.770009199585;6605.933940660532;6641.701123449457;6660.000999850061;6678.83302917431;6683.2648408675;5656.208130861683;5687.090065589568;5724.570657200727;5734.996375634248;5763.711814409263;5716;5740.799072032542;5806.44838740319;5849.356570777211;5880.0003999320215;6302.306746257908;6390.616563006234;6421.389967953037;6429.32492088324;6472.190976128079;6495.805125846232;6629.237637671729;6646.302138275605;6702.19573651165;6723.159605049369;6408.391202835724;6457.289698133108;6486.318936511599;6491.188601424822;6491.837704057248;6520.576162549419;6596.60420374779;6610.8016759497295;6624.867502650017;6625.933740662532;6627.304133065959;6650.268470468342;6655.968324909453;6759.019942108268;6777.152855893013;6336.081268216175;6418.165638467156;6469.5794773339585;6481.740730370732;6482.935170648422;6409.7436102555375;6435.646039467874;6448.065030570635;6460.063290822898;6478.870422591616;6348.71430785625;6354.93645063562;6449.806505804833;6450.322716114741;6451.1936007999;6429.646369449725;6484.351564843478;6537.640429776408;6573.5069869759;6580.539362244597;6212.223472065992;6304.05439184126;6322.0516922462;6357.173567436389;6388.041793730792 22:01:10 INFO - PID 3573 | |1;ext.html;780.5628847845207;809.5952023988006;832.8417600655877;834.1533343656187;1181.4270079011671;31674.841625791898;42444.36333454997;43662.78168609161;43781.34327985083;43851;43380.56619433805;43572;43619.56380436195;43685.34471982923;43891.122177556426;7549.471536992426;7664.616769161547;7673.309402153805;7673.616319184019;7678.9232107679045;7531.3221810037085;7576.545407275581;7628.618569071552;7638.045244344457;7649.273319034711;7511.511751736147;7693.153753087156;7699.499532530395;7699.6920123195005;7701.961490192569;7598.202188770182;7640.159582445926;7665.731699390551;7672.232776722339;7676.1939996300425;7487.951686763858;7547.320741133324;7652.464327497078;7654.923450765476;7684.654190561439;39370.80314598437;39761.40357894634;39839.8008009961;39879.60120398788;40018;3573.5711714594154;3611.043073585502;3619.3123306571665;3622.6196249393697;3626.691731202851;31744.523832142535;31786.364272714647;31834.840825795953;31881.8405907969;31922.361552769045;4845.878853028667;4858.222684370519;4859.659823812334;4873.439554451248;4888.120138375127;187011;187809.0609546957;188701.05649471664;188786;188788;49652;49669.25496117561;49713.50286497161;49747.50252497501;49796.25305620419;52644.473555264725;52662.52368548716;52703.20945185825;52724.73637631787;52737.47262527402;15938.442154524537;15948.76076858848;16004.599885002735;16082.919585402233;16117.274722637509;13090.607281781371;13093.345332733516;13106.672333191747;13112.147710398793;13114.934425327812;14795.852041479662;14830;15064;15138.318775655121;15139.54581362561;5821.2141360916585;5917.467427931507;5948.7323070461935;6075.5747097703625;6104.908426373608;995.9203263739029;1012.6455740490769;1014.7513859104419;1029.9382037077798;1041.1670663469195;22692.65961010586;28397;28442.573361399594;29073;29374.853125734233;1069.5187165775433;1090.3076546393097;1095.9890401096047;1103.1119948441421;1115.3308015190983;11890.940545297392;12213.69465763363;12232.510699572096;12353.3205673687;12404;237488;239017;240312;240640;240843;52901.735491322295;53130.46869531255;53158.46841531613;53422.73288633532;53447.46552534425;1473.9189344585936;1474.7198032373815;1477.519806063034;1510.6601014771588;1513.9091654500764;21707;21934.561308774053;22013.559728805656;22029.228976985727;22065.33803985883;34418.139546511535;34514.65485345215;34549.136271592404;34583.82708086444;34637.48043779396;202675;202773;203199;203621;203825;34162.48756268708;34465;34479.31041379208;36993.445098323005;37379;45691.31463027991;47114.528854712386;47487;47627.76186119047;47692.284615730096;33477;34846.12884677904;34914.127146820516;34945.12637184091;35057;33938.830305849304;34147.31705365829;34337.48493772546;34489.31021379609;34811.47782783311;38084.80957595194;38152;38374.616253837106;38485;38490.615093848704;31626.683733162376;32603.34793304168;33189;33415;33741.32517349689;24321.756782432658;24375.75624243735;24562.50874982526;24783.752162478144;25457.74542254628 22:01:10 INFO - PID 3573 | |2;jquery.html;569.5500554561896;573.3692937768452;576.1444255280904;583.2272239282951;596.394659420688;22008.559828803434;23031.539369212627;23062.65406018911;23102.422439439022;24234.636480452806;22600.208992685217;23355.299341019752;23424.5315093698;23458.76541234587;23507.05971761132;6575.473962083034;6705.430038446713;6711.563748356366;6717.8320541986595;6726.394624483795;6051.667158306292;6278.623282603058;6570.080188773575;6582.572132811376;6595.373439523238;6531;6531.967340163293;6538.248101468321;6543.509236807258;6562.737490500398;6498.902516462257;6514.088027676129;6518.217813862343;6523.119378883837;6533.020046992965;6058.878822423571;6067.939320606782;6083.756649734005;6095.420935011167;6096.420840020191;28674;29127.854360728274;29283.707162928313;29528;30090.84954575213;1981.5739615982488;2010.2763005318075;2013.456366780961;2016.5361966747585;2018.6568283391712;18309.176087076114;18949;18953.147108380017;18976.240950361967;19013.80986190148;2341.0212741390737;2390.737018927934;2447.229122826304;2452.558539462896;2471.7775400213886;134778;136290;136388.31805841008;136904;137033.999999999;13736.862631373759;14736.852631473548;14740.041897276642;14890.329935152944;14949.177795221367;22690;22792.202272920367;22802.771972280065;22815.429614259778;22914.770852291596;9999.050090241415;10022.248331375176;10116.08955194036;10122;10122.595096196217;7449.478536502393;9327.766805829908;9397.57710903011;9462.148406643435;9556.904430955741;7679.40074906367;8674.696385626472;9057.275417966679;9069.863952040725;9202.861957070649;2584.651072105279;2594.701609314915;2663.693675227335;2666.440047589989;2766.9031583894466;944.8535477001076;962.6390103711109;973.4500007495742;990.7225976726528;991.2218908157062;19524.414267571996;19577;22378.776212237994;23768.643470347957;24335.634965475532;1020.1532727835878;1021.3463383434607;1042.6507120114695;1065.2756125834353;1067.8558394616628;10945.945270273598;11043.337399756041;11228.382438965935;11248.26886252391;11336.43317834105;441993;455144;456120;464785;466741;119953;120255;121374.3931280338;122844;123313;1252.5303011370918;1271.4151490314373;1288.7100402409383;1297.2151848131743;1298.0589072922055;17584.648307034044;17600.29598816033;17666.38167664177;17814.821851781315;18552.257909684;54537.45462545324;55945.44054559402;56386;57905.131423027844;58491.415085848595;71609;72046.1988450293;72062;72276;73032.63483682547;11994.820077698667;14378.424863005781;14627.414903404171;14850.628734281298;14858.702825943637;22670.319890403316;23114.537709245385;23547.41131471727;23983.880080599487;24170.758292417555;18834.52913677169;18983.71524427162;19280.517987050436;19291.51771205675;19641.11614977358;16436.17819109016;16494.67010659804;16989.575260618585;17379.739303910705;17913.820861791217;19247.615047698688;19737.80262197417;19767.70348444746;19890.90054549776;19919.701204482233;14514.34685439179;14837.035592686441;14848.851511484747;14853.925730371278;14863.777043344575;17385;17650.205740741952;17686.823131768517;17805.643887122445;18356 22:01:10 INFO - PID 3573 | |3;mootools.html;1343.6640839790052;1390.575874358321;1422.6798970231694;1431.363043445667;1435.440178330451;13094.869051309495;13605.931970340134;13647.454101835914;13759.31203439829;13763.105398149113;14088.859111408883;14320.856791432083;14343.713125737479;14374.137551746877;14444;2706.418120104182;2735.603337516059;2761.9447611047867;2762;2762.1713485954233;2623.1737002844043;2732.0847516082135;2732.2622891819196;2735.575985722216;2736.616873637682;2543.605741110131;2588.6634737484196;2592.44262483566;2606.2311618072617;2620.436606129682;2560.884760185796;2572.369769406507;2595.8702064896775;2610.765031147196;2619.5808670612705;2488.4401009772837;2492.713337966121;2513.3339664988794;2513.54756143894;2517.609770485578;13247.47010119594;13529.526466573623;13533.390997405042;13547.525836595672;13551.932240338834;7479.775606731807;7758.6896524138965;7776;7777;7781.299683028498;4780.976095119537;5000.074986127578;5035.672681275742;5091.745412729349;5107.948920510822;1677.1949464257102;1697.499237724874;1709.435886157565;1754.350890170645;1761.8942863428235;21980.670289945665;22106.668399974013;22164.88917555418;22171.778282217132;22193.44516387103;6236.563440559208;6278.434940855345;6327.430531252209;6407.006913928349;6481.578697384655;15473.922630387002;15479.767803482957;15505;15513.844861551466;15523.37906483728;7311.780646580611;7407.592582407911;7486.7005319786595;7502.437317201232;7507.399408047452;6788.422984046411;6808.557443766139;6956.582605043714;7006.859862802716;7082.681279342442;4686.297055441711;4932.827351042696;4934.9013019739405;4973.353464049723;4989.476105008922;1337.1175024483794;1366.794980752895;1377.9931100344434;1389.8471168171493;1393.3451277899371;821.4660470694097;830.4228561150063;833.8624127018974;861.2722249698994;876.7720392697944;6615.37153970372;6811.795646130624;6820.658967051628;6893.862122757517;7033.577985320897;685.5372623479132;693.2201273567237;704.8484575816121;723.2405973727671;725.4522835259451;4570.7257564546235;4860.489648586848;4990.750462476862;5267.525922666979;5330;18268.086595670164;18346.63306733858;18581.070946452623;18612.44162675122;18776.81223187778;17988.37040703569;18212.817871821113;18236.726449103273;18637.90681046586;18653.906730466533;10248.897511024943;10409.42748148859;10510.527026283835;10545.420001899816;10556.155507559377;7512.962435187789;7803.492772969966;7976.361891048586;7981;8232.670693172206;15905.68188636244;16271.3491460345;16328.183590820649;16425;16517.917410412872;16391.918040410197;16826.831731682527;16889.493315200565;16946.237419316407;17041.062741548838;12315;12581.119321647397;12590.055745818918;12677.746445070863;12686.809697854354;12528.812067819172;12638.178518396275;12653.74692506163;12788.296643684687;12815;9837.262205334771;10148.34035787701;10443.895561044292;10481.947590262;10885.673429797118;10363.740906477398;10403.427811470441;10451.68644940653;10633.734156645836;10821.729456763644;9466.52667366615;9548.952255238957;9573.425594464354;9574.664886728931;9585.041495850359;6397.488200943821;6478.2550006749825;6581.2102547694585;6649.235337936199;6734.326567343226;6588.538802283794;6944.548604340702;6951.756688515878;6976.476764242803;7048.577085374894 22:01:10 INFO - PID 3573 | |4;prototype.html;498.3686667668574;501.47801422682153;516.3055690096818;517.7514792899406;520.0872468817225;6025.487833534155;6187.319394866561;6291.213598300218;6301.684915754211;6332.588381755183;6026.668533230671;6065.545084118698;6085.604435711687;6091.6089261004;6171.753129874811;5132.769025393866;5139.229115632666;5139.331886854704;5165.631107756429;5220.895582088366;4799.784009719571;5129.05046630002;5178.482151784829;5194.92207616886;5213.1919552469235;4877.171060852181;4893.951060489385;4911.5088491150955;4918.36061312029;4952.405711314647;4912.950870491303;4943.826966056171;4944.87637809054;4959.156943319645;4970.502949705036;4390.604845563915;4403.251447253974;4437.778111094464;4459.662101369576;4461.308497182942;6068.180795592582;6082.087686846964;6122;6142.6007309525185;6145;5588.2455868458055;5714.685692286923;5715.1135778909265;5717.857053573653;5747.3103227612955;6441.291457939623;6461.935380646228;6473.805785826433;6506.219253689587;6510.576812507172;4852.344933433977;4853.757312134379;4874.951885344668;4881.779555111222;4890.926636100461;6867.862642747117;6869.7595584154315;6964.477664175207;6998.965005174941;7005.299470053056;4965.82619608312;5008.749562521859;5032.647714660012;5046.243063540425;5047.747612619354;5069.986002799381;5088.6946783193125;5089.05852417304;5096.694198348111;5097.949020509747;5630.887382252332;5707.200991861143;5714.314282286069;5737.799177028784;5748.885022299531;6399.8080057598345;6524.010176895998;6546.836329091716;6579.967100164468;6608.306127856602;1692.8730345224158;1711.0161657047247;1723.4657256250603;1726.6460375622967;1751.737239414098;1223.9143259971715;1228.5761412312738;1230.1204638683384;1246.875312468746;1255.29076072019;5733.971330143406;5739.971300143473;5754.913676294859;5772.826815195551;5793.435772341444;6463.385978332051;6643.7674681385915;6647.800565983028;6677;6733;5708.857278568069;5717.285339332583;5737.168110623936;5787.913181302284;5805.651660900359;3526.8662459211805;3549.5563054618174;3585.94621080684;3595.658412450813;3596.9280614387567;6372.426481616677;6480.837979050467;6489.480841532666;6491.350864913471;6519.771807986698;6788.456923446112;6921.307869213139;6941.167059952737;6976.686049127801;6987.475939304572;6369.585976911486;6514;6527.706253218616;6553.606783593;6560.770373037016;6747.291534388818;6775.457963362821;6784.76253331131;6802.795916122524;6829.52193346461;6658.334166583303;6669.933300666931;6739.359760822714;6740.6966686498245;6765.830854228684;6442.323556026549;6449.226092868698;6516.446102081376;6520.739170433129;6529.542931994714;4909.705417674808;4933.876653083702;4950.430700469348;4960.677555958851;5020.171671674133;6670.299618539983;6718.932810672026;6760.895523879636;6780.881154609434;6796.456283497408;6473.190851143607;6516.185476815398;6529.967350163219;6556.803295901131;6596.141257364496;6498.220213574212;6506.739730410731;6556.803295901131;6557.344265573404;6570.277269500447;6205.138458462534;6269.5611307208055;6271.717772700148;6395.680215989275;6471.579347342407;6439;6473.190851143607;6520.282768895512;6553.967230163818;6558.672066396756;6285.59143655661;6326.810195694136;6356.650384228912;6407.391297826699;6437.558084921389 22:01:10 INFO - PID 3573 | |5;yui.html;794.4843145263238;825.5665775467883;842.6545116502232;920.9953950230249;944.268192151083;17192.656146877056;18255.269789208432;19034.61930761384;19085.14116864741;19127.808721912777;19391.806081939176;19438.22247110114;19447.805521944778;19492.80507194931;19536.804631953677;968.6851773173712;1029.0429900192817;1032.9845052324201;1048.6329784575375;1063.702163394247;1077.9730506737355;1078.0136175399539;1079.379356869803;1079.962201322954;1080.0171843622306;1060.9575616975312;1100.9284396514201;1106.3638407915441;1109.3233127792041;1120.1542835159444;1085.4464223246162;1087.4345340422935;1087.6138970665418;1087.7008822573775;1088.2219213262515;792.5561685456163;793.8848866914265;794.7099308752322;797.6091715059637;798.6126728536655;19390.515237119045;19712.80287197124;19988;20022.09900554464;20396.28612998553;20381.8980905096;20503.897480512504;20660.380188594365;21178.364649060553;21197;16056.518304450885;16401.917990409973;16610.418635347825;16616.00303981765;16910.83089169105;3540.5751309842985;3560.9109772255642;3561.3233485637907;3562.9109272268142;3566.2154326048226;119332;121151;123141;125229;127609.36195318964;15593.766093508606;15726.21368931549;15916.28376723027;16093.517194484184;16106.75839862403;28595;29396;30505.542416863766;30674;30694.53958190629;8293.460925039853;8377.790555236046;8408.705695300758;8418.915810841936;8435;3547.1486843157454;3709.9814500927323;3863.362545180014;4026.859059932888;4046.736962097454;5160.948390516121;5268.78924843002;5278.5513231375;5295.682259064469;5314;1027.77388974427;1059.3537941855461;1065.6856227412932;1080.0441609175937;1114.2089116727213;679.5582871133704;698.7274962764526;700.310194458458;708.787363790871;719.9280071992758;11061.889381106246;12099.697507562205;12140.817887731691;12581.308028058362;12674.36628168588;638.2054342343812;658.6640813185214;665.3911670821241;673.4107655801174;688.6074937285799;5325.786968521294;5370.892582148414;5417.5395091416885;5421.512063914267;5623.493885550321;102195.48902255589;104038;105486;108908;109247;84251.57874210589;85589;86748;88694;90046.54976725075;74801.62599187078;77700.22299777043;78921.60539197267;83039.58480207682;85105;12118.636440906786;12409.255444673348;12564.183328083645;12768.872311276768;12808.871911281141;36450.27099458049;36507.452388213664;36726.816365918;36738.63261367352;36746.63253367539;66406;66456;66927.66536167289;68156.6592167036;69711.30288697251;18438;18625.161867716255;19335.806641933963;19398.127084281525;19655.312064077687;18901.905490472458;20076.79923200749;20192.49518762043;20390.082446289656;20885;16329.918350408172;19001.62479690039;19169.61660766749;19240.615187696447;19366.4190074298;19126.139323730742;19374.70937935904;19527.51181220424;19748.111334989673;19983.400497985083;18317;19208.903955480135;19364;19410.51473713112;19650.115744791234;12222.20555663879;12701.110922235355;13082.738345232852;13371.866281337063;13535.526256580972;13921.512747053805;14442.205678687773;14565.27173641335;14865.405383784528;15327.46353877609 22:01:10 INFO - PID 3573 | __end_tp_report 22:01:10 INFO - PID 3573 | __start_cc_report 22:01:10 INFO - PID 3573 | _x_x_mozilla_cycle_collect,371 22:01:10 INFO - PID 3573 | __end_cc_report 22:01:10 INFO - PID 3573 | __startTimestamp1501131670912__endTimestamp 22:01:10 INFO - PID 3573 | 22:01:10 INFO - PID 3573 | ------- Summary: start ------- 22:01:10 INFO - PID 3573 | Number of tests: 6 22:01:10 INFO - PID 3573 | 22:01:10 INFO - PID 3573 | [#0] dojo.html Cycles:165 Average:6103.78 Median:6357.17 stddev:737.13 (11.6%) stddev-sans-first:700.25 22:01:10 INFO - PID 3573 | Values: 3082.3 3100.4 3100.6 3119.5 3162.8 6181.7 6184.9 6207.1 6241.8 6252.3 6099.6 6174.4 6199.8 6218.2 6235.0 5585.7 5623.2 5635.7 5640.2 5671.6 5655.5 5657.0 5669.3 5676.4 5768.6 5721.9 5742.8 5759.6 5805.2 5808.8 5650.6 5668.3 5722.4 5743.2 5762.7 5452.1 5473.2 5553.9 5615.6 5659.4 6131.8 6141.4 6169.0 6212.8 6236.6 6485.0 6637.2 6699.0 6711.2 6711.9 6600.3 6626.6 6662.2 6664.4 6676.0 6152.2 6159.4 6160.5 6163.3 6164.0 6788.7 6796.3 6802.0 6802.6 6802.6 6404.6 6461.7 6471.7 6486.1 6559.6 6686.4 6696.9 6700.4 6708.2 6732.6 6604.0 6626.5 6684.1 6706.3 6715.7 6643.8 6648.8 6725.7 6738.3 6747.8 5251.7 5292.9 5293.1 5300.9 5322.5 4191.6 4549.0 4624.0 4627.2 4633.2 5548.2 5613.2 5716.7 5730.5 5749.8 6605.9 6641.7 6660.0 6678.8 6683.3 5656.2 5687.1 5724.6 5735.0 5763.7 5716.0 5740.8 5806.4 5849.4 5880.0 6302.3 6390.6 6421.4 6429.3 6472.2 6495.8 6629.2 6646.3 6702.2 6723.2 6408.4 6457.3 6486.3 6491.2 6491.8 6520.6 6596.6 6610.8 6624.9 6625.9 6627.3 6650.3 6656.0 6759.0 6777.2 6336.1 6418.2 6469.6 6481.7 6482.9 6409.7 6435.6 6448.1 6460.1 6478.9 6348.7 6354.9 6449.8 6450.3 6451.2 6429.6 6484.4 6537.6 6573.5 6580.5 6212.2 6304.1 6322.1 6357.2 6388.0 22:01:10 INFO - PID 3573 | 22:01:10 INFO - PID 3573 | [#1] ext.html Cycles:180 Average:38558.78 Median:34880.13 stddev:54815.21 (157.2%) stddev-sans-first:54895.58 22:01:10 INFO - PID 3573 | Values: 780.6 809.6 832.8 834.2 1181.4 31674.8 42444.4 43662.8 43781.3 43851.0 43380.6 43572.0 43619.6 43685.3 43891.1 7549.5 7664.6 7673.3 7673.6 7678.9 7531.3 7576.5 7628.6 7638.0 7649.3 7511.5 7693.2 7699.5 7699.7 7702.0 7598.2 7640.2 7665.7 7672.2 7676.2 7488.0 7547.3 7652.5 7654.9 7684.7 39370.8 39761.4 39839.8 39879.6 40018.0 3573.6 3611.0 3619.3 3622.6 3626.7 31744.5 31786.4 31834.8 31881.8 31922.4 4845.9 4858.2 4859.7 4873.4 4888.1 187011.0 187809.1 188701.1 188786.0 188788.0 49652.0 49669.3 49713.5 49747.5 49796.3 52644.5 52662.5 52703.2 52724.7 52737.5 15938.4 15948.8 16004.6 16082.9 16117.3 13090.6 13093.3 13106.7 13112.1 13114.9 14795.9 14830.0 15064.0 15138.3 15139.5 5821.2 5917.5 5948.7 6075.6 6104.9 995.9 1012.6 1014.8 1029.9 1041.2 22692.7 28397.0 28442.6 29073.0 29374.9 1069.5 1090.3 1096.0 1103.1 1115.3 11890.9 12213.7 12232.5 12353.3 12404.0 237488.0 239017.0 240312.0 240640.0 240843.0 52901.7 53130.5 53158.5 53422.7 53447.5 1473.9 1474.7 1477.5 1510.7 1513.9 21707.0 21934.6 22013.6 22029.2 22065.3 34418.1 34514.7 34549.1 34583.8 34637.5 202675.0 202773.0 203199.0 203621.0 203825.0 34162.5 34465.0 34479.3 36993.4 37379.0 45691.3 47114.5 47487.0 47627.8 47692.3 33477.0 34846.1 34914.1 34945.1 35057.0 33938.8 34147.3 34337.5 34489.3 34811.5 38084.8 38152.0 38374.6 38485.0 38490.6 31626.7 32603.3 33189.0 33415.0 33741.3 24321.8 24375.8 24562.5 24783.8 25457.7 22:01:10 INFO - PID 3573 | 22:01:10 INFO - PID 3573 | [#2] jquery.html Cycles:180 Average:33992.56 Median:23047.10 stddev:77647.14 (336.9%) stddev-sans-first:77824.41 22:01:10 INFO - PID 3573 | Values: 569.6 573.4 576.1 583.2 596.4 22008.6 23031.5 23062.7 23102.4 24234.6 22600.2 23355.3 23424.5 23458.8 23507.1 6575.5 6705.4 6711.6 6717.8 6726.4 6051.7 6278.6 6570.1 6582.6 6595.4 6531.0 6532.0 6538.2 6543.5 6562.7 6498.9 6514.1 6518.2 6523.1 6533.0 6058.9 6067.9 6083.8 6095.4 6096.4 28674.0 29127.9 29283.7 29528.0 30090.8 1981.6 2010.3 2013.5 2016.5 2018.7 18309.2 18949.0 18953.1 18976.2 19013.8 2341.0 2390.7 2447.2 2452.6 2471.8 134778.0 136290.0 136388.3 136904.0 137034.0 13736.9 14736.9 14740.0 14890.3 14949.2 22690.0 22792.2 22802.8 22815.4 22914.8 9999.1 10022.2 10116.1 10122.0 10122.6 7449.5 9327.8 9397.6 9462.1 9556.9 7679.4 8674.7 9057.3 9069.9 9202.9 2584.7 2594.7 2663.7 2666.4 2766.9 944.9 962.6 973.5 990.7 991.2 19524.4 19577.0 22378.8 23768.6 24335.6 1020.2 1021.3 1042.7 1065.3 1067.9 10945.9 11043.3 11228.4 11248.3 11336.4 441993.0 455144.0 456120.0 464785.0 466741.0 119953.0 120255.0 121374.4 122844.0 123313.0 1252.5 1271.4 1288.7 1297.2 1298.1 17584.6 17600.3 17666.4 17814.8 18552.3 54537.5 55945.4 56386.0 57905.1 58491.4 71609.0 72046.2 72062.0 72276.0 73032.6 11994.8 14378.4 14627.4 14850.6 14858.7 22670.3 23114.5 23547.4 23983.9 24170.8 18834.5 18983.7 19280.5 19291.5 19641.1 16436.2 16494.7 16989.6 17379.7 17913.8 19247.6 19737.8 19767.7 19890.9 19919.7 14514.3 14837.0 14848.9 14853.9 14863.8 17385.0 17650.2 17686.8 17805.6 18356.0 22:01:10 INFO - PID 3573 | 22:01:10 INFO - PID 3573 | [#3] mootools.html Cycles:180 Average:8496.15 Median:2566.63 stddev:5760.47 (224.4%) stddev-sans-first:5751.56 22:01:10 INFO - PID 3573 | Values: 1343.7 1390.6 1422.7 1431.4 1435.4 13094.9 13605.9 13647.5 13759.3 13763.1 14088.9 14320.9 14343.7 14374.1 14444.0 2706.4 2735.6 2761.9 2762.0 2762.2 2623.2 2732.1 2732.3 2735.6 2736.6 2543.6 2588.7 2592.4 2606.2 2620.4 2560.9 2572.4 2595.9 2610.8 2619.6 2488.4 2492.7 2513.3 2513.5 2517.6 13247.5 13529.5 13533.4 13547.5 13551.9 7479.8 7758.7 7776.0 7777.0 7781.3 4781.0 5000.1 5035.7 5091.7 5107.9 1677.2 1697.5 1709.4 1754.4 1761.9 21980.7 22106.7 22164.9 22171.8 22193.4 6236.6 6278.4 6327.4 6407.0 6481.6 15473.9 15479.8 15505.0 15513.8 15523.4 7311.8 7407.6 7486.7 7502.4 7507.4 6788.4 6808.6 6956.6 7006.9 7082.7 4686.3 4932.8 4934.9 4973.4 4989.5 1337.1 1366.8 1378.0 1389.8 1393.3 821.5 830.4 833.9 861.3 876.8 6615.4 6811.8 6820.7 6893.9 7033.6 685.5 693.2 704.8 723.2 725.5 4570.7 4860.5 4990.8 5267.5 5330.0 18268.1 18346.6 18581.1 18612.4 18776.8 17988.4 18212.8 18236.7 18637.9 18653.9 10248.9 10409.4 10510.5 10545.4 10556.2 7513.0 7803.5 7976.4 7981.0 8232.7 15905.7 16271.3 16328.2 16425.0 16517.9 16391.9 16826.8 16889.5 16946.2 17041.1 12315.0 12581.1 12590.1 12677.7 12686.8 12528.8 12638.2 12653.7 12788.3 12815.0 9837.3 10148.3 10443.9 10481.9 10885.7 10363.7 10403.4 10451.7 10633.7 10821.7 9466.5 9549.0 9573.4 9574.7 9585.0 6397.5 6478.3 6581.2 6649.2 6734.3 6588.5 6944.5 6951.8 6976.5 7048.6 22:01:10 INFO - PID 3573 | 22:01:10 INFO - PID 3573 | [#4] prototype.html Cycles:180 Average:5509.94 Median:6088.61 stddev:1544.61 (25.4%) stddev-sans-first:1502.45 22:01:10 INFO - PID 3573 | Values: 498.4 501.5 516.3 517.8 520.1 6025.5 6187.3 6291.2 6301.7 6332.6 6026.7 6065.5 6085.6 6091.6 6171.8 5132.8 5139.2 5139.3 5165.6 5220.9 4799.8 5129.1 5178.5 5194.9 5213.2 4877.2 4894.0 4911.5 4918.4 4952.4 4913.0 4943.8 4944.9 4959.2 4970.5 4390.6 4403.3 4437.8 4459.7 4461.3 6068.2 6082.1 6122.0 6142.6 6145.0 5588.2 5714.7 5715.1 5717.9 5747.3 6441.3 6461.9 6473.8 6506.2 6510.6 4852.3 4853.8 4875.0 4881.8 4890.9 6867.9 6869.8 6964.5 6999.0 7005.3 4965.8 5008.7 5032.6 5046.2 5047.7 5070.0 5088.7 5089.1 5096.7 5097.9 5630.9 5707.2 5714.3 5737.8 5748.9 6399.8 6524.0 6546.8 6580.0 6608.3 1692.9 1711.0 1723.5 1726.6 1751.7 1223.9 1228.6 1230.1 1246.9 1255.3 5734.0 5740.0 5754.9 5772.8 5793.4 6463.4 6643.8 6647.8 6677.0 6733.0 5708.9 5717.3 5737.2 5787.9 5805.7 3526.9 3549.6 3585.9 3595.7 3596.9 6372.4 6480.8 6489.5 6491.4 6519.8 6788.5 6921.3 6941.2 6976.7 6987.5 6369.6 6514.0 6527.7 6553.6 6560.8 6747.3 6775.5 6784.8 6802.8 6829.5 6658.3 6669.9 6739.4 6740.7 6765.8 6442.3 6449.2 6516.4 6520.7 6529.5 4909.7 4933.9 4950.4 4960.7 5020.2 6670.3 6718.9 6760.9 6780.9 6796.5 6473.2 6516.2 6530.0 6556.8 6596.1 6498.2 6506.7 6556.8 6557.3 6570.3 6205.1 6269.6 6271.7 6395.7 6471.6 6439.0 6473.2 6520.3 6554.0 6558.7 6285.6 6326.8 6356.7 6407.4 6437.6 22:01:10 INFO - PID 3573 | 22:01:10 INFO - PID 3573 | [#5] yui.html Cycles:180 Average:22920.71 Median:19532.16 stddev:30414.86 (155.7%) stddev-sans-first:30454.80 22:01:10 INFO - PID 3573 | Values: 794.5 825.6 842.7 921.0 944.3 17192.7 18255.3 19034.6 19085.1 19127.8 19391.8 19438.2 19447.8 19492.8 19536.8 968.7 1029.0 1033.0 1048.6 1063.7 1078.0 1078.0 1079.4 1080.0 1080.0 1061.0 1100.9 1106.4 1109.3 1120.2 1085.4 1087.4 1087.6 1087.7 1088.2 792.6 793.9 794.7 797.6 798.6 19390.5 19712.8 19988.0 20022.1 20396.3 20381.9 20503.9 20660.4 21178.4 21197.0 16056.5 16401.9 16610.4 16616.0 16910.8 3540.6 3560.9 3561.3 3562.9 3566.2 119332.0 121151.0 123141.0 125229.0 127609.4 15593.8 15726.2 15916.3 16093.5 16106.8 28595.0 29396.0 30505.5 30674.0 30694.5 8293.5 8377.8 8408.7 8418.9 8435.0 3547.1 3710.0 3863.4 4026.9 4046.7 5160.9 5268.8 5278.6 5295.7 5314.0 1027.8 1059.4 1065.7 1080.0 1114.2 679.6 698.7 700.3 708.8 719.9 11061.9 12099.7 12140.8 12581.3 12674.4 638.2 658.7 665.4 673.4 688.6 5325.8 5370.9 5417.5 5421.5 5623.5 102195.5 104038.0 105486.0 108908.0 109247.0 84251.6 85589.0 86748.0 88694.0 90046.5 74801.6 77700.2 78921.6 83039.6 85105.0 12118.6 12409.3 12564.2 12768.9 12808.9 36450.3 36507.5 36726.8 36738.6 36746.6 66406.0 66456.0 66927.7 68156.7 69711.3 18438.0 18625.2 19335.8 19398.1 19655.3 18901.9 20076.8 20192.5 20390.1 20885.0 16329.9 19001.6 19169.6 19240.6 19366.4 19126.1 19374.7 19527.5 19748.1 19983.4 18317.0 19208.9 19364.0 19410.5 19650.1 12222.2 12701.1 13082.7 13371.9 13535.5 13921.5 14442.2 14565.3 14865.4 15327.5 22:01:10 INFO - PID 3573 | -------- Summary: end -------- 22:01:10 INFO - PID 3573 | 22:01:11 INFO - TEST-INFO | 3573: exit 0 22:01:11 INFO - TEST-OK | dromaeo_css | took 1115091ms 22:01:11 INFO - TEST-START | kraken 22:01:11 INFO - Initialising browser for kraken test... 22:01:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52565/getInfo.html -profile /tmp/tmpQdGkZ5/profile 22:01:11 INFO - TEST-INFO | started process 3929 (/builds/slave/test/build/application/firefox/firefox http://localhost:52565/getInfo.html) 22:01:17 INFO - TEST-INFO | 3929: exit 0 22:01:17 INFO - Browser initialized. 22:01:17 INFO - Running cycle 1/1 for kraken test... 22:01:17 INFO - TEST-INFO | started process 4138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQdGkZ5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 22:01:18 INFO - PID 4138 | 22:01:18 INFO - PID 4138 | (/builds/slave/test/build/application/firefox/firefox:4186): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 22:01:18 INFO - PID 4138 | 22:01:28 INFO - PID 4138 | RSS: Main: 170840064 22:01:28 INFO - PID 4138 | 22:01:31 INFO - PID 4138 | Cycle 1(1): loaded http://localhost:52565/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52565/tests/kraken/driver.html?testName=audio-beat-detection) 22:01:32 INFO - PID 4138 | RSS: Main: 175616000 22:01:32 INFO - PID 4138 | 22:01:34 INFO - PID 4138 | Cycle 1(1): loaded http://localhost:52565/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52565/tests/kraken/driver.html?testName=audio-dft) 22:01:35 INFO - PID 4138 | RSS: Main: 176549888 22:01:35 INFO - PID 4138 | 22:01:38 INFO - PID 4138 | Cycle 1(1): loaded http://localhost:52565/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52565/tests/kraken/driver.html?testName=audio-fft) 22:01:39 INFO - PID 4138 | RSS: Main: 170389504 22:01:39 INFO - PID 4138 | 22:01:41 INFO - PID 4138 | Cycle 1(1): loaded http://localhost:52565/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52565/tests/kraken/driver.html?testName=audio-oscillator) 22:01:41 INFO - PID 4138 | RSS: Main: 170835968 22:01:41 INFO - PID 4138 | 22:01:43 INFO - PID 4138 | Cycle 1(1): loaded http://localhost:52565/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52565/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:01:44 INFO - PID 4138 | RSS: Main: 171175936 22:01:44 INFO - PID 4138 | 22:01:47 INFO - PID 4138 | Cycle 1(1): loaded http://localhost:52565/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52565/tests/kraken/driver.html?testName=imaging-darkroom) 22:01:48 INFO - PID 4138 | RSS: Main: 174247936 22:01:48 INFO - PID 4138 | 22:01:51 INFO - PID 4138 | Cycle 1(1): loaded http://localhost:52565/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52565/tests/kraken/driver.html?testName=imaging-desaturate) 22:01:52 INFO - PID 4138 | RSS: Main: 175017984 22:01:52 INFO - PID 4138 | 22:01:55 INFO - PID 4138 | Cycle 1(1): loaded http://localhost:52565/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52565/tests/kraken/driver.html?testName=json-parse-financial) 22:01:55 INFO - PID 4138 | RSS: Main: 174866432 22:01:55 INFO - PID 4138 | 22:01:57 INFO - PID 4138 | Cycle 1(1): loaded http://localhost:52565/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52565/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:01:58 INFO - PID 4138 | RSS: Main: 174821376 22:01:58 INFO - PID 4138 | 22:02:00 INFO - PID 4138 | Cycle 1(1): loaded http://localhost:52565/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52565/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:02:00 INFO - PID 4138 | RSS: Main: 174866432 22:02:00 INFO - PID 4138 | 22:02:02 INFO - PID 4138 | Cycle 1(1): loaded http://localhost:52565/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52565/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:02:03 INFO - PID 4138 | RSS: Main: 172019712 22:02:03 INFO - PID 4138 | 22:02:06 INFO - PID 4138 | Cycle 1(1): loaded http://localhost:52565/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:02:06 INFO - PID 4138 | RSS: Main: 172371968 22:02:06 INFO - PID 4138 | 22:02:09 INFO - PID 4138 | Cycle 1(1): loaded http://localhost:52565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:02:10 INFO - PID 4138 | RSS: Main: 172298240 22:02:10 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | Cycle 1(1): loaded http://localhost:52565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52565/tests/kraken/driver.html?testName=ai-astar) 22:02:12 INFO - PID 4138 | RSS: Main: 174014464 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | __start_tp_report 22:02:12 INFO - PID 4138 | _x_x_mozilla_page_load 22:02:12 INFO - PID 4138 | _x_x_mozilla_page_load_details 22:02:12 INFO - PID 4138 | |i|pagename|runs| 22:02:12 INFO - PID 4138 | |0;ai-astar;98;109;101;107;108;109;112;100;108;111 22:02:12 INFO - PID 4138 | |1;audio-beat-detection;139;120;146;192;118;149;144;119;190;124 22:02:12 INFO - PID 4138 | |2;audio-dft;164;165;164;164;162;162;165;171;168;167 22:02:12 INFO - PID 4138 | |3;audio-fft;75;75;77;182;87;75;77;90;96;74 22:02:12 INFO - PID 4138 | |4;audio-oscillator;79;79;135;82;83;80;130;79;80;129 22:02:12 INFO - PID 4138 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;114;114;114 22:02:12 INFO - PID 4138 | |6;imaging-darkroom;157;152;151;157;150;151;151;151;151;151 22:02:12 INFO - PID 4138 | |7;imaging-desaturate;98;94;94;93;94;94;94;94;93;93 22:02:12 INFO - PID 4138 | |8;json-parse-financial;55;56;55;56;56;63;60;56;58;55 22:02:12 INFO - PID 4138 | |9;json-stringify-tinderbox;54;54;53;55;55;54;54;54;54;54 22:02:12 INFO - PID 4138 | |10;stanford-crypto-aes;77;77;77;79;78;77;77;87;79;78 22:02:12 INFO - PID 4138 | |11;stanford-crypto-ccm;128;129;129;126;148;123;136;127;129;174 22:02:12 INFO - PID 4138 | |12;stanford-crypto-pbkdf2;187;170;177;173;173;179;177;175;179;172 22:02:12 INFO - PID 4138 | |13;stanford-crypto-sha256-iterative;70;70;67;68;66;66;68;66;66;67 22:02:12 INFO - PID 4138 | __end_tp_report 22:02:12 INFO - PID 4138 | __start_cc_report 22:02:12 INFO - PID 4138 | _x_x_mozilla_cycle_collect,981 22:02:12 INFO - PID 4138 | __end_cc_report 22:02:12 INFO - PID 4138 | __startTimestamp1501131732566__endTimestamp 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | ------- Summary: start ------- 22:02:12 INFO - PID 4138 | Number of tests: 14 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | [#0] ai-astar Cycles:10 Average:106.30 Median:109.00 stddev:4.85 (4.5%) stddev-sans-first:4.12 22:02:12 INFO - PID 4138 | Values: 98.0 109.0 101.0 107.0 108.0 109.0 112.0 100.0 108.0 111.0 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:145.00 stddev:27.39 (18.9%) stddev-sans-first:28.99 22:02:12 INFO - PID 4138 | Values: 139.0 120.0 146.0 192.0 118.0 149.0 144.0 119.0 190.0 124.0 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:2.78 (1.7%) stddev-sans-first:2.92 22:02:12 INFO - PID 4138 | Values: 164.0 165.0 164.0 164.0 162.0 162.0 165.0 171.0 168.0 167.0 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | [#3] audio-fft Cycles:10 Average:90.80 Median:77.00 stddev:32.95 (42.8%) stddev-sans-first:34.45 22:02:12 INFO - PID 4138 | Values: 75.0 75.0 77.0 182.0 87.0 75.0 77.0 90.0 96.0 74.0 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:79.50 stddev:24.74 (31.1%) stddev-sans-first:25.50 22:02:12 INFO - PID 4138 | Values: 79.0 79.0 135.0 82.0 83.0 80.0 130.0 79.0 80.0 129.0 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 22:02:12 INFO - PID 4138 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | [#6] imaging-darkroom Cycles:10 Average:152.20 Median:151.00 stddev:2.57 (1.7%) stddev-sans-first:2.06 22:02:12 INFO - PID 4138 | Values: 157.0 152.0 151.0 157.0 150.0 151.0 151.0 151.0 151.0 151.0 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:1.45 (1.5%) stddev-sans-first:0.50 22:02:12 INFO - PID 4138 | Values: 98.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 93.0 93.0 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.00 stddev:2.62 (4.7%) stddev-sans-first:2.68 22:02:12 INFO - PID 4138 | Values: 55.0 56.0 55.0 56.0 56.0 63.0 60.0 56.0 58.0 55.0 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:54.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 22:02:12 INFO - PID 4138 | Values: 54.0 54.0 53.0 55.0 55.0 54.0 54.0 54.0 54.0 54.0 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:78.00 stddev:3.06 (3.9%) stddev-sans-first:3.19 22:02:12 INFO - PID 4138 | Values: 77.0 77.0 77.0 79.0 78.0 77.0 77.0 87.0 79.0 78.0 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:129.00 stddev:15.41 (11.9%) stddev-sans-first:16.14 22:02:12 INFO - PID 4138 | Values: 128.0 129.0 129.0 126.0 148.0 123.0 136.0 127.0 129.0 174.0 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:177.00 stddev:4.85 (2.7%) stddev-sans-first:3.20 22:02:12 INFO - PID 4138 | Values: 187.0 170.0 177.0 173.0 173.0 179.0 177.0 175.0 179.0 172.0 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.58 (2.3%) stddev-sans-first:1.36 22:02:12 INFO - PID 4138 | Values: 70.0 70.0 67.0 68.0 66.0 66.0 68.0 66.0 66.0 67.0 22:02:12 INFO - PID 4138 | -------- Summary: end -------- 22:02:12 INFO - PID 4138 | 22:02:12 INFO - PID 4138 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 22:02:13 INFO - TEST-INFO | 4138: exit 0 22:02:13 INFO - TEST-OK | kraken | took 61592ms 22:02:13 INFO - SUITE-END | took 1176s 22:02:13 INFO - Completed test suite (00:19:36) 22:02:13 INFO - javascript benchmark 22:02:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8429.638062594973, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.3372974810413, 3100.379924015196, 3100.581421508096, 3119.532070189471, 3162.841857907104, 6181.721822517986, 6184.907226391608, 6207.068939659053, 6241.843953901155, 6252.280987686412, 6099.634021958675, 6174.382561743834, 6199.845003874905, 6218.191635087433, 6235.0, 5585.692786896719, 5623.156526521014, 5635.6618602883955, 5640.182173584828, 5671.574631902603, 5655.462731040545, 5657.0, 5669.262995810539, 5676.403977582357, 5768.567357448187, 5721.885562288772, 5742.79900203493, 5759.5968282220265, 5805.187273781674, 5808.796692115777, 5650.576206784466, 5668.26312579362, 5722.37053924068, 5743.167240750068, 5762.683052432115, 5452.1276595744885, 5473.233747275384, 5553.944460555384, 5615.578831587647, 5659.40576239493, 6131.754729810802, 6141.416565426277, 6168.9691551541955, 6212.782552610682, 6236.594621349598, 6484.967575162094, 6637.203535575713, 6699.0, 6711.228208756007, 6711.865762684719, 6600.273969863311, 6626.56927299724, 6662.167229096363, 6664.433523150489, 6676.0, 6152.230971128609, 6159.445649891486, 6160.476359509447, 6163.291221509494, 6164.013757798731, 6788.728450862009, 6796.320367963263, 6802.0, 6802.591844489347, 6802.6258555779905, 6404.647744374011, 6461.741530338733, 6471.6764161791725, 6486.059521369375, 6559.606423614503, 6686.398224159849, 6696.866062678817, 6700.430463410567, 6708.161479815023, 6732.596044237263, 6604.0, 6626.536142470077, 6684.097646817715, 6706.26231114577, 6715.697793599202, 6643.767468138689, 6648.767293144813, 6725.6973436195485, 6738.326167383222, 6747.763828265987, 5251.711155886386, 5292.947070529322, 5293.126634105406, 5300.893982120413, 5322.467753224724, 4191.580841915784, 4549.0, 4624.0, 4627.213373726475, 4633.235516139799, 5548.223248745179, 5613.158026296088, 5716.657000579979, 5730.541556675456, 5749.770009199585, 6605.933940660532, 6641.701123449457, 6660.000999850061, 6678.83302917431, 6683.2648408675, 5656.208130861683, 5687.090065589568, 5724.570657200727, 5734.996375634248, 5763.711814409263, 5716.0, 5740.799072032542, 5806.44838740319, 5849.356570777211, 5880.0003999320215, 6302.306746257908, 6390.616563006234, 6421.389967953037, 6429.32492088324, 6472.190976128079, 6495.805125846232, 6629.237637671729, 6646.302138275605, 6702.19573651165, 6723.159605049369, 6408.391202835724, 6457.289698133108, 6486.318936511599, 6491.188601424822, 6491.837704057248, 6520.576162549419, 6596.60420374779, 6610.8016759497295, 6624.867502650017, 6625.933740662532, 6627.304133065959, 6650.268470468342, 6655.968324909453, 6759.019942108268, 6777.152855893013, 6336.081268216175, 6418.165638467156, 6469.5794773339585, 6481.740730370732, 6482.935170648422, 6409.7436102555375, 6435.646039467874, 6448.065030570635, 6460.063290822898, 6478.870422591616, 6348.71430785625, 6354.93645063562, 6449.806505804833, 6450.322716114741, 6451.1936007999, 6429.646369449725, 6484.351564843478, 6537.640429776408, 6573.5069869759, 6580.539362244597, 6212.223472065992, 6304.05439184126, 6322.0516922462, 6357.173567436389, 6388.041793730792], "value": 6047.265329670054, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.5628847845207, 809.5952023988006, 832.8417600655877, 834.1533343656187, 1181.4270079011671, 31674.841625791898, 42444.36333454997, 43662.78168609161, 43781.34327985083, 43851.0, 43380.56619433805, 43572.0, 43619.56380436195, 43685.34471982923, 43891.122177556426, 7549.471536992426, 7664.616769161547, 7673.309402153805, 7673.616319184019, 7678.9232107679045, 7531.3221810037085, 7576.545407275581, 7628.618569071552, 7638.045244344457, 7649.273319034711, 7511.511751736147, 7693.153753087156, 7699.499532530395, 7699.6920123195005, 7701.961490192569, 7598.202188770182, 7640.159582445926, 7665.731699390551, 7672.232776722339, 7676.1939996300425, 7487.951686763858, 7547.320741133324, 7652.464327497078, 7654.923450765476, 7684.654190561439, 39370.80314598437, 39761.40357894634, 39839.8008009961, 39879.60120398788, 40018.0, 3573.5711714594154, 3611.043073585502, 3619.3123306571665, 3622.6196249393697, 3626.691731202851, 31744.523832142535, 31786.364272714647, 31834.840825795953, 31881.8405907969, 31922.361552769045, 4845.878853028667, 4858.222684370519, 4859.659823812334, 4873.439554451248, 4888.120138375127, 187011.0, 187809.0609546957, 188701.05649471664, 188786.0, 188788.0, 49652.0, 49669.25496117561, 49713.50286497161, 49747.50252497501, 49796.25305620419, 52644.473555264725, 52662.52368548716, 52703.20945185825, 52724.73637631787, 52737.47262527402, 15938.442154524537, 15948.76076858848, 16004.599885002735, 16082.919585402233, 16117.274722637509, 13090.607281781371, 13093.345332733516, 13106.672333191747, 13112.147710398793, 13114.934425327812, 14795.852041479662, 14830.0, 15064.0, 15138.318775655121, 15139.54581362561, 5821.2141360916585, 5917.467427931507, 5948.7323070461935, 6075.5747097703625, 6104.908426373608, 995.9203263739029, 1012.6455740490769, 1014.7513859104419, 1029.9382037077798, 1041.1670663469195, 22692.65961010586, 28397.0, 28442.573361399594, 29073.0, 29374.853125734233, 1069.5187165775433, 1090.3076546393097, 1095.9890401096047, 1103.1119948441421, 1115.3308015190983, 11890.940545297392, 12213.69465763363, 12232.510699572096, 12353.3205673687, 12404.0, 237488.0, 239017.0, 240312.0, 240640.0, 240843.0, 52901.735491322295, 53130.46869531255, 53158.46841531613, 53422.73288633532, 53447.46552534425, 1473.9189344585936, 1474.7198032373815, 1477.519806063034, 1510.6601014771588, 1513.9091654500764, 21707.0, 21934.561308774053, 22013.559728805656, 22029.228976985727, 22065.33803985883, 34418.139546511535, 34514.65485345215, 34549.136271592404, 34583.82708086444, 34637.48043779396, 202675.0, 202773.0, 203199.0, 203621.0, 203825.0, 34162.48756268708, 34465.0, 34479.31041379208, 36993.445098323005, 37379.0, 45691.31463027991, 47114.528854712386, 47487.0, 47627.76186119047, 47692.284615730096, 33477.0, 34846.12884677904, 34914.127146820516, 34945.12637184091, 35057.0, 33938.830305849304, 34147.31705365829, 34337.48493772546, 34489.31021379609, 34811.47782783311, 38084.80957595194, 38152.0, 38374.616253837106, 38485.0, 38490.615093848704, 31626.683733162376, 32603.34793304168, 33189.0, 33415.0, 33741.32517349689, 24321.756782432658, 24375.75624243735, 24562.50874982526, 24783.752162478144, 25457.74542254628], "value": 17518.251307484286, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.5500554561896, 573.3692937768452, 576.1444255280904, 583.2272239282951, 596.394659420688, 22008.559828803434, 23031.539369212627, 23062.65406018911, 23102.422439439022, 24234.636480452806, 22600.208992685217, 23355.299341019752, 23424.5315093698, 23458.76541234587, 23507.05971761132, 6575.473962083034, 6705.430038446713, 6711.563748356366, 6717.8320541986595, 6726.394624483795, 6051.667158306292, 6278.623282603058, 6570.080188773575, 6582.572132811376, 6595.373439523238, 6531.0, 6531.967340163293, 6538.248101468321, 6543.509236807258, 6562.737490500398, 6498.902516462257, 6514.088027676129, 6518.217813862343, 6523.119378883837, 6533.020046992965, 6058.878822423571, 6067.939320606782, 6083.756649734005, 6095.420935011167, 6096.420840020191, 28674.0, 29127.854360728274, 29283.707162928313, 29528.0, 30090.84954575213, 1981.5739615982488, 2010.2763005318075, 2013.456366780961, 2016.5361966747585, 2018.6568283391712, 18309.176087076114, 18949.0, 18953.147108380017, 18976.240950361967, 19013.80986190148, 2341.0212741390737, 2390.737018927934, 2447.229122826304, 2452.558539462896, 2471.7775400213886, 134778.0, 136290.0, 136388.31805841008, 136904.0, 137033.999999999, 13736.862631373759, 14736.852631473548, 14740.041897276642, 14890.329935152944, 14949.177795221367, 22690.0, 22792.202272920367, 22802.771972280065, 22815.429614259778, 22914.770852291596, 9999.050090241415, 10022.248331375176, 10116.08955194036, 10122.0, 10122.595096196217, 7449.478536502393, 9327.766805829908, 9397.57710903011, 9462.148406643435, 9556.904430955741, 7679.40074906367, 8674.696385626472, 9057.275417966679, 9069.863952040725, 9202.861957070649, 2584.651072105279, 2594.701609314915, 2663.693675227335, 2666.440047589989, 2766.9031583894466, 944.8535477001076, 962.6390103711109, 973.4500007495742, 990.7225976726528, 991.2218908157062, 19524.414267571996, 19577.0, 22378.776212237994, 23768.643470347957, 24335.634965475532, 1020.1532727835878, 1021.3463383434607, 1042.6507120114695, 1065.2756125834353, 1067.8558394616628, 10945.945270273598, 11043.337399756041, 11228.382438965935, 11248.26886252391, 11336.43317834105, 441993.0, 455144.0, 456120.0, 464785.0, 466741.0, 119953.0, 120255.0, 121374.3931280338, 122844.0, 123313.0, 1252.5303011370918, 1271.4151490314373, 1288.7100402409383, 1297.2151848131743, 1298.0589072922055, 17584.648307034044, 17600.29598816033, 17666.38167664177, 17814.821851781315, 18552.257909684, 54537.45462545324, 55945.44054559402, 56386.0, 57905.131423027844, 58491.415085848595, 71609.0, 72046.1988450293, 72062.0, 72276.0, 73032.63483682547, 11994.820077698667, 14378.424863005781, 14627.414903404171, 14850.628734281298, 14858.702825943637, 22670.319890403316, 23114.537709245385, 23547.41131471727, 23983.880080599487, 24170.758292417555, 18834.52913677169, 18983.71524427162, 19280.517987050436, 19291.51771205675, 19641.11614977358, 16436.17819109016, 16494.67010659804, 16989.575260618585, 17379.739303910705, 17913.820861791217, 19247.615047698688, 19737.80262197417, 19767.70348444746, 19890.90054549776, 19919.701204482233, 14514.34685439179, 14837.035592686441, 14848.851511484747, 14853.925730371278, 14863.777043344575, 17385.0, 17650.205740741952, 17686.823131768517, 17805.643887122445, 18356.0], "value": 11972.24234012156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.6640839790052, 1390.575874358321, 1422.6798970231694, 1431.363043445667, 1435.440178330451, 13094.869051309495, 13605.931970340134, 13647.454101835914, 13759.31203439829, 13763.105398149113, 14088.859111408883, 14320.856791432083, 14343.713125737479, 14374.137551746877, 14444.0, 2706.418120104182, 2735.603337516059, 2761.9447611047867, 2762.0, 2762.1713485954233, 2623.1737002844043, 2732.0847516082135, 2732.2622891819196, 2735.575985722216, 2736.616873637682, 2543.605741110131, 2588.6634737484196, 2592.44262483566, 2606.2311618072617, 2620.436606129682, 2560.884760185796, 2572.369769406507, 2595.8702064896775, 2610.765031147196, 2619.5808670612705, 2488.4401009772837, 2492.713337966121, 2513.3339664988794, 2513.54756143894, 2517.609770485578, 13247.47010119594, 13529.526466573623, 13533.390997405042, 13547.525836595672, 13551.932240338834, 7479.775606731807, 7758.6896524138965, 7776.0, 7777.0, 7781.299683028498, 4780.976095119537, 5000.074986127578, 5035.672681275742, 5091.745412729349, 5107.948920510822, 1677.1949464257102, 1697.499237724874, 1709.435886157565, 1754.350890170645, 1761.8942863428235, 21980.670289945665, 22106.668399974013, 22164.88917555418, 22171.778282217132, 22193.44516387103, 6236.563440559208, 6278.434940855345, 6327.430531252209, 6407.006913928349, 6481.578697384655, 15473.922630387002, 15479.767803482957, 15505.0, 15513.844861551466, 15523.37906483728, 7311.780646580611, 7407.592582407911, 7486.7005319786595, 7502.437317201232, 7507.399408047452, 6788.422984046411, 6808.557443766139, 6956.582605043714, 7006.859862802716, 7082.681279342442, 4686.297055441711, 4932.827351042696, 4934.9013019739405, 4973.353464049723, 4989.476105008922, 1337.1175024483794, 1366.794980752895, 1377.9931100344434, 1389.8471168171493, 1393.3451277899371, 821.4660470694097, 830.4228561150063, 833.8624127018974, 861.2722249698994, 876.7720392697944, 6615.37153970372, 6811.795646130624, 6820.658967051628, 6893.862122757517, 7033.577985320897, 685.5372623479132, 693.2201273567237, 704.8484575816121, 723.2405973727671, 725.4522835259451, 4570.7257564546235, 4860.489648586848, 4990.750462476862, 5267.525922666979, 5330.0, 18268.086595670164, 18346.63306733858, 18581.070946452623, 18612.44162675122, 18776.81223187778, 17988.37040703569, 18212.817871821113, 18236.726449103273, 18637.90681046586, 18653.906730466533, 10248.897511024943, 10409.42748148859, 10510.527026283835, 10545.420001899816, 10556.155507559377, 7512.962435187789, 7803.492772969966, 7976.361891048586, 7981.0, 8232.670693172206, 15905.68188636244, 16271.3491460345, 16328.183590820649, 16425.0, 16517.917410412872, 16391.918040410197, 16826.831731682527, 16889.493315200565, 16946.237419316407, 17041.062741548838, 12315.0, 12581.119321647397, 12590.055745818918, 12677.746445070863, 12686.809697854354, 12528.812067819172, 12638.178518396275, 12653.74692506163, 12788.296643684687, 12815.0, 9837.262205334771, 10148.34035787701, 10443.895561044292, 10481.947590262, 10885.673429797118, 10363.740906477398, 10403.427811470441, 10451.68644940653, 10633.734156645836, 10821.729456763644, 9466.52667366615, 9548.952255238957, 9573.425594464354, 9574.664886728931, 9585.041495850359, 6397.488200943821, 6478.2550006749825, 6581.2102547694585, 6649.235337936199, 6734.326567343226, 6588.538802283794, 6944.548604340702, 6951.756688515878, 6976.476764242803, 7048.577085374894], "value": 6165.209297831891, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.3686667668574, 501.47801422682153, 516.3055690096818, 517.7514792899406, 520.0872468817225, 6025.487833534155, 6187.319394866561, 6291.213598300218, 6301.684915754211, 6332.588381755183, 6026.668533230671, 6065.545084118698, 6085.604435711687, 6091.6089261004, 6171.753129874811, 5132.769025393866, 5139.229115632666, 5139.331886854704, 5165.631107756429, 5220.895582088366, 4799.784009719571, 5129.05046630002, 5178.482151784829, 5194.92207616886, 5213.1919552469235, 4877.171060852181, 4893.951060489385, 4911.5088491150955, 4918.36061312029, 4952.405711314647, 4912.950870491303, 4943.826966056171, 4944.87637809054, 4959.156943319645, 4970.502949705036, 4390.604845563915, 4403.251447253974, 4437.778111094464, 4459.662101369576, 4461.308497182942, 6068.180795592582, 6082.087686846964, 6122.0, 6142.6007309525185, 6145.0, 5588.2455868458055, 5714.685692286923, 5715.1135778909265, 5717.857053573653, 5747.3103227612955, 6441.291457939623, 6461.935380646228, 6473.805785826433, 6506.219253689587, 6510.576812507172, 4852.344933433977, 4853.757312134379, 4874.951885344668, 4881.779555111222, 4890.926636100461, 6867.862642747117, 6869.7595584154315, 6964.477664175207, 6998.965005174941, 7005.299470053056, 4965.82619608312, 5008.749562521859, 5032.647714660012, 5046.243063540425, 5047.747612619354, 5069.986002799381, 5088.6946783193125, 5089.05852417304, 5096.694198348111, 5097.949020509747, 5630.887382252332, 5707.200991861143, 5714.314282286069, 5737.799177028784, 5748.885022299531, 6399.8080057598345, 6524.010176895998, 6546.836329091716, 6579.967100164468, 6608.306127856602, 1692.8730345224158, 1711.0161657047247, 1723.4657256250603, 1726.6460375622967, 1751.737239414098, 1223.9143259971715, 1228.5761412312738, 1230.1204638683384, 1246.875312468746, 1255.29076072019, 5733.971330143406, 5739.971300143473, 5754.913676294859, 5772.826815195551, 5793.435772341444, 6463.385978332051, 6643.7674681385915, 6647.800565983028, 6677.0, 6733.0, 5708.857278568069, 5717.285339332583, 5737.168110623936, 5787.913181302284, 5805.651660900359, 3526.8662459211805, 3549.5563054618174, 3585.94621080684, 3595.658412450813, 3596.9280614387567, 6372.426481616677, 6480.837979050467, 6489.480841532666, 6491.350864913471, 6519.771807986698, 6788.456923446112, 6921.307869213139, 6941.167059952737, 6976.686049127801, 6987.475939304572, 6369.585976911486, 6514.0, 6527.706253218616, 6553.606783593, 6560.770373037016, 6747.291534388818, 6775.457963362821, 6784.76253331131, 6802.795916122524, 6829.52193346461, 6658.334166583303, 6669.933300666931, 6739.359760822714, 6740.6966686498245, 6765.830854228684, 6442.323556026549, 6449.226092868698, 6516.446102081376, 6520.739170433129, 6529.542931994714, 4909.705417674808, 4933.876653083702, 4950.430700469348, 4960.677555958851, 5020.171671674133, 6670.299618539983, 6718.932810672026, 6760.895523879636, 6780.881154609434, 6796.456283497408, 6473.190851143607, 6516.185476815398, 6529.967350163219, 6556.803295901131, 6596.141257364496, 6498.220213574212, 6506.739730410731, 6556.803295901131, 6557.344265573404, 6570.277269500447, 6205.138458462534, 6269.5611307208055, 6271.717772700148, 6395.680215989275, 6471.579347342407, 6439.0, 6473.190851143607, 6520.282768895512, 6553.967230163818, 6558.672066396756, 6285.59143655661, 6326.810195694136, 6356.650384228912, 6407.391297826699, 6437.558084921389], "value": 5054.550306935373, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.4843145263238, 825.5665775467883, 842.6545116502232, 920.9953950230249, 944.268192151083, 17192.656146877056, 18255.269789208432, 19034.61930761384, 19085.14116864741, 19127.808721912777, 19391.806081939176, 19438.22247110114, 19447.805521944778, 19492.80507194931, 19536.804631953677, 968.6851773173712, 1029.0429900192817, 1032.9845052324201, 1048.6329784575375, 1063.702163394247, 1077.9730506737355, 1078.0136175399539, 1079.379356869803, 1079.962201322954, 1080.0171843622306, 1060.9575616975312, 1100.9284396514201, 1106.3638407915441, 1109.3233127792041, 1120.1542835159444, 1085.4464223246162, 1087.4345340422935, 1087.6138970665418, 1087.7008822573775, 1088.2219213262515, 792.5561685456163, 793.8848866914265, 794.7099308752322, 797.6091715059637, 798.6126728536655, 19390.515237119045, 19712.80287197124, 19988.0, 20022.09900554464, 20396.28612998553, 20381.8980905096, 20503.897480512504, 20660.380188594365, 21178.364649060553, 21197.0, 16056.518304450885, 16401.917990409973, 16610.418635347825, 16616.00303981765, 16910.83089169105, 3540.5751309842985, 3560.9109772255642, 3561.3233485637907, 3562.9109272268142, 3566.2154326048226, 119332.0, 121151.0, 123141.0, 125229.0, 127609.36195318964, 15593.766093508606, 15726.21368931549, 15916.28376723027, 16093.517194484184, 16106.75839862403, 28595.0, 29396.0, 30505.542416863766, 30674.0, 30694.53958190629, 8293.460925039853, 8377.790555236046, 8408.705695300758, 8418.915810841936, 8435.0, 3547.1486843157454, 3709.9814500927323, 3863.362545180014, 4026.859059932888, 4046.736962097454, 5160.948390516121, 5268.78924843002, 5278.5513231375, 5295.682259064469, 5314.0, 1027.77388974427, 1059.3537941855461, 1065.6856227412932, 1080.0441609175937, 1114.2089116727213, 679.5582871133704, 698.7274962764526, 700.310194458458, 708.787363790871, 719.9280071992758, 11061.889381106246, 12099.697507562205, 12140.817887731691, 12581.308028058362, 12674.36628168588, 638.2054342343812, 658.6640813185214, 665.3911670821241, 673.4107655801174, 688.6074937285799, 5325.786968521294, 5370.892582148414, 5417.5395091416885, 5421.512063914267, 5623.493885550321, 102195.48902255589, 104038.0, 105486.0, 108908.0, 109247.0, 84251.57874210589, 85589.0, 86748.0, 88694.0, 90046.54976725075, 74801.62599187078, 77700.22299777043, 78921.60539197267, 83039.58480207682, 85105.0, 12118.636440906786, 12409.255444673348, 12564.183328083645, 12768.872311276768, 12808.871911281141, 36450.27099458049, 36507.452388213664, 36726.816365918, 36738.63261367352, 36746.63253367539, 66406.0, 66456.0, 66927.66536167289, 68156.6592167036, 69711.30288697251, 18438.0, 18625.161867716255, 19335.806641933963, 19398.127084281525, 19655.312064077687, 18901.905490472458, 20076.79923200749, 20192.49518762043, 20390.082446289656, 20885.0, 16329.918350408172, 19001.62479690039, 19169.61660766749, 19240.615187696447, 19366.4190074298, 19126.139323730742, 19374.70937935904, 19527.51181220424, 19748.111334989673, 19983.400497985083, 18317.0, 19208.903955480135, 19364.0, 19410.51473713112, 19650.115744791234, 12222.20555663879, 12701.110922235355, 13082.738345232852, 13371.866281337063, 13535.526256580972, 13921.512747053805, 14442.205678687773, 14565.27173641335, 14865.405383784528, 15327.46353877609], "value": 9077.577834142647, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 109.0, 101.0, 107.0, 108.0, 109.0, 112.0, 100.0, 108.0, 111.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 120.0, 146.0, 192.0, 118.0, 149.0, 144.0, 119.0, 190.0, 124.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 164.0, 162.0, 162.0, 165.0, 171.0, 168.0, 167.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 182.0, 87.0, 75.0, 77.0, 90.0, 96.0, 74.0], "value": 90.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 135.0, 82.0, 83.0, 80.0, 130.0, 79.0, 80.0, 129.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 152.0, 151.0, 157.0, 150.0, 151.0, 151.0, 151.0, 151.0, 151.0], "value": 152.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 56.0, 56.0, 63.0, 60.0, 56.0, 58.0, 55.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 79.0, 78.0, 77.0, 77.0, 87.0, 79.0, 78.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 129.0, 129.0, 126.0, 148.0, 123.0, 136.0, 127.0, 129.0, 174.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 170.0, 177.0, 173.0, 173.0, 179.0, 177.0, 175.0, 179.0, 172.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 67.0, 68.0, 66.0, 66.0, 68.0, 66.0, 66.0, 67.0], "value": 67.4, "unit": "score"}]}]} 22:02:13 INFO - Return code: 0 22:02:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:02:13 INFO - # TBPL SUCCESS # 22:02:13 INFO - Running post-action listener: _package_coverage_data 22:02:13 INFO - Running post-action listener: _resource_record_post_action 22:02:13 INFO - [mozharness: 2017-07-27 05:02:13.350213Z] Finished run-tests step (success) 22:02:13 INFO - Running post-run listener: _resource_record_post_run 22:02:13 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 5419008; Write bytes: 441217024; Read time: 1876; Write time: 442364 22:02:13 INFO - TinderboxPrint: CPU usage
13.1% 22:02:13 INFO - TinderboxPrint: I/O read bytes / time
5,419,008 / 1,876 22:02:13 INFO - TinderboxPrint: I/O write bytes / time
441,217,024 / 442,364 22:02:13 INFO - TinderboxPrint: CPU idle
8,275.6 (86.9%) 22:02:13 INFO - TinderboxPrint: CPU user
1,200.0 (12.6%) 22:02:13 INFO - TinderboxPrint: Swap in / out
0 / 0 22:02:13 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 116834304; Read time: 0; Write time: 112696 22:02:13 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 22:02:13 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 2924544; Write bytes: 324382720; Read time: 1056; Write time: 329668 22:02:14 INFO - Running post-run listener: _upload_blobber_files 22:02:14 INFO - Blob upload gear active. 22:02:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:02:14 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 22:02:14 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:02:14 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:02:14 INFO - (blobuploader) - INFO - Open directory for files ... 22:02:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:02:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:02:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:15 INFO - (blobuploader) - INFO - Done attempting. 22:02:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:02:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:02:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:16 INFO - (blobuploader) - INFO - Done attempting. 22:02:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:02:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:02:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:17 INFO - (blobuploader) - INFO - Done attempting. 22:02:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:02:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:02:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:24 INFO - (blobuploader) - INFO - Done attempting. 22:02:24 INFO - (blobuploader) - INFO - Iteration through files over. 22:02:24 INFO - Return code: 0 22:02:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:02:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:02:24 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/10fb00a143a78440c7b9fdcf3323260cf7f1ff288ec63a789ce7a4b647229802c62694704464bf07167627d7a81637470d31ff7778a812b06d70a40ce3f3e417", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d25159a03e2bda5d3f6adc5775a269f19f599da4642c7bac6930e3956ed983bbd3a4519d88f1f1d046b15ef05bd0214eb2efe643a95dd5a3b073b7726def1b6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/f337b37bf98ff84b54a25bc9d65aeb46b32be8b4fa9871d36d15e8f220257979ae6145a567a259509b9e9c32fed949e052883043619bced1b78fc0ce8e768eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/b294f509dfbeac9bf1fe6eab3dd6de5ee74db9c4f68c44e45e2e0a4444b8a3c1a75ee524eac02ae0494de866c966aa8ce2fb61fc48b10aac794935d4f147b4cb"} 22:02:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:02:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:02:24 INFO - Contents: 22:02:24 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/10fb00a143a78440c7b9fdcf3323260cf7f1ff288ec63a789ce7a4b647229802c62694704464bf07167627d7a81637470d31ff7778a812b06d70a40ce3f3e417", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d25159a03e2bda5d3f6adc5775a269f19f599da4642c7bac6930e3956ed983bbd3a4519d88f1f1d046b15ef05bd0214eb2efe643a95dd5a3b073b7726def1b6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/f337b37bf98ff84b54a25bc9d65aeb46b32be8b4fa9871d36d15e8f220257979ae6145a567a259509b9e9c32fed949e052883043619bced1b78fc0ce8e768eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/b294f509dfbeac9bf1fe6eab3dd6de5ee74db9c4f68c44e45e2e0a4444b8a3c1a75ee524eac02ae0494de866c966aa8ce2fb61fc48b10aac794935d4f147b4cb"} 22:02:24 INFO - Running post-run listener: copy_logs_to_upload_dir 22:02:24 INFO - Copying logs to upload dir... 22:02:24 INFO - mkdir: /builds/slave/test/build/upload/logs 22:02:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.487740 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-07-26 22:02:23.923821) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-26 22:02:23.927359) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/10fb00a143a78440c7b9fdcf3323260cf7f1ff288ec63a789ce7a4b647229802c62694704464bf07167627d7a81637470d31ff7778a812b06d70a40ce3f3e417", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d25159a03e2bda5d3f6adc5775a269f19f599da4642c7bac6930e3956ed983bbd3a4519d88f1f1d046b15ef05bd0214eb2efe643a95dd5a3b073b7726def1b6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/f337b37bf98ff84b54a25bc9d65aeb46b32be8b4fa9871d36d15e8f220257979ae6145a567a259509b9e9c32fed949e052883043619bced1b78fc0ce8e768eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/b294f509dfbeac9bf1fe6eab3dd6de5ee74db9c4f68c44e45e2e0a4444b8a3c1a75ee524eac02ae0494de866c966aa8ce2fb61fc48b10aac794935d4f147b4cb"} build_url:https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011145 build_url: 'https://queue.taskcluster.net/v1/task/B4JtmHcKS0CU_UWMXvqOvA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/10fb00a143a78440c7b9fdcf3323260cf7f1ff288ec63a789ce7a4b647229802c62694704464bf07167627d7a81637470d31ff7778a812b06d70a40ce3f3e417", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d25159a03e2bda5d3f6adc5775a269f19f599da4642c7bac6930e3956ed983bbd3a4519d88f1f1d046b15ef05bd0214eb2efe643a95dd5a3b073b7726def1b6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/f337b37bf98ff84b54a25bc9d65aeb46b32be8b4fa9871d36d15e8f220257979ae6145a567a259509b9e9c32fed949e052883043619bced1b78fc0ce8e768eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/b294f509dfbeac9bf1fe6eab3dd6de5ee74db9c4f68c44e45e2e0a4444b8a3c1a75ee524eac02ae0494de866c966aa8ce2fb61fc48b10aac794935d4f147b4cb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-26 22:02:23.952117) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 22:02:23.952486) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1501112220.325114-196356730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004376 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 22:02:24.036106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-26 22:02:24.036431) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-26 22:02:24.036756) ========= ========= Total master_lag: 0.20 =========