builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1502559500.63 results: success (0) revision: 1f363abd841d1ad9fb8ac1e67ea7c8636895d766 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-12 10:38:20.632747) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-12 10:38:20.633234) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-12 10:38:20.633570) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-12 10:38:20.651170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 10:38:20.651541) ========= 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=652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-12 10:38: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% 42.4M=0s 2017-08-12 10:38:20 (42.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099558 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 10:38:20.764246) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 10:38:20.764554) ========= 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=652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018782 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 10:38:20.814275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-12 10:38:20.814632) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1f363abd841d1ad9fb8ac1e67ea7c8636895d766 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 1f363abd841d1ad9fb8ac1e67ea7c8636895d766 --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=652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-12 10:38:20,881 truncating revision to first 12 chars 2017-08-12 10:38:20,881 Setting DEBUG logging. 2017-08-12 10:38:20,881 attempt 1/10 2017-08-12 10:38:20,881 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1f363abd841d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-12 10:38:22,147 unpacking tar archive at: mozilla-central-1f363abd841d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.663104 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-12 10:38:22.491124) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-12 10:38:22.491570) ========= script_repo_revision: 1f363abd841d1ad9fb8ac1e67ea7c8636895d766 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-12 10:38:22.495960) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-12 10:38:22.496268) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-12 10:38:22.507546) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-12 10:38:22.507813) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:38:22 INFO - MultiFileLogger online at 20170812 10:38:22 in /builds/slave/test 10:38:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:38:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:38:22 INFO - {'append_to_log': False, 10:38:22 INFO - 'base_work_dir': '/builds/slave/test', 10:38:22 INFO - 'blob_upload_branch': 'Firefox', 10:38:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:38:22 INFO - 'branch': 'Firefox', 10:38:22 INFO - 'buildbot_json_path': 'buildprops.json', 10:38:22 INFO - 'code_coverage': False, 10:38:22 INFO - 'config_files': ('talos/linux_config.py',), 10:38:22 INFO - 'default_actions': ('clobber', 10:38:22 INFO - 'read-buildbot-config', 10:38:22 INFO - 'download-and-extract', 10:38:22 INFO - 'populate-webroot', 10:38:22 INFO - 'create-virtualenv', 10:38:22 INFO - 'install', 10:38:22 INFO - 'setup-mitmproxy', 10:38:22 INFO - 'run-tests'), 10:38:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:38:22 INFO - 'disable_ccov_upload': False, 10:38:22 INFO - 'download_minidump_stackwalk': True, 10:38:22 INFO - 'download_symbols': 'ondemand', 10:38:22 INFO - 'enable_stylo': False, 10:38:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:38:22 INFO - 'tooltool.py': '/tools/tooltool.py', 10:38:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:38:22 INFO - '/tools/misc-python/virtualenv.py')}, 10:38:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:38:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:38:22 INFO - 'gecko_profile': False, 10:38:22 INFO - 'gecko_profile_interval': 0, 10:38:22 INFO - 'installer_path': 'installer.exe', 10:38:22 INFO - 'log_level': 'info', 10:38:22 INFO - 'log_name': 'talos', 10:38:22 INFO - 'log_to_console': True, 10:38:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:38:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:38:22 INFO - 'opt_config_files': (), 10:38:22 INFO - 'pip_index': False, 10:38:22 INFO - 'suite': 'dromaeojs-e10s', 10:38:22 INFO - 'system_bits': '32', 10:38:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:38:22 INFO - 'title': 'talos-linux64-ix-046', 10:38:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:38:22 INFO - 'use_talos_json': True, 10:38:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:38:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:38:22 INFO - 'work_dir': 'build'} 10:38:22 INFO - [mozharness: 2017-08-12 17:38:22.683160Z] Running clobber step. 10:38:22 INFO - Running pre-action listener: _resource_record_pre_action 10:38:22 INFO - Running main action method: clobber 10:38:22 INFO - rmtree: /builds/slave/test/build 10:38:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:38:23 INFO - Running post-action listener: _resource_record_post_action 10:38:23 INFO - [mozharness: 2017-08-12 17:38:23.707016Z] Finished clobber step (success) 10:38:23 INFO - [mozharness: 2017-08-12 17:38:23.707119Z] Running read-buildbot-config step. 10:38:23 INFO - Running pre-action listener: _resource_record_pre_action 10:38:23 INFO - Running main action method: read_buildbot_config 10:38:23 INFO - Using buildbot properties: 10:38:23 INFO - { 10:38:23 INFO - "project": "", 10:38:23 INFO - "product": "firefox", 10:38:23 INFO - "who": "ffxbld@noreply.mozilla.org", 10:38:23 INFO - "installer_path": "public/build/target.tar.bz2", 10:38:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 10:38:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:38:23 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 10:38:23 INFO - "stage_platform": "linux64-stylosequential", 10:38:23 INFO - "basedir": "/builds/slave/test", 10:38:23 INFO - "buildnumber": 184, 10:38:23 INFO - "platform": "ubuntu64_hw_styloseq", 10:38:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:38:23 INFO - "slavebuilddir": "test", 10:38:23 INFO - "taskId": "eJlz5McDSBKAdAbASquP2A", 10:38:23 INFO - "branch": "mozilla-central", 10:38:23 INFO - "script_repo_revision": "production", 10:38:23 INFO - "revision": "1f363abd841d1ad9fb8ac1e67ea7c8636895d766", 10:38:23 INFO - "slavename": "talos-linux64-ix-046", 10:38:23 INFO - "repo_path": "mozilla-central" 10:38:23 INFO - } 10:38:23 INFO - Finding installer, test and symbols from parent task. 10:38:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eJlz5McDSBKAdAbASquP2A'}, attempt #1 10:38:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eJlz5McDSBKAdAbASquP2A'}, attempt #1 10:38:24 INFO - Task dependencies: equmlGMdQTeuA3YD9CXIvQ 10:38:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ'}, attempt #1 10:38:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.tar.bz2 10:38:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.test_packages.json 10:38:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.crashreporter-symbols.zip 10:38:25 INFO - Running post-action listener: _resource_record_post_action 10:38:25 INFO - [mozharness: 2017-08-12 17:38:25.049538Z] Finished read-buildbot-config step (success) 10:38:25 INFO - [mozharness: 2017-08-12 17:38:25.049760Z] Running download-and-extract step. 10:38:25 INFO - Running pre-action listener: _resource_record_pre_action 10:38:25 INFO - Running main action method: download_and_extract 10:38:25 INFO - mkdir: /builds/slave/test/build/tests 10:38:25 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')]} 10:38:25 INFO - trying https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.test_packages.json 10:38:25 INFO - Downloading https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:38:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:38:25 INFO - Downloaded 989 bytes. 10:38:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:38:25 INFO - Using the following test package requirements: 10:38:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:38:25 INFO - u'common': [u'target.common.tests.zip'], 10:38:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:38:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:38:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:38:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:38:25 INFO - u'mozbase': [u'target.common.tests.zip'], 10:38:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:38:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:38:25 INFO - u'web-platform': [u'target.common.tests.zip', 10:38:25 INFO - u'target.web-platform.tests.tar.gz'], 10:38:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:38:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:38:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.common.tests.zip 10:38:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:38:25 INFO - Fetch https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.common.tests.zip into memory 10:38:26 INFO - Content-Length response header: 54036626 10:38:26 INFO - Bytes received: 54036626 10:38:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:38:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.common.tests.zip 10:38:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:38:37 INFO - Fetch https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.common.tests.zip into memory 10:38:38 INFO - Content-Length response header: 54036626 10:38:38 INFO - Bytes received: 54036626 10:38:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.talos.tests.zip 10:38:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:38:50 INFO - Fetch https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.talos.tests.zip into memory 10:38:51 INFO - Content-Length response header: 14496050 10:38:51 INFO - Bytes received: 14496050 10:38:52 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')]} 10:38:52 INFO - trying https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.tar.bz2 10:38:52 INFO - Downloading https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:38:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:38:56 INFO - Downloaded 61894138 bytes. 10:38:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.tar.bz2 10:38:56 INFO - mkdir: /builds/slave/test/properties 10:38:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:38:56 INFO - Writing to file /builds/slave/test/properties/build_url 10:38:56 INFO - Contents: 10:38:56 INFO - build_url:https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.tar.bz2 10:38:56 INFO - Running post-action listener: _resource_record_post_action 10:38:56 INFO - Running post-action listener: set_extra_try_arguments 10:38:56 INFO - [mozharness: 2017-08-12 17:38:56.216947Z] Finished download-and-extract step (success) 10:38:56 INFO - [mozharness: 2017-08-12 17:38:56.217046Z] Running populate-webroot step. 10:38:56 INFO - Running pre-action listener: _resource_record_pre_action 10:38:56 INFO - Running main action method: populate_webroot 10:38:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:38:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:38:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:38:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:38:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:38:56 INFO - 'tests': ['damp', 'tps']}, 10:38:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:38:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:38:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:38:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:38:56 INFO - 'other-e10s': {'tests': ['a11yr', 10:38:56 INFO - 'ts_paint', 10:38:56 INFO - 'tpaint', 10:38:56 INFO - 'sessionrestore', 10:38:56 INFO - 'sessionrestore_many_windows', 10:38:56 INFO - 'sessionrestore_no_auto_restore', 10:38:56 INFO - 'tabpaint']}, 10:38:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:38:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:38:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:38:56 INFO - 'tsvgr_opacity', 10:38:56 INFO - 'tart', 10:38:56 INFO - 'tscrollx', 10:38:56 INFO - 'tsvg_static']}, 10:38:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:38:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:38:56 INFO - 'talos_options': ['--mitmproxy', 10:38:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:38:56 INFO - '--firstNonBlankPaint'], 10:38:56 INFO - 'tests': ['tp6_google', 10:38:56 INFO - 'tp6_youtube', 10:38:56 INFO - 'tp6_amazon', 10:38:56 INFO - 'tp6_facebook']}, 10:38:56 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:38:56 INFO - 'talos_options': ['--stylo', 10:38:56 INFO - '--mitmproxy', 10:38:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:38:56 INFO - '--firstNonBlankPaint'], 10:38:56 INFO - 'tests': ['tp6_google', 10:38:56 INFO - 'tp6_youtube', 10:38:56 INFO - 'tp6_amazon', 10:38:56 INFO - 'tp6_facebook']}, 10:38:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:38:56 INFO - 'talos_options': ['--stylo', 10:38:56 INFO - '--stylo-threads=1', 10:38:56 INFO - '--mitmproxy', 10:38:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:38:56 INFO - '--firstNonBlankPaint'], 10:38:56 INFO - 'tests': ['tp6_google', 10:38:56 INFO - 'tp6_youtube', 10:38:56 INFO - 'tp6_amazon', 10:38:56 INFO - 'tp6_facebook']}, 10:38:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:38:56 INFO - 'talos_options': ['--xperf_path', 10:38:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:38:56 INFO - 'tests': ['tp5n']}}} 10:38:56 INFO - Running post-action listener: _resource_record_post_action 10:38:56 INFO - [mozharness: 2017-08-12 17:38:56.225619Z] Finished populate-webroot step (success) 10:38:56 INFO - [mozharness: 2017-08-12 17:38:56.225710Z] Running create-virtualenv step. 10:38:56 INFO - Running pre-action listener: _resource_record_pre_action 10:38:56 INFO - Running main action method: create_virtualenv 10:38:56 INFO - Creating virtualenv /builds/slave/test/build/venv 10:38: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 10:38:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:38:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:38:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:38:56 INFO - Using real prefix '/usr' 10:38:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:38:56 INFO - Installing distribute.............................................................................................................................................................................................done. 10:38:58 INFO - Installing pip.................done. 10:38:58 INFO - Return code: 0 10:38:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:38:59 INFO - Reading from file tmpfile_stdout 10:38:59 INFO - Output received: 10:38: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) 10:38:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:38: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')]} 10:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38: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')]} 10:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38: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 0x275e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acef00>, '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 0x2ac9ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aca050>, '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': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', '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 10:38: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 10:38: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 10:38:59 INFO - Using env: {'DISPLAY': ':0', 10:38:59 INFO - 'HOME': '/home/cltbld', 10:38:59 INFO - 'LANG': 'en_US.UTF-8', 10:38:59 INFO - 'LANGUAGE': 'en_US:en', 10:38:59 INFO - 'LOGNAME': 'cltbld', 10:38:59 INFO - 'MAIL': '/var/mail/cltbld', 10:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:59 INFO - 'MOZ_NO_REMOTE': '1', 10:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:59 INFO - 'NO_EM_RESTART': '1', 10:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:59 INFO - 'PWD': '/builds/slave/test', 10:38:59 INFO - 'SHELL': '/bin/bash', 10:38:59 INFO - 'SHLVL': '1', 10:38:59 INFO - 'TERM': 'linux', 10:38:59 INFO - 'TMOUT': '86400', 10:38:59 INFO - 'USER': 'cltbld', 10:38:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', 10:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:59 INFO - '_': '/tools/buildbot/bin/python'} 10:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38: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 10:38:59 INFO - Cleaning up... 10:38:59 INFO - Return code: 0 10:38:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:38: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')]} 10:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38: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')]} 10:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38: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 0x275e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acef00>, '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 0x2ac9ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aca050>, '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': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', '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 10:38: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 10:38: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 10:38:59 INFO - Using env: {'DISPLAY': ':0', 10:38:59 INFO - 'HOME': '/home/cltbld', 10:38:59 INFO - 'LANG': 'en_US.UTF-8', 10:38:59 INFO - 'LANGUAGE': 'en_US:en', 10:38:59 INFO - 'LOGNAME': 'cltbld', 10:38:59 INFO - 'MAIL': '/var/mail/cltbld', 10:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:59 INFO - 'MOZ_NO_REMOTE': '1', 10:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:59 INFO - 'NO_EM_RESTART': '1', 10:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:59 INFO - 'PWD': '/builds/slave/test', 10:38:59 INFO - 'SHELL': '/bin/bash', 10:38:59 INFO - 'SHLVL': '1', 10:38:59 INFO - 'TERM': 'linux', 10:38:59 INFO - 'TMOUT': '86400', 10:38:59 INFO - 'USER': 'cltbld', 10:38:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', 10:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:59 INFO - '_': '/tools/buildbot/bin/python'} 10:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:59 INFO - Downloading/unpacking psutil>=3.1.1 10:38: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 10:38: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 10:38: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 10:38: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 10:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:39:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:39:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:39:00 INFO - Installing collected packages: psutil 10:39:00 INFO - Running setup.py install for psutil 10:39:00 INFO - building 'psutil._psutil_linux' extension 10:39: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 10:39:00 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 10:39:01 INFO - building 'psutil._psutil_posix' extension 10:39:01 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 10:39:01 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 10:39:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:39:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:39:01 INFO - Successfully installed psutil 10:39:01 INFO - Cleaning up... 10:39:01 INFO - Return code: 0 10:39:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:01 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 0x275e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acef00>, '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 0x2ac9ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aca050>, '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': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', '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 10:39:01 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 10:39:01 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 10:39:01 INFO - Using env: {'DISPLAY': ':0', 10:39:01 INFO - 'HOME': '/home/cltbld', 10:39:01 INFO - 'LANG': 'en_US.UTF-8', 10:39:01 INFO - 'LANGUAGE': 'en_US:en', 10:39:01 INFO - 'LOGNAME': 'cltbld', 10:39:01 INFO - 'MAIL': '/var/mail/cltbld', 10:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:01 INFO - 'MOZ_NO_REMOTE': '1', 10:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:01 INFO - 'NO_EM_RESTART': '1', 10:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:01 INFO - 'PWD': '/builds/slave/test', 10:39:01 INFO - 'SHELL': '/bin/bash', 10:39:01 INFO - 'SHLVL': '1', 10:39:01 INFO - 'TERM': 'linux', 10:39:01 INFO - 'TMOUT': '86400', 10:39:01 INFO - 'USER': 'cltbld', 10:39:01 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', 10:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:01 INFO - '_': '/tools/buildbot/bin/python'} 10:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:39:01 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 10:39:01 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 10:39:01 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 10:39:01 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 10:39:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:39:02 INFO - Installing collected packages: mozsystemmonitor 10:39:02 INFO - Running setup.py install for mozsystemmonitor 10:39:02 INFO - Successfully installed mozsystemmonitor 10:39:02 INFO - Cleaning up... 10:39:02 INFO - Return code: 0 10:39:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:39: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')]} 10:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39: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')]} 10:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39: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', '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 0x275e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acef00>, '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 0x2ac9ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aca050>, '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': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', '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 10:39: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:39: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 jsonschema==2.5.1 10:39:02 INFO - Using env: {'DISPLAY': ':0', 10:39:02 INFO - 'HOME': '/home/cltbld', 10:39:02 INFO - 'LANG': 'en_US.UTF-8', 10:39:02 INFO - 'LANGUAGE': 'en_US:en', 10:39:02 INFO - 'LOGNAME': 'cltbld', 10:39:02 INFO - 'MAIL': '/var/mail/cltbld', 10:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:02 INFO - 'MOZ_NO_REMOTE': '1', 10:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:02 INFO - 'NO_EM_RESTART': '1', 10:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:02 INFO - 'PWD': '/builds/slave/test', 10:39:02 INFO - 'SHELL': '/bin/bash', 10:39:02 INFO - 'SHLVL': '1', 10:39:02 INFO - 'TERM': 'linux', 10:39:02 INFO - 'TMOUT': '86400', 10:39:02 INFO - 'USER': 'cltbld', 10:39:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', 10:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:02 INFO - '_': '/tools/buildbot/bin/python'} 10:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:03 INFO - Downloading/unpacking jsonschema==2.5.1 10:39:03 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 10:39:03 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 10:39:03 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 10:39:03 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 10:39:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:39:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:39: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 10:39: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 10:39: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 10:39: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 10:39:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:39:04 INFO - warning: no files found matching '*.txt' 10:39:04 INFO - no previously-included directories found matching 'build' 10:39:04 INFO - no previously-included directories found matching 'dist' 10:39:04 INFO - no previously-included directories found matching '.git*' 10:39:04 INFO - Installing collected packages: jsonschema, functools32 10:39:04 INFO - Running setup.py install for functools32 10:39:04 INFO - warning: no files found matching '*.txt' 10:39:04 INFO - no previously-included directories found matching 'build' 10:39:04 INFO - no previously-included directories found matching 'dist' 10:39:04 INFO - no previously-included directories found matching '.git*' 10:39:04 INFO - Successfully installed jsonschema functools32 10:39:04 INFO - Cleaning up... 10:39:04 INFO - Return code: 0 10:39:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:04 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 0x275e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acef00>, '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 0x2ac9ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aca050>, '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': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', '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 10:39:04 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 10:39:04 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 10:39:04 INFO - Using env: {'DISPLAY': ':0', 10:39:04 INFO - 'HOME': '/home/cltbld', 10:39:04 INFO - 'LANG': 'en_US.UTF-8', 10:39:04 INFO - 'LANGUAGE': 'en_US:en', 10:39:04 INFO - 'LOGNAME': 'cltbld', 10:39:04 INFO - 'MAIL': '/var/mail/cltbld', 10:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:04 INFO - 'MOZ_NO_REMOTE': '1', 10:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:04 INFO - 'NO_EM_RESTART': '1', 10:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:04 INFO - 'PWD': '/builds/slave/test', 10:39:04 INFO - 'SHELL': '/bin/bash', 10:39:04 INFO - 'SHLVL': '1', 10:39:04 INFO - 'TERM': 'linux', 10:39:04 INFO - 'TMOUT': '86400', 10:39:04 INFO - 'USER': 'cltbld', 10:39:04 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', 10:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:04 INFO - '_': '/tools/buildbot/bin/python'} 10:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:39:04 INFO - Cleaning up... 10:39:04 INFO - Return code: 0 10:39:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:04 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 0x275e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acef00>, '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 0x2ac9ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aca050>, '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': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', '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 10:39:04 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 10:39:04 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 10:39:04 INFO - Using env: {'DISPLAY': ':0', 10:39:04 INFO - 'HOME': '/home/cltbld', 10:39:04 INFO - 'LANG': 'en_US.UTF-8', 10:39:04 INFO - 'LANGUAGE': 'en_US:en', 10:39:04 INFO - 'LOGNAME': 'cltbld', 10:39:04 INFO - 'MAIL': '/var/mail/cltbld', 10:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:04 INFO - 'MOZ_NO_REMOTE': '1', 10:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:04 INFO - 'NO_EM_RESTART': '1', 10:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:04 INFO - 'PWD': '/builds/slave/test', 10:39:04 INFO - 'SHELL': '/bin/bash', 10:39:04 INFO - 'SHLVL': '1', 10:39:04 INFO - 'TERM': 'linux', 10:39:04 INFO - 'TMOUT': '86400', 10:39:04 INFO - 'USER': 'cltbld', 10:39:04 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', 10:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:04 INFO - '_': '/tools/buildbot/bin/python'} 10:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:04 INFO - Downloading/unpacking blobuploader==1.2.4 10:39: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 10:39: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 10:39: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 10:39: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 10:39:06 INFO - Downloading blobuploader-1.2.4.tar.gz 10:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:39:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:39: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 10:39: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 10:39: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 10:39: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 10:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:39:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:39: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 10:39: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 10:39: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 10:39: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 10:39:06 INFO - Downloading docopt-0.6.1.tar.gz 10:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:39:06 INFO - Installing collected packages: blobuploader, requests, docopt 10:39:06 INFO - Running setup.py install for blobuploader 10:39:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:39:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:39:06 INFO - Running setup.py install for requests 10:39:07 INFO - Running setup.py install for docopt 10:39:07 INFO - Successfully installed blobuploader requests docopt 10:39:07 INFO - Cleaning up... 10:39:07 INFO - Return code: 0 10:39:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:07 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 0x275e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acef00>, '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 0x2ac9ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aca050>, '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': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', '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 10:39:07 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 10:39:07 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 10:39:07 INFO - Using env: {'DISPLAY': ':0', 10:39:07 INFO - 'HOME': '/home/cltbld', 10:39:07 INFO - 'LANG': 'en_US.UTF-8', 10:39:07 INFO - 'LANGUAGE': 'en_US:en', 10:39:07 INFO - 'LOGNAME': 'cltbld', 10:39:07 INFO - 'MAIL': '/var/mail/cltbld', 10:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:07 INFO - 'MOZ_NO_REMOTE': '1', 10:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:07 INFO - 'NO_EM_RESTART': '1', 10:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:07 INFO - 'PWD': '/builds/slave/test', 10:39:07 INFO - 'SHELL': '/bin/bash', 10:39:07 INFO - 'SHLVL': '1', 10:39:07 INFO - 'TERM': 'linux', 10:39:07 INFO - 'TMOUT': '86400', 10:39:07 INFO - 'USER': 'cltbld', 10:39:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', 10:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:07 INFO - '_': '/tools/buildbot/bin/python'} 10:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:39:07 INFO - Running setup.py (path:/tmp/pip-zEaqtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:39:07 INFO - Running setup.py (path:/tmp/pip-8XsvtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:39:07 INFO - Running setup.py (path:/tmp/pip-msiYTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:39:07 INFO - Running setup.py (path:/tmp/pip-QSNoyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:39:07 INFO - Running setup.py (path:/tmp/pip-wJDQpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:39:07 INFO - Running setup.py (path:/tmp/pip-5hVMYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:39:07 INFO - Running setup.py (path:/tmp/pip-1SIP5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:39:07 INFO - Running setup.py (path:/tmp/pip-LiIMFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:39:08 INFO - Running setup.py (path:/tmp/pip-Eufvyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:39:08 INFO - Running setup.py (path:/tmp/pip-wbk8Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:39:08 INFO - Running setup.py (path:/tmp/pip-OMAvPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:39:08 INFO - Running setup.py (path:/tmp/pip-02gpXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:39:08 INFO - Running setup.py (path:/tmp/pip-_iMrWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:39:08 INFO - Running setup.py (path:/tmp/pip-qAA8_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:08 INFO - Running setup.py (path:/tmp/pip-4vxWbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:39:08 INFO - Running setup.py (path:/tmp/pip-CGwmtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:39:08 INFO - Running setup.py (path:/tmp/pip-5nXac0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:39:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:39:08 INFO - Running setup.py install for manifestparser 10:39:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:39:08 INFO - Running setup.py install for mozcrash 10:39:08 INFO - Running setup.py install for mozdebug 10:39:08 INFO - Running setup.py install for mozdevice 10:39:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:39:09 INFO - Running setup.py install for mozfile 10:39:09 INFO - Running setup.py install for mozhttpd 10:39:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:39:09 INFO - Running setup.py install for mozinfo 10:39:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:39:09 INFO - Running setup.py install for mozInstall 10:39:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:39:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:39:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:39:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:39:09 INFO - Running setup.py install for mozleak 10:39:09 INFO - Running setup.py install for mozlog 10:39:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:39:09 INFO - Running setup.py install for moznetwork 10:39:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:39:09 INFO - Running setup.py install for mozprocess 10:39:09 INFO - Running setup.py install for mozprofile 10:39:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:39:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:39:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:39:09 INFO - Running setup.py install for mozrunner 10:39:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:39:10 INFO - Running setup.py install for mozscreenshot 10:39:10 INFO - Running setup.py install for moztest 10:39:10 INFO - Running setup.py install for mozversion 10:39:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:39:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:39:10 INFO - Cleaning up... 10:39:10 INFO - Return code: 0 10:39:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:10 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 0x275e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acef00>, '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 0x2ac9ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aca050>, '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': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', '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 10:39:10 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 10:39:10 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 10:39:10 INFO - Using env: {'DISPLAY': ':0', 10:39:10 INFO - 'HOME': '/home/cltbld', 10:39:10 INFO - 'LANG': 'en_US.UTF-8', 10:39:10 INFO - 'LANGUAGE': 'en_US:en', 10:39:10 INFO - 'LOGNAME': 'cltbld', 10:39:10 INFO - 'MAIL': '/var/mail/cltbld', 10:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:10 INFO - 'MOZ_NO_REMOTE': '1', 10:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:10 INFO - 'NO_EM_RESTART': '1', 10:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:10 INFO - 'PWD': '/builds/slave/test', 10:39:10 INFO - 'SHELL': '/bin/bash', 10:39:10 INFO - 'SHLVL': '1', 10:39:10 INFO - 'TERM': 'linux', 10:39:10 INFO - 'TMOUT': '86400', 10:39:10 INFO - 'USER': 'cltbld', 10:39:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', 10:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:10 INFO - '_': '/tools/buildbot/bin/python'} 10:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:39:10 INFO - Running setup.py (path:/tmp/pip-BF9MUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:39:10 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)) 10:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:39:10 INFO - Running setup.py (path:/tmp/pip-SSTl67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:39:10 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)) 10:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:39:10 INFO - Running setup.py (path:/tmp/pip-4qCCyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:39:10 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)) 10:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:39:10 INFO - Running setup.py (path:/tmp/pip-NKhgIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:39:10 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)) 10:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:39:10 INFO - Running setup.py (path:/tmp/pip-inDgBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:39:11 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)) 10:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:39:11 INFO - Running setup.py (path:/tmp/pip-qejB0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:39:11 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)) 10:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:39:11 INFO - Running setup.py (path:/tmp/pip-eofQbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:39:11 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)) 10:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:39:11 INFO - Running setup.py (path:/tmp/pip-LQ5J47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:39:11 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)) 10:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:39:11 INFO - Running setup.py (path:/tmp/pip-GhMU_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:39:11 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)) 10:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:39:11 INFO - Running setup.py (path:/tmp/pip-OUIzEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:39:11 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)) 10:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:39:11 INFO - Running setup.py (path:/tmp/pip-NtG0Iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:39:11 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)) 10:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:39:11 INFO - Running setup.py (path:/tmp/pip-ChvQs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:39:11 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)) 10:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:39:11 INFO - Running setup.py (path:/tmp/pip-NbC20u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:39:11 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)) 10:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:39:11 INFO - Running setup.py (path:/tmp/pip-PvINes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:39:11 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)) 10:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:11 INFO - Running setup.py (path:/tmp/pip-XC4GvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:11 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)) 10:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:39:11 INFO - Running setup.py (path:/tmp/pip-fEi0tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:39:11 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)) 10:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:39:11 INFO - Running setup.py (path:/tmp/pip-bEljRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:39:11 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)) 10:39:11 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)) 10:39:11 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)) 10:39:11 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)) 10:39:11 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)) 10:39:11 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)) 10:39:11 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)) 10:39:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:12 INFO - Downloading blessings-1.6.tar.gz 10:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:39:13 INFO - Installing collected packages: blessings 10:39:13 INFO - Running setup.py install for blessings 10:39:13 INFO - Successfully installed blessings 10:39:13 INFO - Cleaning up... 10:39:13 INFO - Return code: 0 10:39:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:39:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:39:13 INFO - Reading from file tmpfile_stdout 10:39:13 INFO - Current package versions: 10:39:13 INFO - argparse == 1.2.1 10:39:13 INFO - blessings == 1.6 10:39:13 INFO - blobuploader == 1.2.4 10:39:13 INFO - docopt == 0.6.1 10:39:13 INFO - functools32 == 3.2.3-2 10:39:13 INFO - jsonschema == 2.5.1 10:39:13 INFO - manifestparser == 1.1 10:39:13 INFO - mozInstall == 1.13 10:39:13 INFO - mozcrash == 1.0 10:39:13 INFO - mozdebug == 0.1 10:39:13 INFO - mozdevice == 0.51 10:39:13 INFO - mozfile == 1.2 10:39:13 INFO - mozhttpd == 0.7 10:39:13 INFO - mozinfo == 0.10 10:39:13 INFO - mozleak == 0.1 10:39:13 INFO - mozlog == 3.5 10:39:13 INFO - moznetwork == 0.27 10:39:13 INFO - mozprocess == 0.25 10:39:13 INFO - mozprofile == 0.28 10:39:13 INFO - mozrunner == 6.13 10:39:13 INFO - mozscreenshot == 0.1 10:39:13 INFO - mozsystemmonitor == 0.3 10:39:13 INFO - moztest == 0.8 10:39:13 INFO - mozversion == 1.4 10:39:13 INFO - psutil == 3.1.1 10:39:13 INFO - requests == 1.2.3 10:39:13 INFO - wsgiref == 0.1.2 10:39:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:13 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')]} 10:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:13 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')]} 10:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:13 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 0x275e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acef00>, '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 0x2ac9ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aca050>, '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': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', '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 10:39:13 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 10:39:13 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 10:39:13 INFO - Using env: {'DISPLAY': ':0', 10:39:13 INFO - 'HOME': '/home/cltbld', 10:39:13 INFO - 'LANG': 'en_US.UTF-8', 10:39:13 INFO - 'LANGUAGE': 'en_US:en', 10:39:13 INFO - 'LOGNAME': 'cltbld', 10:39:13 INFO - 'MAIL': '/var/mail/cltbld', 10:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:13 INFO - 'MOZ_NO_REMOTE': '1', 10:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:13 INFO - 'NO_EM_RESTART': '1', 10:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:13 INFO - 'PWD': '/builds/slave/test', 10:39:13 INFO - 'SHELL': '/bin/bash', 10:39:13 INFO - 'SHLVL': '1', 10:39:13 INFO - 'TERM': 'linux', 10:39:13 INFO - 'TMOUT': '86400', 10:39:13 INFO - 'USER': 'cltbld', 10:39:13 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', 10:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:13 INFO - '_': '/tools/buildbot/bin/python'} 10:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:13 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)) 10:39:13 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)) 10:39:13 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)) 10:39:13 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)) 10:39:13 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)) 10:39:13 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)) 10:39:13 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)) 10:39:13 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)) 10:39:13 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)) 10:39:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:39: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 10:39: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 10:39: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 10:39: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 10:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:39:14 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)) 10:39:14 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)) 10:39:14 INFO - Installing collected packages: simplejson 10:39:14 INFO - Running setup.py install for simplejson 10:39:14 INFO - building 'simplejson._speedups' extension 10:39:14 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 10:39:15 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 10:39:15 INFO - Successfully installed simplejson 10:39:15 INFO - Cleaning up... 10:39:15 INFO - Return code: 0 10:39:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:15 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 0x275e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acef00>, '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 0x2ac9ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aca050>, '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': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', '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 10:39:15 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 10:39:15 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 10:39:15 INFO - Using env: {'DISPLAY': ':0', 10:39:15 INFO - 'HOME': '/home/cltbld', 10:39:15 INFO - 'LANG': 'en_US.UTF-8', 10:39:15 INFO - 'LANGUAGE': 'en_US:en', 10:39:15 INFO - 'LOGNAME': 'cltbld', 10:39:15 INFO - 'MAIL': '/var/mail/cltbld', 10:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:15 INFO - 'MOZ_NO_REMOTE': '1', 10:39:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:15 INFO - 'NO_EM_RESTART': '1', 10:39:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:15 INFO - 'PWD': '/builds/slave/test', 10:39:15 INFO - 'SHELL': '/bin/bash', 10:39:15 INFO - 'SHLVL': '1', 10:39:15 INFO - 'TERM': 'linux', 10:39:15 INFO - 'TMOUT': '86400', 10:39:15 INFO - 'USER': 'cltbld', 10:39:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', 10:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:15 INFO - '_': '/tools/buildbot/bin/python'} 10:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:39:16 INFO - Cleaning up... 10:39:16 INFO - Return code: 0 10:39:16 INFO - Running post-action listener: _resource_record_post_action 10:39:16 INFO - Running post-action listener: _start_resource_monitoring 10:39:16 INFO - Starting resource monitoring. 10:39:16 INFO - [mozharness: 2017-08-12 17:39:16.156901Z] Finished create-virtualenv step (success) 10:39:16 INFO - [mozharness: 2017-08-12 17:39:16.157453Z] Running install step. 10:39:16 INFO - Running pre-action listener: _resource_record_pre_action 10:39:16 INFO - Running main action method: install 10:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:39:16 INFO - Reading from file tmpfile_stdout 10:39:16 INFO - Detecting whether we're running mozinstall >=1.0... 10:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:39:16 INFO - Reading from file tmpfile_stdout 10:39:16 INFO - Output received: 10:39:16 INFO - Usage: mozinstall [options] installer 10:39:16 INFO - Options: 10:39:16 INFO - -h, --help show this help message and exit 10:39:16 INFO - -d DEST, --destination=DEST 10:39:16 INFO - Directory to install application into. [default: 10:39:16 INFO - "/builds/slave/test"] 10:39:16 INFO - --app=APP Application being installed. [default: firefox] 10:39:16 INFO - mkdir: /builds/slave/test/build/application 10:39:16 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'] 10:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:39:34 INFO - Reading from file tmpfile_stdout 10:39:34 INFO - Output received: 10:39:34 INFO - /builds/slave/test/build/application/firefox/firefox 10:39:34 INFO - Running post-action listener: _resource_record_post_action 10:39:34 INFO - [mozharness: 2017-08-12 17:39:34.457105Z] Finished install step (success) 10:39:34 INFO - [mozharness: 2017-08-12 17:39:34.457426Z] Running setup-mitmproxy step. 10:39:34 INFO - Running pre-action listener: _resource_record_pre_action 10:39:34 INFO - Running main action method: setup_mitmproxy 10:39:34 INFO - Skipping: mitmproxy is not required 10:39:34 INFO - Running post-action listener: _resource_record_post_action 10:39:34 INFO - [mozharness: 2017-08-12 17:39:34.458597Z] Finished setup-mitmproxy step (success) 10:39:34 INFO - [mozharness: 2017-08-12 17:39:34.458819Z] Running run-tests step. 10:39:34 INFO - Running pre-action listener: _resource_record_pre_action 10:39:34 INFO - Running pre-action listener: _set_gcov_prefix 10:39:34 INFO - Running main action method: run_tests 10:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:39:34 INFO - Python 2.7.3 10:39:34 INFO - Return code: 0 10:39:34 INFO - grabbing minidump binary from tooltool 10:39:34 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')]} 10:39:34 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 0x2acef00>, '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 0x2ac9ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aca050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:39:34 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 10:39:34 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 10:39:34 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 10:39:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:39:34 INFO - Return code: 0 10:39:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:39:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:39:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:39:34 INFO - ENV: RUST_BACKTRACE is now full 10:39:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:39:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 10:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 10:39:34 INFO - Using env: {'DISPLAY': ':0', 10:39:34 INFO - 'HOME': '/home/cltbld', 10:39:34 INFO - 'LANG': 'en_US.UTF-8', 10:39:34 INFO - 'LANGUAGE': 'en_US:en', 10:39:34 INFO - 'LOGNAME': 'cltbld', 10:39:34 INFO - 'MAIL': '/var/mail/cltbld', 10:39:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:39:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:34 INFO - 'MOZ_NO_REMOTE': '1', 10:39:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:34 INFO - 'NO_EM_RESTART': '1', 10:39:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:34 INFO - 'PWD': '/builds/slave/test', 10:39:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:39:34 INFO - 'RUST_BACKTRACE': 'full', 10:39:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:39:34 INFO - 'SHELL': '/bin/bash', 10:39:34 INFO - 'SHLVL': '1', 10:39:34 INFO - 'STYLO_FORCE_ENABLED': '1', 10:39:34 INFO - 'TERM': 'linux', 10:39:34 INFO - 'TMOUT': '86400', 10:39:34 INFO - 'USER': 'cltbld', 10:39:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132', 10:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:34 INFO - '_': '/tools/buildbot/bin/python'} 10:39:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 10:39:34 INFO - mozversion application_buildid: 20170812165514 10:39:34 INFO - mozversion application_changeset: 1f363abd841d1ad9fb8ac1e67ea7c8636895d766 10:39:34 INFO - mozversion application_display_name: Nightly 10:39:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:39:34 INFO - mozversion application_name: Firefox 10:39:34 INFO - mozversion application_remotingname: firefox 10:39:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:39:34 INFO - mozversion application_vendor: Mozilla 10:39:34 INFO - mozversion application_version: 57.0a1 10:39:34 INFO - mozversion platform_buildid: 20170812165514 10:39:34 INFO - mozversion platform_changeset: 1f363abd841d1ad9fb8ac1e67ea7c8636895d766 10:39:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:39:34 INFO - mozversion platform_version: 57.0a1 10:39:34 INFO - using testdate: 1502559574 10:39:34 INFO - actual date: 1502559574 10:39:34 INFO - starting webserver on 'localhost:47046' 10:39:34 INFO - SUITE-START | Running 2 tests 10:39:34 INFO - TEST-START | dromaeo_css 10:39:34 INFO - Initialising browser for dromaeo_css test... 10:39:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47046/getInfo.html -profile /tmp/tmpLMbXSF/profile 10:39:34 INFO - TEST-INFO | started process 6032 (/builds/slave/test/build/application/firefox/firefox http://localhost:47046/getInfo.html) 10:39:40 INFO - TEST-INFO | 6032: exit 0 10:39:40 INFO - Browser initialized. 10:39:40 INFO - Running cycle 1/1 for dromaeo_css test... 10:39:40 INFO - TEST-INFO | started process 6269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLMbXSF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:39:41 INFO - PID 6269 | 10:39:41 INFO - PID 6269 | (/builds/slave/test/build/application/firefox/firefox:6323): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:39:41 INFO - PID 6269 | 10:39:52 INFO - PID 6269 | RSS: Main: 167542784 10:39:52 INFO - PID 6269 | 10:42:52 INFO - PID 6269 | Cycle 1(1): loaded http://localhost:47046/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47046/tests/dromaeo/cssquery-ext.html) 10:42:52 INFO - PID 6269 | RSS: Main: 175398912 10:42:52 INFO - PID 6269 | 10:45:54 INFO - PID 6269 | Cycle 1(1): loaded http://localhost:47046/tests/dromaeo/cssquery-ext.html (next: http://localhost:47046/tests/dromaeo/cssquery-jquery.html) 10:45:55 INFO - PID 6269 | RSS: Main: 172711936 10:45:55 INFO - PID 6269 | 10:48:57 INFO - PID 6269 | Cycle 1(1): loaded http://localhost:47046/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47046/tests/dromaeo/cssquery-mootools.html) 10:48:57 INFO - PID 6269 | RSS: Main: 174297088 10:48:57 INFO - PID 6269 | 10:51:59 INFO - PID 6269 | Cycle 1(1): loaded http://localhost:47046/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47046/tests/dromaeo/cssquery-prototype.html) 10:52:00 INFO - PID 6269 | RSS: Main: 172883968 10:52:00 INFO - PID 6269 | 10:55:03 INFO - PID 6269 | Cycle 1(1): loaded http://localhost:47046/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47046/tests/dromaeo/cssquery-yui.html) 10:55:04 INFO - PID 6269 | RSS: Main: 176599040 10:55:04 INFO - PID 6269 | 10:58:06 INFO - PID 6269 | Cycle 1(1): loaded http://localhost:47046/tests/dromaeo/cssquery-yui.html (next: http://localhost:47046/tests/dromaeo/cssquery-dojo.html) 10:58:06 INFO - PID 6269 | RSS: Main: 177278976 10:58:06 INFO - PID 6269 | 10:58:06 INFO - PID 6269 | __start_tp_report 10:58:06 INFO - PID 6269 | _x_x_mozilla_page_load 10:58:06 INFO - PID 6269 | _x_x_mozilla_page_load_details 10:58:06 INFO - PID 6269 | |i|pagename|runs| 10:58:06 INFO - PID 6269 | |0;dojo.html;3174.9206269843266;3197.520371944208;3215.405150047243;3222.7260682841966;3233.224026233703;6193.81418557444;6252.843678908024;6273.278572964111;6312;6333.176687030679;6048.123022161784;6132.26412830461;6141.017437210047;6142.047982562699;6143.723532441039;5642.971785141069;5655;5669.09294512878;5673.716314184295;5754.798582049629;5718.228039214715;5745.885082298351;5766.481016708495;5772.480476757091;5796.24648795656;5561.110222364402;5630.887382252332;5672.489475947164;5726.856828579277;5778.739956701937;5651.208830763697;5703.458171473703;5715.628484148517;5748.281464816898;5751.1085781703905;5622.971885140589;5640.182173584848;5670.092785154356;5679.829605111853;5700.714964251771;6096.542759293071;6109.205803245594;6175.475084617813;6201.751929922798;6211.689415529206;6634.668266586699;6654.46764258863;6679.732810687567;6736.6631668416385;6742.730290788362;6596.43930265928;6694.062831203635;6710.463162946952;6788.9660551696925;6795.626240556768;6160.8767824643255;6186.752529898844;6187.721552530147;6188.133661287423;6188.319284878615;6817.420519255819;6873.347032031949;6942.201646810681;6957.512974091765;6970.477214208853;6514.9348506514325;6604.537682362285;6607.14107166075;6627.768028118992;6631.038499417557;6539.182602174728;6634.038064480624;6662.133922590032;6727.024581435664;6780.32196780318;6333.113364129025;6471.579347342407;6614.503912206604;6677.699503522354;6715.3620406061345;6676.399124078759;6739.460843132538;6740.12378390806;6745.6289904054765;6759.763408280686;5277.393099793496;5343.332083489564;5391.946080539223;5429.212764149255;5430.619856610078;4595.035042641016;4600.309953506934;4623.375844261049;4625.861224163281;4634.304854271819;5816.828629101904;5820.82537523875;5908.763649453974;5911.733971971272;5912.3496415394275;6672.332766723289;6696.497762667819;6786.219584747719;6791.898121528181;6799.150106236721;5719.7712091516705;5781.566382521328;5795.130730390475;5795.652260864362;5802.651840889475;5808.361080281165;5827.155062515912;5834.679092649945;5835.824925252249;5843.181954526284;6375.10748495211;6391.041343798374;6392.3927226913365;6404.23149222087;6417.358264173638;6173.104899789595;6505.869882602226;6659.2008958925235;6695;6756.9188929771;6445.70994305248;6470.255920569007;6538.705758240795;6558.868822623425;6577.408033277028;6503.869922601427;6574.901376479261;6579.078928949855;6594.670266486753;6687.598744075371;6729.899051514133;6730.899036514358;6731.899021514779;6741;6742.662866856539;6450.516211284266;6474.773382931575;6520.739170433129;6534.575252608565;6535.150430444202;6402.679866006774;6424.775132870327;6497.057926600711;6501.122348483083;6511.544191906711;6243.562950593415;6354.650494222862;6360.904586431115;6454.128692626436;6454.386833250834;6464.450521705708;6506.739730410731;6561.278259391368;6591.242007169237;6620.271770105381;6207.441330280297;6296.748130074746;6310.5267104968225;6312.274088479883;6371.299157092809 10:58:06 INFO - PID 6269 | |1;ext.html;840.5587066789934;857.7083791510885;872.8036191856833;899.7390756680561;899.9820003599929;41620.16759664805;42484;42608.57391426085;42613;42694.35958460625;39460.605393946054;39677.80161099198;39724.20551588966;39756.80121599388;39823.601763982355;6760.290169532214;6892.4830637702125;6893.620850853201;6894.5518541294905;6895.5173137880365;6774.153230846145;6873.450123990094;6890.000949862267;6894.13823272091;6901.827454313632;7446.553206807609;7613.086429628453;7635.083789945186;7656.042994625672;7660.961695191516;7550;7587.430942679322;7604.54372737632;7608.163102058769;7610.429217808659;7339.9633001834645;7495.575840590325;7499.512531685477;7578.469507134503;7604.657790399446;39293.80353098245;39464.40803387952;39641.80179099115;39678.40482392767;39712;3413.7269018478464;3461.0136111208185;3465.9775366267013;3474.1662001119803;3480.129967508123;31687.366252674816;31819.204519886956;31854.362912741846;31858;31874;5098.821541246039;5104.7622845805245;5116.539511443951;5118.513741194581;5133.614978876599;190021;190049;190119.9999999986;190512.04743976193;190621.046894766;49752.25371619429;49761;49871.251931221064;49882.75058624684;49890.50109498931;51358.48641513612;51370.74314628403;51471;51585.7420712894;51667;16624.418145365096;16827;16876.493705188863;16896.746548801777;16932.06873621938;13812.37844297009;13866.306684665726;13876;13878.722425551432;13928.86071139296;14641.926790366193;14676.926615366854;14724.116553006854;14749.926250368679;14770.48303309379;5859.648421094748;6067.848303792352;6097.786577469856;6164.106204600397;6204.098761978077;970.5147426286857;1010.4291075542295;1010.9797804044025;1012.6961911426542;1018.3024628129755;21453.67819482709;21593;21644;21864.01611927467;22056.779432205472;1056.630179437191;1082.4209048159198;1083.712816103733;1093.5461783359976;1110.0730889707024;12000.879991199976;12183.32991685448;12227.671837696953;12281.69295767613;12294.139410241198;227020;227235;228400;229208;229249;52212;52403.47596524062;54509;55796.44203557912;57235.71382143146;1460.8027916231385;1497.6929729405447;1502.7295086884467;1508.351408894186;1517.840626734199;26736.866315668296;26737.33156671099;27056.729432706208;27291.86354068217;27424.862875685492;51232.48767512426;51726.741366292925;51913;52040;52146.21780673217;204784;205303;205789;206060;207526;35706.821465892506;35875;35880.282394351445;36046.09884752902;36091;42477;44188.33717494176;44438.3334249993;44542;44561.55438445574;32700;33026.66973330236;33370.499442508866;33579.99260022203;33600.327993440485;32656.673433266315;32691.836540817145;32836.67163328336;33195.66804332023;33247.83376083104;35759.46360804642;35793.46309805407;35802;35923.82038089793;36105.458418124275;31358.843205783825;31411.371772563965;31765.841170794;32271;32302.19244518906;22829.31512054641;23582;23588.938497767984;23720.762792371854;23871.283861484182 10:58:06 INFO - PID 6269 | |2;jquery.html;577.8382053025153;579.7391173971714;581.1718301420475;585.604716816149;589.2192844481062;22663.660045099336;23496.88251558744;23516.412089697766;23634.409139771513;24291.149809756662;25954.091606793765;26541;26655.733442665616;26796.196114116607;26808.19575412736;6060.757569697207;6606.042123892044;6679.866402671943;6728.730850765988;6740.629265390402;6478.514111441637;6531.346865313454;6543.770968016121;6558.376954189368;6560.278369379364;6482.805515834509;6497.9675101624425;6498.545101842849;6504.479641628682;6512.055751915969;6506.089147519351;6507.577007494521;6508.64202468864;6509.967450162766;6522.7390904363765;6064.666443345658;6070.362611925772;6075.878482430327;6079.240094988127;6091.756329746805;29115.56326655102;29708.70291297081;30284.394312113855;30362.240943976358;30445.543316850264;1924.2976313645418;1947.2113793913488;1950.882947023183;1950.9219631214735;1952.6387618290662;19749.308774192836;20642.380728578017;20658.896705516527;20770.376888693365;20842.478938026517;2421.4551725861716;2449.081594402099;2498.5002999400194;2517.1567524879006;2519.571672815626;141368;150729;151017.24491377472;151402;151453;15371.077735335915;15712.92143539275;15810.446634367741;15885.205739712968;15968.520944371687;24174.274771756875;24265.757342426703;24278;24349.87825060899;24455.388615284406;10517.421541815274;10730.463476826128;10852.511636976196;10893.237473376788;10969.725756856142;9927.106560409453;9956.601735930626;9996.300258981946;10106.090451859369;10134.54394552247;9726.2705297103;9831.1643510301;9835.852462213072;9854;9922.206223502102;2688.5295073362086;2734;2792.2740087577376;2806.7473927346637;2891.8698658560415;927.3230541704594;947.1948843483123;950.9952450237843;958.7459323279337;959.0457494792587;19427.80572194288;19894.104765285596;19898.60202795936;19961.900190498956;20211.696824547642;1011.1758916483043;1016.2428990402198;1026.7227848481018;1033.8811036730722;1034.9327293725885;11101.5559377624;11162.162837787037;11219.495122719498;11246.49390777417;11320.830187547193;459401;477460;482108;511303;522338;118913;120530.39734801445;122510;126228;128074;1130.7908037013178;1190.7082764722697;1243.459095293532;1249.7375551134182;1298.6818229533635;20505.589888201856;20559.588808224053;20875.26936557213;21180.364589062352;21373.89313053425;54584.90830183453;55094.173587397025;56020;57128.42871571231;57618.7119064402;69893.65053174701;70888.29111708817;70924.64537677278;71355.64322178355;71482.64258678674;14853.846192302271;15109.168995705342;15133.848661513684;15145.469908553148;15257.237138142826;23166.3050108497;23500.294991150295;23523.76476235216;23650.29049128529;23657.40856478602;18275.812072215263;18471.90764046171;18536.351227707506;18701.812981870007;18854.71717924205;14793.482228121964;15358.462453814063;17101.144942752562;17738.467845964642;17777.2000259986;17013.319467221667;17368.739468907723;17372;17445.30218791285;17476.03881786514;14334.49829255971;14861.777073344125;15154.772678410052;15284.465043723416;15287.082775033534;18990;19070.904645476683;19119.61760764749;19221.807781922562;19248.133833977223 10:58:06 INFO - PID 6269 | |3;mootools.html;1336.1715736243527;1398.5035312464074;1411.6541447345398;1411.858814118589;1416.327244558834;14286.571402857919;14413.63965900853;14907;14926.701465970675;14937.775933360994;14979.625509362244;15247;15252.313645885934;15259.847401525982;15268.312925918333;2743.7804975602003;2785.1922942346696;2787.6236708044357;2788.776897848167;2789.4839454700946;2650.390410205654;2730.481208570375;2778.263760103574;2785.373291009527;2790.483760504313;2698.662667166604;2755.1321333779797;2802.4675311690817;2804.5372513535344;2806.7333603307757;2560.5519034169038;2563.269468201563;2571.2671888511873;2574.858382788946;2576.265764257187;2600.362911086796;2609.556375416184;2613.6732908386452;2637.0638423359815;2652.6418933444124;13918.234497102656;14228.715425691427;14238.715225695532;14260.714785704331;14305.284735763275;7666.693332266703;7876.448648594601;7901.920980790176;7913;7929.563873986928;5127.48725127488;5203.245529398216;5275.287836142148;5377.176982084397;5387.838364849022;1927.1038966880328;1930.8374620425072;1931.565397785501;1958.6180694764528;2006.378022812918;23537.529249415085;23666;23751.287461376185;23760.881195594084;23763.1682891098;6419.1334169887405;6447.194100737408;6561;6601.53789234749;6795.626240556817;16073.517794466185;16182.75725864113;16189.514314570582;16211.189440527927;16216.594585135466;7482.326590606872;7761.6119194040075;7761.650725717356;7769.261920117579;7772.145064042951;6190.628562286277;6223.626582405071;7100.68046937889;7173.175084865203;7221.711131554679;5094.898102038012;5124.641275110706;5147.6654017488745;5158.535731784157;5229;1459.3432955170003;1471.4261438039173;1486.182599570232;1489.0618910086794;1493.1563666528377;875.0636818604032;883.9425437346551;885.5926273913943;900.0504467786417;903.746950853762;7204.71181152748;7209.062821833233;8101.513909165469;8423.241908228167;8443.66225350979;977.6920270114891;1001.234055947201;1011.4942528735633;1019.1591936652292;1027.8561001459802;4782;4951.282064100686;4985;5045.01622183678;5135.435102138762;19108.904455477634;19392.4182274532;20177.092030858646;20188.596228075356;20222.191112355635;19951.900240498704;20147.194112235346;20171.697424538645;20193.798062019192;20237.595248094956;10374.481275936172;10676.145908327315;11076.501557429934;11176.776464470666;11217.383043932661;7957;8061.879071814044;8074.717384891501;8243.381746368927;8250.834983300421;16652.58368540796;16889.577760556083;17074.74387884158;17218.311267549157;17669.911650441667;17110.657786844444;17355.913220434322;18408.171632276313;18516.444506664822;18518.629627407645;11676.124290678063;11913.404329783303;12034.398280086136;12042.63872083839;12058;13300;13827.101238419471;13850.792238116637;13867.445302188204;13871.167729936236;11055;11141.220114592224;11323.094152467947;11357.886421135683;11408.54365825391;10541.31481453703;10695;10838.67483975482;10883.67348979532;11309.943450282695;9054.818903622023;9491.193248573949;9571.808563828823;9583.377080489747;9604.9039509604;6666.566673166229;6710.295418980937;6714.160729908762;6818.727250909908;6823.727050917908;6726.39462448382;6847;6856.862862742817;6884.896726549206;6919.896201557081 10:58:06 INFO - PID 6269 | |4;prototype.html;508.3315440196143;509.10651806080324;520.7916833266693;521.6322492642687;531.5110098709188;6162.907556386652;6175.876482470348;6219.346968568298;6229.470495007924;6286.9056964145575;6154.323024467316;6165.660888651122;6220.4712599428985;6241.65670888101;6248.9062664060075;5151.304573882525;5158.277841102249;5164.767585458663;5185.948140518584;5205.635605507597;4883.560479556839;5005.799768009275;5020.297158397827;5134.998675258326;5167.121589329804;4967.130752118383;4993.425756038047;4993.725345106018;5002.549770520653;5010.0981823271795;4978.800847966095;4983.975080124576;4984.177610694249;5003.649744517885;5008.749562521859;4347.630451411634;4419.42547468827;4482.282834746457;4485.932711009337;4488.867787800768;6038.909416358758;6049.697515124226;6055.515558755289;6057.42454466825;6058.454739073461;5716.1425786131995;5752.769889204426;5777.468970722762;5785.942140578582;5813.941860581383;6583.308752580958;6593.901091483632;6609.834754131137;6620.933790662128;6638.73445062197;4900.093482705711;4906.55840974314;4919.385076865392;4943.456219815817;4949.381327334083;6540.9345906541275;6732.865342693217;6792.150981127408;6799.626020568867;6845.14435695538;5047.520485553867;5047.671901326402;5052.9242061369105;5061.392632884077;5071.112555302807;5129.563987061067;5141.203113517336;5143.819966301162;5154.201098829687;5183.688978661217;5709.686772042453;5735.168400581976;5745.13822926556;5752.194692743019;5788.82633520995;6652.800415987528;6662.300458451889;6675.833104172434;6696.46428285736;6726.520165563568;1774.53861995882;1791.7491551182845;1792.8207179282228;1795.195828192658;1809.9909500452677;1173.137743758337;1244.4275633208824;1248.6878280429892;1252.167308739678;1260.8928241099427;5904.114382842522;5906.084556893688;5907.675077870758;5939.316978547436;5942.039127088051;6792.558483698544;6806.115205023315;6822.829429264308;6878.621675807879;6880.277570854988;5891.882162356729;5894.38108998549;5898.911516327258;5901.734421951022;5932.822015339547;3586.1751797086295;3629.5100161477862;3629.7459177857295;3631.909202269964;3636.909077273089;6569.014647802868;6571.605703657796;6619.437347825488;6640.816285740049;6677.165354330708;6844.452443804584;6905.75829845963;6966.477514186457;6973.895391569131;7029.824254393681;6171.9691401542705;6551.968889644226;6589.374009469285;6620.966895165493;6662.56693314933;6708.362705542965;6738.225104113089;6793.898091528532;6800.285969973082;6802.8639427212165;6601.33986601336;6644.634545100066;6693.431058360094;6742.561733487308;6774.119364482585;6504;6540.542162048611;6564.9671751642845;6587.538872278895;6629.834254143685;5058.747062646927;5060;5063.367079115111;5082.491750824888;5106.770195341144;6629.337066293332;6630.46956243509;6768.56004359715;6851.48613853953;6931.6880740367815;6410.1987251593555;6466.32103629131;6484.578502397329;6550.344965503412;6587.176602924635;6438.806835794933;6457.354264573693;6554.63949482783;6590.4182996079635;6631.6684165792485;6447.871042579216;6497.642629655415;6516.967415163083;6532.118164047793;6559.868802623825;6648.83377915556;6651.800445986628;6656.700448479927;6694.866102678016;6700.66496675174;6394.424501794861;6428.971364581645;6458.741650333934;6464.353564643498;6474.805755827333 10:58:06 INFO - PID 6269 | |5;yui.html;914.1681070226095;920.0937076979175;931.2317338195986;936.4708939449215;946.3375637054064;21415.250466233683;23172.420689482773;23249.651255231165;23256.3023109307;23363;20354.185832566716;20445.795542044576;20700.27549035784;20783.16867325309;20834.68747968782;731.8207039275385;1042.5725452564468;1047.9685609431692;1060.3266925502285;1066.9733256668567;803.935685145187;809.3039985612369;1006.788574399377;1041.8280983637728;1045.9738506537321;1097.829836375359;1112.8108221602306;1113.0205419231106;1114.5931734916778;1118.03290154017;1097.5006372100675;1108.9279196852178;1110.3227031510853;1111.127764704707;1111.5109351885185;791.7901756034655;800.8798680197958;805.8186907945724;806.9314108300802;807.2089352434647;20198.495037624176;20389.796102039087;20395.694064589043;20615.484612884648;20719.689204661943;21875.343739687836;22079.44801379962;22249.22127725522;22315.10739570415;22614.43463913399;16164.75752863708;16508.66982660352;16689;16874;16992.490225293262;3620.402633565485;3651.470536772153;3651.8539258429632;3652.8356223969986;3654.214343916044;121852.39073804663;123332.38333808363;123659.38170309181;125528.37235813763;127809;16819;16897.662046758996;17287;17288.394906178222;17447.30210791554;24775.628365574532;30638.234044149074;31976;32009.07945523276;32210.19474513109;8715.477071375612;8760.8685869712;8957.955210224038;8965.551722413853;8995.190432860943;4233.872983810429;4340.197063543254;4362.760048197316;4378.321360189112;4399.340098985178;5324.9733751331;5413.756380962866;5421.430749771296;5442.319710036246;5444.482774136451;1095.5398732532356;1111.8332250162377;1118.4799068433217;1126.1666366888608;1126.1835169502046;674.430106559956;698.6471831724947;699.6816448515913;711.861187068527;723.1755798389839;11865.762684746256;12074.939625301817;12208.511659533518;12320.81518777219;12411.193272437262;677.9830504237434;683.0914883205425;689.5207830557714;695.124143579094;703.4653663215993;5301.678150146081;5543.639663421945;5665.3201615806365;5696.946064977992;5697.686627235459;106458.46770766251;109925.45037274923;111076.44461777639;113192.43403782928;115087;96837;97915;99798;100317.49841250747;104116;84597;87079.56460217659;87212.56393718117;89799;90223.54888225517;11585.420728963687;12521.624351269476;12706.936465317614;12829.358532073173;12994.960403167535;39562.604373955895;39567.80216098901;40780.18439631131;41412;42300.78849605732;66962.66074678382;69194.30805691879;70593.29406705867;71918.28081719116;72095.27904720885;18779;19022.619547609247;19061.809381906005;19324.516887077934;19443.51391215231;21302.36092917215;21304.680429793254;21591.568168636226;21673.783262167177;21759.673604895623;18564.350247741266;18996.43010709681;19095.23619055278;19445.8055419444;19655.213791448754;18499.537511562317;18865.24539018424;19083.332083377016;19157.13792879296;19186.424407267805;18574.81425185785;18661.90669046646;18827.341043063974;18830.623387532447;18986.240550377832;14580.1980891052;14666.34001469915;14739.778903316674;14822.777658334919;15011.174385408907;13910.165390076629;14049.157050576998;14534.418623254951;14926;15100.39598416051 10:58:06 INFO - PID 6269 | __end_tp_report 10:58:06 INFO - PID 6269 | __start_cc_report 10:58:06 INFO - PID 6269 | _x_x_mozilla_cycle_collect,375 10:58:06 INFO - PID 6269 | __end_cc_report 10:58:06 INFO - PID 6269 | __startTimestamp1502560686292__endTimestamp 10:58:06 INFO - PID 6269 | 10:58:06 INFO - PID 6269 | ------- Summary: start ------- 10:58:06 INFO - PID 6269 | Number of tests: 6 10:58:06 INFO - PID 6269 | 10:58:06 INFO - PID 6269 | [#0] dojo.html Cycles:165 Average:6137.09 Median:6354.65 stddev:719.46 (11.3%) stddev-sans-first:683.11 10:58:06 INFO - PID 6269 | Values: 3174.9 3197.5 3215.4 3222.7 3233.2 6193.8 6252.8 6273.3 6312.0 6333.2 6048.1 6132.3 6141.0 6142.0 6143.7 5643.0 5655.0 5669.1 5673.7 5754.8 5718.2 5745.9 5766.5 5772.5 5796.2 5561.1 5630.9 5672.5 5726.9 5778.7 5651.2 5703.5 5715.6 5748.3 5751.1 5623.0 5640.2 5670.1 5679.8 5700.7 6096.5 6109.2 6175.5 6201.8 6211.7 6634.7 6654.5 6679.7 6736.7 6742.7 6596.4 6694.1 6710.5 6789.0 6795.6 6160.9 6186.8 6187.7 6188.1 6188.3 6817.4 6873.3 6942.2 6957.5 6970.5 6514.9 6604.5 6607.1 6627.8 6631.0 6539.2 6634.0 6662.1 6727.0 6780.3 6333.1 6471.6 6614.5 6677.7 6715.4 6676.4 6739.5 6740.1 6745.6 6759.8 5277.4 5343.3 5391.9 5429.2 5430.6 4595.0 4600.3 4623.4 4625.9 4634.3 5816.8 5820.8 5908.8 5911.7 5912.3 6672.3 6696.5 6786.2 6791.9 6799.2 5719.8 5781.6 5795.1 5795.7 5802.7 5808.4 5827.2 5834.7 5835.8 5843.2 6375.1 6391.0 6392.4 6404.2 6417.4 6173.1 6505.9 6659.2 6695.0 6756.9 6445.7 6470.3 6538.7 6558.9 6577.4 6503.9 6574.9 6579.1 6594.7 6687.6 6729.9 6730.9 6731.9 6741.0 6742.7 6450.5 6474.8 6520.7 6534.6 6535.2 6402.7 6424.8 6497.1 6501.1 6511.5 6243.6 6354.7 6360.9 6454.1 6454.4 6464.5 6506.7 6561.3 6591.2 6620.3 6207.4 6296.7 6310.5 6312.3 6371.3 10:58:06 INFO - PID 6269 | 10:58:06 INFO - PID 6269 | [#1] ext.html Cycles:180 Average:38464.03 Median:35776.46 stddev:54110.26 (151.2%) stddev-sans-first:54188.30 10:58:06 INFO - PID 6269 | Values: 840.6 857.7 872.8 899.7 900.0 41620.2 42484.0 42608.6 42613.0 42694.4 39460.6 39677.8 39724.2 39756.8 39823.6 6760.3 6892.5 6893.6 6894.6 6895.5 6774.2 6873.5 6890.0 6894.1 6901.8 7446.6 7613.1 7635.1 7656.0 7661.0 7550.0 7587.4 7604.5 7608.2 7610.4 7340.0 7495.6 7499.5 7578.5 7604.7 39293.8 39464.4 39641.8 39678.4 39712.0 3413.7 3461.0 3466.0 3474.2 3480.1 31687.4 31819.2 31854.4 31858.0 31874.0 5098.8 5104.8 5116.5 5118.5 5133.6 190021.0 190049.0 190120.0 190512.0 190621.0 49752.3 49761.0 49871.3 49882.8 49890.5 51358.5 51370.7 51471.0 51585.7 51667.0 16624.4 16827.0 16876.5 16896.7 16932.1 13812.4 13866.3 13876.0 13878.7 13928.9 14641.9 14676.9 14724.1 14749.9 14770.5 5859.6 6067.8 6097.8 6164.1 6204.1 970.5 1010.4 1011.0 1012.7 1018.3 21453.7 21593.0 21644.0 21864.0 22056.8 1056.6 1082.4 1083.7 1093.5 1110.1 12000.9 12183.3 12227.7 12281.7 12294.1 227020.0 227235.0 228400.0 229208.0 229249.0 52212.0 52403.5 54509.0 55796.4 57235.7 1460.8 1497.7 1502.7 1508.4 1517.8 26736.9 26737.3 27056.7 27291.9 27424.9 51232.5 51726.7 51913.0 52040.0 52146.2 204784.0 205303.0 205789.0 206060.0 207526.0 35706.8 35875.0 35880.3 36046.1 36091.0 42477.0 44188.3 44438.3 44542.0 44561.6 32700.0 33026.7 33370.5 33580.0 33600.3 32656.7 32691.8 32836.7 33195.7 33247.8 35759.5 35793.5 35802.0 35923.8 36105.5 31358.8 31411.4 31765.8 32271.0 32302.2 22829.3 23582.0 23588.9 23720.8 23871.3 10:58:06 INFO - PID 6269 | 10:58:06 INFO - PID 6269 | [#2] jquery.html Cycles:180 Average:35599.68 Median:23508.35 stddev:83294.86 (354.3%) stddev-sans-first:83487.02 10:58:06 INFO - PID 6269 | Values: 577.8 579.7 581.2 585.6 589.2 22663.7 23496.9 23516.4 23634.4 24291.1 25954.1 26541.0 26655.7 26796.2 26808.2 6060.8 6606.0 6679.9 6728.7 6740.6 6478.5 6531.3 6543.8 6558.4 6560.3 6482.8 6498.0 6498.5 6504.5 6512.1 6506.1 6507.6 6508.6 6510.0 6522.7 6064.7 6070.4 6075.9 6079.2 6091.8 29115.6 29708.7 30284.4 30362.2 30445.5 1924.3 1947.2 1950.9 1950.9 1952.6 19749.3 20642.4 20658.9 20770.4 20842.5 2421.5 2449.1 2498.5 2517.2 2519.6 141368.0 150729.0 151017.2 151402.0 151453.0 15371.1 15712.9 15810.4 15885.2 15968.5 24174.3 24265.8 24278.0 24349.9 24455.4 10517.4 10730.5 10852.5 10893.2 10969.7 9927.1 9956.6 9996.3 10106.1 10134.5 9726.3 9831.2 9835.9 9854.0 9922.2 2688.5 2734.0 2792.3 2806.7 2891.9 927.3 947.2 951.0 958.7 959.0 19427.8 19894.1 19898.6 19961.9 20211.7 1011.2 1016.2 1026.7 1033.9 1034.9 11101.6 11162.2 11219.5 11246.5 11320.8 459401.0 477460.0 482108.0 511303.0 522338.0 118913.0 120530.4 122510.0 126228.0 128074.0 1130.8 1190.7 1243.5 1249.7 1298.7 20505.6 20559.6 20875.3 21180.4 21373.9 54584.9 55094.2 56020.0 57128.4 57618.7 69893.7 70888.3 70924.6 71355.6 71482.6 14853.8 15109.2 15133.8 15145.5 15257.2 23166.3 23500.3 23523.8 23650.3 23657.4 18275.8 18471.9 18536.4 18701.8 18854.7 14793.5 15358.5 17101.1 17738.5 17777.2 17013.3 17368.7 17372.0 17445.3 17476.0 14334.5 14861.8 15154.8 15284.5 15287.1 18990.0 19070.9 19119.6 19221.8 19248.1 10:58:06 INFO - PID 6269 | 10:58:06 INFO - PID 6269 | [#3] mootools.html Cycles:180 Average:8924.53 Median:2567.27 stddev:6164.85 (240.1%) stddev-sans-first:6155.78 10:58:06 INFO - PID 6269 | Values: 1336.2 1398.5 1411.7 1411.9 1416.3 14286.6 14413.6 14907.0 14926.7 14937.8 14979.6 15247.0 15252.3 15259.8 15268.3 2743.8 2785.2 2787.6 2788.8 2789.5 2650.4 2730.5 2778.3 2785.4 2790.5 2698.7 2755.1 2802.5 2804.5 2806.7 2560.6 2563.3 2571.3 2574.9 2576.3 2600.4 2609.6 2613.7 2637.1 2652.6 13918.2 14228.7 14238.7 14260.7 14305.3 7666.7 7876.4 7901.9 7913.0 7929.6 5127.5 5203.2 5275.3 5377.2 5387.8 1927.1 1930.8 1931.6 1958.6 2006.4 23537.5 23666.0 23751.3 23760.9 23763.2 6419.1 6447.2 6561.0 6601.5 6795.6 16073.5 16182.8 16189.5 16211.2 16216.6 7482.3 7761.6 7761.7 7769.3 7772.1 6190.6 6223.6 7100.7 7173.2 7221.7 5094.9 5124.6 5147.7 5158.5 5229.0 1459.3 1471.4 1486.2 1489.1 1493.2 875.1 883.9 885.6 900.1 903.7 7204.7 7209.1 8101.5 8423.2 8443.7 977.7 1001.2 1011.5 1019.2 1027.9 4782.0 4951.3 4985.0 5045.0 5135.4 19108.9 19392.4 20177.1 20188.6 20222.2 19951.9 20147.2 20171.7 20193.8 20237.6 10374.5 10676.1 11076.5 11176.8 11217.4 7957.0 8061.9 8074.7 8243.4 8250.8 16652.6 16889.6 17074.7 17218.3 17669.9 17110.7 17355.9 18408.2 18516.4 18518.6 11676.1 11913.4 12034.4 12042.6 12058.0 13300.0 13827.1 13850.8 13867.4 13871.2 11055.0 11141.2 11323.1 11357.9 11408.5 10541.3 10695.0 10838.7 10883.7 11309.9 9054.8 9491.2 9571.8 9583.4 9604.9 6666.6 6710.3 6714.2 6818.7 6823.7 6726.4 6847.0 6856.9 6884.9 6919.9 10:58:06 INFO - PID 6269 | 10:58:06 INFO - PID 6269 | [#4] prototype.html Cycles:180 Average:5561.93 Median:6158.62 stddev:1552.06 (25.2%) stddev-sans-first:1509.35 10:58:06 INFO - PID 6269 | Values: 508.3 509.1 520.8 521.6 531.5 6162.9 6175.9 6219.3 6229.5 6286.9 6154.3 6165.7 6220.5 6241.7 6248.9 5151.3 5158.3 5164.8 5185.9 5205.6 4883.6 5005.8 5020.3 5135.0 5167.1 4967.1 4993.4 4993.7 5002.5 5010.1 4978.8 4984.0 4984.2 5003.6 5008.7 4347.6 4419.4 4482.3 4485.9 4488.9 6038.9 6049.7 6055.5 6057.4 6058.5 5716.1 5752.8 5777.5 5785.9 5813.9 6583.3 6593.9 6609.8 6620.9 6638.7 4900.1 4906.6 4919.4 4943.5 4949.4 6540.9 6732.9 6792.2 6799.6 6845.1 5047.5 5047.7 5052.9 5061.4 5071.1 5129.6 5141.2 5143.8 5154.2 5183.7 5709.7 5735.2 5745.1 5752.2 5788.8 6652.8 6662.3 6675.8 6696.5 6726.5 1774.5 1791.7 1792.8 1795.2 1810.0 1173.1 1244.4 1248.7 1252.2 1260.9 5904.1 5906.1 5907.7 5939.3 5942.0 6792.6 6806.1 6822.8 6878.6 6880.3 5891.9 5894.4 5898.9 5901.7 5932.8 3586.2 3629.5 3629.7 3631.9 3636.9 6569.0 6571.6 6619.4 6640.8 6677.2 6844.5 6905.8 6966.5 6973.9 7029.8 6172.0 6552.0 6589.4 6621.0 6662.6 6708.4 6738.2 6793.9 6800.3 6802.9 6601.3 6644.6 6693.4 6742.6 6774.1 6504.0 6540.5 6565.0 6587.5 6629.8 5058.7 5060.0 5063.4 5082.5 5106.8 6629.3 6630.5 6768.6 6851.5 6931.7 6410.2 6466.3 6484.6 6550.3 6587.2 6438.8 6457.4 6554.6 6590.4 6631.7 6447.9 6497.6 6517.0 6532.1 6559.9 6648.8 6651.8 6656.7 6694.9 6700.7 6394.4 6429.0 6458.7 6464.4 6474.8 10:58:06 INFO - PID 6269 | 10:58:06 INFO - PID 6269 | [#5] yui.html Cycles:180 Average:24225.57 Median:20709.98 stddev:32220.91 (155.6%) stddev-sans-first:32263.75 10:58:06 INFO - PID 6269 | Values: 914.2 920.1 931.2 936.5 946.3 21415.3 23172.4 23249.7 23256.3 23363.0 20354.2 20445.8 20700.3 20783.2 20834.7 731.8 1042.6 1048.0 1060.3 1067.0 803.9 809.3 1006.8 1041.8 1046.0 1097.8 1112.8 1113.0 1114.6 1118.0 1097.5 1108.9 1110.3 1111.1 1111.5 791.8 800.9 805.8 806.9 807.2 20198.5 20389.8 20395.7 20615.5 20719.7 21875.3 22079.4 22249.2 22315.1 22614.4 16164.8 16508.7 16689.0 16874.0 16992.5 3620.4 3651.5 3651.9 3652.8 3654.2 121852.4 123332.4 123659.4 125528.4 127809.0 16819.0 16897.7 17287.0 17288.4 17447.3 24775.6 30638.2 31976.0 32009.1 32210.2 8715.5 8760.9 8958.0 8965.6 8995.2 4233.9 4340.2 4362.8 4378.3 4399.3 5325.0 5413.8 5421.4 5442.3 5444.5 1095.5 1111.8 1118.5 1126.2 1126.2 674.4 698.6 699.7 711.9 723.2 11865.8 12074.9 12208.5 12320.8 12411.2 678.0 683.1 689.5 695.1 703.5 5301.7 5543.6 5665.3 5696.9 5697.7 106458.5 109925.5 111076.4 113192.4 115087.0 96837.0 97915.0 99798.0 100317.5 104116.0 84597.0 87079.6 87212.6 89799.0 90223.5 11585.4 12521.6 12706.9 12829.4 12995.0 39562.6 39567.8 40780.2 41412.0 42300.8 66962.7 69194.3 70593.3 71918.3 72095.3 18779.0 19022.6 19061.8 19324.5 19443.5 21302.4 21304.7 21591.6 21673.8 21759.7 18564.4 18996.4 19095.2 19445.8 19655.2 18499.5 18865.2 19083.3 19157.1 19186.4 18574.8 18661.9 18827.3 18830.6 18986.2 14580.2 14666.3 14739.8 14822.8 15011.2 13910.2 14049.2 14534.4 14926.0 15100.4 10:58:06 INFO - PID 6269 | -------- Summary: end -------- 10:58:06 INFO - PID 6269 | 10:58:06 INFO - TEST-INFO | 6269: exit 0 10:58:06 INFO - TEST-OK | dromaeo_css | took 1112137ms 10:58:06 INFO - TEST-START | kraken 10:58:06 INFO - Initialising browser for kraken test... 10:58:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47046/getInfo.html -profile /tmp/tmpG9VV8j/profile 10:58:06 INFO - TEST-INFO | started process 6639 (/builds/slave/test/build/application/firefox/firefox http://localhost:47046/getInfo.html) 10:58:12 INFO - TEST-INFO | 6639: exit 0 10:58:12 INFO - Browser initialized. 10:58:12 INFO - Running cycle 1/1 for kraken test... 10:58:12 INFO - TEST-INFO | started process 6877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG9VV8j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:58:13 INFO - PID 6877 | 10:58:13 INFO - PID 6877 | (/builds/slave/test/build/application/firefox/firefox:6932): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:58:13 INFO - PID 6877 | 10:58:24 INFO - PID 6877 | RSS: Main: 167837696 10:58:24 INFO - PID 6877 | 10:58:26 INFO - PID 6877 | Cycle 1(1): loaded http://localhost:47046/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47046/tests/kraken/driver.html?testName=audio-beat-detection) 10:58:27 INFO - PID 6877 | RSS: Main: 174309376 10:58:27 INFO - PID 6877 | 10:58:30 INFO - PID 6877 | Cycle 1(1): loaded http://localhost:47046/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47046/tests/kraken/driver.html?testName=audio-dft) 10:58:31 INFO - PID 6877 | RSS: Main: 175226880 10:58:31 INFO - PID 6877 | 10:58:34 INFO - PID 6877 | Cycle 1(1): loaded http://localhost:47046/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47046/tests/kraken/driver.html?testName=audio-fft) 10:58:34 INFO - PID 6877 | RSS: Main: 169562112 10:58:34 INFO - PID 6877 | 10:58:37 INFO - PID 6877 | Cycle 1(1): loaded http://localhost:47046/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47046/tests/kraken/driver.html?testName=audio-oscillator) 10:58:37 INFO - PID 6877 | RSS: Main: 170012672 10:58:37 INFO - PID 6877 | 10:58:40 INFO - PID 6877 | Cycle 1(1): loaded http://localhost:47046/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47046/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:58:40 INFO - PID 6877 | RSS: Main: 170229760 10:58:40 INFO - PID 6877 | 10:58:43 INFO - PID 6877 | Cycle 1(1): loaded http://localhost:47046/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47046/tests/kraken/driver.html?testName=imaging-darkroom) 10:58:44 INFO - PID 6877 | RSS: Main: 172691456 10:58:44 INFO - PID 6877 | 10:58:48 INFO - PID 6877 | Cycle 1(1): loaded http://localhost:47046/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47046/tests/kraken/driver.html?testName=imaging-desaturate) 10:58:48 INFO - PID 6877 | RSS: Main: 172511232 10:58:48 INFO - PID 6877 | 10:58:51 INFO - PID 6877 | Cycle 1(1): loaded http://localhost:47046/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47046/tests/kraken/driver.html?testName=json-parse-financial) 10:58:52 INFO - PID 6877 | RSS: Main: 173531136 10:58:52 INFO - PID 6877 | 10:58:53 INFO - PID 6877 | Cycle 1(1): loaded http://localhost:47046/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47046/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:58:54 INFO - PID 6877 | RSS: Main: 173236224 10:58:54 INFO - PID 6877 | 10:58:56 INFO - PID 6877 | Cycle 1(1): loaded http://localhost:47046/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47046/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:58:56 INFO - PID 6877 | RSS: Main: 173277184 10:58:56 INFO - PID 6877 | 10:58:59 INFO - PID 6877 | Cycle 1(1): loaded http://localhost:47046/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47046/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:58:59 INFO - PID 6877 | RSS: Main: 173367296 10:58:59 INFO - PID 6877 | 10:59:02 INFO - PID 6877 | Cycle 1(1): loaded http://localhost:47046/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47046/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:59:03 INFO - PID 6877 | RSS: Main: 173768704 10:59:03 INFO - PID 6877 | 10:59:06 INFO - PID 6877 | Cycle 1(1): loaded http://localhost:47046/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47046/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:59:07 INFO - PID 6877 | RSS: Main: 173731840 10:59:07 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | Cycle 1(1): loaded http://localhost:47046/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47046/tests/kraken/driver.html?testName=ai-astar) 10:59:09 INFO - PID 6877 | RSS: Main: 175448064 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | __start_tp_report 10:59:09 INFO - PID 6877 | _x_x_mozilla_page_load 10:59:09 INFO - PID 6877 | _x_x_mozilla_page_load_details 10:59:09 INFO - PID 6877 | |i|pagename|runs| 10:59:09 INFO - PID 6877 | |0;ai-astar;99;107;99;108;108;113;108;98;109;108 10:59:09 INFO - PID 6877 | |1;audio-beat-detection;149;118;147;169;120;146;148;119;181;120 10:59:09 INFO - PID 6877 | |2;audio-dft;166;162;163;166;162;165;181;170;165;165 10:59:09 INFO - PID 6877 | |3;audio-fft;75;84;75;186;76;75;80;75;152;77 10:59:09 INFO - PID 6877 | |4;audio-oscillator;79;77;137;80;80;79;130;81;79;131 10:59:09 INFO - PID 6877 | |5;imaging-gaussian-blur;115;115;123;114;124;117;117;116;116;116 10:59:09 INFO - PID 6877 | |6;imaging-darkroom;150;153;150;150;149;150;151;153;152;151 10:59:09 INFO - PID 6877 | |7;imaging-desaturate;94;94;95;94;99;99;94;93;94;95 10:59:09 INFO - PID 6877 | |8;json-parse-financial;56;56;64;69;55;57;57;65;62;55 10:59:09 INFO - PID 6877 | |9;json-stringify-tinderbox;55;55;55;59;55;61;61;56;56;55 10:59:09 INFO - PID 6877 | |10;stanford-crypto-aes;80;80;77;79;83;81;79;80;78;78 10:59:09 INFO - PID 6877 | |11;stanford-crypto-ccm;129;131;130;124;137;127;136;125;123;163 10:59:09 INFO - PID 6877 | |12;stanford-crypto-pbkdf2;178;177;187;183;175;182;177;176;203;182 10:59:09 INFO - PID 6877 | |13;stanford-crypto-sha256-iterative;83;73;72;70;74;77;72;69;70;70 10:59:09 INFO - PID 6877 | __end_tp_report 10:59:09 INFO - PID 6877 | __start_cc_report 10:59:09 INFO - PID 6877 | _x_x_mozilla_cycle_collect,1001 10:59:09 INFO - PID 6877 | __end_cc_report 10:59:09 INFO - PID 6877 | __startTimestamp1502560749283__endTimestamp 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | ------- Summary: start ------- 10:59:09 INFO - PID 6877 | Number of tests: 14 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | [#0] ai-astar Cycles:10 Average:105.70 Median:111.00 stddev:5.12 (4.6%) stddev-sans-first:4.82 10:59:09 INFO - PID 6877 | Values: 99.0 107.0 99.0 108.0 108.0 113.0 108.0 98.0 109.0 108.0 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:147.50 stddev:22.23 (15.1%) stddev-sans-first:23.42 10:59:09 INFO - PID 6877 | Values: 149.0 118.0 147.0 169.0 120.0 146.0 148.0 119.0 181.0 120.0 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | [#2] audio-dft Cycles:10 Average:166.50 Median:165.50 stddev:5.60 (3.4%) stddev-sans-first:5.94 10:59:09 INFO - PID 6877 | Values: 166.0 162.0 163.0 166.0 162.0 165.0 181.0 170.0 165.0 165.0 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | [#3] audio-fft Cycles:10 Average:95.50 Median:75.50 stddev:39.66 (52.5%) stddev-sans-first:41.37 10:59:09 INFO - PID 6877 | Values: 75.0 84.0 75.0 186.0 76.0 75.0 80.0 75.0 152.0 77.0 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:79.00 stddev:25.87 (32.7%) stddev-sans-first:26.76 10:59:09 INFO - PID 6877 | Values: 79.0 77.0 137.0 80.0 80.0 79.0 130.0 81.0 79.0 131.0 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:116.50 stddev:3.40 (2.9%) stddev-sans-first:3.50 10:59:09 INFO - PID 6877 | Values: 115.0 115.0 123.0 114.0 124.0 117.0 117.0 116.0 116.0 116.0 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:1.37 (0.9%) stddev-sans-first:1.41 10:59:09 INFO - PID 6877 | Values: 150.0 153.0 150.0 150.0 149.0 150.0 151.0 153.0 152.0 151.0 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.50 stddev:2.13 (2.3%) stddev-sans-first:2.22 10:59:09 INFO - PID 6877 | Values: 94.0 94.0 95.0 94.0 99.0 99.0 94.0 93.0 94.0 95.0 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:59.50 stddev:4.99 (8.4%) stddev-sans-first:5.12 10:59:09 INFO - PID 6877 | Values: 56.0 56.0 64.0 69.0 55.0 57.0 57.0 65.0 62.0 55.0 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:56.00 stddev:2.53 (4.5%) stddev-sans-first:2.60 10:59:09 INFO - PID 6877 | Values: 55.0 55.0 55.0 59.0 55.0 61.0 61.0 56.0 56.0 55.0 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:80.00 stddev:1.72 (2.1%) stddev-sans-first:1.81 10:59:09 INFO - PID 6877 | Values: 80.0 80.0 77.0 79.0 83.0 81.0 79.0 80.0 78.0 78.0 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:130.50 stddev:11.70 (9.0%) stddev-sans-first:12.34 10:59:09 INFO - PID 6877 | Values: 129.0 131.0 130.0 124.0 137.0 127.0 136.0 125.0 123.0 163.0 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:182.00 stddev:8.29 (4.6%) stddev-sans-first:8.66 10:59:09 INFO - PID 6877 | Values: 178.0 177.0 187.0 183.0 175.0 182.0 177.0 176.0 203.0 182.0 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:72.50 stddev:4.24 (5.9%) stddev-sans-first:2.52 10:59:09 INFO - PID 6877 | Values: 83.0 73.0 72.0 70.0 74.0 77.0 72.0 69.0 70.0 70.0 10:59:09 INFO - PID 6877 | -------- Summary: end -------- 10:59:09 INFO - PID 6877 | 10:59:09 INFO - PID 6877 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:59:09 INFO - TEST-INFO | 6877: exit 0 10:59:10 INFO - TEST-OK | kraken | took 63060ms 10:59:10 INFO - SUITE-END | took 1175s 10:59:10 INFO - Completed test suite (00:19:35) 10:59:10 INFO - javascript benchmark 10:59:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8602.80016187443, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3174.9206269843266, 3197.520371944208, 3215.405150047243, 3222.7260682841966, 3233.224026233703, 6193.81418557444, 6252.843678908024, 6273.278572964111, 6312.0, 6333.176687030679, 6048.123022161784, 6132.26412830461, 6141.017437210047, 6142.047982562699, 6143.723532441039, 5642.971785141069, 5655.0, 5669.09294512878, 5673.716314184295, 5754.798582049629, 5718.228039214715, 5745.885082298351, 5766.481016708495, 5772.480476757091, 5796.24648795656, 5561.110222364402, 5630.887382252332, 5672.489475947164, 5726.856828579277, 5778.739956701937, 5651.208830763697, 5703.458171473703, 5715.628484148517, 5748.281464816898, 5751.1085781703905, 5622.971885140589, 5640.182173584848, 5670.092785154356, 5679.829605111853, 5700.714964251771, 6096.542759293071, 6109.205803245594, 6175.475084617813, 6201.751929922798, 6211.689415529206, 6634.668266586699, 6654.46764258863, 6679.732810687567, 6736.6631668416385, 6742.730290788362, 6596.43930265928, 6694.062831203635, 6710.463162946952, 6788.9660551696925, 6795.626240556768, 6160.8767824643255, 6186.752529898844, 6187.721552530147, 6188.133661287423, 6188.319284878615, 6817.420519255819, 6873.347032031949, 6942.201646810681, 6957.512974091765, 6970.477214208853, 6514.9348506514325, 6604.537682362285, 6607.14107166075, 6627.768028118992, 6631.038499417557, 6539.182602174728, 6634.038064480624, 6662.133922590032, 6727.024581435664, 6780.32196780318, 6333.113364129025, 6471.579347342407, 6614.503912206604, 6677.699503522354, 6715.3620406061345, 6676.399124078759, 6739.460843132538, 6740.12378390806, 6745.6289904054765, 6759.763408280686, 5277.393099793496, 5343.332083489564, 5391.946080539223, 5429.212764149255, 5430.619856610078, 4595.035042641016, 4600.309953506934, 4623.375844261049, 4625.861224163281, 4634.304854271819, 5816.828629101904, 5820.82537523875, 5908.763649453974, 5911.733971971272, 5912.3496415394275, 6672.332766723289, 6696.497762667819, 6786.219584747719, 6791.898121528181, 6799.150106236721, 5719.7712091516705, 5781.566382521328, 5795.130730390475, 5795.652260864362, 5802.651840889475, 5808.361080281165, 5827.155062515912, 5834.679092649945, 5835.824925252249, 5843.181954526284, 6375.10748495211, 6391.041343798374, 6392.3927226913365, 6404.23149222087, 6417.358264173638, 6173.104899789595, 6505.869882602226, 6659.2008958925235, 6695.0, 6756.9188929771, 6445.70994305248, 6470.255920569007, 6538.705758240795, 6558.868822623425, 6577.408033277028, 6503.869922601427, 6574.901376479261, 6579.078928949855, 6594.670266486753, 6687.598744075371, 6729.899051514133, 6730.899036514358, 6731.899021514779, 6741.0, 6742.662866856539, 6450.516211284266, 6474.773382931575, 6520.739170433129, 6534.575252608565, 6535.150430444202, 6402.679866006774, 6424.775132870327, 6497.057926600711, 6501.122348483083, 6511.544191906711, 6243.562950593415, 6354.650494222862, 6360.904586431115, 6454.128692626436, 6454.386833250834, 6464.450521705708, 6506.739730410731, 6561.278259391368, 6591.242007169237, 6620.271770105381, 6207.441330280297, 6296.748130074746, 6310.5267104968225, 6312.274088479883, 6371.299157092809], "value": 6084.164916145459, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [840.5587066789934, 857.7083791510885, 872.8036191856833, 899.7390756680561, 899.9820003599929, 41620.16759664805, 42484.0, 42608.57391426085, 42613.0, 42694.35958460625, 39460.605393946054, 39677.80161099198, 39724.20551588966, 39756.80121599388, 39823.601763982355, 6760.290169532214, 6892.4830637702125, 6893.620850853201, 6894.5518541294905, 6895.5173137880365, 6774.153230846145, 6873.450123990094, 6890.000949862267, 6894.13823272091, 6901.827454313632, 7446.553206807609, 7613.086429628453, 7635.083789945186, 7656.042994625672, 7660.961695191516, 7550.0, 7587.430942679322, 7604.54372737632, 7608.163102058769, 7610.429217808659, 7339.9633001834645, 7495.575840590325, 7499.512531685477, 7578.469507134503, 7604.657790399446, 39293.80353098245, 39464.40803387952, 39641.80179099115, 39678.40482392767, 39712.0, 3413.7269018478464, 3461.0136111208185, 3465.9775366267013, 3474.1662001119803, 3480.129967508123, 31687.366252674816, 31819.204519886956, 31854.362912741846, 31858.0, 31874.0, 5098.821541246039, 5104.7622845805245, 5116.539511443951, 5118.513741194581, 5133.614978876599, 190021.0, 190049.0, 190119.9999999986, 190512.04743976193, 190621.046894766, 49752.25371619429, 49761.0, 49871.251931221064, 49882.75058624684, 49890.50109498931, 51358.48641513612, 51370.74314628403, 51471.0, 51585.7420712894, 51667.0, 16624.418145365096, 16827.0, 16876.493705188863, 16896.746548801777, 16932.06873621938, 13812.37844297009, 13866.306684665726, 13876.0, 13878.722425551432, 13928.86071139296, 14641.926790366193, 14676.926615366854, 14724.116553006854, 14749.926250368679, 14770.48303309379, 5859.648421094748, 6067.848303792352, 6097.786577469856, 6164.106204600397, 6204.098761978077, 970.5147426286857, 1010.4291075542295, 1010.9797804044025, 1012.6961911426542, 1018.3024628129755, 21453.67819482709, 21593.0, 21644.0, 21864.01611927467, 22056.779432205472, 1056.630179437191, 1082.4209048159198, 1083.712816103733, 1093.5461783359976, 1110.0730889707024, 12000.879991199976, 12183.32991685448, 12227.671837696953, 12281.69295767613, 12294.139410241198, 227020.0, 227235.0, 228400.0, 229208.0, 229249.0, 52212.0, 52403.47596524062, 54509.0, 55796.44203557912, 57235.71382143146, 1460.8027916231385, 1497.6929729405447, 1502.7295086884467, 1508.351408894186, 1517.840626734199, 26736.866315668296, 26737.33156671099, 27056.729432706208, 27291.86354068217, 27424.862875685492, 51232.48767512426, 51726.741366292925, 51913.0, 52040.0, 52146.21780673217, 204784.0, 205303.0, 205789.0, 206060.0, 207526.0, 35706.821465892506, 35875.0, 35880.282394351445, 36046.09884752902, 36091.0, 42477.0, 44188.33717494176, 44438.3334249993, 44542.0, 44561.55438445574, 32700.0, 33026.66973330236, 33370.499442508866, 33579.99260022203, 33600.327993440485, 32656.673433266315, 32691.836540817145, 32836.67163328336, 33195.66804332023, 33247.83376083104, 35759.46360804642, 35793.46309805407, 35802.0, 35923.82038089793, 36105.458418124275, 31358.843205783825, 31411.371772563965, 31765.841170794, 32271.0, 32302.19244518906, 22829.31512054641, 23582.0, 23588.938497767984, 23720.762792371854, 23871.283861484182], "value": 17437.569698913936, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8382053025153, 579.7391173971714, 581.1718301420475, 585.604716816149, 589.2192844481062, 22663.660045099336, 23496.88251558744, 23516.412089697766, 23634.409139771513, 24291.149809756662, 25954.091606793765, 26541.0, 26655.733442665616, 26796.196114116607, 26808.19575412736, 6060.757569697207, 6606.042123892044, 6679.866402671943, 6728.730850765988, 6740.629265390402, 6478.514111441637, 6531.346865313454, 6543.770968016121, 6558.376954189368, 6560.278369379364, 6482.805515834509, 6497.9675101624425, 6498.545101842849, 6504.479641628682, 6512.055751915969, 6506.089147519351, 6507.577007494521, 6508.64202468864, 6509.967450162766, 6522.7390904363765, 6064.666443345658, 6070.362611925772, 6075.878482430327, 6079.240094988127, 6091.756329746805, 29115.56326655102, 29708.70291297081, 30284.394312113855, 30362.240943976358, 30445.543316850264, 1924.2976313645418, 1947.2113793913488, 1950.882947023183, 1950.9219631214735, 1952.6387618290662, 19749.308774192836, 20642.380728578017, 20658.896705516527, 20770.376888693365, 20842.478938026517, 2421.4551725861716, 2449.081594402099, 2498.5002999400194, 2517.1567524879006, 2519.571672815626, 141368.0, 150729.0, 151017.24491377472, 151402.0, 151453.0, 15371.077735335915, 15712.92143539275, 15810.446634367741, 15885.205739712968, 15968.520944371687, 24174.274771756875, 24265.757342426703, 24278.0, 24349.87825060899, 24455.388615284406, 10517.421541815274, 10730.463476826128, 10852.511636976196, 10893.237473376788, 10969.725756856142, 9927.106560409453, 9956.601735930626, 9996.300258981946, 10106.090451859369, 10134.54394552247, 9726.2705297103, 9831.1643510301, 9835.852462213072, 9854.0, 9922.206223502102, 2688.5295073362086, 2734.0, 2792.2740087577376, 2806.7473927346637, 2891.8698658560415, 927.3230541704594, 947.1948843483123, 950.9952450237843, 958.7459323279337, 959.0457494792587, 19427.80572194288, 19894.104765285596, 19898.60202795936, 19961.900190498956, 20211.696824547642, 1011.1758916483043, 1016.2428990402198, 1026.7227848481018, 1033.8811036730722, 1034.9327293725885, 11101.5559377624, 11162.162837787037, 11219.495122719498, 11246.49390777417, 11320.830187547193, 459401.0, 477460.0, 482108.0, 511303.0, 522338.0, 118913.0, 120530.39734801445, 122510.0, 126228.0, 128074.0, 1130.7908037013178, 1190.7082764722697, 1243.459095293532, 1249.7375551134182, 1298.6818229533635, 20505.589888201856, 20559.588808224053, 20875.26936557213, 21180.364589062352, 21373.89313053425, 54584.90830183453, 55094.173587397025, 56020.0, 57128.42871571231, 57618.7119064402, 69893.65053174701, 70888.29111708817, 70924.64537677278, 71355.64322178355, 71482.64258678674, 14853.846192302271, 15109.168995705342, 15133.848661513684, 15145.469908553148, 15257.237138142826, 23166.3050108497, 23500.294991150295, 23523.76476235216, 23650.29049128529, 23657.40856478602, 18275.812072215263, 18471.90764046171, 18536.351227707506, 18701.812981870007, 18854.71717924205, 14793.482228121964, 15358.462453814063, 17101.144942752562, 17738.467845964642, 17777.2000259986, 17013.319467221667, 17368.739468907723, 17372.0, 17445.30218791285, 17476.03881786514, 14334.49829255971, 14861.777073344125, 15154.772678410052, 15284.465043723416, 15287.082775033534, 18990.0, 19070.904645476683, 19119.61760764749, 19221.807781922562, 19248.133833977223], "value": 12243.58211368316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.1715736243527, 1398.5035312464074, 1411.6541447345398, 1411.858814118589, 1416.327244558834, 14286.571402857919, 14413.63965900853, 14907.0, 14926.701465970675, 14937.775933360994, 14979.625509362244, 15247.0, 15252.313645885934, 15259.847401525982, 15268.312925918333, 2743.7804975602003, 2785.1922942346696, 2787.6236708044357, 2788.776897848167, 2789.4839454700946, 2650.390410205654, 2730.481208570375, 2778.263760103574, 2785.373291009527, 2790.483760504313, 2698.662667166604, 2755.1321333779797, 2802.4675311690817, 2804.5372513535344, 2806.7333603307757, 2560.5519034169038, 2563.269468201563, 2571.2671888511873, 2574.858382788946, 2576.265764257187, 2600.362911086796, 2609.556375416184, 2613.6732908386452, 2637.0638423359815, 2652.6418933444124, 13918.234497102656, 14228.715425691427, 14238.715225695532, 14260.714785704331, 14305.284735763275, 7666.693332266703, 7876.448648594601, 7901.920980790176, 7913.0, 7929.563873986928, 5127.48725127488, 5203.245529398216, 5275.287836142148, 5377.176982084397, 5387.838364849022, 1927.1038966880328, 1930.8374620425072, 1931.565397785501, 1958.6180694764528, 2006.378022812918, 23537.529249415085, 23666.0, 23751.287461376185, 23760.881195594084, 23763.1682891098, 6419.1334169887405, 6447.194100737408, 6561.0, 6601.53789234749, 6795.626240556817, 16073.517794466185, 16182.75725864113, 16189.514314570582, 16211.189440527927, 16216.594585135466, 7482.326590606872, 7761.6119194040075, 7761.650725717356, 7769.261920117579, 7772.145064042951, 6190.628562286277, 6223.626582405071, 7100.68046937889, 7173.175084865203, 7221.711131554679, 5094.898102038012, 5124.641275110706, 5147.6654017488745, 5158.535731784157, 5229.0, 1459.3432955170003, 1471.4261438039173, 1486.182599570232, 1489.0618910086794, 1493.1563666528377, 875.0636818604032, 883.9425437346551, 885.5926273913943, 900.0504467786417, 903.746950853762, 7204.71181152748, 7209.062821833233, 8101.513909165469, 8423.241908228167, 8443.66225350979, 977.6920270114891, 1001.234055947201, 1011.4942528735633, 1019.1591936652292, 1027.8561001459802, 4782.0, 4951.282064100686, 4985.0, 5045.01622183678, 5135.435102138762, 19108.904455477634, 19392.4182274532, 20177.092030858646, 20188.596228075356, 20222.191112355635, 19951.900240498704, 20147.194112235346, 20171.697424538645, 20193.798062019192, 20237.595248094956, 10374.481275936172, 10676.145908327315, 11076.501557429934, 11176.776464470666, 11217.383043932661, 7957.0, 8061.879071814044, 8074.717384891501, 8243.381746368927, 8250.834983300421, 16652.58368540796, 16889.577760556083, 17074.74387884158, 17218.311267549157, 17669.911650441667, 17110.657786844444, 17355.913220434322, 18408.171632276313, 18516.444506664822, 18518.629627407645, 11676.124290678063, 11913.404329783303, 12034.398280086136, 12042.63872083839, 12058.0, 13300.0, 13827.101238419471, 13850.792238116637, 13867.445302188204, 13871.167729936236, 11055.0, 11141.220114592224, 11323.094152467947, 11357.886421135683, 11408.54365825391, 10541.31481453703, 10695.0, 10838.67483975482, 10883.67348979532, 11309.943450282695, 9054.818903622023, 9491.193248573949, 9571.808563828823, 9583.377080489747, 9604.9039509604, 6666.566673166229, 6710.295418980937, 6714.160729908762, 6818.727250909908, 6823.727050917908, 6726.39462448382, 6847.0, 6856.862862742817, 6884.896726549206, 6919.896201557081], "value": 6487.567880347149, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.3315440196143, 509.10651806080324, 520.7916833266693, 521.6322492642687, 531.5110098709188, 6162.907556386652, 6175.876482470348, 6219.346968568298, 6229.470495007924, 6286.9056964145575, 6154.323024467316, 6165.660888651122, 6220.4712599428985, 6241.65670888101, 6248.9062664060075, 5151.304573882525, 5158.277841102249, 5164.767585458663, 5185.948140518584, 5205.635605507597, 4883.560479556839, 5005.799768009275, 5020.297158397827, 5134.998675258326, 5167.121589329804, 4967.130752118383, 4993.425756038047, 4993.725345106018, 5002.549770520653, 5010.0981823271795, 4978.800847966095, 4983.975080124576, 4984.177610694249, 5003.649744517885, 5008.749562521859, 4347.630451411634, 4419.42547468827, 4482.282834746457, 4485.932711009337, 4488.867787800768, 6038.909416358758, 6049.697515124226, 6055.515558755289, 6057.42454466825, 6058.454739073461, 5716.1425786131995, 5752.769889204426, 5777.468970722762, 5785.942140578582, 5813.941860581383, 6583.308752580958, 6593.901091483632, 6609.834754131137, 6620.933790662128, 6638.73445062197, 4900.093482705711, 4906.55840974314, 4919.385076865392, 4943.456219815817, 4949.381327334083, 6540.9345906541275, 6732.865342693217, 6792.150981127408, 6799.626020568867, 6845.14435695538, 5047.520485553867, 5047.671901326402, 5052.9242061369105, 5061.392632884077, 5071.112555302807, 5129.563987061067, 5141.203113517336, 5143.819966301162, 5154.201098829687, 5183.688978661217, 5709.686772042453, 5735.168400581976, 5745.13822926556, 5752.194692743019, 5788.82633520995, 6652.800415987528, 6662.300458451889, 6675.833104172434, 6696.46428285736, 6726.520165563568, 1774.53861995882, 1791.7491551182845, 1792.8207179282228, 1795.195828192658, 1809.9909500452677, 1173.137743758337, 1244.4275633208824, 1248.6878280429892, 1252.167308739678, 1260.8928241099427, 5904.114382842522, 5906.084556893688, 5907.675077870758, 5939.316978547436, 5942.039127088051, 6792.558483698544, 6806.115205023315, 6822.829429264308, 6878.621675807879, 6880.277570854988, 5891.882162356729, 5894.38108998549, 5898.911516327258, 5901.734421951022, 5932.822015339547, 3586.1751797086295, 3629.5100161477862, 3629.7459177857295, 3631.909202269964, 3636.909077273089, 6569.014647802868, 6571.605703657796, 6619.437347825488, 6640.816285740049, 6677.165354330708, 6844.452443804584, 6905.75829845963, 6966.477514186457, 6973.895391569131, 7029.824254393681, 6171.9691401542705, 6551.968889644226, 6589.374009469285, 6620.966895165493, 6662.56693314933, 6708.362705542965, 6738.225104113089, 6793.898091528532, 6800.285969973082, 6802.8639427212165, 6601.33986601336, 6644.634545100066, 6693.431058360094, 6742.561733487308, 6774.119364482585, 6504.0, 6540.542162048611, 6564.9671751642845, 6587.538872278895, 6629.834254143685, 5058.747062646927, 5060.0, 5063.367079115111, 5082.491750824888, 5106.770195341144, 6629.337066293332, 6630.46956243509, 6768.56004359715, 6851.48613853953, 6931.6880740367815, 6410.1987251593555, 6466.32103629131, 6484.578502397329, 6550.344965503412, 6587.176602924635, 6438.806835794933, 6457.354264573693, 6554.63949482783, 6590.4182996079635, 6631.6684165792485, 6447.871042579216, 6497.642629655415, 6516.967415163083, 6532.118164047793, 6559.868802623825, 6648.83377915556, 6651.800445986628, 6656.700448479927, 6694.866102678016, 6700.66496675174, 6394.424501794861, 6428.971364581645, 6458.741650333934, 6464.353564643498, 6474.805755827333], "value": 5105.663565765491, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [914.1681070226095, 920.0937076979175, 931.2317338195986, 936.4708939449215, 946.3375637054064, 21415.250466233683, 23172.420689482773, 23249.651255231165, 23256.3023109307, 23363.0, 20354.185832566716, 20445.795542044576, 20700.27549035784, 20783.16867325309, 20834.68747968782, 731.8207039275385, 1042.5725452564468, 1047.9685609431692, 1060.3266925502285, 1066.9733256668567, 803.935685145187, 809.3039985612369, 1006.788574399377, 1041.8280983637728, 1045.9738506537321, 1097.829836375359, 1112.8108221602306, 1113.0205419231106, 1114.5931734916778, 1118.03290154017, 1097.5006372100675, 1108.9279196852178, 1110.3227031510853, 1111.127764704707, 1111.5109351885185, 791.7901756034655, 800.8798680197958, 805.8186907945724, 806.9314108300802, 807.2089352434647, 20198.495037624176, 20389.796102039087, 20395.694064589043, 20615.484612884648, 20719.689204661943, 21875.343739687836, 22079.44801379962, 22249.22127725522, 22315.10739570415, 22614.43463913399, 16164.75752863708, 16508.66982660352, 16689.0, 16874.0, 16992.490225293262, 3620.402633565485, 3651.470536772153, 3651.8539258429632, 3652.8356223969986, 3654.214343916044, 121852.39073804663, 123332.38333808363, 123659.38170309181, 125528.37235813763, 127809.0, 16819.0, 16897.662046758996, 17287.0, 17288.394906178222, 17447.30210791554, 24775.628365574532, 30638.234044149074, 31976.0, 32009.07945523276, 32210.19474513109, 8715.477071375612, 8760.8685869712, 8957.955210224038, 8965.551722413853, 8995.190432860943, 4233.872983810429, 4340.197063543254, 4362.760048197316, 4378.321360189112, 4399.340098985178, 5324.9733751331, 5413.756380962866, 5421.430749771296, 5442.319710036246, 5444.482774136451, 1095.5398732532356, 1111.8332250162377, 1118.4799068433217, 1126.1666366888608, 1126.1835169502046, 674.430106559956, 698.6471831724947, 699.6816448515913, 711.861187068527, 723.1755798389839, 11865.762684746256, 12074.939625301817, 12208.511659533518, 12320.81518777219, 12411.193272437262, 677.9830504237434, 683.0914883205425, 689.5207830557714, 695.124143579094, 703.4653663215993, 5301.678150146081, 5543.639663421945, 5665.3201615806365, 5696.946064977992, 5697.686627235459, 106458.46770766251, 109925.45037274923, 111076.44461777639, 113192.43403782928, 115087.0, 96837.0, 97915.0, 99798.0, 100317.49841250747, 104116.0, 84597.0, 87079.56460217659, 87212.56393718117, 89799.0, 90223.54888225517, 11585.420728963687, 12521.624351269476, 12706.936465317614, 12829.358532073173, 12994.960403167535, 39562.604373955895, 39567.80216098901, 40780.18439631131, 41412.0, 42300.78849605732, 66962.66074678382, 69194.30805691879, 70593.29406705867, 71918.28081719116, 72095.27904720885, 18779.0, 19022.619547609247, 19061.809381906005, 19324.516887077934, 19443.51391215231, 21302.36092917215, 21304.680429793254, 21591.568168636226, 21673.783262167177, 21759.673604895623, 18564.350247741266, 18996.43010709681, 19095.23619055278, 19445.8055419444, 19655.213791448754, 18499.537511562317, 18865.24539018424, 19083.332083377016, 19157.13792879296, 19186.424407267805, 18574.81425185785, 18661.90669046646, 18827.341043063974, 18830.623387532447, 18986.240550377832, 14580.1980891052, 14666.34001469915, 14739.778903316674, 14822.777658334919, 15011.174385408907, 13910.165390076629, 14049.157050576998, 14534.418623254951, 14926.0, 15100.39598416051], "value": 9420.685563835641, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 99.0, 108.0, 108.0, 113.0, 108.0, 98.0, 109.0, 108.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 147.0, 169.0, 120.0, 146.0, 148.0, 119.0, 181.0, 120.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 163.0, 166.0, 162.0, 165.0, 181.0, 170.0, 165.0, 165.0], "value": 166.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 84.0, 75.0, 186.0, 76.0, 75.0, 80.0, 75.0, 152.0, 77.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 137.0, 80.0, 80.0, 79.0, 130.0, 81.0, 79.0, 131.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 123.0, 114.0, 124.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 153.0, 150.0, 150.0, 149.0, 150.0, 151.0, 153.0, 152.0, 151.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 99.0, 99.0, 94.0, 93.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 64.0, 69.0, 55.0, 57.0, 57.0, 65.0, 62.0, 55.0], "value": 59.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 59.0, 55.0, 61.0, 61.0, 56.0, 56.0, 55.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 77.0, 79.0, 83.0, 81.0, 79.0, 80.0, 78.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 130.0, 124.0, 137.0, 127.0, 136.0, 125.0, 123.0, 163.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 177.0, 187.0, 183.0, 175.0, 182.0, 177.0, 176.0, 203.0, 182.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 73.0, 72.0, 70.0, 74.0, 77.0, 72.0, 69.0, 70.0, 70.0], "value": 73.0, "unit": "score"}]}]} 10:59:10 INFO - Return code: 0 10:59:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:59:10 INFO - # TBPL SUCCESS # 10:59:10 INFO - Running post-action listener: _package_coverage_data 10:59:10 INFO - Running post-action listener: _resource_record_post_action 10:59:10 INFO - [mozharness: 2017-08-12 17:59:10.542544Z] Finished run-tests step (success) 10:59:10 INFO - Running post-run listener: _resource_record_post_run 10:59:10 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 432476160; Read time: 164; Write time: 343720 10:59:10 INFO - TinderboxPrint: CPU usage
13.1% 10:59:10 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 164 10:59:10 INFO - TinderboxPrint: I/O write bytes / time
432,476,160 / 343,720 10:59:10 INFO - TinderboxPrint: CPU idle
8,266.0 (86.8%) 10:59:10 INFO - TinderboxPrint: CPU user
1,202.0 (12.6%) 10:59:10 INFO - TinderboxPrint: Swap in / out
0 / 0 10:59:10 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106754048; Read time: 0; Write time: 97288 10:59:10 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:59:10 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 325722112; Read time: 152; Write time: 246432 10:59:11 INFO - Running post-run listener: _upload_blobber_files 10:59:11 INFO - Blob upload gear active. 10:59:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:59:11 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 10:59:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:59:11 INFO - (blobuploader) - INFO - Open directory for files ... 10:59:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:59:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:59:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:12 INFO - (blobuploader) - INFO - Done attempting. 10:59:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:59:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:59:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:13 INFO - (blobuploader) - INFO - Done attempting. 10:59:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:59:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:59:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:13 INFO - (blobuploader) - INFO - Done attempting. 10:59:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:59:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:59:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:19 INFO - (blobuploader) - INFO - Done attempting. 10:59:19 INFO - (blobuploader) - INFO - Iteration through files over. 10:59:19 INFO - Return code: 0 10:59:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:59:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:59:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecc3baefd0957143b62cf7ca3ae9ec2e0f2a3857eeca34bfc44adfcf4bf3cd407c6e2828f57619dd91029256114aef5032a67f2644bc2f919e35fa47d4e9b244", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7284e1bfb89512be894b8c27199f75112511be13ed3b46b0f4ee4517abea8454509bc0b5c0d83afd2809c5a479a613327a85c69fb57728db3828def0af5e1186", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f28045ad599c78bacd03adb301ff2655b36b0fe7813a662260a0c4002d48c04bb73f3514791c6d032c3e11889663c25e3f85facab4c4666794734d19985aafd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53089eb450788a1e571f996751af8b3f954045239e61157be3da9a20402b2e657a5864cce893a9f057a310d893ce7c9613a6e9176a9f233dd022e72aff0c8ba1"} 10:59:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:59:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:59:19 INFO - Contents: 10:59:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecc3baefd0957143b62cf7ca3ae9ec2e0f2a3857eeca34bfc44adfcf4bf3cd407c6e2828f57619dd91029256114aef5032a67f2644bc2f919e35fa47d4e9b244", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7284e1bfb89512be894b8c27199f75112511be13ed3b46b0f4ee4517abea8454509bc0b5c0d83afd2809c5a479a613327a85c69fb57728db3828def0af5e1186", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f28045ad599c78bacd03adb301ff2655b36b0fe7813a662260a0c4002d48c04bb73f3514791c6d032c3e11889663c25e3f85facab4c4666794734d19985aafd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53089eb450788a1e571f996751af8b3f954045239e61157be3da9a20402b2e657a5864cce893a9f057a310d893ce7c9613a6e9176a9f233dd022e72aff0c8ba1"} 10:59:19 INFO - Running post-run listener: copy_logs_to_upload_dir 10:59:19 INFO - Copying logs to upload dir... 10:59:19 INFO - mkdir: /builds/slave/test/build/upload/logs 10:59:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.382297 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-12 10:59:19.921816) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-12 10:59:19.926099) ========= 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=652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecc3baefd0957143b62cf7ca3ae9ec2e0f2a3857eeca34bfc44adfcf4bf3cd407c6e2828f57619dd91029256114aef5032a67f2644bc2f919e35fa47d4e9b244", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7284e1bfb89512be894b8c27199f75112511be13ed3b46b0f4ee4517abea8454509bc0b5c0d83afd2809c5a479a613327a85c69fb57728db3828def0af5e1186", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f28045ad599c78bacd03adb301ff2655b36b0fe7813a662260a0c4002d48c04bb73f3514791c6d032c3e11889663c25e3f85facab4c4666794734d19985aafd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53089eb450788a1e571f996751af8b3f954045239e61157be3da9a20402b2e657a5864cce893a9f057a310d893ce7c9613a6e9176a9f233dd022e72aff0c8ba1"} build_url:https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/equmlGMdQTeuA3YD9CXIvQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecc3baefd0957143b62cf7ca3ae9ec2e0f2a3857eeca34bfc44adfcf4bf3cd407c6e2828f57619dd91029256114aef5032a67f2644bc2f919e35fa47d4e9b244", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7284e1bfb89512be894b8c27199f75112511be13ed3b46b0f4ee4517abea8454509bc0b5c0d83afd2809c5a479a613327a85c69fb57728db3828def0af5e1186", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f28045ad599c78bacd03adb301ff2655b36b0fe7813a662260a0c4002d48c04bb73f3514791c6d032c3e11889663c25e3f85facab4c4666794734d19985aafd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53089eb450788a1e571f996751af8b3f954045239e61157be3da9a20402b2e657a5864cce893a9f057a310d893ce7c9613a6e9176a9f233dd022e72aff0c8ba1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-12 10:59:19.954122) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 10:59:19.954562) ========= 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=652eb03db935cfc1c15ebda0000001ad-1502553496.910670-2118153132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 10:59:20.037048) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-12 10:59:20.037544) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-12 10:59:20.038005) ========= ========= Total master_lag: 0.18 =========