builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1502852730.89 results: success (0) revision: 4e93516e92e58d166ad37b8544c3230024afb587 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:30.885815) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:30.886287) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:30.886561) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:30.927102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:30.927485) ========= 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=a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 20:05:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.3M=0s 2017-08-15 20:05:31 (34.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.192238 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:31.139825) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:31.140163) ========= 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=a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020168 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:31.192991) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-15 20:05:31.196601) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4e93516e92e58d166ad37b8544c3230024afb587 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 4e93516e92e58d166ad37b8544c3230024afb587 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 20:05:31,256 truncating revision to first 12 chars 2017-08-15 20:05:31,256 Setting DEBUG logging. 2017-08-15 20:05:31,256 attempt 1/10 2017-08-15 20:05:31,256 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4e93516e92e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-15 20:05:32,075 unpacking tar archive at: mozilla-central-4e93516e92e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.090870 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-15 20:05:32.302793) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:32.303103) ========= script_repo_revision: 4e93516e92e58d166ad37b8544c3230024afb587 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:32.306664) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:32.306964) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:32.319216) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-15 20:05:32.319611) ========= /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=a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:05:32 INFO - MultiFileLogger online at 20170815 20:05:32 in /builds/slave/test 20:05:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 20:05:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:05:32 INFO - {'append_to_log': False, 20:05:32 INFO - 'base_work_dir': '/builds/slave/test', 20:05:32 INFO - 'blob_upload_branch': 'Firefox', 20:05:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:05:32 INFO - 'branch': 'Firefox', 20:05:32 INFO - 'buildbot_json_path': 'buildprops.json', 20:05:32 INFO - 'code_coverage': False, 20:05:32 INFO - 'config_files': ('talos/linux_config.py',), 20:05:32 INFO - 'default_actions': ('clobber', 20:05:32 INFO - 'read-buildbot-config', 20:05:32 INFO - 'download-and-extract', 20:05:32 INFO - 'populate-webroot', 20:05:32 INFO - 'create-virtualenv', 20:05:32 INFO - 'install', 20:05:32 INFO - 'setup-mitmproxy', 20:05:32 INFO - 'run-tests'), 20:05:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:05:32 INFO - 'disable_ccov_upload': False, 20:05:32 INFO - 'download_minidump_stackwalk': True, 20:05:32 INFO - 'download_symbols': 'ondemand', 20:05:32 INFO - 'enable_stylo': False, 20:05:32 INFO - 'enable_webrender': False, 20:05:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:05:32 INFO - 'tooltool.py': '/tools/tooltool.py', 20:05:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:05:32 INFO - '/tools/misc-python/virtualenv.py')}, 20:05:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:05:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:05:32 INFO - 'gecko_profile': False, 20:05:32 INFO - 'gecko_profile_interval': 0, 20:05:32 INFO - 'installer_path': 'installer.exe', 20:05:32 INFO - 'log_level': 'info', 20:05:32 INFO - 'log_name': 'talos', 20:05:32 INFO - 'log_to_console': True, 20:05:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:05:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:05:32 INFO - 'opt_config_files': (), 20:05:32 INFO - 'pip_index': False, 20:05:32 INFO - 'suite': 'dromaeojs-e10s', 20:05:32 INFO - 'system_bits': '32', 20:05:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:05:32 INFO - 'title': 'talos-linux64-ix-002', 20:05:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:05:32 INFO - 'use_talos_json': True, 20:05:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:05:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:05:32 INFO - 'work_dir': 'build'} 20:05:32 INFO - [mozharness: 2017-08-16 03:05:32.583148Z] Running clobber step. 20:05:32 INFO - Running pre-action listener: _resource_record_pre_action 20:05:32 INFO - Running main action method: clobber 20:05:32 INFO - rmtree: /builds/slave/test/build 20:05:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:05:33 INFO - Running post-action listener: _resource_record_post_action 20:05:33 INFO - [mozharness: 2017-08-16 03:05:33.562201Z] Finished clobber step (success) 20:05:33 INFO - [mozharness: 2017-08-16 03:05:33.562303Z] Running read-buildbot-config step. 20:05:33 INFO - Running pre-action listener: _resource_record_pre_action 20:05:33 INFO - Running main action method: read_buildbot_config 20:05:33 INFO - Using buildbot properties: 20:05:33 INFO - { 20:05:33 INFO - "project": "", 20:05:33 INFO - "product": "firefox", 20:05:33 INFO - "who": "kwierso@gmail.com", 20:05:33 INFO - "installer_path": "public/build/target.tar.bz2", 20:05:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 20:05:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 20:05:33 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 20:05:33 INFO - "stage_platform": "linux64-stylosequential", 20:05:33 INFO - "basedir": "/builds/slave/test", 20:05:33 INFO - "buildnumber": 149, 20:05:33 INFO - "platform": "ubuntu64_hw_styloseq", 20:05:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:05:33 INFO - "slavebuilddir": "test", 20:05:33 INFO - "taskId": "K4hgYKd5TGKrsYxHvj0cOQ", 20:05:33 INFO - "branch": "mozilla-central", 20:05:33 INFO - "script_repo_revision": "production", 20:05:33 INFO - "revision": "4e93516e92e58d166ad37b8544c3230024afb587", 20:05:33 INFO - "slavename": "talos-linux64-ix-002", 20:05:33 INFO - "repo_path": "mozilla-central" 20:05:33 INFO - } 20:05:33 INFO - Finding installer, test and symbols from parent task. 20:05:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K4hgYKd5TGKrsYxHvj0cOQ'}, attempt #1 20:05:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K4hgYKd5TGKrsYxHvj0cOQ'}, attempt #1 20:05:34 INFO - Task dependencies: CfE8SazFTyCmvfD5YyBUnw 20:05:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw'}, attempt #1 20:05:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 20:05:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.test_packages.json 20:05:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.crashreporter-symbols.zip 20:05:34 INFO - Running post-action listener: _resource_record_post_action 20:05:34 INFO - [mozharness: 2017-08-16 03:05:34.904050Z] Finished read-buildbot-config step (success) 20:05:34 INFO - [mozharness: 2017-08-16 03:05:34.904271Z] Running download-and-extract step. 20:05:34 INFO - Running pre-action listener: _resource_record_pre_action 20:05:34 INFO - Running main action method: download_and_extract 20:05:34 INFO - mkdir: /builds/slave/test/build/tests 20:05: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')]} 20:05:34 INFO - trying https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.test_packages.json 20:05:34 INFO - Downloading https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:05:35 INFO - Downloaded 989 bytes. 20:05:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:05:35 INFO - Using the following test package requirements: 20:05:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:05:35 INFO - u'common': [u'target.common.tests.zip'], 20:05:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:05:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:05:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:05:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:05:35 INFO - u'mozbase': [u'target.common.tests.zip'], 20:05:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:05:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:05:35 INFO - u'web-platform': [u'target.common.tests.zip', 20:05:35 INFO - u'target.web-platform.tests.tar.gz'], 20:05:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:05:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 20:05:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip 20:05:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:05:35 INFO - Fetch https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip into memory 20:05:36 INFO - Content-Length response header: 54004333 20:05:36 INFO - Bytes received: 54004333 20:05:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 20:05:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip 20:05:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:05:47 INFO - Fetch https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip into memory 20:05:49 INFO - Content-Length response header: 54004333 20:05:49 INFO - Bytes received: 54004333 20:06:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.talos.tests.zip 20:06:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:06:01 INFO - Fetch https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.talos.tests.zip into memory 20:06:02 INFO - Content-Length response header: 14496050 20:06:02 INFO - Bytes received: 14496050 20:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:02 INFO - trying https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 20:06:02 INFO - Downloading https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:06:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:06:03 INFO - Downloaded 61853457 bytes. 20:06:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 20:06:03 INFO - mkdir: /builds/slave/test/properties 20:06:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:06:03 INFO - Writing to file /builds/slave/test/properties/build_url 20:06:03 INFO - Contents: 20:06:03 INFO - build_url:https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 20:06:03 INFO - Running post-action listener: _resource_record_post_action 20:06:03 INFO - Running post-action listener: set_extra_try_arguments 20:06:03 INFO - [mozharness: 2017-08-16 03:06:03.594175Z] Finished download-and-extract step (success) 20:06:03 INFO - [mozharness: 2017-08-16 03:06:03.594295Z] Running populate-webroot step. 20:06:03 INFO - Running pre-action listener: _resource_record_pre_action 20:06:03 INFO - Running main action method: populate_webroot 20:06:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:06:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:06:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:06:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:06:03 INFO - 'tests': ['damp', 'tps']}, 20:06:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:06:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 20:06:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 20:06:03 INFO - 'other-e10s': {'tests': ['a11yr', 20:06:03 INFO - 'ts_paint', 20:06:03 INFO - 'tpaint', 20:06:03 INFO - 'sessionrestore', 20:06:03 INFO - 'sessionrestore_many_windows', 20:06:03 INFO - 'sessionrestore_no_auto_restore', 20:06:03 INFO - 'tabpaint']}, 20:06:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 20:06:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 20:06:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:06:03 INFO - 'tsvgr_opacity', 20:06:03 INFO - 'tart', 20:06:03 INFO - 'tscrollx', 20:06:03 INFO - 'tsvg_static']}, 20:06:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:06:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:06:03 INFO - 'talos_options': ['--mitmproxy', 20:06:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:06:03 INFO - '--firstNonBlankPaint'], 20:06:03 INFO - 'tests': ['tp6_google', 20:06:03 INFO - 'tp6_youtube', 20:06:03 INFO - 'tp6_amazon', 20:06:03 INFO - 'tp6_facebook']}, 20:06:03 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:06:03 INFO - 'talos_options': ['--stylo', 20:06:03 INFO - '--mitmproxy', 20:06:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:06:03 INFO - '--firstNonBlankPaint'], 20:06:03 INFO - 'tests': ['tp6_google', 20:06:03 INFO - 'tp6_youtube', 20:06:03 INFO - 'tp6_amazon', 20:06:03 INFO - 'tp6_facebook']}, 20:06:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:06:03 INFO - 'talos_options': ['--stylo', 20:06:03 INFO - '--stylo-threads=1', 20:06:03 INFO - '--mitmproxy', 20:06:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:06:03 INFO - '--firstNonBlankPaint'], 20:06:03 INFO - 'tests': ['tp6_google', 20:06:03 INFO - 'tp6_youtube', 20:06:03 INFO - 'tp6_amazon', 20:06:03 INFO - 'tp6_facebook']}, 20:06:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:06:03 INFO - 'talos_options': ['--xperf_path', 20:06:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:03 INFO - 'tests': ['tp5n']}}} 20:06:03 INFO - Running post-action listener: _resource_record_post_action 20:06:03 INFO - [mozharness: 2017-08-16 03:06:03.603993Z] Finished populate-webroot step (success) 20:06:03 INFO - [mozharness: 2017-08-16 03:06:03.604083Z] Running create-virtualenv step. 20:06:03 INFO - Running pre-action listener: _resource_record_pre_action 20:06:03 INFO - Running main action method: create_virtualenv 20:06:03 INFO - Creating virtualenv /builds/slave/test/build/venv 20:06:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:06:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:06:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 20:06:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:03 INFO - Using real prefix '/usr' 20:06:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:06:04 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:06 INFO - Installing pip.................done. 20:06:06 INFO - Return code: 0 20:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:06:06 INFO - Reading from file tmpfile_stdout 20:06:06 INFO - Output received: 20:06:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:06:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c0b0>, '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 0x1f1cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:06:06 INFO - Using env: {'DISPLAY': ':0', 20:06:06 INFO - 'HOME': '/home/cltbld', 20:06:06 INFO - 'LANG': 'en_US.UTF-8', 20:06:06 INFO - 'LANGUAGE': 'en_US:en', 20:06:06 INFO - 'LOGNAME': 'cltbld', 20:06:06 INFO - 'MAIL': '/var/mail/cltbld', 20:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:06 INFO - 'MOZ_NO_REMOTE': '1', 20:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:06 INFO - 'NO_EM_RESTART': '1', 20:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:06 INFO - 'PWD': '/builds/slave/test', 20:06:06 INFO - 'SHELL': '/bin/bash', 20:06:06 INFO - 'SHLVL': '1', 20:06:06 INFO - 'TERM': 'linux', 20:06:06 INFO - 'TMOUT': '86400', 20:06:06 INFO - 'USER': 'cltbld', 20:06:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 20:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:06 INFO - '_': '/tools/buildbot/bin/python'} 20:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:06:06 INFO - Cleaning up... 20:06:06 INFO - Return code: 0 20:06:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c0b0>, '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 0x1f1cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:06:06 INFO - Using env: {'DISPLAY': ':0', 20:06:06 INFO - 'HOME': '/home/cltbld', 20:06:06 INFO - 'LANG': 'en_US.UTF-8', 20:06:06 INFO - 'LANGUAGE': 'en_US:en', 20:06:06 INFO - 'LOGNAME': 'cltbld', 20:06:06 INFO - 'MAIL': '/var/mail/cltbld', 20:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:06 INFO - 'MOZ_NO_REMOTE': '1', 20:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:06 INFO - 'NO_EM_RESTART': '1', 20:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:06 INFO - 'PWD': '/builds/slave/test', 20:06:06 INFO - 'SHELL': '/bin/bash', 20:06:06 INFO - 'SHLVL': '1', 20:06:06 INFO - 'TERM': 'linux', 20:06:06 INFO - 'TMOUT': '86400', 20:06:06 INFO - 'USER': 'cltbld', 20:06:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 20:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:06 INFO - '_': '/tools/buildbot/bin/python'} 20:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:06 INFO - Downloading/unpacking psutil>=3.1.1 20:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:08 INFO - Installing collected packages: psutil 20:06:08 INFO - Running setup.py install for psutil 20:06:08 INFO - building 'psutil._psutil_linux' extension 20:06:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:06:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:06:09 INFO - building 'psutil._psutil_posix' extension 20:06:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:06:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:06:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:09 INFO - Successfully installed psutil 20:06:09 INFO - Cleaning up... 20:06:09 INFO - Return code: 0 20:06:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c0b0>, '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 0x1f1cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:06:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:06:09 INFO - Using env: {'DISPLAY': ':0', 20:06:09 INFO - 'HOME': '/home/cltbld', 20:06:09 INFO - 'LANG': 'en_US.UTF-8', 20:06:09 INFO - 'LANGUAGE': 'en_US:en', 20:06:09 INFO - 'LOGNAME': 'cltbld', 20:06:09 INFO - 'MAIL': '/var/mail/cltbld', 20:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:09 INFO - 'MOZ_NO_REMOTE': '1', 20:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:09 INFO - 'NO_EM_RESTART': '1', 20:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:09 INFO - 'PWD': '/builds/slave/test', 20:06:09 INFO - 'SHELL': '/bin/bash', 20:06:09 INFO - 'SHLVL': '1', 20:06:09 INFO - 'TERM': 'linux', 20:06:09 INFO - 'TMOUT': '86400', 20:06:09 INFO - 'USER': 'cltbld', 20:06:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 20:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:09 INFO - '_': '/tools/buildbot/bin/python'} 20:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:06:11 INFO - Installing collected packages: mozsystemmonitor 20:06:11 INFO - Running setup.py install for mozsystemmonitor 20:06:11 INFO - Successfully installed mozsystemmonitor 20:06:11 INFO - Cleaning up... 20:06:11 INFO - Return code: 0 20:06:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c0b0>, '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 0x1f1cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:06:11 INFO - Using env: {'DISPLAY': ':0', 20:06:11 INFO - 'HOME': '/home/cltbld', 20:06:11 INFO - 'LANG': 'en_US.UTF-8', 20:06:11 INFO - 'LANGUAGE': 'en_US:en', 20:06:11 INFO - 'LOGNAME': 'cltbld', 20:06:11 INFO - 'MAIL': '/var/mail/cltbld', 20:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:11 INFO - 'MOZ_NO_REMOTE': '1', 20:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:11 INFO - 'NO_EM_RESTART': '1', 20:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:11 INFO - 'PWD': '/builds/slave/test', 20:06:11 INFO - 'SHELL': '/bin/bash', 20:06:11 INFO - 'SHLVL': '1', 20:06:11 INFO - 'TERM': 'linux', 20:06:11 INFO - 'TMOUT': '86400', 20:06:11 INFO - 'USER': 'cltbld', 20:06:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 20:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:11 INFO - '_': '/tools/buildbot/bin/python'} 20:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:11 INFO - Downloading/unpacking jsonschema==2.5.1 20:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:12 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:12 INFO - warning: no files found matching '*.txt' 20:06:12 INFO - no previously-included directories found matching 'build' 20:06:12 INFO - no previously-included directories found matching 'dist' 20:06:12 INFO - no previously-included directories found matching '.git*' 20:06:12 INFO - Installing collected packages: jsonschema, functools32 20:06:12 INFO - Running setup.py install for functools32 20:06:12 INFO - warning: no files found matching '*.txt' 20:06:12 INFO - no previously-included directories found matching 'build' 20:06:12 INFO - no previously-included directories found matching 'dist' 20:06:12 INFO - no previously-included directories found matching '.git*' 20:06:12 INFO - Successfully installed jsonschema functools32 20:06:12 INFO - Cleaning up... 20:06:12 INFO - Return code: 0 20:06:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c0b0>, '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 0x1f1cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:06:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:06:12 INFO - Using env: {'DISPLAY': ':0', 20:06:12 INFO - 'HOME': '/home/cltbld', 20:06:12 INFO - 'LANG': 'en_US.UTF-8', 20:06:12 INFO - 'LANGUAGE': 'en_US:en', 20:06:12 INFO - 'LOGNAME': 'cltbld', 20:06:12 INFO - 'MAIL': '/var/mail/cltbld', 20:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:12 INFO - 'MOZ_NO_REMOTE': '1', 20:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:12 INFO - 'NO_EM_RESTART': '1', 20:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:12 INFO - 'PWD': '/builds/slave/test', 20:06:12 INFO - 'SHELL': '/bin/bash', 20:06:12 INFO - 'SHLVL': '1', 20:06:12 INFO - 'TERM': 'linux', 20:06:12 INFO - 'TMOUT': '86400', 20:06:12 INFO - 'USER': 'cltbld', 20:06:12 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 20:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:12 INFO - '_': '/tools/buildbot/bin/python'} 20:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:06:13 INFO - Cleaning up... 20:06:13 INFO - Return code: 0 20:06:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06: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')]} 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:13 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 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c0b0>, '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 0x1f1cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:06:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:06:13 INFO - Using env: {'DISPLAY': ':0', 20:06:13 INFO - 'HOME': '/home/cltbld', 20:06:13 INFO - 'LANG': 'en_US.UTF-8', 20:06:13 INFO - 'LANGUAGE': 'en_US:en', 20:06:13 INFO - 'LOGNAME': 'cltbld', 20:06:13 INFO - 'MAIL': '/var/mail/cltbld', 20:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:13 INFO - 'MOZ_NO_REMOTE': '1', 20:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:13 INFO - 'NO_EM_RESTART': '1', 20:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:13 INFO - 'PWD': '/builds/slave/test', 20:06:13 INFO - 'SHELL': '/bin/bash', 20:06:13 INFO - 'SHLVL': '1', 20:06:13 INFO - 'TERM': 'linux', 20:06:13 INFO - 'TMOUT': '86400', 20:06:13 INFO - 'USER': 'cltbld', 20:06:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 20:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:13 INFO - '_': '/tools/buildbot/bin/python'} 20:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:13 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:14 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:14 INFO - Downloading docopt-0.6.1.tar.gz 20:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:15 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:15 INFO - Running setup.py install for blobuploader 20:06:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:15 INFO - Running setup.py install for requests 20:06:15 INFO - Running setup.py install for docopt 20:06:15 INFO - Successfully installed blobuploader requests docopt 20:06:15 INFO - Cleaning up... 20:06:15 INFO - Return code: 0 20:06:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c0b0>, '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 0x1f1cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:06:15 INFO - Using env: {'DISPLAY': ':0', 20:06:15 INFO - 'HOME': '/home/cltbld', 20:06:15 INFO - 'LANG': 'en_US.UTF-8', 20:06:15 INFO - 'LANGUAGE': 'en_US:en', 20:06:15 INFO - 'LOGNAME': 'cltbld', 20:06:15 INFO - 'MAIL': '/var/mail/cltbld', 20:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:15 INFO - 'MOZ_NO_REMOTE': '1', 20:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:15 INFO - 'NO_EM_RESTART': '1', 20:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:15 INFO - 'PWD': '/builds/slave/test', 20:06:15 INFO - 'SHELL': '/bin/bash', 20:06:15 INFO - 'SHLVL': '1', 20:06:15 INFO - 'TERM': 'linux', 20:06:15 INFO - 'TMOUT': '86400', 20:06:15 INFO - 'USER': 'cltbld', 20:06:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 20:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:15 INFO - '_': '/tools/buildbot/bin/python'} 20:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:15 INFO - Running setup.py (path:/tmp/pip-2Zf_M3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:15 INFO - Running setup.py (path:/tmp/pip-9fXwMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:16 INFO - Running setup.py (path:/tmp/pip-hh4Nc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:16 INFO - Running setup.py (path:/tmp/pip-FpdTFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:16 INFO - Running setup.py (path:/tmp/pip-tHYiDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:16 INFO - Running setup.py (path:/tmp/pip-0ttbPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:16 INFO - Running setup.py (path:/tmp/pip-Ovd8IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:16 INFO - Running setup.py (path:/tmp/pip-icbZdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:16 INFO - Running setup.py (path:/tmp/pip-V3MiXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:16 INFO - Running setup.py (path:/tmp/pip-WbHQTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:16 INFO - Running setup.py (path:/tmp/pip-YB1Hcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:16 INFO - Running setup.py (path:/tmp/pip-XtiDHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:16 INFO - Running setup.py (path:/tmp/pip-ydU3ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:16 INFO - Running setup.py (path:/tmp/pip-rg3KsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:16 INFO - Running setup.py (path:/tmp/pip-RFe7w6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:16 INFO - Running setup.py (path:/tmp/pip-KjS7PU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:17 INFO - Running setup.py (path:/tmp/pip-ImECVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:17 INFO - Running setup.py install for manifestparser 20:06:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Running setup.py install for mozcrash 20:06:17 INFO - Running setup.py install for mozdebug 20:06:17 INFO - Running setup.py install for mozdevice 20:06:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Running setup.py install for mozfile 20:06:17 INFO - Running setup.py install for mozhttpd 20:06:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Running setup.py install for mozinfo 20:06:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Running setup.py install for mozInstall 20:06:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:17 INFO - Running setup.py install for mozleak 20:06:17 INFO - Running setup.py install for mozlog 20:06:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:18 INFO - Running setup.py install for moznetwork 20:06:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:18 INFO - Running setup.py install for mozprocess 20:06:18 INFO - Running setup.py install for mozprofile 20:06:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:18 INFO - Running setup.py install for mozrunner 20:06:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:18 INFO - Running setup.py install for mozscreenshot 20:06:18 INFO - Running setup.py install for moztest 20:06:18 INFO - Running setup.py install for mozversion 20:06:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:18 INFO - Cleaning up... 20:06:18 INFO - Return code: 0 20:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c0b0>, '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 0x1f1cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:06:18 INFO - Using env: {'DISPLAY': ':0', 20:06:18 INFO - 'HOME': '/home/cltbld', 20:06:18 INFO - 'LANG': 'en_US.UTF-8', 20:06:18 INFO - 'LANGUAGE': 'en_US:en', 20:06:18 INFO - 'LOGNAME': 'cltbld', 20:06:18 INFO - 'MAIL': '/var/mail/cltbld', 20:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:18 INFO - 'MOZ_NO_REMOTE': '1', 20:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:18 INFO - 'NO_EM_RESTART': '1', 20:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:18 INFO - 'PWD': '/builds/slave/test', 20:06:18 INFO - 'SHELL': '/bin/bash', 20:06:18 INFO - 'SHLVL': '1', 20:06:18 INFO - 'TERM': 'linux', 20:06:18 INFO - 'TMOUT': '86400', 20:06:18 INFO - 'USER': 'cltbld', 20:06:18 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 20:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:18 INFO - '_': '/tools/buildbot/bin/python'} 20:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:19 INFO - Running setup.py (path:/tmp/pip-ekqyQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:19 INFO - Running setup.py (path:/tmp/pip-VnbjI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:19 INFO - Running setup.py (path:/tmp/pip-kcWD4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:19 INFO - Running setup.py (path:/tmp/pip-R0unNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:19 INFO - Running setup.py (path:/tmp/pip-bAZNqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:19 INFO - Running setup.py (path:/tmp/pip-mxoCG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:19 INFO - Running setup.py (path:/tmp/pip-u0b0p1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:19 INFO - Running setup.py (path:/tmp/pip-0E4Say-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:19 INFO - Running setup.py (path:/tmp/pip-ApCNLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:19 INFO - Running setup.py (path:/tmp/pip-_rrprm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:19 INFO - Running setup.py (path:/tmp/pip-hupa8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:19 INFO - Running setup.py (path:/tmp/pip-exezym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:19 INFO - Running setup.py (path:/tmp/pip-2h7_Ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:20 INFO - Running setup.py (path:/tmp/pip-PyxGC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:20 INFO - Running setup.py (path:/tmp/pip-JbCPDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:20 INFO - Running setup.py (path:/tmp/pip-QIA_jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:20 INFO - Running setup.py (path:/tmp/pip-RdBi7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:06:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:21 INFO - Downloading blessings-1.6.tar.gz 20:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:21 INFO - Installing collected packages: blessings 20:06:21 INFO - Running setup.py install for blessings 20:06:21 INFO - Successfully installed blessings 20:06:21 INFO - Cleaning up... 20:06:21 INFO - Return code: 0 20:06:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:21 INFO - Reading from file tmpfile_stdout 20:06:21 INFO - Current package versions: 20:06:21 INFO - argparse == 1.2.1 20:06:21 INFO - blessings == 1.6 20:06:21 INFO - blobuploader == 1.2.4 20:06:21 INFO - docopt == 0.6.1 20:06:21 INFO - functools32 == 3.2.3-2 20:06:21 INFO - jsonschema == 2.5.1 20:06:21 INFO - manifestparser == 1.1 20:06:21 INFO - mozInstall == 1.13 20:06:21 INFO - mozcrash == 1.0 20:06:21 INFO - mozdebug == 0.1 20:06:21 INFO - mozdevice == 0.51 20:06:21 INFO - mozfile == 1.2 20:06:21 INFO - mozhttpd == 0.7 20:06:21 INFO - mozinfo == 0.10 20:06:21 INFO - mozleak == 0.1 20:06:21 INFO - mozlog == 3.5 20:06:21 INFO - moznetwork == 0.27 20:06:21 INFO - mozprocess == 0.25 20:06:21 INFO - mozprofile == 0.28 20:06:21 INFO - mozrunner == 6.13 20:06:21 INFO - mozscreenshot == 0.1 20:06:21 INFO - mozsystemmonitor == 0.3 20:06:21 INFO - moztest == 0.8 20:06:21 INFO - mozversion == 1.4 20:06:21 INFO - psutil == 3.1.1 20:06:21 INFO - requests == 1.2.3 20:06:21 INFO - wsgiref == 0.1.2 20:06:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c0b0>, '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 0x1f1cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:06:21 INFO - Using env: {'DISPLAY': ':0', 20:06:21 INFO - 'HOME': '/home/cltbld', 20:06:21 INFO - 'LANG': 'en_US.UTF-8', 20:06:21 INFO - 'LANGUAGE': 'en_US:en', 20:06:21 INFO - 'LOGNAME': 'cltbld', 20:06:21 INFO - 'MAIL': '/var/mail/cltbld', 20:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:21 INFO - 'MOZ_NO_REMOTE': '1', 20:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:21 INFO - 'NO_EM_RESTART': '1', 20:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:21 INFO - 'PWD': '/builds/slave/test', 20:06:21 INFO - 'SHELL': '/bin/bash', 20:06:21 INFO - 'SHLVL': '1', 20:06:21 INFO - 'TERM': 'linux', 20:06:21 INFO - 'TMOUT': '86400', 20:06:21 INFO - 'USER': 'cltbld', 20:06:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 20:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:21 INFO - '_': '/tools/buildbot/bin/python'} 20:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:06:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 20:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 20:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:06:23 INFO - Installing collected packages: simplejson 20:06:23 INFO - Running setup.py install for simplejson 20:06:23 INFO - building 'simplejson._speedups' extension 20:06:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 20:06:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 20:06:24 INFO - Successfully installed simplejson 20:06:24 INFO - Cleaning up... 20:06:24 INFO - Return code: 0 20:06:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:24 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 0x1c771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c0b0>, '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 0x1f1cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:06:24 INFO - Using env: {'DISPLAY': ':0', 20:06:24 INFO - 'HOME': '/home/cltbld', 20:06:24 INFO - 'LANG': 'en_US.UTF-8', 20:06:24 INFO - 'LANGUAGE': 'en_US:en', 20:06:24 INFO - 'LOGNAME': 'cltbld', 20:06:24 INFO - 'MAIL': '/var/mail/cltbld', 20:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:24 INFO - 'MOZ_NO_REMOTE': '1', 20:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:24 INFO - 'NO_EM_RESTART': '1', 20:06:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:24 INFO - 'PWD': '/builds/slave/test', 20:06:24 INFO - 'SHELL': '/bin/bash', 20:06:24 INFO - 'SHLVL': '1', 20:06:24 INFO - 'TERM': 'linux', 20:06:24 INFO - 'TMOUT': '86400', 20:06:24 INFO - 'USER': 'cltbld', 20:06:24 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 20:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:24 INFO - '_': '/tools/buildbot/bin/python'} 20:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:06:24 INFO - Cleaning up... 20:06:24 INFO - Return code: 0 20:06:24 INFO - Running post-action listener: _resource_record_post_action 20:06:24 INFO - Running post-action listener: _start_resource_monitoring 20:06:24 INFO - Starting resource monitoring. 20:06:24 INFO - [mozharness: 2017-08-16 03:06:24.605806Z] Finished create-virtualenv step (success) 20:06:24 INFO - [mozharness: 2017-08-16 03:06:24.606796Z] Running install step. 20:06:24 INFO - Running pre-action listener: _resource_record_pre_action 20:06:24 INFO - Running main action method: install 20:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:24 INFO - Reading from file tmpfile_stdout 20:06:24 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:24 INFO - Reading from file tmpfile_stdout 20:06:24 INFO - Output received: 20:06:24 INFO - Usage: mozinstall [options] installer 20:06:24 INFO - Options: 20:06:24 INFO - -h, --help show this help message and exit 20:06:24 INFO - -d DEST, --destination=DEST 20:06:24 INFO - Directory to install application into. [default: 20:06:24 INFO - "/builds/slave/test"] 20:06:24 INFO - --app=APP Application being installed. [default: firefox] 20:06:24 INFO - mkdir: /builds/slave/test/build/application 20:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:06:42 INFO - Reading from file tmpfile_stdout 20:06:42 INFO - Output received: 20:06:42 INFO - /builds/slave/test/build/application/firefox/firefox 20:06:42 INFO - Running post-action listener: _resource_record_post_action 20:06:42 INFO - [mozharness: 2017-08-16 03:06:42.893427Z] Finished install step (success) 20:06:42 INFO - [mozharness: 2017-08-16 03:06:42.893770Z] Running setup-mitmproxy step. 20:06:42 INFO - Running pre-action listener: _resource_record_pre_action 20:06:42 INFO - Running main action method: setup_mitmproxy 20:06:42 INFO - Skipping: mitmproxy is not required 20:06:42 INFO - Running post-action listener: _resource_record_post_action 20:06:42 INFO - [mozharness: 2017-08-16 03:06:42.895414Z] Finished setup-mitmproxy step (success) 20:06:42 INFO - [mozharness: 2017-08-16 03:06:42.895728Z] Running run-tests step. 20:06:42 INFO - Running pre-action listener: _resource_record_pre_action 20:06:42 INFO - Running pre-action listener: _set_gcov_prefix 20:06:42 INFO - Running main action method: run_tests 20:06:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:06:42 INFO - Python 2.7.3 20:06:42 INFO - Return code: 0 20:06:42 INFO - grabbing minidump binary from tooltool 20:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c0b0>, '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 0x1f1cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:06:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:06:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:06:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:06:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:06:43 INFO - Return code: 0 20:06:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:06:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:06:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:06:43 INFO - ENV: RUST_BACKTRACE is now full 20:06:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:06:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:06:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:06:43 INFO - Using env: {'DISPLAY': ':0', 20:06:43 INFO - 'HOME': '/home/cltbld', 20:06:43 INFO - 'LANG': 'en_US.UTF-8', 20:06:43 INFO - 'LANGUAGE': 'en_US:en', 20:06:43 INFO - 'LOGNAME': 'cltbld', 20:06:43 INFO - 'MAIL': '/var/mail/cltbld', 20:06:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:06:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:43 INFO - 'MOZ_NO_REMOTE': '1', 20:06:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:43 INFO - 'NO_EM_RESTART': '1', 20:06:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:43 INFO - 'PWD': '/builds/slave/test', 20:06:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:06:43 INFO - 'RUST_BACKTRACE': 'full', 20:06:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:06:43 INFO - 'SHELL': '/bin/bash', 20:06:43 INFO - 'SHLVL': '1', 20:06:43 INFO - 'STYLO_FORCE_ENABLED': '1', 20:06:43 INFO - 'TERM': 'linux', 20:06:43 INFO - 'TMOUT': '86400', 20:06:43 INFO - 'USER': 'cltbld', 20:06:43 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834', 20:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:43 INFO - '_': '/tools/buildbot/bin/python'} 20:06:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:06:43 INFO - mozversion application_buildid: 20170816020308 20:06:43 INFO - mozversion application_changeset: 4e93516e92e58d166ad37b8544c3230024afb587 20:06:43 INFO - mozversion application_display_name: Nightly 20:06:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:06:43 INFO - mozversion application_name: Firefox 20:06:43 INFO - mozversion application_remotingname: firefox 20:06:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:06:43 INFO - mozversion application_vendor: Mozilla 20:06:43 INFO - mozversion application_version: 57.0a1 20:06:43 INFO - mozversion platform_buildid: 20170816020308 20:06:43 INFO - mozversion platform_changeset: 4e93516e92e58d166ad37b8544c3230024afb587 20:06:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:06:43 INFO - mozversion platform_version: 57.0a1 20:06:43 INFO - using testdate: 1502852803 20:06:43 INFO - actual date: 1502852803 20:06:43 INFO - starting webserver on 'localhost:43401' 20:06:43 INFO - SUITE-START | Running 2 tests 20:06:43 INFO - TEST-START | dromaeo_css 20:06:43 INFO - Initialising browser for dromaeo_css test... 20:06:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43401/getInfo.html -profile /tmp/tmpHoIixx/profile 20:06:43 INFO - TEST-INFO | started process 3334 (/builds/slave/test/build/application/firefox/firefox http://localhost:43401/getInfo.html) 20:06:51 INFO - TEST-INFO | 3334: exit 0 20:06:51 INFO - Browser initialized. 20:06:51 INFO - Running cycle 1/1 for dromaeo_css test... 20:06:51 INFO - TEST-INFO | started process 3524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHoIixx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:52 INFO - PID 3524 | 20:06:52 INFO - PID 3524 | (/builds/slave/test/build/application/firefox/firefox:3579): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:06:52 INFO - PID 3524 | 20:07:03 INFO - PID 3524 | RSS: Main: 170668032 20:07:03 INFO - PID 3524 | 20:10:02 INFO - PID 3524 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43401/tests/dromaeo/cssquery-ext.html) 20:10:03 INFO - PID 3524 | RSS: Main: 175304704 20:10:03 INFO - PID 3524 | 20:13:05 INFO - PID 3524 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-ext.html (next: http://localhost:43401/tests/dromaeo/cssquery-jquery.html) 20:13:06 INFO - PID 3524 | RSS: Main: 172871680 20:13:06 INFO - PID 3524 | 20:16:07 INFO - PID 3524 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43401/tests/dromaeo/cssquery-mootools.html) 20:16:08 INFO - PID 3524 | RSS: Main: 174489600 20:16:08 INFO - PID 3524 | 20:19:10 INFO - PID 3524 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43401/tests/dromaeo/cssquery-prototype.html) 20:19:10 INFO - PID 3524 | RSS: Main: 172863488 20:19:10 INFO - PID 3524 | 20:22:14 INFO - PID 3524 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43401/tests/dromaeo/cssquery-yui.html) 20:22:15 INFO - PID 3524 | RSS: Main: 174587904 20:22:15 INFO - PID 3524 | 20:25:17 INFO - PID 3524 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-yui.html (next: http://localhost:43401/tests/dromaeo/cssquery-dojo.html) 20:25:17 INFO - PID 3524 | RSS: Main: 177168384 20:25:17 INFO - PID 3524 | 20:25:17 INFO - PID 3524 | __start_tp_report 20:25:17 INFO - PID 3524 | _x_x_mozilla_page_load 20:25:17 INFO - PID 3524 | _x_x_mozilla_page_load_details 20:25:17 INFO - PID 3524 | |i|pagename|runs| 20:25:17 INFO - PID 3524 | |0;dojo.html;3104.1773929908563;3140.89006884759;3147.480665690162;3178.1577881861294;3179.841007949602;6145.139680444736;6160.137580738695;6263.624182549051;6265.968670156654;6268.7179076941475;6176.938230617692;6185.876282474348;6231.937680623192;6287.905681414771;6292.433680968712;5553.972230138864;5659.717014149297;5702.629329093616;5740.512056475204;5771.336296325934;5615.494605485505;5648.4633959773755;5654.575906806986;5658.971705141468;5679.091345384739;5666.206731057655;5742.167385729088;5743.282089738783;5743.9712801435935;5756.654600723949;5652.943470565283;5712.685802280873;5727.284089488814;5755.963926493229;5763.221965034709;5562.415946325658;5608.747606357723;5638.746256418471;5710.971445142789;5712.885742285131;6036.96981515094;6076.422739839708;6130.724117414682;6134.69326533676;6153.046277826944;6621.569597976164;6642.202935647705;6648.16897887764;6701.798946031627;6717.227518835299;6717.261101278856;6723.899141512881;6795.490338224653;6803.7618683345845;6817.5227734058635;6072.878542429171;6155.784547540859;6178.258608966953;6235.937640623626;6252.499800015988;6683.231428385798;6857.074294970215;6927;6959;6974.721011159599;6393.968030159819;6464.159659244362;6467.741290348334;6485.4811615070685;6496.0255961606135;6589.538732288694;6590.1103351046995;6602.570832895846;6608.339166083353;6719.932800671931;6689.632070236086;6706.295838936939;6715.832104197434;6718.025886246467;6724.260331363546;6645.435138013323;6645.867082658319;6647.401733843977;6733;6738.225104112992;5289.947100528945;5391.353037635509;5393.191021346829;5508.14623733322;5517.668939863621;4601.953980460219;4659.860204193879;4680.602148817321;4690.953090469052;4710.858674239778;5745.798897038583;5819.738111784895;5828.417158284137;5829.912551311733;5832.037713777179;6664.233613134455;6674.199096108401;6751.885938820138;6762.729490820312;6773.525853190328;5662.37713851476;5749.367569567345;5759.22250496186;5760.884782304414;5833.066709326487;5837.153612726131;5893.116032595145;5929.555283353766;5929.792457263975;5932.19915311436;6485.837854053686;6515.51133664977;6532.771353002622;6540.117084193573;6544.770933017321;6712.731490740316;6788.287229840796;6789.694463749044;6792.592444453348;6801.523893327618;6414.358564143548;6428.646424446701;6431.067495213074;6553.2136143663065;6563.146790917151;6402.775902843378;6471.805845824632;6506.4469520091325;6627.668616569249;6639.767608133692;6724.93275067243;6750.831229219309;6757.087793147862;6766.086578312062;6794.72821087151;6450.225972883284;6523.706433210612;6537.444317233088;6545.14913061299;6558.442532384801;6420.7431702731365;6438.3883531064475;6511.479081673549;6529.118568993125;6551.344865513411;6286.717097730521;6333.240011198685;6353.555251132377;6372.235331760218;6386.776462823779;6445.291017988111;6514.967425162844;6572.638504882278;6586.736530538725;6595.604263744191;6198.884200843711;6271.3415091414745;6298.874022519615;6303.46420554258;6307.180066591313 20:25:17 INFO - PID 3524 | |1;ext.html;842.1704620948365;860.1226748716314;875.5228400521715;903.4127816919;903.4759839293207;42153;42791.358129628;42957.57042429575;42971.78514107429;43140;38895.41656875149;39090;39392.21215575694;39460.605393946054;39507.60492395075;7014.859702805954;7082.716691332341;7097.893531597005;7141.571505709674;7149.606771627558;7056.04743359645;7142.821429464253;7147.571145731246;7159.964200178992;7165.0327205827325;7111.751088711896;7729.884051739228;7836.138024817265;7897.5656338901335;7929.722459713911;7775.805604859867;7852.3325517331095;7868.72459463916;7873.763787086396;7876.724314649017;7597.658105385271;7720.53676779395;7753;7756.263155000266;7757.922420775776;39270.410943835865;39342.409863852066;39377.80311098455;39501.40747888784;39659.40510892339;3593.928121437583;3636.8363423645733;3639.927201455956;3641.0715267606593;3643.8178091095606;32882.6711732882;32918.177045573815;32918.506222406686;33167.33665326704;33182.17044573881;5102.285680004765;5116.641835071509;5136.794528218867;5153.58771298299;5154.768035438415;186547;186882;188173;189353;200382.9980850101;50836.49163508391;50883.7455812726;50997;51008.23487647688;51042.48957510452;53484.73257633687;53792.19311710328;53797.1930421044;53839;53945;14704.044237124554;14829.480968166063;14830.33263503145;14845.628859278604;14853.851461485463;12002.21985570935;12034.879651203551;12039.879601204051;12039.939800300943;12044.39778011096;15005.17471539054;15006.774898376532;15065.774013389808;15086.094834309757;15181.16503592291;5889.734961926638;5920.822375328747;5957.195778569838;6003.369646187175;6011;994.4132961552718;997.9201663866874;1033;1033.5245786937942;1037.6575730009079;23404.414889627555;23636.527269454513;23879.641805372932;23893.641595376084;23952.40118997039;1098.7198264442516;1108.38484641025;1112.8275117356661;1116.330201878866;1119.9104071674246;12491.2526242127;12594.81107783384;12621.368931553568;12627;12706;236060;236422;239109;239206;240236;54046.729766350916;54201.1869821953;54500.72749636226;54873.725631372385;54898.45101549013;1477.726620575197;1489.9031562948373;1509.9094054356774;1515;1515.515035188751;23425.531489369776;23629.172978945655;23710;23721.16975905835;23835;38005.80997095107;38011.809940950116;38050.2389952205;38059.61940380672;38111.237775244896;181584;182376;182754;182826;182997;31329;31994.68005319917;35012.64987350094;35214.47178292379;36007.759301662976;44352.7782361099;45853;46130.308045378675;46188.7690561545;46408.76795616;33782;33834;34349.48475772915;34353.48469772905;34636.307273853876;32942.67057329396;33240.66759332376;33529.66470335363;33772.49341259834;34037.48943765895;36148.638513614525;36494;36496.63503364933;36501.26997460089;36629.81685091557;31785.682143178274;32002;32034.67965320317;32212.83893580517;32427.837860811487;23610.88194559016;25238.87380563159;25751.871240643675;25858.87070564635;25859 20:25:17 INFO - PID 3524 | |2;jquery.html;565.282091743486;568.6730130175149;570.6988067206768;578.306032760687;591.7514643849582;22002.88998555007;22997.080116795307;23012.65481017784;23070.423239419044;24082.277531674034;25892.74107258927;26498.602520962202;26529.204123876265;26551.867240663818;26560.867195663996;6467.611943283418;6571.211454625428;6583.045458408528;6602.570832895846;6619.669016549177;5882.294124705041;6101.35935726749;6383.6808159592065;6390.041493775924;6390.520710946675;6344.492440604764;6384.010478375859;6385.840353991141;6386.10594516768;6387.265464471576;6383.744650213986;6389.297177310492;6390.520710946697;6391.233052033763;6393.680315984182;5943.227380440559;5958.285005799332;5959.135925290809;5964.582479226456;5970.850728731773;28855.278618034507;29197.562036569467;29429.264268393246;29852.253693657614;29994.25014374636;1900.3633782682818;1940.670086085369;1956.0122138320057;1956.7554055743033;1958.6866101423705;19273.421797345964;19365.612687746307;19557.80442195574;20415.591688166154;20439.693404598944;2447.816413768957;2464.7288798232357;2517.332906779705;2524.9873750631127;2528.304716203059;136536;137627;138648;139691;140277.2986135073;14555;14576.708465830625;15002.324895379516;15166.393344266326;15404.768928466083;23793.762062379155;23903.282901512634;23905.7609423907;23919;23971.520569588858;9575.856362154573;9664.855027174597;9685.70942871715;9879.901200988043;9879.901200988043;7192.82017949545;8770.38607297483;8813.911860881437;8966.730998070068;9072.90927090734;7985.760427187193;9218.492982886006;9233.953830230806;9246.491442970566;9403.952980235192;2658.441727237263;2662.6420525532117;2739.4794988952035;2755.586662000716;2797.762190213814;952.2334520710756;966.9846661005915;973.868527748759;982.9115379615869;984.3798407003542;19732.013399329975;19946.30187943415;20268.493287667632;20377.796222037887;20661.690074648894;1032.26193271811;1034.896510348959;1042.7080417483116;1043.6242952537082;1044.99477502612;11069.833952490719;11088.778224435466;11190.832137517944;11330.60342887995;11435.256708313933;482669;492808;495358;496185;497163;107019.46490267498;112386.43806781077;114697.4265128669;115330;115840;1181.4147588679436;1213.2114125818289;1239.0335538280156;1239.7458521003173;1240.2248594628356;17862.285508579513;17930.5517362067;18002.459926202235;18310.908445457688;18610.53473663115;55335.16997245125;55678.72160639171;56104;56308.43691563196;57163;70560;71227.28772712415;71242.2189445268;71487.28512715014;71641.28358716346;12314.26114433101;12750.553730619384;14185.858141418867;14617.122972621677;14927.552173434815;23315.650265245695;23705.288841334786;23744.762552374254;24446.26661200167;24488.877555612107;19136.234550618377;19433.708494372313;19443.805561944766;19542.706859397404;19545.70681439808;17596.82403175952;17650.470485885446;17657.735133973256;17671.29314827444;17808.109594519963;19498;19539.804601953798;19959;20019;20264.59470810605;14711.411543538567;14813.555593332218;14950.626234344229;15028.023178493362;15240.237988100329;18432.17055232491;18592.256309747998;18593.90703046476;18693.439196824118;18942.242310307985 20:25:17 INFO - PID 3524 | |3;mootools.html;1326.5357125006246;1391.6451304917246;1402.1236727045596;1402.635314818147;1408.964775880603;14190.503332383369;14443.711125777478;14770.11379317239;14771.556853294405;14785.778213326808;14717.116972981628;14999.625009374771;15015.099094054338;15033.849661503382;15038.097714137159;2676.7189445108274;2714.1450443110457;2717.5244332241878;2718.130198336533;2718.4698983698186;2598;2611.425486393;2698.3119304577403;2756.9172924812287;2761.9861900690466;2755.4902343066497;2773.278947473651;2780.666320041598;2782.5408807546733;2782.6660800703944;2633.4074833162576;2661.3479697474245;2663.8268512546624;2668.6664166979126;2714.470678217748;2570.9485810283877;2592.1057235253807;2613.124603257911;2659.760621544051;2663.640408544841;14145;14218;14268;14308.28458577067;14309.069910455892;7491.101067871836;7733.033370828646;7737.535747855147;7739.496932699357;7744.148143704188;4972.229304457815;5085.160948443502;5171.870703232412;5225.137852254374;5232.2674825524455;1865.1793210987123;1903.1530968718926;1909.3412772593433;1938.8255057044935;1945.902704864751;23780.40548986272;23863.284101476984;23873.448225865264;23945.88027059871;23965;6548.738050477928;6568.146141001639;6623.790704478228;6722.159730033746;6753.898691519631;16519.6696066078;16571.337146514245;16576.6684666306;16583.17084145788;16589.253483593267;7488.513246638951;7615.809604759815;7624.351930086005;7627.809304767315;7630.694772209049;6895;6959.338862808025;7013.3687968082095;7166.140063192451;7166.426685865118;4970.453250142481;5171.793128274827;5176.197689358156;5182.144946083929;5207.869803254949;1380.1994842991041;1412.5056230319306;1530.3496014193922;1550.8991915525455;1567.764835274695;868.5700578213824;890.9153630405101;894.141624040915;900.9414388064755;904.4980036080038;8471;8805.779855503535;8869.911300887037;8954.462732235956;9199.77000574991;926.990730092704;973.6592192732628;982.5824024789435;983.7589790501373;1008.0675375277839;5182.8963420732125;5310.495502927216;5395.73021348931;5693.4875861172695;5842.737076831553;20560.485987850425;20804;20869.37391878246;21017.159313627282;21042.368728938156;19373.903130484257;20059.49851253701;20505.89747051255;20524.89737551303;20572.794272057086;10910.836337454944;11123.110151187886;11128.165387596124;11145.442727863574;11162.609308674157;8353.122922093093;8620.672428435779;8839.558022098998;8855.867161992704;9025.187733104052;17820.55448613795;17832.465026049238;17945.192466339307;17957.281708732025;17973.460796176136;18395.448136555926;18510;18524.629507410045;18534.907325463286;18688.34590789316;12050.698732531406;12304.692382690504;12305.200161989442;12311.19977201479;12346.629601111981;12364.62906112782;13512.189268643913;13741.862581374058;13829.377678004716;13859.307034648025;10094.444805535471;11412.543498259976;11417.657470275904;11575.71060723455;11690.415479226174;10676.679699609023;10780.730481738019;10859.945700271448;10890.727731806768;11031.613893513688;9672.129508344282;9825.4104753715;9833.60665573369;9837.803243934937;9844.360116592685;7021.43828493709;7042;7085.787426377011;7095.361417472453;7138.321859423347;7090.964545177448;7199.604021778852;7255.746048888263;7264.273572642694;7313.48805583604 20:25:17 INFO - PID 3524 | |4;prototype.html;499.0512050443019;501.76012692746303;520.448324775738;522.1332587904079;524.9763760630774;6254.343293954137;6260.186175797146;6261.655608941506;6344.58760180588;6370.108184854124;5911.527077833774;6087.147799308101;6121.908171377433;6138.176438838129;6180.03358387974;4969.105560999019;4982.128127577677;4987.326710894019;5027.49725027498;5038.420581633122;5008.1486147355035;5016.924746128811;5030.547250747432;5047.570956468705;5091.79632814687;4753.120672675549;4943.876403089934;4980.27785971034;4985.551300382965;4987.650864439491;4899.510048995107;4935.531124543163;4954.628402869781;4964.280179374006;5002.9499705002845;4451.464244835526;4474.6420286377015;4476.171908196994;4486.282194848841;4508.301213311942;5958;5965.3736357682255;5999.910001349983;6039.335673075958;6052;5744.195812586199;5770.884582308372;5774.538036957076;5794.565407594448;5814.680192589406;6389.6805159741825;6462.0306953956815;6480.3195664455025;6480.57876238043;6555.3772391622715;4802.831900883452;4857.077155340509;4883.169861123618;4897.967343552422;4910.852674419773;6902.206246281692;6968.477364197705;6981.82545436358;6988.860222795515;6989.231184569693;4985.426675932242;5022.773975171126;5023.447420783711;5034.320366750442;5108;5091.7963281469065;5113.335266415343;5139.331886854759;5144.485551444825;5146;5686.606781338599;5707.600467967285;5710.885782284331;5764.481196692234;5770.13447982806;6504.934950650433;6550.181227346582;6553.868922621521;6639.535232533676;6736.663166841737;1663.891847029939;1701.702202114625;1727.417510821305;1752.2027477497709;1764.3119183518438;1401.7827236778317;1446.132320607627;1447.1389523233659;1450.4125829039256;1458.2052781234254;5566.777328906879;5639.802606908738;5662.603617746719;5689.516391106719;5722.484976352148;6467.838304042437;6537.365658585353;6549.345065493412;6618.305077966744;6730.528862979544;5722.828315150469;5744.425557444222;5837.591368604157;5887.380115848407;5896.557758168155;3549.0240183949622;3551.8989113374937;3566.6789988901123;3594;3595.8741444049856;6519.522581419125;6528.673566321665;6577.572457790228;6606;6658.300878407795;6967.581945083311;6990.811562034466;7025.367716905503;7028.332308430691;7072.257412971667;6545.4654486577665;6556.18047744032;6571.5728477647845;6579;6644.501662375341;6802.829929251809;6837.453003759787;6848.212455567674;6863.347981941708;6897.448204143556;6688.3646053624825;6751.122354093936;6759;6767.221769496571;6799.2520822708475;6485.643289618927;6551.967240163959;6581.276059633341;6649.567778094409;6650.403903063133;5051.924221136613;5072.163093089746;5100.775813804586;5102.729285467931;5108.259302401206;6797.320267973163;6886.51794374389;6900.3444672756;6904.171499420102;6916.861662766817;6538.738450461929;6543.484995353191;6566.274995876658;6629.767958121635;6633.568818026813;6519.8044058678315;6524.836879078061;6554.115194448688;6609.603423794588;6628.204615446178;6221.377862213742;6279.591826531261;6403.295637479967;6406.970528135392;6503.902441463477;6563.310852360433;6598.901016484852;6628.171478565179;6643.9335606645245;6658.83352916181;6280.748770049329;6301.6219026858535;6363.7772677956045;6368.993766963392;6393.104965304768 20:25:17 INFO - PID 3524 | |5;yui.html;900.7387857521323;915.7619019055044;921.3734660430907;935.4995077633467;941.6327632223432;17113.144342782874;17642.735358969625;17666.734998975026;17726.202320895558;17742.55643608909;16058.678826423493;16362.181890905436;20024;21645.45886352842;21730.565388692256;1017.2828156149934;1058.925875188737;1061.1563806773595;1061.3790932304573;1062.2511129653615;949.9620015199383;1047.1151876664208;1060.0194819791661;1062.5112448273803;1063.8085144673955;1098.6868742408415;1099.1591432554103;1099.274478843959;1099.4008265495324;1106.590561492249;1090.225939582893;1098.1983152298867;1098.3080659184743;1099.0438318662775;1109.6171820721838;810.7243537197322;811.5901469757794;811.8985126859143;816.9468984516047;822.3914303415429;19910.60178796416;19967.700484492743;20083.598328033502;20246.49383765403;20302.69545956812;19782.109805058808;20274.69587956182;20348.796512034987;20365.981700914894;20575.485612859797;16759.329626814913;16815.41146059894;17108.315667373292;17176.914115429343;17208.311667533282;3593.6765691087667;3615.1685112424025;3624.5106910567265;3626.057225121461;3629.491871138043;128492;128715.35642321823;131655.99999999904;132638;132999.33500332534;16224.756628650579;16241.350345986264;16364.099974501278;16606.916965415097;16836.410725624544;30631.8468407661;31174.376512469622;31209;31217.68782312193;31372.215694607818;8772;8786.033536311;8820.382573219813;8830.77923051916;8865.290776737975;4077.6533994610195;4079.7348172369293;4141.772202528829;4157.08544120293;4167.187398457272;5297.735113244323;5423.538999185113;5424.105022671294;5433.022056029874;5447.400785913546;883.1830556734994;907.3421769217397;921.502388710089;931.5528546297815;935.3265648732902;601.7472661482188;614.9169862068653;623.4825095170997;625.9749610015548;639.5043841023152;10422.5830966762;10494.632687855888;11022.393768342657;11372.26080304794;11410.486528106256;664.2460806984011;671.3454381977533;676.09403399444;677.3463607618573;678.1861765880864;5267.499587539178;5292.629515933924;5301.098813201765;5344.652597581145;5409.161579955114;107427;111103;111633.44183279194;111795;116351;91913.5404322974;93324;95490.65782697572;99342.5032874831;100409.99590004153;80850;82159.5892020548;82709.58645206735;83137;84796;12300.384980751105;12391.256524608552;12419.254844709347;12477.563285284972;12542.930416481178;38531;38843.80578097091;39311.803440982614;39424.40863386994;40193.79903100466;47676;50435.74782126066;50577.49422505728;62279.6886015567;71103;16853.747193791856;17608.207630656907;18386.724199136755;18521.166547505127;18951.14719837583;19022.524436889187;19172.328968486036;21419;21728.782712172677;21832.45418864541;18266;18463.815361846748;18656.720149197503;18832.905835471283;18849;18645.160967756212;18663.533411664816;19137.52156196106;19159;19187;17962.550936226176;18863.43409697711;18978.335758248395;19591;19631.214751409785;13313.46746130144;13345.266010369523;13445.731085378433;13688.589342319747;13913.930430347784;12638.304893230961;13929.58211253664;13948.302584870513;14057.437702492194;14228.573142805732 20:25:17 INFO - PID 3524 | __end_tp_report 20:25:17 INFO - PID 3524 | __start_cc_report 20:25:17 INFO - PID 3524 | _x_x_mozilla_cycle_collect,381 20:25:17 INFO - PID 3524 | __end_cc_report 20:25:17 INFO - PID 3524 | __startTimestamp1502853917385__endTimestamp 20:25:17 INFO - PID 3524 | 20:25:17 INFO - PID 3524 | ------- Summary: start ------- 20:25:17 INFO - PID 3524 | Number of tests: 6 20:25:17 INFO - PID 3524 | 20:25:17 INFO - PID 3524 | [#0] dojo.html Cycles:165 Average:6140.94 Median:6353.56 stddev:725.96 (11.4%) stddev-sans-first:687.99 20:25:17 INFO - PID 3524 | Values: 3104.2 3140.9 3147.5 3178.2 3179.8 6145.1 6160.1 6263.6 6266.0 6268.7 6176.9 6185.9 6231.9 6287.9 6292.4 5554.0 5659.7 5702.6 5740.5 5771.3 5615.5 5648.5 5654.6 5659.0 5679.1 5666.2 5742.2 5743.3 5744.0 5756.7 5652.9 5712.7 5727.3 5756.0 5763.2 5562.4 5608.7 5638.7 5711.0 5712.9 6037.0 6076.4 6130.7 6134.7 6153.0 6621.6 6642.2 6648.2 6701.8 6717.2 6717.3 6723.9 6795.5 6803.8 6817.5 6072.9 6155.8 6178.3 6235.9 6252.5 6683.2 6857.1 6927.0 6959.0 6974.7 6394.0 6464.2 6467.7 6485.5 6496.0 6589.5 6590.1 6602.6 6608.3 6719.9 6689.6 6706.3 6715.8 6718.0 6724.3 6645.4 6645.9 6647.4 6733.0 6738.2 5289.9 5391.4 5393.2 5508.1 5517.7 4602.0 4659.9 4680.6 4691.0 4710.9 5745.8 5819.7 5828.4 5829.9 5832.0 6664.2 6674.2 6751.9 6762.7 6773.5 5662.4 5749.4 5759.2 5760.9 5833.1 5837.2 5893.1 5929.6 5929.8 5932.2 6485.8 6515.5 6532.8 6540.1 6544.8 6712.7 6788.3 6789.7 6792.6 6801.5 6414.4 6428.6 6431.1 6553.2 6563.1 6402.8 6471.8 6506.4 6627.7 6639.8 6724.9 6750.8 6757.1 6766.1 6794.7 6450.2 6523.7 6537.4 6545.1 6558.4 6420.7 6438.4 6511.5 6529.1 6551.3 6286.7 6333.2 6353.6 6372.2 6386.8 6445.3 6515.0 6572.6 6586.7 6595.6 6198.9 6271.3 6298.9 6303.5 6307.2 20:25:17 INFO - PID 3524 | 20:25:17 INFO - PID 3524 | [#1] ext.html Cycles:180 Average:37851.32 Median:3638.38 stddev:53222.09 (1462.8%) stddev-sans-first:53298.84 20:25:17 INFO - PID 3524 | Values: 842.2 860.1 875.5 903.4 903.5 42153.0 42791.4 42957.6 42971.8 43140.0 38895.4 39090.0 39392.2 39460.6 39507.6 7014.9 7082.7 7097.9 7141.6 7149.6 7056.0 7142.8 7147.6 7160.0 7165.0 7111.8 7729.9 7836.1 7897.6 7929.7 7775.8 7852.3 7868.7 7873.8 7876.7 7597.7 7720.5 7753.0 7756.3 7757.9 39270.4 39342.4 39377.8 39501.4 39659.4 3593.9 3636.8 3639.9 3641.1 3643.8 32882.7 32918.2 32918.5 33167.3 33182.2 5102.3 5116.6 5136.8 5153.6 5154.8 186547.0 186882.0 188173.0 189353.0 200383.0 50836.5 50883.7 50997.0 51008.2 51042.5 53484.7 53792.2 53797.2 53839.0 53945.0 14704.0 14829.5 14830.3 14845.6 14853.9 12002.2 12034.9 12039.9 12039.9 12044.4 15005.2 15006.8 15065.8 15086.1 15181.2 5889.7 5920.8 5957.2 6003.4 6011.0 994.4 997.9 1033.0 1033.5 1037.7 23404.4 23636.5 23879.6 23893.6 23952.4 1098.7 1108.4 1112.8 1116.3 1119.9 12491.3 12594.8 12621.4 12627.0 12706.0 236060.0 236422.0 239109.0 239206.0 240236.0 54046.7 54201.2 54500.7 54873.7 54898.5 1477.7 1489.9 1509.9 1515.0 1515.5 23425.5 23629.2 23710.0 23721.2 23835.0 38005.8 38011.8 38050.2 38059.6 38111.2 181584.0 182376.0 182754.0 182826.0 182997.0 31329.0 31994.7 35012.6 35214.5 36007.8 44352.8 45853.0 46130.3 46188.8 46408.8 33782.0 33834.0 34349.5 34353.5 34636.3 32942.7 33240.7 33529.7 33772.5 34037.5 36148.6 36494.0 36496.6 36501.3 36629.8 31785.7 32002.0 32034.7 32212.8 32427.8 23610.9 25238.9 25751.9 25858.9 25859.0 20:25:17 INFO - PID 3524 | 20:25:17 INFO - PID 3524 | [#2] jquery.html Cycles:180 Average:34916.18 Median:23945.26 stddev:82941.52 (346.4%) stddev-sans-first:83134.09 20:25:17 INFO - PID 3524 | Values: 565.3 568.7 570.7 578.3 591.8 22002.9 22997.1 23012.7 23070.4 24082.3 25892.7 26498.6 26529.2 26551.9 26560.9 6467.6 6571.2 6583.0 6602.6 6619.7 5882.3 6101.4 6383.7 6390.0 6390.5 6344.5 6384.0 6385.8 6386.1 6387.3 6383.7 6389.3 6390.5 6391.2 6393.7 5943.2 5958.3 5959.1 5964.6 5970.9 28855.3 29197.6 29429.3 29852.3 29994.3 1900.4 1940.7 1956.0 1956.8 1958.7 19273.4 19365.6 19557.8 20415.6 20439.7 2447.8 2464.7 2517.3 2525.0 2528.3 136536.0 137627.0 138648.0 139691.0 140277.3 14555.0 14576.7 15002.3 15166.4 15404.8 23793.8 23903.3 23905.8 23919.0 23971.5 9575.9 9664.9 9685.7 9879.9 9879.9 7192.8 8770.4 8813.9 8966.7 9072.9 7985.8 9218.5 9234.0 9246.5 9404.0 2658.4 2662.6 2739.5 2755.6 2797.8 952.2 967.0 973.9 982.9 984.4 19732.0 19946.3 20268.5 20377.8 20661.7 1032.3 1034.9 1042.7 1043.6 1045.0 11069.8 11088.8 11190.8 11330.6 11435.3 482669.0 492808.0 495358.0 496185.0 497163.0 107019.5 112386.4 114697.4 115330.0 115840.0 1181.4 1213.2 1239.0 1239.7 1240.2 17862.3 17930.6 18002.5 18310.9 18610.5 55335.2 55678.7 56104.0 56308.4 57163.0 70560.0 71227.3 71242.2 71487.3 71641.3 12314.3 12750.6 14185.9 14617.1 14927.6 23315.7 23705.3 23744.8 24446.3 24488.9 19136.2 19433.7 19443.8 19542.7 19545.7 17596.8 17650.5 17657.7 17671.3 17808.1 19498.0 19539.8 19959.0 20019.0 20264.6 14711.4 14813.6 14950.6 15028.0 15240.2 18432.2 18592.3 18593.9 18693.4 18942.2 20:25:17 INFO - PID 3524 | 20:25:17 INFO - PID 3524 | [#3] mootools.html Cycles:180 Average:9089.25 Median:2623.27 stddev:6276.98 (239.3%) stddev-sans-first:6267.49 20:25:17 INFO - PID 3524 | Values: 1326.5 1391.6 1402.1 1402.6 1409.0 14190.5 14443.7 14770.1 14771.6 14785.8 14717.1 14999.6 15015.1 15033.8 15038.1 2676.7 2714.1 2717.5 2718.1 2718.5 2598.0 2611.4 2698.3 2756.9 2762.0 2755.5 2773.3 2780.7 2782.5 2782.7 2633.4 2661.3 2663.8 2668.7 2714.5 2570.9 2592.1 2613.1 2659.8 2663.6 14145.0 14218.0 14268.0 14308.3 14309.1 7491.1 7733.0 7737.5 7739.5 7744.1 4972.2 5085.2 5171.9 5225.1 5232.3 1865.2 1903.2 1909.3 1938.8 1945.9 23780.4 23863.3 23873.4 23945.9 23965.0 6548.7 6568.1 6623.8 6722.2 6753.9 16519.7 16571.3 16576.7 16583.2 16589.3 7488.5 7615.8 7624.4 7627.8 7630.7 6895.0 6959.3 7013.4 7166.1 7166.4 4970.5 5171.8 5176.2 5182.1 5207.9 1380.2 1412.5 1530.3 1550.9 1567.8 868.6 890.9 894.1 900.9 904.5 8471.0 8805.8 8869.9 8954.5 9199.8 927.0 973.7 982.6 983.8 1008.1 5182.9 5310.5 5395.7 5693.5 5842.7 20560.5 20804.0 20869.4 21017.2 21042.4 19373.9 20059.5 20505.9 20524.9 20572.8 10910.8 11123.1 11128.2 11145.4 11162.6 8353.1 8620.7 8839.6 8855.9 9025.2 17820.6 17832.5 17945.2 17957.3 17973.5 18395.4 18510.0 18524.6 18534.9 18688.3 12050.7 12304.7 12305.2 12311.2 12346.6 12364.6 13512.2 13741.9 13829.4 13859.3 10094.4 11412.5 11417.7 11575.7 11690.4 10676.7 10780.7 10859.9 10890.7 11031.6 9672.1 9825.4 9833.6 9837.8 9844.4 7021.4 7042.0 7085.8 7095.4 7138.3 7091.0 7199.6 7255.7 7264.3 7313.5 20:25:17 INFO - PID 3524 | 20:25:17 INFO - PID 3524 | [#4] prototype.html Cycles:180 Average:5540.85 Median:6069.57 stddev:1545.32 (25.5%) stddev-sans-first:1502.60 20:25:17 INFO - PID 3524 | Values: 499.1 501.8 520.4 522.1 525.0 6254.3 6260.2 6261.7 6344.6 6370.1 5911.5 6087.1 6121.9 6138.2 6180.0 4969.1 4982.1 4987.3 5027.5 5038.4 5008.1 5016.9 5030.5 5047.6 5091.8 4753.1 4943.9 4980.3 4985.6 4987.7 4899.5 4935.5 4954.6 4964.3 5002.9 4451.5 4474.6 4476.2 4486.3 4508.3 5958.0 5965.4 5999.9 6039.3 6052.0 5744.2 5770.9 5774.5 5794.6 5814.7 6389.7 6462.0 6480.3 6480.6 6555.4 4802.8 4857.1 4883.2 4898.0 4910.9 6902.2 6968.5 6981.8 6988.9 6989.2 4985.4 5022.8 5023.4 5034.3 5108.0 5091.8 5113.3 5139.3 5144.5 5146.0 5686.6 5707.6 5710.9 5764.5 5770.1 6504.9 6550.2 6553.9 6639.5 6736.7 1663.9 1701.7 1727.4 1752.2 1764.3 1401.8 1446.1 1447.1 1450.4 1458.2 5566.8 5639.8 5662.6 5689.5 5722.5 6467.8 6537.4 6549.3 6618.3 6730.5 5722.8 5744.4 5837.6 5887.4 5896.6 3549.0 3551.9 3566.7 3594.0 3595.9 6519.5 6528.7 6577.6 6606.0 6658.3 6967.6 6990.8 7025.4 7028.3 7072.3 6545.5 6556.2 6571.6 6579.0 6644.5 6802.8 6837.5 6848.2 6863.3 6897.4 6688.4 6751.1 6759.0 6767.2 6799.3 6485.6 6552.0 6581.3 6649.6 6650.4 5051.9 5072.2 5100.8 5102.7 5108.3 6797.3 6886.5 6900.3 6904.2 6916.9 6538.7 6543.5 6566.3 6629.8 6633.6 6519.8 6524.8 6554.1 6609.6 6628.2 6221.4 6279.6 6403.3 6407.0 6503.9 6563.3 6598.9 6628.2 6643.9 6658.8 6280.7 6301.6 6363.8 6369.0 6393.1 20:25:17 INFO - PID 3524 | 20:25:17 INFO - PID 3524 | [#5] yui.html Cycles:180 Average:23339.97 Median:19939.15 stddev:31960.06 (160.3%) stddev-sans-first:32005.30 20:25:17 INFO - PID 3524 | Values: 900.7 915.8 921.4 935.5 941.6 17113.1 17642.7 17666.7 17726.2 17742.6 16058.7 16362.2 20024.0 21645.5 21730.6 1017.3 1058.9 1061.2 1061.4 1062.3 950.0 1047.1 1060.0 1062.5 1063.8 1098.7 1099.2 1099.3 1099.4 1106.6 1090.2 1098.2 1098.3 1099.0 1109.6 810.7 811.6 811.9 816.9 822.4 19910.6 19967.7 20083.6 20246.5 20302.7 19782.1 20274.7 20348.8 20366.0 20575.5 16759.3 16815.4 17108.3 17176.9 17208.3 3593.7 3615.2 3624.5 3626.1 3629.5 128492.0 128715.4 131656.0 132638.0 132999.3 16224.8 16241.4 16364.1 16606.9 16836.4 30631.8 31174.4 31209.0 31217.7 31372.2 8772.0 8786.0 8820.4 8830.8 8865.3 4077.7 4079.7 4141.8 4157.1 4167.2 5297.7 5423.5 5424.1 5433.0 5447.4 883.2 907.3 921.5 931.6 935.3 601.7 614.9 623.5 626.0 639.5 10422.6 10494.6 11022.4 11372.3 11410.5 664.2 671.3 676.1 677.3 678.2 5267.5 5292.6 5301.1 5344.7 5409.2 107427.0 111103.0 111633.4 111795.0 116351.0 91913.5 93324.0 95490.7 99342.5 100410.0 80850.0 82159.6 82709.6 83137.0 84796.0 12300.4 12391.3 12419.3 12477.6 12542.9 38531.0 38843.8 39311.8 39424.4 40193.8 47676.0 50435.7 50577.5 62279.7 71103.0 16853.7 17608.2 18386.7 18521.2 18951.1 19022.5 19172.3 21419.0 21728.8 21832.5 18266.0 18463.8 18656.7 18832.9 18849.0 18645.2 18663.5 19137.5 19159.0 19187.0 17962.6 18863.4 18978.3 19591.0 19631.2 13313.5 13345.3 13445.7 13688.6 13913.9 12638.3 13929.6 13948.3 14057.4 14228.6 20:25:17 INFO - PID 3524 | -------- Summary: end -------- 20:25:17 INFO - PID 3524 | 20:25:18 INFO - TEST-INFO | 3524: exit 0 20:25:18 INFO - TEST-OK | dromaeo_css | took 1114800ms 20:25:18 INFO - TEST-START | kraken 20:25:18 INFO - Initialising browser for kraken test... 20:25:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43401/getInfo.html -profile /tmp/tmpFrOLOa/profile 20:25:18 INFO - TEST-INFO | started process 3899 (/builds/slave/test/build/application/firefox/firefox http://localhost:43401/getInfo.html) 20:25:24 INFO - TEST-INFO | 3899: exit 0 20:25:24 INFO - Browser initialized. 20:25:24 INFO - Running cycle 1/1 for kraken test... 20:25:24 INFO - TEST-INFO | started process 4087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFrOLOa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:25 INFO - PID 4087 | 20:25:25 INFO - PID 4087 | (/builds/slave/test/build/application/firefox/firefox:4141): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:25:25 INFO - PID 4087 | 20:25:35 INFO - PID 4087 | RSS: Main: 167849984 20:25:35 INFO - PID 4087 | 20:25:38 INFO - PID 4087 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43401/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:39 INFO - PID 4087 | RSS: Main: 174170112 20:25:39 INFO - PID 4087 | 20:25:41 INFO - PID 4087 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43401/tests/kraken/driver.html?testName=audio-dft) 20:25:42 INFO - PID 4087 | RSS: Main: 178483200 20:25:42 INFO - PID 4087 | 20:25:45 INFO - PID 4087 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43401/tests/kraken/driver.html?testName=audio-fft) 20:25:46 INFO - PID 4087 | RSS: Main: 172191744 20:25:46 INFO - PID 4087 | 20:25:48 INFO - PID 4087 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43401/tests/kraken/driver.html?testName=audio-oscillator) 20:25:48 INFO - PID 4087 | RSS: Main: 172634112 20:25:48 INFO - PID 4087 | 20:25:51 INFO - PID 4087 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43401/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:25:51 INFO - PID 4087 | RSS: Main: 172720128 20:25:51 INFO - PID 4087 | 20:25:54 INFO - PID 4087 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43401/tests/kraken/driver.html?testName=imaging-darkroom) 20:25:55 INFO - PID 4087 | RSS: Main: 173932544 20:25:55 INFO - PID 4087 | 20:25:58 INFO - PID 4087 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43401/tests/kraken/driver.html?testName=imaging-desaturate) 20:25:59 INFO - PID 4087 | RSS: Main: 174309376 20:25:59 INFO - PID 4087 | 20:26:02 INFO - PID 4087 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43401/tests/kraken/driver.html?testName=json-parse-financial) 20:26:03 INFO - PID 4087 | RSS: Main: 174419968 20:26:03 INFO - PID 4087 | 20:26:04 INFO - PID 4087 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43401/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:26:05 INFO - PID 4087 | RSS: Main: 174358528 20:26:05 INFO - PID 4087 | 20:26:07 INFO - PID 4087 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:26:07 INFO - PID 4087 | RSS: Main: 174059520 20:26:07 INFO - PID 4087 | 20:26:10 INFO - PID 4087 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:10 INFO - PID 4087 | RSS: Main: 174288896 20:26:10 INFO - PID 4087 | 20:26:13 INFO - PID 4087 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:14 INFO - PID 4087 | RSS: Main: 174837760 20:26:14 INFO - PID 4087 | 20:26:17 INFO - PID 4087 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:17 INFO - PID 4087 | RSS: Main: 174714880 20:26:17 INFO - PID 4087 | 20:26:19 INFO - PID 4087 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43401/tests/kraken/driver.html?testName=ai-astar) 20:26:20 INFO - PID 4087 | RSS: Main: 176017408 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | __start_tp_report 20:26:20 INFO - PID 4087 | _x_x_mozilla_page_load 20:26:20 INFO - PID 4087 | _x_x_mozilla_page_load_details 20:26:20 INFO - PID 4087 | |i|pagename|runs| 20:26:20 INFO - PID 4087 | |0;ai-astar;98;111;101;109;108;110;107;105;107;111 20:26:20 INFO - PID 4087 | |1;audio-beat-detection;146;144;141;164;117;145;145;122;171;131 20:26:20 INFO - PID 4087 | |2;audio-dft;164;167;163;161;163;162;167;164;174;164 20:26:20 INFO - PID 4087 | |3;audio-fft;76;76;79;179;77;75;81;76;157;77 20:26:20 INFO - PID 4087 | |4;audio-oscillator;79;79;138;79;78;79;128;78;82;129 20:26:20 INFO - PID 4087 | |5;imaging-gaussian-blur;114;117;113;114;114;113;114;117;114;114 20:26:20 INFO - PID 4087 | |6;imaging-darkroom;151;152;149;149;150;150;156;150;150;149 20:26:20 INFO - PID 4087 | |7;imaging-desaturate;94;94;94;94;98;93;94;94;97;93 20:26:20 INFO - PID 4087 | |8;json-parse-financial;53;57;54;55;53;56;57;52;52;54 20:26:20 INFO - PID 4087 | |9;json-stringify-tinderbox;54;54;58;54;54;53;55;54;54;61 20:26:20 INFO - PID 4087 | |10;stanford-crypto-aes;77;77;78;81;78;77;86;86;77;77 20:26:20 INFO - PID 4087 | |11;stanford-crypto-ccm;130;126;134;130;126;128;120;122;124;172 20:26:20 INFO - PID 4087 | |12;stanford-crypto-pbkdf2;182;186;179;189;189;180;189;189;177;179 20:26:20 INFO - PID 4087 | |13;stanford-crypto-sha256-iterative;76;72;71;77;70;70;71;67;75;69 20:26:20 INFO - PID 4087 | __end_tp_report 20:26:20 INFO - PID 4087 | __start_cc_report 20:26:20 INFO - PID 4087 | _x_x_mozilla_cycle_collect,945 20:26:20 INFO - PID 4087 | __end_cc_report 20:26:20 INFO - PID 4087 | __startTimestamp1502853980103__endTimestamp 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | ------- Summary: start ------- 20:26:20 INFO - PID 4087 | Number of tests: 14 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | [#0] ai-astar Cycles:10 Average:106.70 Median:109.50 stddev:4.30 (3.9%) stddev-sans-first:3.20 20:26:20 INFO - PID 4087 | Values: 98.0 111.0 101.0 109.0 108.0 110.0 107.0 105.0 107.0 111.0 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:145.00 stddev:16.69 (11.5%) stddev-sans-first:17.65 20:26:20 INFO - PID 4087 | Values: 146.0 144.0 141.0 164.0 117.0 145.0 145.0 122.0 171.0 131.0 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:3.73 (2.3%) stddev-sans-first:3.94 20:26:20 INFO - PID 4087 | Values: 164.0 167.0 163.0 161.0 163.0 162.0 167.0 164.0 174.0 164.0 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.50 stddev:38.70 (50.6%) stddev-sans-first:40.42 20:26:20 INFO - PID 4087 | Values: 76.0 76.0 79.0 179.0 77.0 75.0 81.0 76.0 157.0 77.0 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:79.00 stddev:25.53 (32.3%) stddev-sans-first:26.42 20:26:20 INFO - PID 4087 | Values: 79.0 79.0 138.0 79.0 78.0 79.0 128.0 78.0 82.0 129.0 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.43 (1.3%) stddev-sans-first:1.51 20:26:20 INFO - PID 4087 | Values: 114.0 117.0 113.0 114.0 114.0 113.0 114.0 117.0 114.0 114.0 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:150.00 stddev:2.12 (1.4%) stddev-sans-first:2.24 20:26:20 INFO - PID 4087 | Values: 151.0 152.0 149.0 149.0 150.0 150.0 156.0 150.0 150.0 149.0 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.65 (1.8%) stddev-sans-first:1.74 20:26:20 INFO - PID 4087 | Values: 94.0 94.0 94.0 94.0 98.0 93.0 94.0 94.0 97.0 93.0 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:1.89 (3.5%) stddev-sans-first:1.94 20:26:20 INFO - PID 4087 | Values: 53.0 57.0 54.0 55.0 53.0 56.0 57.0 52.0 52.0 54.0 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:54.00 stddev:2.47 (4.6%) stddev-sans-first:2.59 20:26:20 INFO - PID 4087 | Values: 54.0 54.0 58.0 54.0 54.0 53.0 55.0 54.0 54.0 61.0 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:78.00 stddev:3.69 (4.7%) stddev-sans-first:3.81 20:26:20 INFO - PID 4087 | Values: 77.0 77.0 78.0 81.0 78.0 77.0 86.0 86.0 77.0 77.0 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:129.00 stddev:14.91 (11.6%) stddev-sans-first:15.81 20:26:20 INFO - PID 4087 | Values: 130.0 126.0 134.0 130.0 126.0 128.0 120.0 122.0 124.0 172.0 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.90 Median:187.50 stddev:4.98 (2.7%) stddev-sans-first:5.23 20:26:20 INFO - PID 4087 | Values: 182.0 186.0 179.0 189.0 189.0 180.0 189.0 189.0 177.0 179.0 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:71.50 stddev:3.22 (4.5%) stddev-sans-first:3.04 20:26:20 INFO - PID 4087 | Values: 76.0 72.0 71.0 77.0 70.0 70.0 71.0 67.0 75.0 69.0 20:26:20 INFO - PID 4087 | -------- Summary: end -------- 20:26:20 INFO - PID 4087 | 20:26:20 INFO - PID 4087 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:26:20 INFO - TEST-INFO | 4087: exit 0 20:26:20 INFO - TEST-OK | kraken | took 62696ms 20:26:20 INFO - SUITE-END | took 1177s 20:26:21 INFO - Completed test suite (00:19:37) 20:26:21 INFO - javascript benchmark 20:26:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8528.34226757287, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3104.1773929908563, 3140.89006884759, 3147.480665690162, 3178.1577881861294, 3179.841007949602, 6145.139680444736, 6160.137580738695, 6263.624182549051, 6265.968670156654, 6268.7179076941475, 6176.938230617692, 6185.876282474348, 6231.937680623192, 6287.905681414771, 6292.433680968712, 5553.972230138864, 5659.717014149297, 5702.629329093616, 5740.512056475204, 5771.336296325934, 5615.494605485505, 5648.4633959773755, 5654.575906806986, 5658.971705141468, 5679.091345384739, 5666.206731057655, 5742.167385729088, 5743.282089738783, 5743.9712801435935, 5756.654600723949, 5652.943470565283, 5712.685802280873, 5727.284089488814, 5755.963926493229, 5763.221965034709, 5562.415946325658, 5608.747606357723, 5638.746256418471, 5710.971445142789, 5712.885742285131, 6036.96981515094, 6076.422739839708, 6130.724117414682, 6134.69326533676, 6153.046277826944, 6621.569597976164, 6642.202935647705, 6648.16897887764, 6701.798946031627, 6717.227518835299, 6717.261101278856, 6723.899141512881, 6795.490338224653, 6803.7618683345845, 6817.5227734058635, 6072.878542429171, 6155.784547540859, 6178.258608966953, 6235.937640623626, 6252.499800015988, 6683.231428385798, 6857.074294970215, 6927.0, 6959.0, 6974.721011159599, 6393.968030159819, 6464.159659244362, 6467.741290348334, 6485.4811615070685, 6496.0255961606135, 6589.538732288694, 6590.1103351046995, 6602.570832895846, 6608.339166083353, 6719.932800671931, 6689.632070236086, 6706.295838936939, 6715.832104197434, 6718.025886246467, 6724.260331363546, 6645.435138013323, 6645.867082658319, 6647.401733843977, 6733.0, 6738.225104112992, 5289.947100528945, 5391.353037635509, 5393.191021346829, 5508.14623733322, 5517.668939863621, 4601.953980460219, 4659.860204193879, 4680.602148817321, 4690.953090469052, 4710.858674239778, 5745.798897038583, 5819.738111784895, 5828.417158284137, 5829.912551311733, 5832.037713777179, 6664.233613134455, 6674.199096108401, 6751.885938820138, 6762.729490820312, 6773.525853190328, 5662.37713851476, 5749.367569567345, 5759.22250496186, 5760.884782304414, 5833.066709326487, 5837.153612726131, 5893.116032595145, 5929.555283353766, 5929.792457263975, 5932.19915311436, 6485.837854053686, 6515.51133664977, 6532.771353002622, 6540.117084193573, 6544.770933017321, 6712.731490740316, 6788.287229840796, 6789.694463749044, 6792.592444453348, 6801.523893327618, 6414.358564143548, 6428.646424446701, 6431.067495213074, 6553.2136143663065, 6563.146790917151, 6402.775902843378, 6471.805845824632, 6506.4469520091325, 6627.668616569249, 6639.767608133692, 6724.93275067243, 6750.831229219309, 6757.087793147862, 6766.086578312062, 6794.72821087151, 6450.225972883284, 6523.706433210612, 6537.444317233088, 6545.14913061299, 6558.442532384801, 6420.7431702731365, 6438.3883531064475, 6511.479081673549, 6529.118568993125, 6551.344865513411, 6286.717097730521, 6333.240011198685, 6353.555251132377, 6372.235331760218, 6386.776462823779, 6445.291017988111, 6514.967425162844, 6572.638504882278, 6586.736530538725, 6595.604263744191, 6198.884200843711, 6271.3415091414745, 6298.874022519615, 6303.46420554258, 6307.180066591313], "value": 6086.491000471814, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [842.1704620948365, 860.1226748716314, 875.5228400521715, 903.4127816919, 903.4759839293207, 42153.0, 42791.358129628, 42957.57042429575, 42971.78514107429, 43140.0, 38895.41656875149, 39090.0, 39392.21215575694, 39460.605393946054, 39507.60492395075, 7014.859702805954, 7082.716691332341, 7097.893531597005, 7141.571505709674, 7149.606771627558, 7056.04743359645, 7142.821429464253, 7147.571145731246, 7159.964200178992, 7165.0327205827325, 7111.751088711896, 7729.884051739228, 7836.138024817265, 7897.5656338901335, 7929.722459713911, 7775.805604859867, 7852.3325517331095, 7868.72459463916, 7873.763787086396, 7876.724314649017, 7597.658105385271, 7720.53676779395, 7753.0, 7756.263155000266, 7757.922420775776, 39270.410943835865, 39342.409863852066, 39377.80311098455, 39501.40747888784, 39659.40510892339, 3593.928121437583, 3636.8363423645733, 3639.927201455956, 3641.0715267606593, 3643.8178091095606, 32882.6711732882, 32918.177045573815, 32918.506222406686, 33167.33665326704, 33182.17044573881, 5102.285680004765, 5116.641835071509, 5136.794528218867, 5153.58771298299, 5154.768035438415, 186547.0, 186882.0, 188173.0, 189353.0, 200382.9980850101, 50836.49163508391, 50883.7455812726, 50997.0, 51008.23487647688, 51042.48957510452, 53484.73257633687, 53792.19311710328, 53797.1930421044, 53839.0, 53945.0, 14704.044237124554, 14829.480968166063, 14830.33263503145, 14845.628859278604, 14853.851461485463, 12002.21985570935, 12034.879651203551, 12039.879601204051, 12039.939800300943, 12044.39778011096, 15005.17471539054, 15006.774898376532, 15065.774013389808, 15086.094834309757, 15181.16503592291, 5889.734961926638, 5920.822375328747, 5957.195778569838, 6003.369646187175, 6011.0, 994.4132961552718, 997.9201663866874, 1033.0, 1033.5245786937942, 1037.6575730009079, 23404.414889627555, 23636.527269454513, 23879.641805372932, 23893.641595376084, 23952.40118997039, 1098.7198264442516, 1108.38484641025, 1112.8275117356661, 1116.330201878866, 1119.9104071674246, 12491.2526242127, 12594.81107783384, 12621.368931553568, 12627.0, 12706.0, 236060.0, 236422.0, 239109.0, 239206.0, 240236.0, 54046.729766350916, 54201.1869821953, 54500.72749636226, 54873.725631372385, 54898.45101549013, 1477.726620575197, 1489.9031562948373, 1509.9094054356774, 1515.0, 1515.515035188751, 23425.531489369776, 23629.172978945655, 23710.0, 23721.16975905835, 23835.0, 38005.80997095107, 38011.809940950116, 38050.2389952205, 38059.61940380672, 38111.237775244896, 181584.0, 182376.0, 182754.0, 182826.0, 182997.0, 31329.0, 31994.68005319917, 35012.64987350094, 35214.47178292379, 36007.759301662976, 44352.7782361099, 45853.0, 46130.308045378675, 46188.7690561545, 46408.76795616, 33782.0, 33834.0, 34349.48475772915, 34353.48469772905, 34636.307273853876, 32942.67057329396, 33240.66759332376, 33529.66470335363, 33772.49341259834, 34037.48943765895, 36148.638513614525, 36494.0, 36496.63503364933, 36501.26997460089, 36629.81685091557, 31785.682143178274, 32002.0, 32034.67965320317, 32212.83893580517, 32427.837860811487, 23610.88194559016, 25238.87380563159, 25751.871240643675, 25858.87070564635, 25859.0], "value": 17340.630995980617, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.282091743486, 568.6730130175149, 570.6988067206768, 578.306032760687, 591.7514643849582, 22002.88998555007, 22997.080116795307, 23012.65481017784, 23070.423239419044, 24082.277531674034, 25892.74107258927, 26498.602520962202, 26529.204123876265, 26551.867240663818, 26560.867195663996, 6467.611943283418, 6571.211454625428, 6583.045458408528, 6602.570832895846, 6619.669016549177, 5882.294124705041, 6101.35935726749, 6383.6808159592065, 6390.041493775924, 6390.520710946675, 6344.492440604764, 6384.010478375859, 6385.840353991141, 6386.10594516768, 6387.265464471576, 6383.744650213986, 6389.297177310492, 6390.520710946697, 6391.233052033763, 6393.680315984182, 5943.227380440559, 5958.285005799332, 5959.135925290809, 5964.582479226456, 5970.850728731773, 28855.278618034507, 29197.562036569467, 29429.264268393246, 29852.253693657614, 29994.25014374636, 1900.3633782682818, 1940.670086085369, 1956.0122138320057, 1956.7554055743033, 1958.6866101423705, 19273.421797345964, 19365.612687746307, 19557.80442195574, 20415.591688166154, 20439.693404598944, 2447.816413768957, 2464.7288798232357, 2517.332906779705, 2524.9873750631127, 2528.304716203059, 136536.0, 137627.0, 138648.0, 139691.0, 140277.2986135073, 14555.0, 14576.708465830625, 15002.324895379516, 15166.393344266326, 15404.768928466083, 23793.762062379155, 23903.282901512634, 23905.7609423907, 23919.0, 23971.520569588858, 9575.856362154573, 9664.855027174597, 9685.70942871715, 9879.901200988043, 9879.901200988043, 7192.82017949545, 8770.38607297483, 8813.911860881437, 8966.730998070068, 9072.90927090734, 7985.760427187193, 9218.492982886006, 9233.953830230806, 9246.491442970566, 9403.952980235192, 2658.441727237263, 2662.6420525532117, 2739.4794988952035, 2755.586662000716, 2797.762190213814, 952.2334520710756, 966.9846661005915, 973.868527748759, 982.9115379615869, 984.3798407003542, 19732.013399329975, 19946.30187943415, 20268.493287667632, 20377.796222037887, 20661.690074648894, 1032.26193271811, 1034.896510348959, 1042.7080417483116, 1043.6242952537082, 1044.99477502612, 11069.833952490719, 11088.778224435466, 11190.832137517944, 11330.60342887995, 11435.256708313933, 482669.0, 492808.0, 495358.0, 496185.0, 497163.0, 107019.46490267498, 112386.43806781077, 114697.4265128669, 115330.0, 115840.0, 1181.4147588679436, 1213.2114125818289, 1239.0335538280156, 1239.7458521003173, 1240.2248594628356, 17862.285508579513, 17930.5517362067, 18002.459926202235, 18310.908445457688, 18610.53473663115, 55335.16997245125, 55678.72160639171, 56104.0, 56308.43691563196, 57163.0, 70560.0, 71227.28772712415, 71242.2189445268, 71487.28512715014, 71641.28358716346, 12314.26114433101, 12750.553730619384, 14185.858141418867, 14617.122972621677, 14927.552173434815, 23315.650265245695, 23705.288841334786, 23744.762552374254, 24446.26661200167, 24488.877555612107, 19136.234550618377, 19433.708494372313, 19443.805561944766, 19542.706859397404, 19545.70681439808, 17596.82403175952, 17650.470485885446, 17657.735133973256, 17671.29314827444, 17808.109594519963, 19498.0, 19539.804601953798, 19959.0, 20019.0, 20264.59470810605, 14711.411543538567, 14813.555593332218, 14950.626234344229, 15028.023178493362, 15240.237988100329, 18432.17055232491, 18592.256309747998, 18593.90703046476, 18693.439196824118, 18942.242310307985], "value": 12000.338613264224, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.5357125006246, 1391.6451304917246, 1402.1236727045596, 1402.635314818147, 1408.964775880603, 14190.503332383369, 14443.711125777478, 14770.11379317239, 14771.556853294405, 14785.778213326808, 14717.116972981628, 14999.625009374771, 15015.099094054338, 15033.849661503382, 15038.097714137159, 2676.7189445108274, 2714.1450443110457, 2717.5244332241878, 2718.130198336533, 2718.4698983698186, 2598.0, 2611.425486393, 2698.3119304577403, 2756.9172924812287, 2761.9861900690466, 2755.4902343066497, 2773.278947473651, 2780.666320041598, 2782.5408807546733, 2782.6660800703944, 2633.4074833162576, 2661.3479697474245, 2663.8268512546624, 2668.6664166979126, 2714.470678217748, 2570.9485810283877, 2592.1057235253807, 2613.124603257911, 2659.760621544051, 2663.640408544841, 14145.0, 14218.0, 14268.0, 14308.28458577067, 14309.069910455892, 7491.101067871836, 7733.033370828646, 7737.535747855147, 7739.496932699357, 7744.148143704188, 4972.229304457815, 5085.160948443502, 5171.870703232412, 5225.137852254374, 5232.2674825524455, 1865.1793210987123, 1903.1530968718926, 1909.3412772593433, 1938.8255057044935, 1945.902704864751, 23780.40548986272, 23863.284101476984, 23873.448225865264, 23945.88027059871, 23965.0, 6548.738050477928, 6568.146141001639, 6623.790704478228, 6722.159730033746, 6753.898691519631, 16519.6696066078, 16571.337146514245, 16576.6684666306, 16583.17084145788, 16589.253483593267, 7488.513246638951, 7615.809604759815, 7624.351930086005, 7627.809304767315, 7630.694772209049, 6895.0, 6959.338862808025, 7013.3687968082095, 7166.140063192451, 7166.426685865118, 4970.453250142481, 5171.793128274827, 5176.197689358156, 5182.144946083929, 5207.869803254949, 1380.1994842991041, 1412.5056230319306, 1530.3496014193922, 1550.8991915525455, 1567.764835274695, 868.5700578213824, 890.9153630405101, 894.141624040915, 900.9414388064755, 904.4980036080038, 8471.0, 8805.779855503535, 8869.911300887037, 8954.462732235956, 9199.77000574991, 926.990730092704, 973.6592192732628, 982.5824024789435, 983.7589790501373, 1008.0675375277839, 5182.8963420732125, 5310.495502927216, 5395.73021348931, 5693.4875861172695, 5842.737076831553, 20560.485987850425, 20804.0, 20869.37391878246, 21017.159313627282, 21042.368728938156, 19373.903130484257, 20059.49851253701, 20505.89747051255, 20524.89737551303, 20572.794272057086, 10910.836337454944, 11123.110151187886, 11128.165387596124, 11145.442727863574, 11162.609308674157, 8353.122922093093, 8620.672428435779, 8839.558022098998, 8855.867161992704, 9025.187733104052, 17820.55448613795, 17832.465026049238, 17945.192466339307, 17957.281708732025, 17973.460796176136, 18395.448136555926, 18510.0, 18524.629507410045, 18534.907325463286, 18688.34590789316, 12050.698732531406, 12304.692382690504, 12305.200161989442, 12311.19977201479, 12346.629601111981, 12364.62906112782, 13512.189268643913, 13741.862581374058, 13829.377678004716, 13859.307034648025, 10094.444805535471, 11412.543498259976, 11417.657470275904, 11575.71060723455, 11690.415479226174, 10676.679699609023, 10780.730481738019, 10859.945700271448, 10890.727731806768, 11031.613893513688, 9672.129508344282, 9825.4104753715, 9833.60665573369, 9837.803243934937, 9844.360116592685, 7021.43828493709, 7042.0, 7085.787426377011, 7095.361417472453, 7138.321859423347, 7090.964545177448, 7199.604021778852, 7255.746048888263, 7264.273572642694, 7313.48805583604], "value": 6580.638942417562, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.0512050443019, 501.76012692746303, 520.448324775738, 522.1332587904079, 524.9763760630774, 6254.343293954137, 6260.186175797146, 6261.655608941506, 6344.58760180588, 6370.108184854124, 5911.527077833774, 6087.147799308101, 6121.908171377433, 6138.176438838129, 6180.03358387974, 4969.105560999019, 4982.128127577677, 4987.326710894019, 5027.49725027498, 5038.420581633122, 5008.1486147355035, 5016.924746128811, 5030.547250747432, 5047.570956468705, 5091.79632814687, 4753.120672675549, 4943.876403089934, 4980.27785971034, 4985.551300382965, 4987.650864439491, 4899.510048995107, 4935.531124543163, 4954.628402869781, 4964.280179374006, 5002.9499705002845, 4451.464244835526, 4474.6420286377015, 4476.171908196994, 4486.282194848841, 4508.301213311942, 5958.0, 5965.3736357682255, 5999.910001349983, 6039.335673075958, 6052.0, 5744.195812586199, 5770.884582308372, 5774.538036957076, 5794.565407594448, 5814.680192589406, 6389.6805159741825, 6462.0306953956815, 6480.3195664455025, 6480.57876238043, 6555.3772391622715, 4802.831900883452, 4857.077155340509, 4883.169861123618, 4897.967343552422, 4910.852674419773, 6902.206246281692, 6968.477364197705, 6981.82545436358, 6988.860222795515, 6989.231184569693, 4985.426675932242, 5022.773975171126, 5023.447420783711, 5034.320366750442, 5108.0, 5091.7963281469065, 5113.335266415343, 5139.331886854759, 5144.485551444825, 5146.0, 5686.606781338599, 5707.600467967285, 5710.885782284331, 5764.481196692234, 5770.13447982806, 6504.934950650433, 6550.181227346582, 6553.868922621521, 6639.535232533676, 6736.663166841737, 1663.891847029939, 1701.702202114625, 1727.417510821305, 1752.2027477497709, 1764.3119183518438, 1401.7827236778317, 1446.132320607627, 1447.1389523233659, 1450.4125829039256, 1458.2052781234254, 5566.777328906879, 5639.802606908738, 5662.603617746719, 5689.516391106719, 5722.484976352148, 6467.838304042437, 6537.365658585353, 6549.345065493412, 6618.305077966744, 6730.528862979544, 5722.828315150469, 5744.425557444222, 5837.591368604157, 5887.380115848407, 5896.557758168155, 3549.0240183949622, 3551.8989113374937, 3566.6789988901123, 3594.0, 3595.8741444049856, 6519.522581419125, 6528.673566321665, 6577.572457790228, 6606.0, 6658.300878407795, 6967.581945083311, 6990.811562034466, 7025.367716905503, 7028.332308430691, 7072.257412971667, 6545.4654486577665, 6556.18047744032, 6571.5728477647845, 6579.0, 6644.501662375341, 6802.829929251809, 6837.453003759787, 6848.212455567674, 6863.347981941708, 6897.448204143556, 6688.3646053624825, 6751.122354093936, 6759.0, 6767.221769496571, 6799.2520822708475, 6485.643289618927, 6551.967240163959, 6581.276059633341, 6649.567778094409, 6650.403903063133, 5051.924221136613, 5072.163093089746, 5100.775813804586, 5102.729285467931, 5108.259302401206, 6797.320267973163, 6886.51794374389, 6900.3444672756, 6904.171499420102, 6916.861662766817, 6538.738450461929, 6543.484995353191, 6566.274995876658, 6629.767958121635, 6633.568818026813, 6519.8044058678315, 6524.836879078061, 6554.115194448688, 6609.603423794588, 6628.204615446178, 6221.377862213742, 6279.591826531261, 6403.295637479967, 6406.970528135392, 6503.902441463477, 6563.310852360433, 6598.901016484852, 6628.171478565179, 6643.9335606645245, 6658.83352916181, 6280.748770049329, 6301.6219026858535, 6363.7772677956045, 6368.993766963392, 6393.104965304768], "value": 5096.608170201351, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.7387857521323, 915.7619019055044, 921.3734660430907, 935.4995077633467, 941.6327632223432, 17113.144342782874, 17642.735358969625, 17666.734998975026, 17726.202320895558, 17742.55643608909, 16058.678826423493, 16362.181890905436, 20024.0, 21645.45886352842, 21730.565388692256, 1017.2828156149934, 1058.925875188737, 1061.1563806773595, 1061.3790932304573, 1062.2511129653615, 949.9620015199383, 1047.1151876664208, 1060.0194819791661, 1062.5112448273803, 1063.8085144673955, 1098.6868742408415, 1099.1591432554103, 1099.274478843959, 1099.4008265495324, 1106.590561492249, 1090.225939582893, 1098.1983152298867, 1098.3080659184743, 1099.0438318662775, 1109.6171820721838, 810.7243537197322, 811.5901469757794, 811.8985126859143, 816.9468984516047, 822.3914303415429, 19910.60178796416, 19967.700484492743, 20083.598328033502, 20246.49383765403, 20302.69545956812, 19782.109805058808, 20274.69587956182, 20348.796512034987, 20365.981700914894, 20575.485612859797, 16759.329626814913, 16815.41146059894, 17108.315667373292, 17176.914115429343, 17208.311667533282, 3593.6765691087667, 3615.1685112424025, 3624.5106910567265, 3626.057225121461, 3629.491871138043, 128492.0, 128715.35642321823, 131655.99999999904, 132638.0, 132999.33500332534, 16224.756628650579, 16241.350345986264, 16364.099974501278, 16606.916965415097, 16836.410725624544, 30631.8468407661, 31174.376512469622, 31209.0, 31217.68782312193, 31372.215694607818, 8772.0, 8786.033536311, 8820.382573219813, 8830.77923051916, 8865.290776737975, 4077.6533994610195, 4079.7348172369293, 4141.772202528829, 4157.08544120293, 4167.187398457272, 5297.735113244323, 5423.538999185113, 5424.105022671294, 5433.022056029874, 5447.400785913546, 883.1830556734994, 907.3421769217397, 921.502388710089, 931.5528546297815, 935.3265648732902, 601.7472661482188, 614.9169862068653, 623.4825095170997, 625.9749610015548, 639.5043841023152, 10422.5830966762, 10494.632687855888, 11022.393768342657, 11372.26080304794, 11410.486528106256, 664.2460806984011, 671.3454381977533, 676.09403399444, 677.3463607618573, 678.1861765880864, 5267.499587539178, 5292.629515933924, 5301.098813201765, 5344.652597581145, 5409.161579955114, 107427.0, 111103.0, 111633.44183279194, 111795.0, 116351.0, 91913.5404322974, 93324.0, 95490.65782697572, 99342.5032874831, 100409.99590004153, 80850.0, 82159.5892020548, 82709.58645206735, 83137.0, 84796.0, 12300.384980751105, 12391.256524608552, 12419.254844709347, 12477.563285284972, 12542.930416481178, 38531.0, 38843.80578097091, 39311.803440982614, 39424.40863386994, 40193.79903100466, 47676.0, 50435.74782126066, 50577.49422505728, 62279.6886015567, 71103.0, 16853.747193791856, 17608.207630656907, 18386.724199136755, 18521.166547505127, 18951.14719837583, 19022.524436889187, 19172.328968486036, 21419.0, 21728.782712172677, 21832.45418864541, 18266.0, 18463.815361846748, 18656.720149197503, 18832.905835471283, 18849.0, 18645.160967756212, 18663.533411664816, 19137.52156196106, 19159.0, 19187.0, 17962.550936226176, 18863.43409697711, 18978.335758248395, 19591.0, 19631.214751409785, 13313.46746130144, 13345.266010369523, 13445.731085378433, 13688.589342319747, 13913.930430347784, 12638.304893230961, 13929.58211253664, 13948.302584870513, 14057.437702492194, 14228.573142805732], "value": 9057.051527657588, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 111.0, 101.0, 109.0, 108.0, 110.0, 107.0, 105.0, 107.0, 111.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 144.0, 141.0, 164.0, 117.0, 145.0, 145.0, 122.0, 171.0, 131.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 163.0, 161.0, 163.0, 162.0, 167.0, 164.0, 174.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 79.0, 179.0, 77.0, 75.0, 81.0, 76.0, 157.0, 77.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 138.0, 79.0, 78.0, 79.0, 128.0, 78.0, 82.0, 129.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 113.0, 114.0, 114.0, 113.0, 114.0, 117.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 149.0, 149.0, 150.0, 150.0, 156.0, 150.0, 150.0, 149.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 98.0, 93.0, 94.0, 94.0, 97.0, 93.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 54.0, 55.0, 53.0, 56.0, 57.0, 52.0, 52.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 58.0, 54.0, 54.0, 53.0, 55.0, 54.0, 54.0, 61.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 81.0, 78.0, 77.0, 86.0, 86.0, 77.0, 77.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 134.0, 130.0, 126.0, 128.0, 120.0, 122.0, 124.0, 172.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 186.0, 179.0, 189.0, 189.0, 180.0, 189.0, 189.0, 177.0, 179.0], "value": 183.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 71.0, 77.0, 70.0, 70.0, 71.0, 67.0, 75.0, 69.0], "value": 71.8, "unit": "score"}]}]} 20:26:21 INFO - Return code: 0 20:26:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:26:21 INFO - # TBPL SUCCESS # 20:26:21 INFO - Running post-action listener: _package_coverage_data 20:26:21 INFO - Running post-action listener: _resource_record_post_action 20:26:21 INFO - [mozharness: 2017-08-16 03:26:21.369511Z] Finished run-tests step (success) 20:26:21 INFO - Running post-run listener: _resource_record_post_run 20:26:21 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 6094848; Write bytes: 442830848; Read time: 2816; Write time: 368980 20:26:21 INFO - TinderboxPrint: CPU usage
13.1% 20:26:21 INFO - TinderboxPrint: I/O read bytes / time
6,094,848 / 2,816 20:26:21 INFO - TinderboxPrint: I/O write bytes / time
442,830,848 / 368,980 20:26:21 INFO - TinderboxPrint: CPU idle
8,281.3 (86.8%) 20:26:21 INFO - TinderboxPrint: CPU user
1,200.4 (12.6%) 20:26:21 INFO - TinderboxPrint: Swap in / out
0 / 0 20:26:21 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 118382592; Read time: 128; Write time: 98920 20:26:21 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 20:26:21 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 3850240; Write bytes: 324448256; Read time: 2500; Write time: 270060 20:26:21 INFO - Running post-run listener: _upload_blobber_files 20:26:22 INFO - Blob upload gear active. 20:26:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:26:22 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:26:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:23 INFO - (blobuploader) - INFO - Done attempting. 20:26:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:26:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:26:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:24 INFO - (blobuploader) - INFO - Done attempting. 20:26:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:26:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:26:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:30 INFO - (blobuploader) - INFO - Done attempting. 20:26:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:26:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:26:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:31 INFO - (blobuploader) - INFO - Done attempting. 20:26:31 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:31 INFO - Return code: 0 20:26:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:31 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/197f4ff2beb60c3cd796ca68827a56d3c25b426935cba8e4bb5271609343edba191435e9639c6707416673091762d62fa09f84d8038e1d43aca6143ad18c7a93", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d53ab33b7eedb96545f53e093e3890c24d4801ba96b65dc5f3a02d13cc7c82407dceb2aa8e1ab8abc158cafc5b19c84e8cd72d0d545e5825f40d785b11763f9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1f630896ba0430a9210c060ab1846509d35654f42a178f23ee6586e5f795eb64901f79abededcba36c7e6aea83656ed1cba75e63eb935ccbf1ff537aa5232b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60d235e54b5148f4a75e46b26164a6577a8419c7f5a57505ac7760e794ef32955e6e401559e6abc695ad8bf509d1332f9540235b74c142cbec2f04dde16f9e98"} 20:26:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:31 INFO - Contents: 20:26:31 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/197f4ff2beb60c3cd796ca68827a56d3c25b426935cba8e4bb5271609343edba191435e9639c6707416673091762d62fa09f84d8038e1d43aca6143ad18c7a93", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d53ab33b7eedb96545f53e093e3890c24d4801ba96b65dc5f3a02d13cc7c82407dceb2aa8e1ab8abc158cafc5b19c84e8cd72d0d545e5825f40d785b11763f9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1f630896ba0430a9210c060ab1846509d35654f42a178f23ee6586e5f795eb64901f79abededcba36c7e6aea83656ed1cba75e63eb935ccbf1ff537aa5232b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60d235e54b5148f4a75e46b26164a6577a8419c7f5a57505ac7760e794ef32955e6e401559e6abc695ad8bf509d1332f9540235b74c142cbec2f04dde16f9e98"} 20:26:31 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:31 INFO - Copying logs to upload dir... 20:26:31 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.234800 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-15 20:26:31.612861) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:31.621619) ========= 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=a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/197f4ff2beb60c3cd796ca68827a56d3c25b426935cba8e4bb5271609343edba191435e9639c6707416673091762d62fa09f84d8038e1d43aca6143ad18c7a93", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d53ab33b7eedb96545f53e093e3890c24d4801ba96b65dc5f3a02d13cc7c82407dceb2aa8e1ab8abc158cafc5b19c84e8cd72d0d545e5825f40d785b11763f9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1f630896ba0430a9210c060ab1846509d35654f42a178f23ee6586e5f795eb64901f79abededcba36c7e6aea83656ed1cba75e63eb935ccbf1ff537aa5232b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60d235e54b5148f4a75e46b26164a6577a8419c7f5a57505ac7760e794ef32955e6e401559e6abc695ad8bf509d1332f9540235b74c142cbec2f04dde16f9e98"} build_url:https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/197f4ff2beb60c3cd796ca68827a56d3c25b426935cba8e4bb5271609343edba191435e9639c6707416673091762d62fa09f84d8038e1d43aca6143ad18c7a93", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d53ab33b7eedb96545f53e093e3890c24d4801ba96b65dc5f3a02d13cc7c82407dceb2aa8e1ab8abc158cafc5b19c84e8cd72d0d545e5825f40d785b11763f9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1f630896ba0430a9210c060ab1846509d35654f42a178f23ee6586e5f795eb64901f79abededcba36c7e6aea83656ed1cba75e63eb935ccbf1ff537aa5232b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60d235e54b5148f4a75e46b26164a6577a8419c7f5a57505ac7760e794ef32955e6e401559e6abc695ad8bf509d1332f9540235b74c142cbec2f04dde16f9e98"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:31.654363) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:31.654702) ========= 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=a0d2d2de893abaa8702a9954000001a7-1502851648.967186-813861834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:31.737033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:26:31.739355) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:26:31.739685) ========= ========= Total master_lag: 0.23 =========