builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1502322920.37 results: success (0) revision: a4a448ba7f187069fce916ee234a06cbb0d06f80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-09 16:55:20.368573) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-09 16:55:20.369391) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-09 16:55:20.369673) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-09 16:55:20.416455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:55:20.416929) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-09 16:55:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-08-09 16:55:20 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105814 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:55:20.536311) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:55:20.536670) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020171 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:55:20.586353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:55:20.586691) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a4a448ba7f187069fce916ee234a06cbb0d06f80 --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 a4a448ba7f187069fce916ee234a06cbb0d06f80 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-09 16:55:20,780 truncating revision to first 12 chars 2017-08-09 16:55:20,780 Setting DEBUG logging. 2017-08-09 16:55:20,781 attempt 1/10 2017-08-09 16:55:20,781 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a4a448ba7f18?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-09 16:55:21,249 unpacking tar archive at: mozilla-central-a4a448ba7f18/testing/mozharness/ program finished with exit code 0 elapsedTime=0.777953 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:55:21.376853) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-09 16:55:21.377130) ========= script_repo_revision: a4a448ba7f187069fce916ee234a06cbb0d06f80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-09 16:55:21.377481) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-09 16:55:21.377756) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-09 16:55:21.389232) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-09 16:55:21.389499) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:55:21 INFO - MultiFileLogger online at 20170809 16:55:21 in /builds/slave/test 16:55:21 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 16:55:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:55:21 INFO - {'append_to_log': False, 16:55:21 INFO - 'base_work_dir': '/builds/slave/test', 16:55:21 INFO - 'blob_upload_branch': 'Firefox', 16:55:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:55:21 INFO - 'branch': 'Firefox', 16:55:21 INFO - 'buildbot_json_path': 'buildprops.json', 16:55:21 INFO - 'code_coverage': False, 16:55:21 INFO - 'config_files': ('talos/linux_config.py',), 16:55:21 INFO - 'default_actions': ('clobber', 16:55:21 INFO - 'read-buildbot-config', 16:55:21 INFO - 'download-and-extract', 16:55:21 INFO - 'populate-webroot', 16:55:21 INFO - 'create-virtualenv', 16:55:21 INFO - 'install', 16:55:21 INFO - 'setup-mitmproxy', 16:55:21 INFO - 'run-tests'), 16:55:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:55:21 INFO - 'disable_ccov_upload': False, 16:55:21 INFO - 'download_minidump_stackwalk': True, 16:55:21 INFO - 'download_symbols': 'ondemand', 16:55:21 INFO - 'enable_stylo': False, 16:55:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:55:21 INFO - 'tooltool.py': '/tools/tooltool.py', 16:55:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:55:21 INFO - '/tools/misc-python/virtualenv.py')}, 16:55:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:55:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:55:21 INFO - 'gecko_profile': False, 16:55:21 INFO - 'gecko_profile_interval': 0, 16:55:21 INFO - 'installer_path': 'installer.exe', 16:55:21 INFO - 'log_level': 'info', 16:55:21 INFO - 'log_name': 'talos', 16:55:21 INFO - 'log_to_console': True, 16:55:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:55:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:55:21 INFO - 'opt_config_files': (), 16:55:21 INFO - 'pip_index': False, 16:55:21 INFO - 'suite': 'dromaeojs-e10s', 16:55:21 INFO - 'system_bits': '32', 16:55:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:55:21 INFO - 'title': 'talos-linux64-ix-034', 16:55:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:55:21 INFO - 'use_talos_json': True, 16:55:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:55:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:55:21 INFO - 'work_dir': 'build'} 16:55:21 INFO - [mozharness: 2017-08-09 23:55:21.694814Z] Running clobber step. 16:55:21 INFO - Running pre-action listener: _resource_record_pre_action 16:55:21 INFO - Running main action method: clobber 16:55:21 INFO - rmtree: /builds/slave/test/build 16:55:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:55:22 INFO - Running post-action listener: _resource_record_post_action 16:55:22 INFO - [mozharness: 2017-08-09 23:55:22.729949Z] Finished clobber step (success) 16:55:22 INFO - [mozharness: 2017-08-09 23:55:22.730050Z] Running read-buildbot-config step. 16:55:22 INFO - Running pre-action listener: _resource_record_pre_action 16:55:22 INFO - Running main action method: read_buildbot_config 16:55:22 INFO - Using buildbot properties: 16:55:22 INFO - { 16:55:22 INFO - "project": "", 16:55:22 INFO - "product": "firefox", 16:55:22 INFO - "who": "ryanvm@gmail.com", 16:55:22 INFO - "installer_path": "public/build/target.tar.bz2", 16:55:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:55:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:55:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 16:55:22 INFO - "stage_platform": "linux64-pgo", 16:55:22 INFO - "basedir": "/builds/slave/test", 16:55:22 INFO - "buildnumber": 116, 16:55:22 INFO - "platform": "ubuntu64_hw", 16:55:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:55:22 INFO - "slavebuilddir": "test", 16:55:22 INFO - "taskId": "XUP196lCQM2auKWVJKEPpg", 16:55:22 INFO - "branch": "mozilla-central", 16:55:22 INFO - "script_repo_revision": "production", 16:55:22 INFO - "revision": "a4a448ba7f187069fce916ee234a06cbb0d06f80", 16:55:22 INFO - "slavename": "talos-linux64-ix-034", 16:55:22 INFO - "repo_path": "mozilla-central" 16:55:22 INFO - } 16:55:22 INFO - Finding installer, test and symbols from parent task. 16:55:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XUP196lCQM2auKWVJKEPpg'}, attempt #1 16:55:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XUP196lCQM2auKWVJKEPpg'}, attempt #1 16:55:23 INFO - Task dependencies: Fg3PAxRJSjOmHq9TmKc96Q 16:55:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q'}, attempt #1 16:55:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.tar.bz2 16:55:24 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.test_packages.json 16:55:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.crashreporter-symbols.zip 16:55:24 INFO - Running post-action listener: _resource_record_post_action 16:55:24 INFO - [mozharness: 2017-08-09 23:55:24.045312Z] Finished read-buildbot-config step (success) 16:55:24 INFO - [mozharness: 2017-08-09 23:55:24.045539Z] Running download-and-extract step. 16:55:24 INFO - Running pre-action listener: _resource_record_pre_action 16:55:24 INFO - Running main action method: download_and_extract 16:55:24 INFO - mkdir: /builds/slave/test/build/tests 16:55: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')]} 16:55:24 INFO - trying https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.test_packages.json 16:55:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:55:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:55:24 INFO - Downloaded 989 bytes. 16:55:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:55:24 INFO - Using the following test package requirements: 16:55:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:55:24 INFO - u'common': [u'target.common.tests.zip'], 16:55:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:55:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:55:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:55:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:55:24 INFO - u'mozbase': [u'target.common.tests.zip'], 16:55:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:55:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:55:24 INFO - u'web-platform': [u'target.common.tests.zip', 16:55:24 INFO - u'target.web-platform.tests.tar.gz'], 16:55:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:55:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:55:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.common.tests.zip 16:55:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:55:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.common.tests.zip into memory 16:55:27 INFO - Content-Length response header: 54896973 16:55:27 INFO - Bytes received: 54896973 16:55:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:55:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.common.tests.zip 16:55:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:55:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.common.tests.zip into memory 16:55:39 INFO - Content-Length response header: 54896973 16:55:39 INFO - Bytes received: 54896973 16:55:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.talos.tests.zip 16:55:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:55:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.talos.tests.zip into memory 16:55:54 INFO - Content-Length response header: 14496008 16:55:54 INFO - Bytes received: 14496008 16:55:54 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')]} 16:55:54 INFO - trying https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.tar.bz2 16:55:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:55:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:55:55 INFO - Downloaded 62789687 bytes. 16:55:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.tar.bz2 16:55:55 INFO - mkdir: /builds/slave/test/properties 16:55:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:55:55 INFO - Writing to file /builds/slave/test/properties/build_url 16:55:55 INFO - Contents: 16:55:55 INFO - build_url:https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.tar.bz2 16:55:55 INFO - Running post-action listener: _resource_record_post_action 16:55:55 INFO - Running post-action listener: set_extra_try_arguments 16:55:55 INFO - [mozharness: 2017-08-09 23:55:55.847071Z] Finished download-and-extract step (success) 16:55:55 INFO - [mozharness: 2017-08-09 23:55:55.847170Z] Running populate-webroot step. 16:55:55 INFO - Running pre-action listener: _resource_record_pre_action 16:55:55 INFO - Running main action method: populate_webroot 16:55:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:55:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:55:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:55:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:55:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:55:55 INFO - 'tests': ['damp', 'tps']}, 16:55:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:55:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:55:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:55:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:55:55 INFO - 'other-e10s': {'tests': ['a11yr', 16:55:55 INFO - 'ts_paint', 16:55:55 INFO - 'tpaint', 16:55:55 INFO - 'sessionrestore', 16:55:55 INFO - 'sessionrestore_many_windows', 16:55:55 INFO - 'sessionrestore_no_auto_restore', 16:55:55 INFO - 'tabpaint']}, 16:55:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:55:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:55:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:55:55 INFO - 'tsvgr_opacity', 16:55:55 INFO - 'tart', 16:55:55 INFO - 'tscrollx', 16:55:55 INFO - 'tsvg_static']}, 16:55:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:55:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:55:55 INFO - 'talos_options': ['--mitmproxy', 16:55:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:55:55 INFO - '--firstNonBlankPaint'], 16:55:55 INFO - 'tests': ['tp6_google', 16:55:55 INFO - 'tp6_youtube', 16:55:55 INFO - 'tp6_amazon', 16:55:55 INFO - 'tp6_facebook']}, 16:55:55 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:55:55 INFO - 'talos_options': ['--stylo', 16:55:55 INFO - '--mitmproxy', 16:55:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:55:55 INFO - '--firstNonBlankPaint'], 16:55:55 INFO - 'tests': ['tp6_google', 16:55:55 INFO - 'tp6_youtube', 16:55:55 INFO - 'tp6_amazon', 16:55:55 INFO - 'tp6_facebook']}, 16:55:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:55:55 INFO - 'talos_options': ['--stylo', 16:55:55 INFO - '--stylo-threads=1', 16:55:55 INFO - '--mitmproxy', 16:55:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:55:55 INFO - '--firstNonBlankPaint'], 16:55:55 INFO - 'tests': ['tp6_google', 16:55:55 INFO - 'tp6_youtube', 16:55:55 INFO - 'tp6_amazon', 16:55:55 INFO - 'tp6_facebook']}, 16:55:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:55:55 INFO - 'talos_options': ['--xperf_path', 16:55:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:55:55 INFO - 'tests': ['tp5n']}}} 16:55:55 INFO - Running post-action listener: _resource_record_post_action 16:55:55 INFO - [mozharness: 2017-08-09 23:55:55.855645Z] Finished populate-webroot step (success) 16:55:55 INFO - [mozharness: 2017-08-09 23:55:55.855735Z] Running create-virtualenv step. 16:55:55 INFO - Running pre-action listener: _resource_record_pre_action 16:55:55 INFO - Running main action method: create_virtualenv 16:55:55 INFO - Creating virtualenv /builds/slave/test/build/venv 16:55:55 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 16:55:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:55:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:55:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:55:55 INFO - Using real prefix '/usr' 16:55:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:55:56 INFO - Installing distribute.............................................................................................................................................................................................done. 16:55:58 INFO - Installing pip.................done. 16:55:58 INFO - Return code: 0 16:55:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:55:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:55:58 INFO - Reading from file tmpfile_stdout 16:55:58 INFO - Output received: 16:55:58 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) 16:55:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:55:58 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')]} 16:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:58 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')]} 16:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:58 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 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f08a0>, '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 0x28f17a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f1c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', '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 16:55:58 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 16:55:58 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 16:55:58 INFO - Using env: {'DISPLAY': ':0', 16:55:58 INFO - 'HOME': '/home/cltbld', 16:55:58 INFO - 'LANG': 'en_US.UTF-8', 16:55:58 INFO - 'LANGUAGE': 'en_US:en', 16:55:58 INFO - 'LOGNAME': 'cltbld', 16:55:58 INFO - 'MAIL': '/var/mail/cltbld', 16:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:58 INFO - 'MOZ_NO_REMOTE': '1', 16:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:58 INFO - 'NO_EM_RESTART': '1', 16:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:58 INFO - 'PWD': '/builds/slave/test', 16:55:58 INFO - 'SHELL': '/bin/bash', 16:55:58 INFO - 'SHLVL': '1', 16:55:58 INFO - 'TERM': 'linux', 16:55:58 INFO - 'TMOUT': '86400', 16:55:58 INFO - 'USER': 'cltbld', 16:55:58 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', 16:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:58 INFO - '_': '/tools/buildbot/bin/python'} 16:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:58 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 16:55:58 INFO - Cleaning up... 16:55:58 INFO - Return code: 0 16:55:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:55:58 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')]} 16:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:58 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')]} 16:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:58 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 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f08a0>, '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 0x28f17a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f1c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', '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 16:55:58 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 16:55:58 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 16:55:58 INFO - Using env: {'DISPLAY': ':0', 16:55:58 INFO - 'HOME': '/home/cltbld', 16:55:58 INFO - 'LANG': 'en_US.UTF-8', 16:55:58 INFO - 'LANGUAGE': 'en_US:en', 16:55:58 INFO - 'LOGNAME': 'cltbld', 16:55:58 INFO - 'MAIL': '/var/mail/cltbld', 16:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:58 INFO - 'MOZ_NO_REMOTE': '1', 16:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:58 INFO - 'NO_EM_RESTART': '1', 16:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:58 INFO - 'PWD': '/builds/slave/test', 16:55:58 INFO - 'SHELL': '/bin/bash', 16:55:58 INFO - 'SHLVL': '1', 16:55:58 INFO - 'TERM': 'linux', 16:55:58 INFO - 'TMOUT': '86400', 16:55:58 INFO - 'USER': 'cltbld', 16:55:58 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', 16:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:58 INFO - '_': '/tools/buildbot/bin/python'} 16:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:59 INFO - Downloading/unpacking psutil>=3.1.1 16:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:56:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:56:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:56:00 INFO - Installing collected packages: psutil 16:56:00 INFO - Running setup.py install for psutil 16:56:00 INFO - building 'psutil._psutil_linux' extension 16:56:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:56:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:56:00 INFO - building 'psutil._psutil_posix' extension 16:56:00 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 16:56:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:56:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:56:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:56:00 INFO - Successfully installed psutil 16:56:00 INFO - Cleaning up... 16:56:00 INFO - Return code: 0 16:56:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:56:00 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')]} 16:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:00 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')]} 16:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:00 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 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f08a0>, '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 0x28f17a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f1c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', '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 16:56:00 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 16:56:00 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 16:56:00 INFO - Using env: {'DISPLAY': ':0', 16:56:00 INFO - 'HOME': '/home/cltbld', 16:56:00 INFO - 'LANG': 'en_US.UTF-8', 16:56:00 INFO - 'LANGUAGE': 'en_US:en', 16:56:00 INFO - 'LOGNAME': 'cltbld', 16:56:00 INFO - 'MAIL': '/var/mail/cltbld', 16:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:00 INFO - 'MOZ_NO_REMOTE': '1', 16:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:00 INFO - 'NO_EM_RESTART': '1', 16:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:00 INFO - 'PWD': '/builds/slave/test', 16:56:00 INFO - 'SHELL': '/bin/bash', 16:56:00 INFO - 'SHLVL': '1', 16:56:00 INFO - 'TERM': 'linux', 16:56:00 INFO - 'TMOUT': '86400', 16:56:00 INFO - 'USER': 'cltbld', 16:56:00 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', 16:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:00 INFO - '_': '/tools/buildbot/bin/python'} 16:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:56:02 INFO - Installing collected packages: mozsystemmonitor 16:56:02 INFO - Running setup.py install for mozsystemmonitor 16:56:02 INFO - Successfully installed mozsystemmonitor 16:56:02 INFO - Cleaning up... 16:56:02 INFO - Return code: 0 16:56:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56: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')]} 16:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f08a0>, '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 0x28f17a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f1c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', '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 16:56:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:56:02 INFO - Using env: {'DISPLAY': ':0', 16:56:02 INFO - 'HOME': '/home/cltbld', 16:56:02 INFO - 'LANG': 'en_US.UTF-8', 16:56:02 INFO - 'LANGUAGE': 'en_US:en', 16:56:02 INFO - 'LOGNAME': 'cltbld', 16:56:02 INFO - 'MAIL': '/var/mail/cltbld', 16:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:02 INFO - 'MOZ_NO_REMOTE': '1', 16:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:02 INFO - 'NO_EM_RESTART': '1', 16:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:02 INFO - 'PWD': '/builds/slave/test', 16:56:02 INFO - 'SHELL': '/bin/bash', 16:56:02 INFO - 'SHLVL': '1', 16:56:02 INFO - 'TERM': 'linux', 16:56:02 INFO - 'TMOUT': '86400', 16:56:02 INFO - 'USER': 'cltbld', 16:56:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', 16:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:02 INFO - '_': '/tools/buildbot/bin/python'} 16:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:02 INFO - Downloading/unpacking jsonschema==2.5.1 16:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:56:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:03 INFO - Downloading functools32-3.2.3-2.tar.gz 16:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:56:03 INFO - warning: no files found matching '*.txt' 16:56:03 INFO - no previously-included directories found matching 'build' 16:56:03 INFO - no previously-included directories found matching 'dist' 16:56:03 INFO - no previously-included directories found matching '.git*' 16:56:03 INFO - Installing collected packages: jsonschema, functools32 16:56:03 INFO - Running setup.py install for functools32 16:56:03 INFO - warning: no files found matching '*.txt' 16:56:03 INFO - no previously-included directories found matching 'build' 16:56:03 INFO - no previously-included directories found matching 'dist' 16:56:03 INFO - no previously-included directories found matching '.git*' 16:56:03 INFO - Successfully installed jsonschema functools32 16:56:03 INFO - Cleaning up... 16:56:03 INFO - Return code: 0 16:56:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f08a0>, '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 0x28f17a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f1c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', '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 16:56:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:56:03 INFO - Using env: {'DISPLAY': ':0', 16:56:03 INFO - 'HOME': '/home/cltbld', 16:56:03 INFO - 'LANG': 'en_US.UTF-8', 16:56:03 INFO - 'LANGUAGE': 'en_US:en', 16:56:03 INFO - 'LOGNAME': 'cltbld', 16:56:03 INFO - 'MAIL': '/var/mail/cltbld', 16:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:03 INFO - 'MOZ_NO_REMOTE': '1', 16:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:03 INFO - 'NO_EM_RESTART': '1', 16:56:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:03 INFO - 'PWD': '/builds/slave/test', 16:56:03 INFO - 'SHELL': '/bin/bash', 16:56:03 INFO - 'SHLVL': '1', 16:56:03 INFO - 'TERM': 'linux', 16:56:03 INFO - 'TMOUT': '86400', 16:56:03 INFO - 'USER': 'cltbld', 16:56:03 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', 16:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:03 INFO - '_': '/tools/buildbot/bin/python'} 16:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:56:04 INFO - Cleaning up... 16:56:04 INFO - Return code: 0 16:56:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f08a0>, '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 0x28f17a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f1c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', '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 16:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:56:04 INFO - Using env: {'DISPLAY': ':0', 16:56:04 INFO - 'HOME': '/home/cltbld', 16:56:04 INFO - 'LANG': 'en_US.UTF-8', 16:56:04 INFO - 'LANGUAGE': 'en_US:en', 16:56:04 INFO - 'LOGNAME': 'cltbld', 16:56:04 INFO - 'MAIL': '/var/mail/cltbld', 16:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:04 INFO - 'MOZ_NO_REMOTE': '1', 16:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:04 INFO - 'NO_EM_RESTART': '1', 16:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:04 INFO - 'PWD': '/builds/slave/test', 16:56:04 INFO - 'SHELL': '/bin/bash', 16:56:04 INFO - 'SHLVL': '1', 16:56:04 INFO - 'TERM': 'linux', 16:56:04 INFO - 'TMOUT': '86400', 16:56:04 INFO - 'USER': 'cltbld', 16:56:04 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', 16:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:04 INFO - '_': '/tools/buildbot/bin/python'} 16:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:04 INFO - Downloading/unpacking blobuploader==1.2.4 16:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:05 INFO - Downloading blobuploader-1.2.4.tar.gz 16:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:56:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:56:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:06 INFO - Downloading docopt-0.6.1.tar.gz 16:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:56:06 INFO - Installing collected packages: blobuploader, requests, docopt 16:56:06 INFO - Running setup.py install for blobuploader 16:56:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:56:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:56:06 INFO - Running setup.py install for requests 16:56:06 INFO - Running setup.py install for docopt 16:56:06 INFO - Successfully installed blobuploader requests docopt 16:56:06 INFO - Cleaning up... 16:56:06 INFO - Return code: 0 16:56:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56: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')]} 16:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:06 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 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f08a0>, '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 0x28f17a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f1c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', '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 16:56:06 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 16:56:06 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 16:56:06 INFO - Using env: {'DISPLAY': ':0', 16:56:06 INFO - 'HOME': '/home/cltbld', 16:56:06 INFO - 'LANG': 'en_US.UTF-8', 16:56:06 INFO - 'LANGUAGE': 'en_US:en', 16:56:06 INFO - 'LOGNAME': 'cltbld', 16:56:06 INFO - 'MAIL': '/var/mail/cltbld', 16:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:06 INFO - 'MOZ_NO_REMOTE': '1', 16:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:06 INFO - 'NO_EM_RESTART': '1', 16:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:06 INFO - 'PWD': '/builds/slave/test', 16:56:06 INFO - 'SHELL': '/bin/bash', 16:56:06 INFO - 'SHLVL': '1', 16:56:06 INFO - 'TERM': 'linux', 16:56:06 INFO - 'TMOUT': '86400', 16:56:06 INFO - 'USER': 'cltbld', 16:56:06 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', 16:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:06 INFO - '_': '/tools/buildbot/bin/python'} 16:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:06 INFO - Running setup.py (path:/tmp/pip-wt_Nbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:06 INFO - Running setup.py (path:/tmp/pip-vHn935-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:07 INFO - Running setup.py (path:/tmp/pip-i0Do8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:07 INFO - Running setup.py (path:/tmp/pip-LHE5y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:07 INFO - Running setup.py (path:/tmp/pip-b2A91a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:07 INFO - Running setup.py (path:/tmp/pip-XWTPXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:07 INFO - Running setup.py (path:/tmp/pip-16uFTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:07 INFO - Running setup.py (path:/tmp/pip-3Pfyhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:07 INFO - Running setup.py (path:/tmp/pip-A5yALr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:07 INFO - Running setup.py (path:/tmp/pip-Gli_Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:07 INFO - Running setup.py (path:/tmp/pip-cdQ302-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:07 INFO - Running setup.py (path:/tmp/pip-6C0ogt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:07 INFO - Running setup.py (path:/tmp/pip-iMSQyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:07 INFO - Running setup.py (path:/tmp/pip-9wdH1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:07 INFO - Running setup.py (path:/tmp/pip-ONJDc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:07 INFO - Running setup.py (path:/tmp/pip-YMOYY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:08 INFO - Running setup.py (path:/tmp/pip-yT1Psa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:56:08 INFO - Running setup.py install for manifestparser 16:56:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:56:08 INFO - Running setup.py install for mozcrash 16:56:08 INFO - Running setup.py install for mozdebug 16:56:08 INFO - Running setup.py install for mozdevice 16:56:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:56:08 INFO - Running setup.py install for mozfile 16:56:08 INFO - Running setup.py install for mozhttpd 16:56:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:56:08 INFO - Running setup.py install for mozinfo 16:56:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:56:08 INFO - Running setup.py install for mozInstall 16:56:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:56:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:56:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:56:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:56:08 INFO - Running setup.py install for mozleak 16:56:08 INFO - Running setup.py install for mozlog 16:56:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:56:09 INFO - Running setup.py install for moznetwork 16:56:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:56:09 INFO - Running setup.py install for mozprocess 16:56:09 INFO - Running setup.py install for mozprofile 16:56:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:56:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:56:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:56:09 INFO - Running setup.py install for mozrunner 16:56:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:56:09 INFO - Running setup.py install for mozscreenshot 16:56:09 INFO - Running setup.py install for moztest 16:56:09 INFO - Running setup.py install for mozversion 16:56:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:56:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:56:09 INFO - Cleaning up... 16:56:09 INFO - Return code: 0 16:56:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56: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')]} 16:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:09 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 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f08a0>, '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 0x28f17a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f1c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', '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 16:56:09 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 16:56:09 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 16:56:09 INFO - Using env: {'DISPLAY': ':0', 16:56:09 INFO - 'HOME': '/home/cltbld', 16:56:09 INFO - 'LANG': 'en_US.UTF-8', 16:56:09 INFO - 'LANGUAGE': 'en_US:en', 16:56:09 INFO - 'LOGNAME': 'cltbld', 16:56:09 INFO - 'MAIL': '/var/mail/cltbld', 16:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:09 INFO - 'MOZ_NO_REMOTE': '1', 16:56:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:09 INFO - 'NO_EM_RESTART': '1', 16:56:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:09 INFO - 'PWD': '/builds/slave/test', 16:56:09 INFO - 'SHELL': '/bin/bash', 16:56:09 INFO - 'SHLVL': '1', 16:56:09 INFO - 'TERM': 'linux', 16:56:09 INFO - 'TMOUT': '86400', 16:56:09 INFO - 'USER': 'cltbld', 16:56:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', 16:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:09 INFO - '_': '/tools/buildbot/bin/python'} 16:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:10 INFO - Running setup.py (path:/tmp/pip-jwAaYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:10 INFO - Running setup.py (path:/tmp/pip-lRM1ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:10 INFO - Running setup.py (path:/tmp/pip-JKXZUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:10 INFO - Running setup.py (path:/tmp/pip-z1t_5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:10 INFO - Running setup.py (path:/tmp/pip-uS1Vuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:10 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)) 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:10 INFO - Running setup.py (path:/tmp/pip-Qnoj5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:10 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)) 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:10 INFO - Running setup.py (path:/tmp/pip-k3reVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:10 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)) 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:10 INFO - Running setup.py (path:/tmp/pip-BxslYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:10 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)) 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:10 INFO - Running setup.py (path:/tmp/pip-itxpJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:10 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)) 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:10 INFO - Running setup.py (path:/tmp/pip-ucRaqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:10 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)) 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:10 INFO - Running setup.py (path:/tmp/pip-k1lu9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:10 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)) 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:10 INFO - Running setup.py (path:/tmp/pip-XCzhya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:11 INFO - Running setup.py (path:/tmp/pip-5TuauM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:11 INFO - Running setup.py (path:/tmp/pip-i9UHRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:11 INFO - Running setup.py (path:/tmp/pip-4aQMVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:11 INFO - Running setup.py (path:/tmp/pip-1FkOwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:11 INFO - Running setup.py (path:/tmp/pip-3Ep1se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:56:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:56: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 16:56: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 16:56: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 16:56: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 16:56:12 INFO - Downloading blessings-1.6.tar.gz 16:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:56:12 INFO - Installing collected packages: blessings 16:56:12 INFO - Running setup.py install for blessings 16:56:12 INFO - Successfully installed blessings 16:56:12 INFO - Cleaning up... 16:56:12 INFO - Return code: 0 16:56:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:56:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:12 INFO - Reading from file tmpfile_stdout 16:56:12 INFO - Current package versions: 16:56:12 INFO - argparse == 1.2.1 16:56:12 INFO - blessings == 1.6 16:56:12 INFO - blobuploader == 1.2.4 16:56:12 INFO - docopt == 0.6.1 16:56:12 INFO - functools32 == 3.2.3-2 16:56:12 INFO - jsonschema == 2.5.1 16:56:12 INFO - manifestparser == 1.1 16:56:12 INFO - mozInstall == 1.13 16:56:12 INFO - mozcrash == 1.0 16:56:12 INFO - mozdebug == 0.1 16:56:12 INFO - mozdevice == 0.51 16:56:12 INFO - mozfile == 1.2 16:56:12 INFO - mozhttpd == 0.7 16:56:12 INFO - mozinfo == 0.10 16:56:12 INFO - mozleak == 0.1 16:56:12 INFO - mozlog == 3.5 16:56:12 INFO - moznetwork == 0.27 16:56:12 INFO - mozprocess == 0.25 16:56:12 INFO - mozprofile == 0.28 16:56:12 INFO - mozrunner == 6.13 16:56:12 INFO - mozscreenshot == 0.1 16:56:12 INFO - mozsystemmonitor == 0.3 16:56:12 INFO - moztest == 0.8 16:56:12 INFO - mozversion == 1.4 16:56:12 INFO - psutil == 3.1.1 16:56:12 INFO - requests == 1.2.3 16:56:12 INFO - wsgiref == 0.1.2 16:56:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56: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')]} 16:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:12 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 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f08a0>, '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 0x28f17a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f1c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', '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 16:56:12 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 16:56:12 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 16:56:12 INFO - Using env: {'DISPLAY': ':0', 16:56:12 INFO - 'HOME': '/home/cltbld', 16:56:12 INFO - 'LANG': 'en_US.UTF-8', 16:56:12 INFO - 'LANGUAGE': 'en_US:en', 16:56:12 INFO - 'LOGNAME': 'cltbld', 16:56:12 INFO - 'MAIL': '/var/mail/cltbld', 16:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:12 INFO - 'MOZ_NO_REMOTE': '1', 16:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:12 INFO - 'NO_EM_RESTART': '1', 16:56:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:12 INFO - 'PWD': '/builds/slave/test', 16:56:12 INFO - 'SHELL': '/bin/bash', 16:56:12 INFO - 'SHLVL': '1', 16:56:12 INFO - 'TERM': 'linux', 16:56:12 INFO - 'TMOUT': '86400', 16:56:12 INFO - 'USER': 'cltbld', 16:56:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', 16:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:12 INFO - '_': '/tools/buildbot/bin/python'} 16:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:56:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:56: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 16:56: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 16:56: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 16:56: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 16:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:56:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:56:14 INFO - Installing collected packages: simplejson 16:56:14 INFO - Running setup.py install for simplejson 16:56:14 INFO - building 'simplejson._speedups' extension 16:56:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 16:56:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 16:56:15 INFO - Successfully installed simplejson 16:56:15 INFO - Cleaning up... 16:56:15 INFO - Return code: 0 16:56:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56: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')]} 16:56:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f08a0>, '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 0x28f17a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f1c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', '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 16:56:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:56:15 INFO - Using env: {'DISPLAY': ':0', 16:56:15 INFO - 'HOME': '/home/cltbld', 16:56:15 INFO - 'LANG': 'en_US.UTF-8', 16:56:15 INFO - 'LANGUAGE': 'en_US:en', 16:56:15 INFO - 'LOGNAME': 'cltbld', 16:56:15 INFO - 'MAIL': '/var/mail/cltbld', 16:56:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:15 INFO - 'MOZ_NO_REMOTE': '1', 16:56:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:15 INFO - 'NO_EM_RESTART': '1', 16:56:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:15 INFO - 'PWD': '/builds/slave/test', 16:56:15 INFO - 'SHELL': '/bin/bash', 16:56:15 INFO - 'SHLVL': '1', 16:56:15 INFO - 'TERM': 'linux', 16:56:15 INFO - 'TMOUT': '86400', 16:56:15 INFO - 'USER': 'cltbld', 16:56:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', 16:56:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:15 INFO - '_': '/tools/buildbot/bin/python'} 16:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:56:15 INFO - Cleaning up... 16:56:15 INFO - Return code: 0 16:56:15 INFO - Running post-action listener: _resource_record_post_action 16:56:15 INFO - Running post-action listener: _start_resource_monitoring 16:56:15 INFO - Starting resource monitoring. 16:56:15 INFO - [mozharness: 2017-08-09 23:56:15.649257Z] Finished create-virtualenv step (success) 16:56:15 INFO - [mozharness: 2017-08-09 23:56:15.649788Z] Running install step. 16:56:15 INFO - Running pre-action listener: _resource_record_pre_action 16:56:15 INFO - Running main action method: install 16:56:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:15 INFO - Reading from file tmpfile_stdout 16:56:15 INFO - Detecting whether we're running mozinstall >=1.0... 16:56:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:56:16 INFO - Reading from file tmpfile_stdout 16:56:16 INFO - Output received: 16:56:16 INFO - Usage: mozinstall [options] installer 16:56:16 INFO - Options: 16:56:16 INFO - -h, --help show this help message and exit 16:56:16 INFO - -d DEST, --destination=DEST 16:56:16 INFO - Directory to install application into. [default: 16:56:16 INFO - "/builds/slave/test"] 16:56:16 INFO - --app=APP Application being installed. [default: firefox] 16:56:16 INFO - mkdir: /builds/slave/test/build/application 16:56:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:56:33 INFO - Reading from file tmpfile_stdout 16:56:33 INFO - Output received: 16:56:33 INFO - /builds/slave/test/build/application/firefox/firefox 16:56:33 INFO - Running post-action listener: _resource_record_post_action 16:56:33 INFO - [mozharness: 2017-08-09 23:56:33.798120Z] Finished install step (success) 16:56:33 INFO - [mozharness: 2017-08-09 23:56:33.798402Z] Running setup-mitmproxy step. 16:56:33 INFO - Running pre-action listener: _resource_record_pre_action 16:56:33 INFO - Running main action method: setup_mitmproxy 16:56:33 INFO - Skipping: mitmproxy is not required 16:56:33 INFO - Running post-action listener: _resource_record_post_action 16:56:33 INFO - [mozharness: 2017-08-09 23:56:33.799561Z] Finished setup-mitmproxy step (success) 16:56:33 INFO - [mozharness: 2017-08-09 23:56:33.799783Z] Running run-tests step. 16:56:33 INFO - Running pre-action listener: _resource_record_pre_action 16:56:33 INFO - Running pre-action listener: _set_gcov_prefix 16:56:33 INFO - Running main action method: run_tests 16:56:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:56:33 INFO - Python 2.7.3 16:56:33 INFO - Return code: 0 16:56:33 INFO - grabbing minidump binary from tooltool 16:56:33 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')]} 16:56:33 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 0x28f08a0>, '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 0x28f17a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f1c30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:56:33 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 16:56:33 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 16:56:33 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 16:56:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:56:33 INFO - Return code: 0 16:56:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:56:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:56:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:56:33 INFO - ENV: RUST_BACKTRACE is now full 16:56:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:56:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:56:33 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/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:56:33 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/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:56:33 INFO - Using env: {'DISPLAY': ':0', 16:56:33 INFO - 'HOME': '/home/cltbld', 16:56:33 INFO - 'LANG': 'en_US.UTF-8', 16:56:33 INFO - 'LANGUAGE': 'en_US:en', 16:56:33 INFO - 'LOGNAME': 'cltbld', 16:56:33 INFO - 'MAIL': '/var/mail/cltbld', 16:56:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:56:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:33 INFO - 'MOZ_NO_REMOTE': '1', 16:56:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:33 INFO - 'NO_EM_RESTART': '1', 16:56:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:33 INFO - 'PWD': '/builds/slave/test', 16:56:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:56:33 INFO - 'RUST_BACKTRACE': 'full', 16:56:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:56:33 INFO - 'SHELL': '/bin/bash', 16:56:33 INFO - 'SHLVL': '1', 16:56:33 INFO - 'TERM': 'linux', 16:56:33 INFO - 'TMOUT': '86400', 16:56:33 INFO - 'USER': 'cltbld', 16:56:33 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819', 16:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:33 INFO - '_': '/tools/buildbot/bin/python'} 16:56:33 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/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:56:34 INFO - mozversion application_buildid: 20170809224807 16:56:34 INFO - mozversion application_changeset: a4a448ba7f187069fce916ee234a06cbb0d06f80 16:56:34 INFO - mozversion application_display_name: Nightly 16:56:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:56:34 INFO - mozversion application_name: Firefox 16:56:34 INFO - mozversion application_remotingname: firefox 16:56:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:56:34 INFO - mozversion application_vendor: Mozilla 16:56:34 INFO - mozversion application_version: 57.0a1 16:56:34 INFO - mozversion platform_buildid: 20170809224807 16:56:34 INFO - mozversion platform_changeset: a4a448ba7f187069fce916ee234a06cbb0d06f80 16:56:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:56:34 INFO - mozversion platform_version: 57.0a1 16:56:34 INFO - using testdate: 1502322994 16:56:34 INFO - actual date: 1502322994 16:56:34 INFO - starting webserver on 'localhost:35252' 16:56:34 INFO - SUITE-START | Running 2 tests 16:56:34 INFO - TEST-START | dromaeo_css 16:56:34 INFO - Initialising browser for dromaeo_css test... 16:56:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35252/getInfo.html -profile /tmp/tmpAeReVH/profile 16:56:34 INFO - TEST-INFO | started process 4214 (/builds/slave/test/build/application/firefox/firefox http://localhost:35252/getInfo.html) 16:56:39 INFO - TEST-INFO | 4214: exit 0 16:56:40 INFO - Browser initialized. 16:56:40 INFO - Running cycle 1/1 for dromaeo_css test... 16:56:40 INFO - TEST-INFO | started process 4426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAeReVH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:40 INFO - PID 4426 | 16:56:40 INFO - PID 4426 | (/builds/slave/test/build/application/firefox/firefox:4474): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:56:40 INFO - PID 4426 | 16:56:51 INFO - PID 4426 | RSS: Main: 164835328 16:56:51 INFO - PID 4426 | 16:59:50 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:35252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35252/tests/dromaeo/cssquery-ext.html) 16:59:51 INFO - PID 4426 | RSS: Main: 166711296 16:59:51 INFO - PID 4426 | 17:02:52 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:35252/tests/dromaeo/cssquery-ext.html (next: http://localhost:35252/tests/dromaeo/cssquery-jquery.html) 17:02:53 INFO - PID 4426 | RSS: Main: 164007936 17:02:53 INFO - PID 4426 | 17:05:54 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:35252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35252/tests/dromaeo/cssquery-mootools.html) 17:05:55 INFO - PID 4426 | RSS: Main: 165916672 17:05:55 INFO - PID 4426 | 17:08:57 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:35252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35252/tests/dromaeo/cssquery-prototype.html) 17:08:57 INFO - PID 4426 | RSS: Main: 164204544 17:08:57 INFO - PID 4426 | 17:12:01 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:35252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35252/tests/dromaeo/cssquery-yui.html) 17:12:01 INFO - PID 4426 | RSS: Main: 167911424 17:12:01 INFO - PID 4426 | 17:15:03 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:35252/tests/dromaeo/cssquery-yui.html (next: http://localhost:35252/tests/dromaeo/cssquery-dojo.html) 17:15:03 INFO - PID 4426 | RSS: Main: 168357888 17:15:03 INFO - PID 4426 | 17:15:03 INFO - PID 4426 | __start_tp_report 17:15:03 INFO - PID 4426 | _x_x_mozilla_page_load 17:15:03 INFO - PID 4426 | _x_x_mozilla_page_load_details 17:15:03 INFO - PID 4426 | |i|pagename|runs| 17:15:03 INFO - PID 4426 | |0;dojo.html;3495.737819663524;3532.8586856525735;3538.044727923459;3544.0431083607427;3563.127033876701;6163.537734669895;6166.4450199482035;6199.907001394983;6213.844653883655;6223.035429508423;6090.208272924525;6134.969325153368;6145.446909778119;6224.782132625348;6348.428641422271;5402.37872644646;5408.729563521828;5496.5053145216925;5501.477359650827;5507.504324610784;5108.259302401149;5288.682679039251;5386.003589335965;5456.48163424476;5460.918086228709;5398.568114550826;5427.104527752956;5469.234307196995;5481.561475082004;5498.395176530578;5427;5438.83683489496;5497.835064948058;5505.642133261325;5516.531094856942;5401.540869026137;5421.105517589593;5426.972865135649;5435.83692489226;5452.154915988028;6115.663638499881;6125.693715314261;6138.263408390977;6178.351273116303;6217.3471785462325;6553.541252112354;6677.93322066778;6695.397414232693;6766.729330826761;6767.763128290486;6699.39705426514;6750.189977202767;6808.183018037867;6818.454523638097;6828.6927088281145;6302.590331628476;6305;6308.463780578656;6311.905321420137;6312.179416675895;6864.24493305736;6919.100516932766;6945.166580010431;7008.579485230903;7009.61447120403;6502.739890404426;6524.9673751630935;6665.766698165541;6730.528862979544;6742.224644165984;6702.865942681216;6779.35596118368;6798.150231221098;6803.387695107464;6806.863862722717;6584.670766461658;6672.666366681647;6721.26066132725;6727.428168605723;6738.258791532928;6577.408033277028;6606.834829129214;6623.3376662333385;6670.166229221348;6761.019652150509;4808.783604737795;4822.614190864722;4842.806287748521;4881.29221262922;4890.608751299887;4290.914181716348;4372.1692878353015;4375.431193944767;4401.075774087478;4401.735895846259;6447.580907241108;6452.612843229327;6519.087327774116;6530.542861999709;6533.052707357407;6721.764738234138;6731.562448440835;6732.596044237362;6813.284605116491;6823.942288945222;6282.528810339151;6358.078078678565;6361.459275961595;6363.61818290904;6507.219133703891;5372.8656783579945;5395.244665746799;5427.972860135674;5431.592630552725;5458.263134476795;7164.0328555645365;7285.672144753499;7287.089113860768;7305.525140865827;7306;6745.460363170934;6779.559328643622;6784.050232967487;6870.587764733932;6872.896906546506;6973.302669732986;7122.323379278961;7212;7263.6005019724425;7287.854242915006;6586.637734924625;6639.269680335063;6645.833854153685;6647.534672572873;6663.400293973566;6716.29478904708;6808.285130061272;6820.590764554143;6831.180258369028;6847.041414202115;6564.80305590833;6596.109525214227;6601.834954126185;6605.207375115017;6611.504137189826;6504.4796416285635;6512.6092434454085;6521.804345869631;6583.0454584086;6590;6370.108184854217;6498.480121590356;6519.380658837593;6550.410463058348;6626.867462650816;6593.934060659524;6604.603723776589;6607.53747237708;6609.107770450928;6619.50353723463;6233.906491402723;6309.085182648582;6355.682215889279;6366.427021568081;6382.808515744535 17:15:03 INFO - PID 4426 | |1;ext.html;904.3533873280605;907.8138981508787;939.5255396025007;971.7813491964305;972.0473935543167;41616.58383416165;42450.57549424509;42469;42559.787201063955;42596.361054584166;38173.80913095431;38792.61207387925;38832.41751373732;38863.41704874429;38932;6758.053872457847;6849.4862885283555;6850.314968503159;6857.485688573352;6871.175458944908;6743.426808721265;6828.897566536506;6831.829204269909;6834.316568343175;6836.5898046117145;7363.15323737769;7505.549667019969;7508.962455187717;7508.962455187744;7510.624468776539;6205.596636218631;7399.630018499053;7456.105267367896;7456.701731930716;7464.10430748311;7329.633518324063;7397.2602739726135;7400.037995060661;7400.074990626172;7404.555726656418;38222.617773822465;38774.612253877385;38939.61060389388;38974.61025389738;39067.218655626726;3490.3193877193958;3527.664871837171;3542.8937131886087;3545.2377738786026;3559.4482855157494;30900;30905.690943090507;30915.227119322197;30943.226419339473;31026.069217923497;5035.1188542005;5063.518965698253;5080.61895357846;5110.463401342842;5129.615278854101;205400;208080;209021;211301;263824;53760.19359709608;54311.45688543064;54348.72825635925;54373;54374.18438723422;56588.15117773237;56915.430845691844;56957.43042569521;57161.14258286129;57242.42757572454;17257.65484690299;17379.13104344778;17381.304747810198;17398;17528.737068943978;14256;14315;14316.642083947776;14321.140731555932;14326.713465730836;15418.922905385401;15444.046236435704;15494.767578486331;15554.9222253888;15562.377504899678;6044.7582096716515;6155.6614386209185;6215.751369945242;6343.904841427382;6384.106225128486;1056.4136904018344;1075.4783929794044;1085.2999815119204;1091.9672409827717;1114.4149321606221;24746.876265618917;24969.62545561818;25132;25152.622710659354;25378;1192.9343886086176;1207.0524638159004;1213.0841214882707;1217.7747116783423;1218.074263559701;13203.273819939996;13293.471250806087;13365.26491043002;13464.798028029587;17504;280695;282131;282825;283274;283284;60539;61281;61595.6920215396;61600;61712;1517.0745845034521;1530.7856900034226;1549.3957356630922;1549.9070055796687;1550.2791202091082;30905.69094309118;30915.536266956464;30966;31032;31828.840855795574;54438;54977.45022549723;55055;55146.44853551413;55262;245211;247987;249861;249864;250302;37075.62924370722;37731.62268377391;39626.801865990485;39744;39771.80114099411;48076.27885581789;49649.75175124101;49761;50002;50113.74943125261;36901.44647830338;37104.44343334798;37442.3150958213;37541.4368784463;37670;36045;36479.27041459209;36617.267654647294;36654.20365327292;36859.63140368669;41858.37212441877;41864.790676046425;42037.159256814084;42330.1533969325;42384;33962;34183.487247690806;34595.135121621155;35931;36330.27339453249;26478.867605662617;27443.86278068597;27606;27670.308242294104;27711.44577108406 17:15:03 INFO - PID 4426 | |2;jquery.html;573.1774903014177;573.8335882594048;573.9024365857804;580.3529065092422;584.5060923519625;23302;23887.28338149854;24184;24288.514229715416;24290.87854560727;27735;28146.718532814666;28396.148115556567;28412.857935710294;28427;6063.6968151592355;6209.3790620938;6212.0371342441995;6213.782517611885;6223.564350495467;5741.511971482429;6161.845953851145;6227.408396202376;6245.937540624581;6246.250449946013;6197.101420294055;6221.4400703936635;6221.564490485668;6224.8132556023165;6225.657588832612;6137.5089992800695;6169.81490555284;6199.473044791153;6203.2866220384785;6207.689615519206;5723;5756.769729210827;5757.539396848242;5765.250517432749;5787.826365209051;30975.845120774477;31941;32412.351752965045;32653.18367040819;32810.835945820356;2240.7759224077627;2248.6064938635673;2269.614165591853;2272.988635056814;2277.851939623919;19993.400197994084;20089.095990680453;21326.893365533073;21332.36002919915;21347.252846150466;2323.674685544025;2356.2695564374926;2393.784559389663;2395.700537432821;2409.1808785013004;156518;159363;167994;168167;168471;15483.690326193413;15890.68218635644;16263.349466021227;16502.669946601;16614.25235864389;25116;25254.494910101694;25264.24207273785;25281.241562753148;25286.24141275765;10741.570337186426;11085.057770089472;11088.279261848116;11211.719707007227;11327.603533876274;10155.136813370798;10171.28800983924;10328.535215915303;10330.535125919352;10333.328333658439;9792.657256996114;9814.312998090065;9971.551280192409;10002.149817265468;10264.948675256575;2813.08574713219;2838.8012839101066;2839.1482555233347;2841.6163817884735;2851.928701782472;1057.360297020307;1058.9403609978517;1072.222638587018;1073.5759375046969;1080.33559360994;26778.464430711276;27738.722612774018;27828.469434181316;27967;28692;1119.8264269038311;1129.9265547739535;1137.7155711072232;1144.9352102544713;1149.93675347855;12119.697007574705;12501.687457813627;12638.115331926678;12664.87335126637;12726.936365318299;583025;583641;600218;603935;611783;133836;134562;134661.3266933659;136016;141700.29149854186;1298.9090763646643;1331.40086960868;1357.3891748713118;1366.6036849313787;1370.7601169795246;23497;23678;23725.881370593037;23749.64375534334;23779.64330535078;70645;72687.63656181685;72949;76212;78188;93191;93533;95033.52483237539;95641;98635.50682246542;22967.540649186587;23653.172138975053;23739;23772.405689857893;23808.761912380654;25977.35056623524;26275.868620656773;26295.342616434744;26419.603705944042;26861.328466788487;20486.38540843777;20658;21251.149954001667;21485.67771483398;21558.245461409402;18104.547386315448;18231.179596918435;18340.266389344277;18515.72226416578;18882.433526994213;21534.353969380943;21643.783562164175;21654;21748.347549573537;21777.782222177575;22405.43986400353;23602.527949441257;23717.16989905345;23728.339016268696;23790;20146.496337591092;20716.274930377363;20733.27433539819;21007.369778906657;21038.368848934555 17:15:03 INFO - PID 4426 | |3;mootools.html;1413.738019169329;1424.195329638754;1450.1661544611845;1457.0839346259675;1460.1312219229555;15239.466618668348;15487;15803.130827804465;15817.36730530779;15820;15835.12906790126;16294.83705162948;16301.673966520662;16306;16428.507144785646;2581.9672131147504;2625.921222363332;2629.947401051978;2642.4979253941688;2655.349439387343;2698.8380697158136;2791.7627001704877;2799.860006999652;2800.0339882740423;2801.3696918193345;2713.8507382093976;2733.070755942979;2757.6690797104375;2763.4473105379006;2767.0730305347734;2698.1231099892516;2713.4166154276927;2717.442924200534;2748.244232835976;2757.586362045689;2592.494463579603;2613.8170328077044;2622.082271205082;2622.2002289301754;2623.252373073665;15124.697506049817;15199.392024319013;15316.540503784905;15366.539003829903;15423.768643470357;7903.802404939865;8182.918170818275;8230.958845205796;8239.052508961486;8242.29940455062;5204.245384419276;5289.3652761668845;5337.172738225581;5404.243405923174;5423.322084739408;1924.5573518090916;1949.4638974282186;1956.5499935014884;1964.499052741556;1973.6842105263088;26190.083347082953;26719;26772.59841102385;26847.865760671073;27564.586531202047;7467.178610352857;7488;7515.586642734702;7609.505382150142;7719.421043421766;20820.47948801292;20825.37523874286;20870.478238044172;20920.686189707165;20988.055537500848;8440.53577053268;8526.531040792815;8535.701250456204;8562.48625082497;8573.614187361583;7612.80967975805;7645.808854778564;7688.192739762357;7711.768646940601;7805.41459390548;5761.53907687384;5822.155787410887;5904.763809447574;5915.08316210988;5947.226860508193;1747.8164792696584;1774.6007148391766;1776.413783451458;1830.7162389829598;1853.6292741451764;940.210223412337;955.7658373698349;961.4759955824093;973.5862258540234;974.8342781727123;9119.863202051974;9205.217556507772;9234.1689247968;9247.306452016126;9427.811443771223;1056.8678915135608;1058.4072919165292;1060.9151267898549;1066.461436974323;1083.7778255457613;4796.352492413549;4943.456219815817;4953.43035550909;4958.380202474691;5004.074246264453;22024.339269821932;22134;22341.776582233968;22753.544929101325;22781.088756449888;22227.22204722859;22340.55318893613;22428;22544.66183007256;22635.320940371814;11530;12146.514139434501;12250.877491225152;12255.325957072446;12280.815787763191;8560.505734489443;8647.394682372174;8736.388452808242;9057.81884362296;9106.27149827999;18626.348077817212;19469;19765.209391624176;19785.802141978395;19842.702359464332;19329.710054349478;19579.70630440516;19683.901580492005;19884.90057549703;20071.799282007578;12550.49798008106;12745.299008554619;12822.487100515875;12829.037822163189;12835.935820321212;13861.514846980308;14052.297385130907;14131.222782747047;14137.858621414065;14333.928330358698;11147.275427097213;11189.832152517882;11242.100631949588;11509.53961841517;11605.535778568763;11113.055390291916;11131.833022504507;11194.328340299608;11221.943890280823;11333.773324533628;10272.794544108927;10350.22373322019;10471.26701130944;10488.68533943983;10621.522031508446;7961.442699011245;8017.318527925192;8108.797280068045;8110.472819266729;8231.835363292821;8147.551884646165;8153.510789352657;8214.753557393287;8272.37957153228;8310.70912518059 17:15:03 INFO - PID 4426 | |4;prototype.html;518.2459521396369;525.7660341148188;528.4319356691557;539.4039586257186;544.216328486979;5960.970195149023;6052.334243233252;6071.453569178773;6077.665728384943;6081.817545473643;6003.879922401549;6018;6076.665783381913;6080.665563394012;6115.724792384342;4866.9756651216785;4877.975625118712;4890.584300334458;4894.632902532324;4915.975420122894;4701.224297990828;4807.543283388072;4863.319135321058;4870.561649451549;4918.090153321629;4703.176944034797;4745.1695953208055;4746.477887432379;4747.691400058985;4761.309610106532;4699.342092107091;4717.174494463455;4734.834280800155;4766.213574760161;4782.33047373368;4196.9370459443135;4258.276093064155;4287.164003019412;4304.956950430487;4326.935095973563;5774;5895.64626122434;5913.822585322448;5923.940760592425;5963.373845746221;5693.117566777156;5731.828045158652;5735.971320143372;5746.425357464262;5760.193572899798;6514.902276465809;6544.4110030097045;6550.2794692583775;6551.6069035858;6562.44219241365;4892.094962431962;4902.264660300983;4907.043126590316;4907.65039614109;4920.630952678528;6566.540342176049;6688.632125233159;6763.830904227384;6811.386975172259;6840.31596840317;5032.7735251913755;5049.6212784041345;5058.8482345528955;5059.696418214919;5065.11360511909;5140.280360749498;5140.511651393112;5166.199239117943;5170.37955445349;5179.19722443022;5661.348944871393;5694.288213973254;5703.287089113861;5723.055695810228;5729.4843464088435;6492.208350409369;6545.410913017851;6549.476041916635;6570.5729127606555;6596.406323430914;1783.1084457771115;1784.5895444047683;1789.5168304557958;1799.5591080185177;1803.5761596025186;1190.6785168004762;1233.901287896966;1255.5354518828092;1261.8801213884667;1262.7348256866162;6228.283747369111;6282.465990390868;6282.968585157045;6313.40022697843;6374.9800031994655;6527.412532871969;6544.280129185786;6602.339766023455;6612.768553100618;6620.304867988792;6240.5319601030105;6272.059191121369;6305.432511074026;6324.241091069009;6394.936050639527;3352.2122301259183;3492.4586689063235;3529.9117522061642;3549.9290014199573;3552;6904.275051119661;7006.229314775371;7076.256993015762;7085.610291434021;7226.819329516804;6281.968590157111;6767.627780472121;6780.3386171466855;6790.94740315252;6886.380225779704;6820.192648948132;6906.274841141608;7026.754063607749;7056.6118863463;7124.145102587722;6511.3163117871945;6549.705263263069;6617.272100069084;6621.768238111643;6681.1314529110905;6445.677716114082;6459.450946669585;6539.803805885831;6564.606123632598;6624.205095388585;6866.793996180123;6980.441564674916;7007.264237255219;7073.2573079827935;7073.508322215327;5037.496250374933;5062.670926389773;5069.847904562869;5094.363204599425;5109.7700603472185;6390.840228994312;6503.414692677682;6575.50683698715;6664.5334826561675;6711.94606454072;6289.333326668528;6363.904541431974;6406.295307516262;6482.675866206765;6497.02544618311;6287.23957291959;6361.268454127649;6363.6818159090935;6428.742850285937;6457.806265812033;6447.580907241015;6449.516286278454;6454.804871588593;6458.7093580789915;6525.3148419417175;6301.243850737757;6363.490920726424;6393.200849893763;6444.258910225384;6539.803805885831;6221.222347206599;6284.874302514016;6290.182276304051;6342.524310676626;6370.840728981812 17:15:03 INFO - PID 4426 | |5;yui.html;933.0622724162216;941.5398410840162;959.0553304994584;962.6919385796543;966.1208300446593;16559.172041397927;17108.486745397626;17114.5721356966;17181.312747490087;22538;21559.6766048509;22031.66952495714;22071.227507037256;22106;22129.55740885181;1004.7789486313018;1037.0459177556666;1039.5841663334652;1040.7294103533097;1040.8282633365523;1042.5152304178555;1076.6554702495205;1080.637986274595;1093.923425360225;1097.0291292206414;1140.3044143072718;1141.3551343490942;1141.6860363400049;1141.8173092305233;1147.4492243723018;1121.6466812953893;1122.3995162588058;1127.4024766873529;1128.328644456551;1136.1535655936339;825.3397282174236;829.1542626520915;830.3523251863556;830.9709160179425;839.492107275102;17722.113894305363;17871.463856084338;17881;19258.614827703506;21471.67792483114;21980.89009554942;22501.54996900069;22514.774852251594;22701;22839.54320913589;16669.666606667797;16804.159792010352;16807.0756108414;16878.409255675993;17355.305787768473;3799.9620003799882;3844.154286057063;3852.6339997700175;3852.903677408059;3856.2287542491335;149074;150275;150282.24858875744;150815;152907;16968.66062678764;17121.571960701083;17293.221805018806;17310.826891731173;17390.21744021522;33514.83242583772;33753.15617109592;34067.31865362679;34349.48475772866;34384.45269962858;8142.918570814334;8532.829343413097;8981.461112333282;9398.530073496435;9571.856422153673;4519.299508576176;4609.032103258286;4610.10103029906;4623.075384922961;4623.884402889955;5686.488216060575;5862.765489380462;6243.96878015607;6383.808485745435;6433.967830160819;1170.8829117088394;1184.988150118505;1205.8372119763894;1207.1188032735977;1222.4804458105448;721.249900103886;735.6652723011017;738.1843063414957;748.76413929612;760.4486747108302;12106.697332566757;12580.496780128875;13127.343632818322;14305.356258968372;14349.928250358682;708.6810935079235;729.7409419656052;739.3087463221905;750.1710609776228;752.9360004399688;6048.092786082035;6938.722451101899;7135.092006183551;7195.352418282379;7360.374368178657;136400;137678.31160844132;142076.2896185533;142562;147241.26379368035;127564.36217818852;128830;130940;131754;133705;111886;111988;112287.87712122938;113588;116197;12942.741145177231;13235.69839802049;13333.266670333225;13417.060805743504;13559;47741.52258477371;47921.520784791705;48256.276155858395;48552.27171592358;48958.51041489682;67182.66408667926;67633.32366676467;67847;68236;69507.65246173737;17624.471265862045;18192.727109093637;18242.817571824642;18345.08274586292;18421.631567368844;22774.430639233487;23267.534649307257;23483.765162348158;24401.26796196117;24811.25566233016;20520.48698782483;20566.38300850977;20780.792192077886;21015.264465744236;21420.892895535424;20550.07524661364;20951.8952405237;21666.24168154107;21731.23940662069;21744.56510869742;19111.80888191156;19892.801071989674;20076.09657565384;20083.297084601967;20637.793622063586;13909.791353129509;14333.713325733219;14780.408783648534;15116.924415377853;15359.385624574892;15695.215239237765;15786.289616967493;15818.762718559;16339.264733086802;16407.83592164063 17:15:03 INFO - PID 4426 | __end_tp_report 17:15:03 INFO - PID 4426 | __start_cc_report 17:15:03 INFO - PID 4426 | _x_x_mozilla_cycle_collect,331 17:15:03 INFO - PID 4426 | __end_cc_report 17:15:03 INFO - PID 4426 | __startTimestamp1502324103572__endTimestamp 17:15:03 INFO - PID 4426 | 17:15:03 INFO - PID 4426 | ------- Summary: start ------- 17:15:03 INFO - PID 4426 | Number of tests: 6 17:15:03 INFO - PID 4426 | 17:15:03 INFO - PID 4426 | [#0] dojo.html Cycles:165 Average:6189.85 Median:6519.09 stddev:820.55 (12.6%) stddev-sans-first:795.38 17:15:03 INFO - PID 4426 | Values: 3495.7 3532.9 3538.0 3544.0 3563.1 6163.5 6166.4 6199.9 6213.8 6223.0 6090.2 6135.0 6145.4 6224.8 6348.4 5402.4 5408.7 5496.5 5501.5 5507.5 5108.3 5288.7 5386.0 5456.5 5460.9 5398.6 5427.1 5469.2 5481.6 5498.4 5427.0 5438.8 5497.8 5505.6 5516.5 5401.5 5421.1 5427.0 5435.8 5452.2 6115.7 6125.7 6138.3 6178.4 6217.3 6553.5 6677.9 6695.4 6766.7 6767.8 6699.4 6750.2 6808.2 6818.5 6828.7 6302.6 6305.0 6308.5 6311.9 6312.2 6864.2 6919.1 6945.2 7008.6 7009.6 6502.7 6525.0 6665.8 6730.5 6742.2 6702.9 6779.4 6798.2 6803.4 6806.9 6584.7 6672.7 6721.3 6727.4 6738.3 6577.4 6606.8 6623.3 6670.2 6761.0 4808.8 4822.6 4842.8 4881.3 4890.6 4290.9 4372.2 4375.4 4401.1 4401.7 6447.6 6452.6 6519.1 6530.5 6533.1 6721.8 6731.6 6732.6 6813.3 6823.9 6282.5 6358.1 6361.5 6363.6 6507.2 5372.9 5395.2 5428.0 5431.6 5458.3 7164.0 7285.7 7287.1 7305.5 7306.0 6745.5 6779.6 6784.1 6870.6 6872.9 6973.3 7122.3 7212.0 7263.6 7287.9 6586.6 6639.3 6645.8 6647.5 6663.4 6716.3 6808.3 6820.6 6831.2 6847.0 6564.8 6596.1 6601.8 6605.2 6611.5 6504.5 6512.6 6521.8 6583.0 6590.0 6370.1 6498.5 6519.4 6550.4 6626.9 6593.9 6604.6 6607.5 6609.1 6619.5 6233.9 6309.1 6355.7 6366.4 6382.8 17:15:03 INFO - PID 4426 | 17:15:03 INFO - PID 4426 | [#1] ext.html Cycles:180 Average:43568.83 Median:37700.81 stddev:65587.37 (174.0%) stddev-sans-first:65693.13 17:15:03 INFO - PID 4426 | Values: 904.4 907.8 939.5 971.8 972.0 41616.6 42450.6 42469.0 42559.8 42596.4 38173.8 38792.6 38832.4 38863.4 38932.0 6758.1 6849.5 6850.3 6857.5 6871.2 6743.4 6828.9 6831.8 6834.3 6836.6 7363.2 7505.5 7509.0 7509.0 7510.6 6205.6 7399.6 7456.1 7456.7 7464.1 7329.6 7397.3 7400.0 7400.1 7404.6 38222.6 38774.6 38939.6 38974.6 39067.2 3490.3 3527.7 3542.9 3545.2 3559.4 30900.0 30905.7 30915.2 30943.2 31026.1 5035.1 5063.5 5080.6 5110.5 5129.6 205400.0 208080.0 209021.0 211301.0 263824.0 53760.2 54311.5 54348.7 54373.0 54374.2 56588.2 56915.4 56957.4 57161.1 57242.4 17257.7 17379.1 17381.3 17398.0 17528.7 14256.0 14315.0 14316.6 14321.1 14326.7 15418.9 15444.0 15494.8 15554.9 15562.4 6044.8 6155.7 6215.8 6343.9 6384.1 1056.4 1075.5 1085.3 1092.0 1114.4 24746.9 24969.6 25132.0 25152.6 25378.0 1192.9 1207.1 1213.1 1217.8 1218.1 13203.3 13293.5 13365.3 13464.8 17504.0 280695.0 282131.0 282825.0 283274.0 283284.0 60539.0 61281.0 61595.7 61600.0 61712.0 1517.1 1530.8 1549.4 1549.9 1550.3 30905.7 30915.5 30966.0 31032.0 31828.8 54438.0 54977.5 55055.0 55146.4 55262.0 245211.0 247987.0 249861.0 249864.0 250302.0 37075.6 37731.6 39626.8 39744.0 39771.8 48076.3 49649.8 49761.0 50002.0 50113.7 36901.4 37104.4 37442.3 37541.4 37670.0 36045.0 36479.3 36617.3 36654.2 36859.6 41858.4 41864.8 42037.2 42330.2 42384.0 33962.0 34183.5 34595.1 35931.0 36330.3 26478.9 27443.9 27606.0 27670.3 27711.4 17:15:03 INFO - PID 4426 | 17:15:03 INFO - PID 4426 | [#2] jquery.html Cycles:180 Average:41817.23 Median:23761.02 stddev:100604.38 (423.4%) stddev-sans-first:100838.94 17:15:03 INFO - PID 4426 | Values: 573.2 573.8 573.9 580.4 584.5 23302.0 23887.3 24184.0 24288.5 24290.9 27735.0 28146.7 28396.1 28412.9 28427.0 6063.7 6209.4 6212.0 6213.8 6223.6 5741.5 6161.8 6227.4 6245.9 6246.3 6197.1 6221.4 6221.6 6224.8 6225.7 6137.5 6169.8 6199.5 6203.3 6207.7 5723.0 5756.8 5757.5 5765.3 5787.8 30975.8 31941.0 32412.4 32653.2 32810.8 2240.8 2248.6 2269.6 2273.0 2277.9 19993.4 20089.1 21326.9 21332.4 21347.3 2323.7 2356.3 2393.8 2395.7 2409.2 156518.0 159363.0 167994.0 168167.0 168471.0 15483.7 15890.7 16263.3 16502.7 16614.3 25116.0 25254.5 25264.2 25281.2 25286.2 10741.6 11085.1 11088.3 11211.7 11327.6 10155.1 10171.3 10328.5 10330.5 10333.3 9792.7 9814.3 9971.6 10002.1 10264.9 2813.1 2838.8 2839.1 2841.6 2851.9 1057.4 1058.9 1072.2 1073.6 1080.3 26778.5 27738.7 27828.5 27967.0 28692.0 1119.8 1129.9 1137.7 1144.9 1149.9 12119.7 12501.7 12638.1 12664.9 12726.9 583025.0 583641.0 600218.0 603935.0 611783.0 133836.0 134562.0 134661.3 136016.0 141700.3 1298.9 1331.4 1357.4 1366.6 1370.8 23497.0 23678.0 23725.9 23749.6 23779.6 70645.0 72687.6 72949.0 76212.0 78188.0 93191.0 93533.0 95033.5 95641.0 98635.5 22967.5 23653.2 23739.0 23772.4 23808.8 25977.4 26275.9 26295.3 26419.6 26861.3 20486.4 20658.0 21251.1 21485.7 21558.2 18104.5 18231.2 18340.3 18515.7 18882.4 21534.4 21643.8 21654.0 21748.3 21777.8 22405.4 23602.5 23717.2 23728.3 23790.0 20146.5 20716.3 20733.3 21007.4 21038.4 17:15:03 INFO - PID 4426 | 17:15:03 INFO - PID 4426 | [#3] mootools.html Cycles:180 Average:9833.27 Median:2587.23 stddev:6989.05 (270.1%) stddev-sans-first:6980.03 17:15:03 INFO - PID 4426 | Values: 1413.7 1424.2 1450.2 1457.1 1460.1 15239.5 15487.0 15803.1 15817.4 15820.0 15835.1 16294.8 16301.7 16306.0 16428.5 2582.0 2625.9 2629.9 2642.5 2655.3 2698.8 2791.8 2799.9 2800.0 2801.4 2713.9 2733.1 2757.7 2763.4 2767.1 2698.1 2713.4 2717.4 2748.2 2757.6 2592.5 2613.8 2622.1 2622.2 2623.3 15124.7 15199.4 15316.5 15366.5 15423.8 7903.8 8182.9 8231.0 8239.1 8242.3 5204.2 5289.4 5337.2 5404.2 5423.3 1924.6 1949.5 1956.5 1964.5 1973.7 26190.1 26719.0 26772.6 26847.9 27564.6 7467.2 7488.0 7515.6 7609.5 7719.4 20820.5 20825.4 20870.5 20920.7 20988.1 8440.5 8526.5 8535.7 8562.5 8573.6 7612.8 7645.8 7688.2 7711.8 7805.4 5761.5 5822.2 5904.8 5915.1 5947.2 1747.8 1774.6 1776.4 1830.7 1853.6 940.2 955.8 961.5 973.6 974.8 9119.9 9205.2 9234.2 9247.3 9427.8 1056.9 1058.4 1060.9 1066.5 1083.8 4796.4 4943.5 4953.4 4958.4 5004.1 22024.3 22134.0 22341.8 22753.5 22781.1 22227.2 22340.6 22428.0 22544.7 22635.3 11530.0 12146.5 12250.9 12255.3 12280.8 8560.5 8647.4 8736.4 9057.8 9106.3 18626.3 19469.0 19765.2 19785.8 19842.7 19329.7 19579.7 19683.9 19884.9 20071.8 12550.5 12745.3 12822.5 12829.0 12835.9 13861.5 14052.3 14131.2 14137.9 14333.9 11147.3 11189.8 11242.1 11509.5 11605.5 11113.1 11131.8 11194.3 11221.9 11333.8 10272.8 10350.2 10471.3 10488.7 10621.5 7961.4 8017.3 8108.8 8110.5 8231.8 8147.6 8153.5 8214.8 8272.4 8310.7 17:15:03 INFO - PID 4426 | 17:15:03 INFO - PID 4426 | [#4] prototype.html Cycles:180 Average:5516.34 Median:6224.75 stddev:1566.46 (25.2%) stddev-sans-first:1525.28 17:15:03 INFO - PID 4426 | Values: 518.2 525.8 528.4 539.4 544.2 5961.0 6052.3 6071.5 6077.7 6081.8 6003.9 6018.0 6076.7 6080.7 6115.7 4867.0 4878.0 4890.6 4894.6 4916.0 4701.2 4807.5 4863.3 4870.6 4918.1 4703.2 4745.2 4746.5 4747.7 4761.3 4699.3 4717.2 4734.8 4766.2 4782.3 4196.9 4258.3 4287.2 4305.0 4326.9 5774.0 5895.6 5913.8 5923.9 5963.4 5693.1 5731.8 5736.0 5746.4 5760.2 6514.9 6544.4 6550.3 6551.6 6562.4 4892.1 4902.3 4907.0 4907.7 4920.6 6566.5 6688.6 6763.8 6811.4 6840.3 5032.8 5049.6 5058.8 5059.7 5065.1 5140.3 5140.5 5166.2 5170.4 5179.2 5661.3 5694.3 5703.3 5723.1 5729.5 6492.2 6545.4 6549.5 6570.6 6596.4 1783.1 1784.6 1789.5 1799.6 1803.6 1190.7 1233.9 1255.5 1261.9 1262.7 6228.3 6282.5 6283.0 6313.4 6375.0 6527.4 6544.3 6602.3 6612.8 6620.3 6240.5 6272.1 6305.4 6324.2 6394.9 3352.2 3492.5 3529.9 3549.9 3552.0 6904.3 7006.2 7076.3 7085.6 7226.8 6282.0 6767.6 6780.3 6790.9 6886.4 6820.2 6906.3 7026.8 7056.6 7124.1 6511.3 6549.7 6617.3 6621.8 6681.1 6445.7 6459.5 6539.8 6564.6 6624.2 6866.8 6980.4 7007.3 7073.3 7073.5 5037.5 5062.7 5069.8 5094.4 5109.8 6390.8 6503.4 6575.5 6664.5 6711.9 6289.3 6363.9 6406.3 6482.7 6497.0 6287.2 6361.3 6363.7 6428.7 6457.8 6447.6 6449.5 6454.8 6458.7 6525.3 6301.2 6363.5 6393.2 6444.3 6539.8 6221.2 6284.9 6290.2 6342.5 6370.8 17:15:03 INFO - PID 4426 | 17:15:03 INFO - PID 4426 | [#5] yui.html Cycles:180 Average:27837.90 Median:20079.70 stddev:40329.43 (200.8%) stddev-sans-first:40391.97 17:15:03 INFO - PID 4426 | Values: 933.1 941.5 959.1 962.7 966.1 16559.2 17108.5 17114.6 17181.3 22538.0 21559.7 22031.7 22071.2 22106.0 22129.6 1004.8 1037.0 1039.6 1040.7 1040.8 1042.5 1076.7 1080.6 1093.9 1097.0 1140.3 1141.4 1141.7 1141.8 1147.4 1121.6 1122.4 1127.4 1128.3 1136.2 825.3 829.2 830.4 831.0 839.5 17722.1 17871.5 17881.0 19258.6 21471.7 21980.9 22501.5 22514.8 22701.0 22839.5 16669.7 16804.2 16807.1 16878.4 17355.3 3800.0 3844.2 3852.6 3852.9 3856.2 149074.0 150275.0 150282.2 150815.0 152907.0 16968.7 17121.6 17293.2 17310.8 17390.2 33514.8 33753.2 34067.3 34349.5 34384.5 8142.9 8532.8 8981.5 9398.5 9571.9 4519.3 4609.0 4610.1 4623.1 4623.9 5686.5 5862.8 6244.0 6383.8 6434.0 1170.9 1185.0 1205.8 1207.1 1222.5 721.2 735.7 738.2 748.8 760.4 12106.7 12580.5 13127.3 14305.4 14349.9 708.7 729.7 739.3 750.2 752.9 6048.1 6938.7 7135.1 7195.4 7360.4 136400.0 137678.3 142076.3 142562.0 147241.3 127564.4 128830.0 130940.0 131754.0 133705.0 111886.0 111988.0 112287.9 113588.0 116197.0 12942.7 13235.7 13333.3 13417.1 13559.0 47741.5 47921.5 48256.3 48552.3 48958.5 67182.7 67633.3 67847.0 68236.0 69507.7 17624.5 18192.7 18242.8 18345.1 18421.6 22774.4 23267.5 23483.8 24401.3 24811.3 20520.5 20566.4 20780.8 21015.3 21420.9 20550.1 20951.9 21666.2 21731.2 21744.6 19111.8 19892.8 20076.1 20083.3 20637.8 13909.8 14333.7 14780.4 15116.9 15359.4 15695.2 15786.3 15818.8 16339.3 16407.8 17:15:03 INFO - PID 4426 | -------- Summary: end -------- 17:15:03 INFO - PID 4426 | 17:15:04 INFO - TEST-INFO | 4426: exit 0 17:15:04 INFO - TEST-OK | dromaeo_css | took 1110022ms 17:15:04 INFO - TEST-START | kraken 17:15:04 INFO - Initialising browser for kraken test... 17:15:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35252/getInfo.html -profile /tmp/tmpTaFogN/profile 17:15:04 INFO - TEST-INFO | started process 4787 (/builds/slave/test/build/application/firefox/firefox http://localhost:35252/getInfo.html) 17:15:09 INFO - TEST-INFO | 4787: exit 0 17:15:09 INFO - Browser initialized. 17:15:09 INFO - Running cycle 1/1 for kraken test... 17:15:09 INFO - TEST-INFO | started process 5004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTaFogN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:10 INFO - PID 5004 | 17:15:10 INFO - PID 5004 | (/builds/slave/test/build/application/firefox/firefox:5055): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:15:10 INFO - PID 5004 | 17:15:21 INFO - PID 5004 | RSS: Main: 161308672 17:15:21 INFO - PID 5004 | 17:15:23 INFO - PID 5004 | Cycle 1(1): loaded http://localhost:35252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35252/tests/kraken/driver.html?testName=audio-beat-detection) 17:15:24 INFO - PID 5004 | RSS: Main: 165990400 17:15:24 INFO - PID 5004 | 17:15:27 INFO - PID 5004 | Cycle 1(1): loaded http://localhost:35252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35252/tests/kraken/driver.html?testName=audio-dft) 17:15:27 INFO - PID 5004 | RSS: Main: 166182912 17:15:27 INFO - PID 5004 | 17:15:30 INFO - PID 5004 | Cycle 1(1): loaded http://localhost:35252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35252/tests/kraken/driver.html?testName=audio-fft) 17:15:31 INFO - PID 5004 | RSS: Main: 160849920 17:15:31 INFO - PID 5004 | 17:15:33 INFO - PID 5004 | Cycle 1(1): loaded http://localhost:35252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35252/tests/kraken/driver.html?testName=audio-oscillator) 17:15:34 INFO - PID 5004 | RSS: Main: 161865728 17:15:34 INFO - PID 5004 | 17:15:36 INFO - PID 5004 | Cycle 1(1): loaded http://localhost:35252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:15:36 INFO - PID 5004 | RSS: Main: 162263040 17:15:36 INFO - PID 5004 | 17:15:39 INFO - PID 5004 | Cycle 1(1): loaded http://localhost:35252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35252/tests/kraken/driver.html?testName=imaging-darkroom) 17:15:40 INFO - PID 5004 | RSS: Main: 165224448 17:15:40 INFO - PID 5004 | 17:15:43 INFO - PID 5004 | Cycle 1(1): loaded http://localhost:35252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35252/tests/kraken/driver.html?testName=imaging-desaturate) 17:15:44 INFO - PID 5004 | RSS: Main: 167288832 17:15:44 INFO - PID 5004 | 17:15:47 INFO - PID 5004 | Cycle 1(1): loaded http://localhost:35252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35252/tests/kraken/driver.html?testName=json-parse-financial) 17:15:47 INFO - PID 5004 | RSS: Main: 165875712 17:15:47 INFO - PID 5004 | 17:15:49 INFO - PID 5004 | Cycle 1(1): loaded http://localhost:35252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:15:50 INFO - PID 5004 | RSS: Main: 166227968 17:15:50 INFO - PID 5004 | 17:15:51 INFO - PID 5004 | Cycle 1(1): loaded http://localhost:35252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35252/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:15:52 INFO - PID 5004 | RSS: Main: 166117376 17:15:52 INFO - PID 5004 | 17:15:54 INFO - PID 5004 | Cycle 1(1): loaded http://localhost:35252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:15:55 INFO - PID 5004 | RSS: Main: 166121472 17:15:55 INFO - PID 5004 | 17:15:57 INFO - PID 5004 | Cycle 1(1): loaded http://localhost:35252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:15:58 INFO - PID 5004 | RSS: Main: 165810176 17:15:58 INFO - PID 5004 | 17:16:01 INFO - PID 5004 | Cycle 1(1): loaded http://localhost:35252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:16:01 INFO - PID 5004 | RSS: Main: 165920768 17:16:01 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | Cycle 1(1): loaded http://localhost:35252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35252/tests/kraken/driver.html?testName=ai-astar) 17:16:03 INFO - PID 5004 | RSS: Main: 167940096 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | __start_tp_report 17:16:03 INFO - PID 5004 | _x_x_mozilla_page_load 17:16:03 INFO - PID 5004 | _x_x_mozilla_page_load_details 17:16:03 INFO - PID 5004 | |i|pagename|runs| 17:16:03 INFO - PID 5004 | |0;ai-astar;98;106;100;106;107;108;114;98;106;108 17:16:03 INFO - PID 5004 | |1;audio-beat-detection;145;114;148;166;129;135;138;113;160;115 17:16:03 INFO - PID 5004 | |2;audio-dft;163;163;162;163;161;160;162;162;165;175 17:16:03 INFO - PID 5004 | |3;audio-fft;76;76;75;103;75;75;76;87;98;75 17:16:03 INFO - PID 5004 | |4;audio-oscillator;77;78;122;79;78;79;126;78;78;132 17:16:03 INFO - PID 5004 | |5;imaging-gaussian-blur;115;114;114;113;114;114;113;114;118;114 17:16:03 INFO - PID 5004 | |6;imaging-darkroom;147;149;147;150;148;148;149;149;147;148 17:16:03 INFO - PID 5004 | |7;imaging-desaturate;93;94;94;95;95;94;94;94;94;99 17:16:03 INFO - PID 5004 | |8;json-parse-financial;46;48;47;47;49;46;50;46;46;47 17:16:03 INFO - PID 5004 | |9;json-stringify-tinderbox;54;54;54;53;53;54;54;54;54;54 17:16:03 INFO - PID 5004 | |10;stanford-crypto-aes;76;75;75;76;74;90;75;74;74;74 17:16:03 INFO - PID 5004 | |11;stanford-crypto-ccm;118;130;116;119;126;120;132;118;121;153 17:16:03 INFO - PID 5004 | |12;stanford-crypto-pbkdf2;158;160;163;170;164;162;162;169;167;164 17:16:03 INFO - PID 5004 | |13;stanford-crypto-sha256-iterative;60;61;62;64;61;64;60;60;61;61 17:16:03 INFO - PID 5004 | __end_tp_report 17:16:03 INFO - PID 5004 | __start_cc_report 17:16:03 INFO - PID 5004 | _x_x_mozilla_cycle_collect,851 17:16:03 INFO - PID 5004 | __end_cc_report 17:16:03 INFO - PID 5004 | __startTimestamp1502324163702__endTimestamp 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | ------- Summary: start ------- 17:16:03 INFO - PID 5004 | Number of tests: 14 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | [#0] ai-astar Cycles:10 Average:105.10 Median:108.00 stddev:5.04 (4.7%) stddev-sans-first:4.65 17:16:03 INFO - PID 5004 | Values: 98.0 106.0 100.0 106.0 107.0 108.0 114.0 98.0 106.0 108.0 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:141.50 stddev:18.88 (13.3%) stddev-sans-first:19.76 17:16:03 INFO - PID 5004 | Values: 145.0 114.0 148.0 166.0 129.0 135.0 138.0 113.0 160.0 115.0 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:4.22 (2.6%) stddev-sans-first:4.47 17:16:03 INFO - PID 5004 | Values: 163.0 163.0 162.0 163.0 161.0 160.0 162.0 162.0 165.0 175.0 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:10.67 (14.0%) stddev-sans-first:11.12 17:16:03 INFO - PID 5004 | Values: 76.0 76.0 75.0 103.0 75.0 75.0 76.0 87.0 98.0 75.0 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:78.00 stddev:23.57 (30.2%) stddev-sans-first:24.30 17:16:03 INFO - PID 5004 | Values: 77.0 78.0 122.0 79.0 78.0 79.0 126.0 78.0 78.0 132.0 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.42 (1.2%) stddev-sans-first:1.48 17:16:03 INFO - PID 5004 | Values: 115.0 114.0 114.0 113.0 114.0 114.0 113.0 114.0 118.0 114.0 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:1.03 (0.7%) stddev-sans-first:1.00 17:16:03 INFO - PID 5004 | Values: 147.0 149.0 147.0 150.0 148.0 148.0 149.0 149.0 147.0 148.0 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:1.65 (1.8%) stddev-sans-first:1.64 17:16:03 INFO - PID 5004 | Values: 93.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 99.0 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | [#8] json-parse-financial Cycles:10 Average:47.20 Median:47.00 stddev:1.40 (3.0%) stddev-sans-first:1.41 17:16:03 INFO - PID 5004 | Values: 46.0 48.0 47.0 47.0 49.0 46.0 50.0 46.0 46.0 47.0 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 17:16:03 INFO - PID 5004 | Values: 54.0 54.0 54.0 53.0 53.0 54.0 54.0 54.0 54.0 54.0 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:75.00 stddev:4.88 (6.5%) stddev-sans-first:5.17 17:16:03 INFO - PID 5004 | Values: 76.0 75.0 75.0 76.0 74.0 90.0 75.0 74.0 74.0 74.0 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:123.50 stddev:11.13 (9.0%) stddev-sans-first:11.48 17:16:03 INFO - PID 5004 | Values: 118.0 130.0 116.0 119.0 126.0 120.0 132.0 118.0 121.0 153.0 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:164.00 stddev:3.81 (2.3%) stddev-sans-first:3.40 17:16:03 INFO - PID 5004 | Values: 158.0 160.0 163.0 170.0 164.0 162.0 162.0 169.0 167.0 164.0 17:16:03 INFO - PID 5004 | 17:16:03 INFO - PID 5004 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.00 stddev:1.51 (2.5%) stddev-sans-first:1.51 17:16:03 INFO - PID 5004 | Values: 60.0 61.0 62.0 64.0 61.0 64.0 60.0 60.0 61.0 61.0 17:16:03 INFO - PID 5004 | -------- Summary: end -------- 17:16:03 INFO - PID 5004 | 17:16:04 INFO - PID 5004 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:16:04 INFO - TEST-INFO | 5004: exit 0 17:16:04 INFO - TEST-OK | kraken | took 60143ms 17:16:04 INFO - SUITE-END | took 1170s 17:16:04 INFO - Completed test suite (00:19:30) 17:16:04 INFO - javascript benchmark 17:16:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9062.812967617318, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3495.737819663524, 3532.8586856525735, 3538.044727923459, 3544.0431083607427, 3563.127033876701, 6163.537734669895, 6166.4450199482035, 6199.907001394983, 6213.844653883655, 6223.035429508423, 6090.208272924525, 6134.969325153368, 6145.446909778119, 6224.782132625348, 6348.428641422271, 5402.37872644646, 5408.729563521828, 5496.5053145216925, 5501.477359650827, 5507.504324610784, 5108.259302401149, 5288.682679039251, 5386.003589335965, 5456.48163424476, 5460.918086228709, 5398.568114550826, 5427.104527752956, 5469.234307196995, 5481.561475082004, 5498.395176530578, 5427.0, 5438.83683489496, 5497.835064948058, 5505.642133261325, 5516.531094856942, 5401.540869026137, 5421.105517589593, 5426.972865135649, 5435.83692489226, 5452.154915988028, 6115.663638499881, 6125.693715314261, 6138.263408390977, 6178.351273116303, 6217.3471785462325, 6553.541252112354, 6677.93322066778, 6695.397414232693, 6766.729330826761, 6767.763128290486, 6699.39705426514, 6750.189977202767, 6808.183018037867, 6818.454523638097, 6828.6927088281145, 6302.590331628476, 6305.0, 6308.463780578656, 6311.905321420137, 6312.179416675895, 6864.24493305736, 6919.100516932766, 6945.166580010431, 7008.579485230903, 7009.61447120403, 6502.739890404426, 6524.9673751630935, 6665.766698165541, 6730.528862979544, 6742.224644165984, 6702.865942681216, 6779.35596118368, 6798.150231221098, 6803.387695107464, 6806.863862722717, 6584.670766461658, 6672.666366681647, 6721.26066132725, 6727.428168605723, 6738.258791532928, 6577.408033277028, 6606.834829129214, 6623.3376662333385, 6670.166229221348, 6761.019652150509, 4808.783604737795, 4822.614190864722, 4842.806287748521, 4881.29221262922, 4890.608751299887, 4290.914181716348, 4372.1692878353015, 4375.431193944767, 4401.075774087478, 4401.735895846259, 6447.580907241108, 6452.612843229327, 6519.087327774116, 6530.542861999709, 6533.052707357407, 6721.764738234138, 6731.562448440835, 6732.596044237362, 6813.284605116491, 6823.942288945222, 6282.528810339151, 6358.078078678565, 6361.459275961595, 6363.61818290904, 6507.219133703891, 5372.8656783579945, 5395.244665746799, 5427.972860135674, 5431.592630552725, 5458.263134476795, 7164.0328555645365, 7285.672144753499, 7287.089113860768, 7305.525140865827, 7306.0, 6745.460363170934, 6779.559328643622, 6784.050232967487, 6870.587764733932, 6872.896906546506, 6973.302669732986, 7122.323379278961, 7212.0, 7263.6005019724425, 7287.854242915006, 6586.637734924625, 6639.269680335063, 6645.833854153685, 6647.534672572873, 6663.400293973566, 6716.29478904708, 6808.285130061272, 6820.590764554143, 6831.180258369028, 6847.041414202115, 6564.80305590833, 6596.109525214227, 6601.834954126185, 6605.207375115017, 6611.504137189826, 6504.4796416285635, 6512.6092434454085, 6521.804345869631, 6583.0454584086, 6590.0, 6370.108184854217, 6498.480121590356, 6519.380658837593, 6550.410463058348, 6626.867462650816, 6593.934060659524, 6604.603723776589, 6607.53747237708, 6609.107770450928, 6619.50353723463, 6233.906491402723, 6309.085182648582, 6355.682215889279, 6366.427021568081, 6382.808515744535], "value": 6126.516188042532, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.3533873280605, 907.8138981508787, 939.5255396025007, 971.7813491964305, 972.0473935543167, 41616.58383416165, 42450.57549424509, 42469.0, 42559.787201063955, 42596.361054584166, 38173.80913095431, 38792.61207387925, 38832.41751373732, 38863.41704874429, 38932.0, 6758.053872457847, 6849.4862885283555, 6850.314968503159, 6857.485688573352, 6871.175458944908, 6743.426808721265, 6828.897566536506, 6831.829204269909, 6834.316568343175, 6836.5898046117145, 7363.15323737769, 7505.549667019969, 7508.962455187717, 7508.962455187744, 7510.624468776539, 6205.596636218631, 7399.630018499053, 7456.105267367896, 7456.701731930716, 7464.10430748311, 7329.633518324063, 7397.2602739726135, 7400.037995060661, 7400.074990626172, 7404.555726656418, 38222.617773822465, 38774.612253877385, 38939.61060389388, 38974.61025389738, 39067.218655626726, 3490.3193877193958, 3527.664871837171, 3542.8937131886087, 3545.2377738786026, 3559.4482855157494, 30900.0, 30905.690943090507, 30915.227119322197, 30943.226419339473, 31026.069217923497, 5035.1188542005, 5063.518965698253, 5080.61895357846, 5110.463401342842, 5129.615278854101, 205400.0, 208080.0, 209021.0, 211301.0, 263824.0, 53760.19359709608, 54311.45688543064, 54348.72825635925, 54373.0, 54374.18438723422, 56588.15117773237, 56915.430845691844, 56957.43042569521, 57161.14258286129, 57242.42757572454, 17257.65484690299, 17379.13104344778, 17381.304747810198, 17398.0, 17528.737068943978, 14256.0, 14315.0, 14316.642083947776, 14321.140731555932, 14326.713465730836, 15418.922905385401, 15444.046236435704, 15494.767578486331, 15554.9222253888, 15562.377504899678, 6044.7582096716515, 6155.6614386209185, 6215.751369945242, 6343.904841427382, 6384.106225128486, 1056.4136904018344, 1075.4783929794044, 1085.2999815119204, 1091.9672409827717, 1114.4149321606221, 24746.876265618917, 24969.62545561818, 25132.0, 25152.622710659354, 25378.0, 1192.9343886086176, 1207.0524638159004, 1213.0841214882707, 1217.7747116783423, 1218.074263559701, 13203.273819939996, 13293.471250806087, 13365.26491043002, 13464.798028029587, 17504.0, 280695.0, 282131.0, 282825.0, 283274.0, 283284.0, 60539.0, 61281.0, 61595.6920215396, 61600.0, 61712.0, 1517.0745845034521, 1530.7856900034226, 1549.3957356630922, 1549.9070055796687, 1550.2791202091082, 30905.69094309118, 30915.536266956464, 30966.0, 31032.0, 31828.840855795574, 54438.0, 54977.45022549723, 55055.0, 55146.44853551413, 55262.0, 245211.0, 247987.0, 249861.0, 249864.0, 250302.0, 37075.62924370722, 37731.62268377391, 39626.801865990485, 39744.0, 39771.80114099411, 48076.27885581789, 49649.75175124101, 49761.0, 50002.0, 50113.74943125261, 36901.44647830338, 37104.44343334798, 37442.3150958213, 37541.4368784463, 37670.0, 36045.0, 36479.27041459209, 36617.267654647294, 36654.20365327292, 36859.63140368669, 41858.37212441877, 41864.790676046425, 42037.159256814084, 42330.1533969325, 42384.0, 33962.0, 34183.487247690806, 34595.135121621155, 35931.0, 36330.27339453249, 26478.867605662617, 27443.86278068597, 27606.0, 27670.308242294104, 27711.44577108406], "value": 18656.312077999675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.1774903014177, 573.8335882594048, 573.9024365857804, 580.3529065092422, 584.5060923519625, 23302.0, 23887.28338149854, 24184.0, 24288.514229715416, 24290.87854560727, 27735.0, 28146.718532814666, 28396.148115556567, 28412.857935710294, 28427.0, 6063.6968151592355, 6209.3790620938, 6212.0371342441995, 6213.782517611885, 6223.564350495467, 5741.511971482429, 6161.845953851145, 6227.408396202376, 6245.937540624581, 6246.250449946013, 6197.101420294055, 6221.4400703936635, 6221.564490485668, 6224.8132556023165, 6225.657588832612, 6137.5089992800695, 6169.81490555284, 6199.473044791153, 6203.2866220384785, 6207.689615519206, 5723.0, 5756.769729210827, 5757.539396848242, 5765.250517432749, 5787.826365209051, 30975.845120774477, 31941.0, 32412.351752965045, 32653.18367040819, 32810.835945820356, 2240.7759224077627, 2248.6064938635673, 2269.614165591853, 2272.988635056814, 2277.851939623919, 19993.400197994084, 20089.095990680453, 21326.893365533073, 21332.36002919915, 21347.252846150466, 2323.674685544025, 2356.2695564374926, 2393.784559389663, 2395.700537432821, 2409.1808785013004, 156518.0, 159363.0, 167994.0, 168167.0, 168471.0, 15483.690326193413, 15890.68218635644, 16263.349466021227, 16502.669946601, 16614.25235864389, 25116.0, 25254.494910101694, 25264.24207273785, 25281.241562753148, 25286.24141275765, 10741.570337186426, 11085.057770089472, 11088.279261848116, 11211.719707007227, 11327.603533876274, 10155.136813370798, 10171.28800983924, 10328.535215915303, 10330.535125919352, 10333.328333658439, 9792.657256996114, 9814.312998090065, 9971.551280192409, 10002.149817265468, 10264.948675256575, 2813.08574713219, 2838.8012839101066, 2839.1482555233347, 2841.6163817884735, 2851.928701782472, 1057.360297020307, 1058.9403609978517, 1072.222638587018, 1073.5759375046969, 1080.33559360994, 26778.464430711276, 27738.722612774018, 27828.469434181316, 27967.0, 28692.0, 1119.8264269038311, 1129.9265547739535, 1137.7155711072232, 1144.9352102544713, 1149.93675347855, 12119.697007574705, 12501.687457813627, 12638.115331926678, 12664.87335126637, 12726.936365318299, 583025.0, 583641.0, 600218.0, 603935.0, 611783.0, 133836.0, 134562.0, 134661.3266933659, 136016.0, 141700.29149854186, 1298.9090763646643, 1331.40086960868, 1357.3891748713118, 1366.6036849313787, 1370.7601169795246, 23497.0, 23678.0, 23725.881370593037, 23749.64375534334, 23779.64330535078, 70645.0, 72687.63656181685, 72949.0, 76212.0, 78188.0, 93191.0, 93533.0, 95033.52483237539, 95641.0, 98635.50682246542, 22967.540649186587, 23653.172138975053, 23739.0, 23772.405689857893, 23808.761912380654, 25977.35056623524, 26275.868620656773, 26295.342616434744, 26419.603705944042, 26861.328466788487, 20486.38540843777, 20658.0, 21251.149954001667, 21485.67771483398, 21558.245461409402, 18104.547386315448, 18231.179596918435, 18340.266389344277, 18515.72226416578, 18882.433526994213, 21534.353969380943, 21643.783562164175, 21654.0, 21748.347549573537, 21777.782222177575, 22405.43986400353, 23602.527949441257, 23717.16989905345, 23728.339016268696, 23790.0, 20146.496337591092, 20716.274930377363, 20733.27433539819, 21007.369778906657, 21038.368848934555], "value": 13507.05654783849, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.738019169329, 1424.195329638754, 1450.1661544611845, 1457.0839346259675, 1460.1312219229555, 15239.466618668348, 15487.0, 15803.130827804465, 15817.36730530779, 15820.0, 15835.12906790126, 16294.83705162948, 16301.673966520662, 16306.0, 16428.507144785646, 2581.9672131147504, 2625.921222363332, 2629.947401051978, 2642.4979253941688, 2655.349439387343, 2698.8380697158136, 2791.7627001704877, 2799.860006999652, 2800.0339882740423, 2801.3696918193345, 2713.8507382093976, 2733.070755942979, 2757.6690797104375, 2763.4473105379006, 2767.0730305347734, 2698.1231099892516, 2713.4166154276927, 2717.442924200534, 2748.244232835976, 2757.586362045689, 2592.494463579603, 2613.8170328077044, 2622.082271205082, 2622.2002289301754, 2623.252373073665, 15124.697506049817, 15199.392024319013, 15316.540503784905, 15366.539003829903, 15423.768643470357, 7903.802404939865, 8182.918170818275, 8230.958845205796, 8239.052508961486, 8242.29940455062, 5204.245384419276, 5289.3652761668845, 5337.172738225581, 5404.243405923174, 5423.322084739408, 1924.5573518090916, 1949.4638974282186, 1956.5499935014884, 1964.499052741556, 1973.6842105263088, 26190.083347082953, 26719.0, 26772.59841102385, 26847.865760671073, 27564.586531202047, 7467.178610352857, 7488.0, 7515.586642734702, 7609.505382150142, 7719.421043421766, 20820.47948801292, 20825.37523874286, 20870.478238044172, 20920.686189707165, 20988.055537500848, 8440.53577053268, 8526.531040792815, 8535.701250456204, 8562.48625082497, 8573.614187361583, 7612.80967975805, 7645.808854778564, 7688.192739762357, 7711.768646940601, 7805.41459390548, 5761.53907687384, 5822.155787410887, 5904.763809447574, 5915.08316210988, 5947.226860508193, 1747.8164792696584, 1774.6007148391766, 1776.413783451458, 1830.7162389829598, 1853.6292741451764, 940.210223412337, 955.7658373698349, 961.4759955824093, 973.5862258540234, 974.8342781727123, 9119.863202051974, 9205.217556507772, 9234.1689247968, 9247.306452016126, 9427.811443771223, 1056.8678915135608, 1058.4072919165292, 1060.9151267898549, 1066.461436974323, 1083.7778255457613, 4796.352492413549, 4943.456219815817, 4953.43035550909, 4958.380202474691, 5004.074246264453, 22024.339269821932, 22134.0, 22341.776582233968, 22753.544929101325, 22781.088756449888, 22227.22204722859, 22340.55318893613, 22428.0, 22544.66183007256, 22635.320940371814, 11530.0, 12146.514139434501, 12250.877491225152, 12255.325957072446, 12280.815787763191, 8560.505734489443, 8647.394682372174, 8736.388452808242, 9057.81884362296, 9106.27149827999, 18626.348077817212, 19469.0, 19765.209391624176, 19785.802141978395, 19842.702359464332, 19329.710054349478, 19579.70630440516, 19683.901580492005, 19884.90057549703, 20071.799282007578, 12550.49798008106, 12745.299008554619, 12822.487100515875, 12829.037822163189, 12835.935820321212, 13861.514846980308, 14052.297385130907, 14131.222782747047, 14137.858621414065, 14333.928330358698, 11147.275427097213, 11189.832152517882, 11242.100631949588, 11509.53961841517, 11605.535778568763, 11113.055390291916, 11131.833022504507, 11194.328340299608, 11221.943890280823, 11333.773324533628, 10272.794544108927, 10350.22373322019, 10471.26701130944, 10488.68533943983, 10621.522031508446, 7961.442699011245, 8017.318527925192, 8108.797280068045, 8110.472819266729, 8231.835363292821, 8147.551884646165, 8153.510789352657, 8214.753557393287, 8272.37957153228, 8310.70912518059], "value": 7026.956335756235, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.2459521396369, 525.7660341148188, 528.4319356691557, 539.4039586257186, 544.216328486979, 5960.970195149023, 6052.334243233252, 6071.453569178773, 6077.665728384943, 6081.817545473643, 6003.879922401549, 6018.0, 6076.665783381913, 6080.665563394012, 6115.724792384342, 4866.9756651216785, 4877.975625118712, 4890.584300334458, 4894.632902532324, 4915.975420122894, 4701.224297990828, 4807.543283388072, 4863.319135321058, 4870.561649451549, 4918.090153321629, 4703.176944034797, 4745.1695953208055, 4746.477887432379, 4747.691400058985, 4761.309610106532, 4699.342092107091, 4717.174494463455, 4734.834280800155, 4766.213574760161, 4782.33047373368, 4196.9370459443135, 4258.276093064155, 4287.164003019412, 4304.956950430487, 4326.935095973563, 5774.0, 5895.64626122434, 5913.822585322448, 5923.940760592425, 5963.373845746221, 5693.117566777156, 5731.828045158652, 5735.971320143372, 5746.425357464262, 5760.193572899798, 6514.902276465809, 6544.4110030097045, 6550.2794692583775, 6551.6069035858, 6562.44219241365, 4892.094962431962, 4902.264660300983, 4907.043126590316, 4907.65039614109, 4920.630952678528, 6566.540342176049, 6688.632125233159, 6763.830904227384, 6811.386975172259, 6840.31596840317, 5032.7735251913755, 5049.6212784041345, 5058.8482345528955, 5059.696418214919, 5065.11360511909, 5140.280360749498, 5140.511651393112, 5166.199239117943, 5170.37955445349, 5179.19722443022, 5661.348944871393, 5694.288213973254, 5703.287089113861, 5723.055695810228, 5729.4843464088435, 6492.208350409369, 6545.410913017851, 6549.476041916635, 6570.5729127606555, 6596.406323430914, 1783.1084457771115, 1784.5895444047683, 1789.5168304557958, 1799.5591080185177, 1803.5761596025186, 1190.6785168004762, 1233.901287896966, 1255.5354518828092, 1261.8801213884667, 1262.7348256866162, 6228.283747369111, 6282.465990390868, 6282.968585157045, 6313.40022697843, 6374.9800031994655, 6527.412532871969, 6544.280129185786, 6602.339766023455, 6612.768553100618, 6620.304867988792, 6240.5319601030105, 6272.059191121369, 6305.432511074026, 6324.241091069009, 6394.936050639527, 3352.2122301259183, 3492.4586689063235, 3529.9117522061642, 3549.9290014199573, 3552.0, 6904.275051119661, 7006.229314775371, 7076.256993015762, 7085.610291434021, 7226.819329516804, 6281.968590157111, 6767.627780472121, 6780.3386171466855, 6790.94740315252, 6886.380225779704, 6820.192648948132, 6906.274841141608, 7026.754063607749, 7056.6118863463, 7124.145102587722, 6511.3163117871945, 6549.705263263069, 6617.272100069084, 6621.768238111643, 6681.1314529110905, 6445.677716114082, 6459.450946669585, 6539.803805885831, 6564.606123632598, 6624.205095388585, 6866.793996180123, 6980.441564674916, 7007.264237255219, 7073.2573079827935, 7073.508322215327, 5037.496250374933, 5062.670926389773, 5069.847904562869, 5094.363204599425, 5109.7700603472185, 6390.840228994312, 6503.414692677682, 6575.50683698715, 6664.5334826561675, 6711.94606454072, 6289.333326668528, 6363.904541431974, 6406.295307516262, 6482.675866206765, 6497.02544618311, 6287.23957291959, 6361.268454127649, 6363.6818159090935, 6428.742850285937, 6457.806265812033, 6447.580907241015, 6449.516286278454, 6454.804871588593, 6458.7093580789915, 6525.3148419417175, 6301.243850737757, 6363.490920726424, 6393.200849893763, 6444.258910225384, 6539.803805885831, 6221.222347206599, 6284.874302514016, 6290.182276304051, 6342.524310676626, 6370.840728981812], "value": 5062.104600000395, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [933.0622724162216, 941.5398410840162, 959.0553304994584, 962.6919385796543, 966.1208300446593, 16559.172041397927, 17108.486745397626, 17114.5721356966, 17181.312747490087, 22538.0, 21559.6766048509, 22031.66952495714, 22071.227507037256, 22106.0, 22129.55740885181, 1004.7789486313018, 1037.0459177556666, 1039.5841663334652, 1040.7294103533097, 1040.8282633365523, 1042.5152304178555, 1076.6554702495205, 1080.637986274595, 1093.923425360225, 1097.0291292206414, 1140.3044143072718, 1141.3551343490942, 1141.6860363400049, 1141.8173092305233, 1147.4492243723018, 1121.6466812953893, 1122.3995162588058, 1127.4024766873529, 1128.328644456551, 1136.1535655936339, 825.3397282174236, 829.1542626520915, 830.3523251863556, 830.9709160179425, 839.492107275102, 17722.113894305363, 17871.463856084338, 17881.0, 19258.614827703506, 21471.67792483114, 21980.89009554942, 22501.54996900069, 22514.774852251594, 22701.0, 22839.54320913589, 16669.666606667797, 16804.159792010352, 16807.0756108414, 16878.409255675993, 17355.305787768473, 3799.9620003799882, 3844.154286057063, 3852.6339997700175, 3852.903677408059, 3856.2287542491335, 149074.0, 150275.0, 150282.24858875744, 150815.0, 152907.0, 16968.66062678764, 17121.571960701083, 17293.221805018806, 17310.826891731173, 17390.21744021522, 33514.83242583772, 33753.15617109592, 34067.31865362679, 34349.48475772866, 34384.45269962858, 8142.918570814334, 8532.829343413097, 8981.461112333282, 9398.530073496435, 9571.856422153673, 4519.299508576176, 4609.032103258286, 4610.10103029906, 4623.075384922961, 4623.884402889955, 5686.488216060575, 5862.765489380462, 6243.96878015607, 6383.808485745435, 6433.967830160819, 1170.8829117088394, 1184.988150118505, 1205.8372119763894, 1207.1188032735977, 1222.4804458105448, 721.249900103886, 735.6652723011017, 738.1843063414957, 748.76413929612, 760.4486747108302, 12106.697332566757, 12580.496780128875, 13127.343632818322, 14305.356258968372, 14349.928250358682, 708.6810935079235, 729.7409419656052, 739.3087463221905, 750.1710609776228, 752.9360004399688, 6048.092786082035, 6938.722451101899, 7135.092006183551, 7195.352418282379, 7360.374368178657, 136400.0, 137678.31160844132, 142076.2896185533, 142562.0, 147241.26379368035, 127564.36217818852, 128830.0, 130940.0, 131754.0, 133705.0, 111886.0, 111988.0, 112287.87712122938, 113588.0, 116197.0, 12942.741145177231, 13235.69839802049, 13333.266670333225, 13417.060805743504, 13559.0, 47741.52258477371, 47921.520784791705, 48256.276155858395, 48552.27171592358, 48958.51041489682, 67182.66408667926, 67633.32366676467, 67847.0, 68236.0, 69507.65246173737, 17624.471265862045, 18192.727109093637, 18242.817571824642, 18345.08274586292, 18421.631567368844, 22774.430639233487, 23267.534649307257, 23483.765162348158, 24401.26796196117, 24811.25566233016, 20520.48698782483, 20566.38300850977, 20780.792192077886, 21015.264465744236, 21420.892895535424, 20550.07524661364, 20951.8952405237, 21666.24168154107, 21731.23940662069, 21744.56510869742, 19111.80888191156, 19892.801071989674, 20076.09657565384, 20083.297084601967, 20637.793622063586, 13909.791353129509, 14333.713325733219, 14780.408783648534, 15116.924415377853, 15359.385624574892, 15695.215239237765, 15786.289616967493, 15818.762718559, 16339.264733086802, 16407.83592164063], "value": 10089.04827243104, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1464.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 106.0, 100.0, 106.0, 107.0, 108.0, 114.0, 98.0, 106.0, 108.0], "value": 105.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 114.0, 148.0, 166.0, 129.0, 135.0, 138.0, 113.0, 160.0, 115.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 163.0, 161.0, 160.0, 162.0, 162.0, 165.0, 175.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 103.0, 75.0, 75.0, 76.0, 87.0, 98.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 122.0, 79.0, 78.0, 79.0, 126.0, 78.0, 78.0, 132.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 118.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 150.0, 148.0, 148.0, 149.0, 149.0, 147.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 99.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 48.0, 47.0, 47.0, 49.0, 46.0, 50.0, 46.0, 46.0, 47.0], "value": 47.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 76.0, 74.0, 90.0, 75.0, 74.0, 74.0, 74.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 130.0, 116.0, 119.0, 126.0, 120.0, 132.0, 118.0, 121.0, 153.0], "value": 125.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 163.0, 170.0, 164.0, 162.0, 162.0, 169.0, 167.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 64.0, 61.0, 64.0, 60.0, 60.0, 61.0, 61.0], "value": 61.4, "unit": "score"}]}]} 17:16:04 INFO - Return code: 0 17:16:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:16:04 INFO - # TBPL SUCCESS # 17:16:04 INFO - Running post-action listener: _package_coverage_data 17:16:04 INFO - Running post-action listener: _resource_record_post_action 17:16:04 INFO - [mozharness: 2017-08-10 00:16:04.489493Z] Finished run-tests step (success) 17:16:04 INFO - Running post-run listener: _resource_record_post_run 17:16:04 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 434176; Write bytes: 439480320; Read time: 280; Write time: 397176 17:16:04 INFO - TinderboxPrint: CPU usage
13.1% 17:16:04 INFO - TinderboxPrint: I/O read bytes / time
434,176 / 280 17:16:04 INFO - TinderboxPrint: I/O write bytes / time
439,480,320 / 397,176 17:16:04 INFO - TinderboxPrint: CPU idle
8,234.1 (86.9%) 17:16:04 INFO - TinderboxPrint: CPU user
1,191.3 (12.6%) 17:16:04 INFO - TinderboxPrint: Swap in / out
0 / 0 17:16:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 119169024; Read time: 28; Write time: 100696 17:16:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:16:04 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 425984; Write bytes: 319275008; Read time: 236; Write time: 296444 17:16:05 INFO - Running post-run listener: _upload_blobber_files 17:16:05 INFO - Blob upload gear active. 17:16:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:16:05 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 17:16:05 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'] 17:16:05 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 17:16:05 INFO - (blobuploader) - INFO - Open directory for files ... 17:16:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:16:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:16:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:06 INFO - (blobuploader) - INFO - Done attempting. 17:16:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:16:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:16:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:08 INFO - (blobuploader) - INFO - Done attempting. 17:16:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:16:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:16:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:09 INFO - (blobuploader) - INFO - Done attempting. 17:16:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:16:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:16:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:15 INFO - (blobuploader) - INFO - Done attempting. 17:16:15 INFO - (blobuploader) - INFO - Iteration through files over. 17:16:15 INFO - Return code: 0 17:16:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:16:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:16:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66804fcfaab607339751f71645d79eec12a9ed2f374fd5de2c6a8c896e88f011abb28aa020edc7e4a6050bb9874974b323652ec457e4c19ba42602f333b5ba85", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/202745de022185ec829fd90974acef9973360155cb230fdd17112cdd2ff741a0d6bb0aaa091cf68106d98f570ffe4cec3da66a9a2f50738366177b7be1107ee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbb6fe53831f55aefa8d1ca1bebf158adb85ac758112f79a0698a37be027467f9777fb4ac27702ac76ea4a9c4fdf7f7c5092e79c85ed9a69a831b1c378036e09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31f55de4e67c10b7f7998d30d5008d0adcd723ca653795dcad54edfe4653079724d6bcb44926be3426879d889d1febf0b366fdbf8b1d4e9b024e09bd47bf4d95"} 17:16:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:16:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:16:15 INFO - Contents: 17:16:15 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66804fcfaab607339751f71645d79eec12a9ed2f374fd5de2c6a8c896e88f011abb28aa020edc7e4a6050bb9874974b323652ec457e4c19ba42602f333b5ba85", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/202745de022185ec829fd90974acef9973360155cb230fdd17112cdd2ff741a0d6bb0aaa091cf68106d98f570ffe4cec3da66a9a2f50738366177b7be1107ee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbb6fe53831f55aefa8d1ca1bebf158adb85ac758112f79a0698a37be027467f9777fb4ac27702ac76ea4a9c4fdf7f7c5092e79c85ed9a69a831b1c378036e09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31f55de4e67c10b7f7998d30d5008d0adcd723ca653795dcad54edfe4653079724d6bcb44926be3426879d889d1febf0b366fdbf8b1d4e9b024e09bd47bf4d95"} 17:16:15 INFO - Running post-run listener: copy_logs_to_upload_dir 17:16:15 INFO - Copying logs to upload dir... 17:16:15 INFO - mkdir: /builds/slave/test/build/upload/logs 17:16:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.418534 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-09 17:16:15.840478) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-09 17:16:15.845245) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819 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/66804fcfaab607339751f71645d79eec12a9ed2f374fd5de2c6a8c896e88f011abb28aa020edc7e4a6050bb9874974b323652ec457e4c19ba42602f333b5ba85", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/202745de022185ec829fd90974acef9973360155cb230fdd17112cdd2ff741a0d6bb0aaa091cf68106d98f570ffe4cec3da66a9a2f50738366177b7be1107ee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbb6fe53831f55aefa8d1ca1bebf158adb85ac758112f79a0698a37be027467f9777fb4ac27702ac76ea4a9c4fdf7f7c5092e79c85ed9a69a831b1c378036e09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31f55de4e67c10b7f7998d30d5008d0adcd723ca653795dcad54edfe4653079724d6bcb44926be3426879d889d1febf0b366fdbf8b1d4e9b024e09bd47bf4d95"} build_url:https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011810 build_url: 'https://queue.taskcluster.net/v1/task/Fg3PAxRJSjOmHq9TmKc96Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66804fcfaab607339751f71645d79eec12a9ed2f374fd5de2c6a8c896e88f011abb28aa020edc7e4a6050bb9874974b323652ec457e4c19ba42602f333b5ba85", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/202745de022185ec829fd90974acef9973360155cb230fdd17112cdd2ff741a0d6bb0aaa091cf68106d98f570ffe4cec3da66a9a2f50738366177b7be1107ee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbb6fe53831f55aefa8d1ca1bebf158adb85ac758112f79a0698a37be027467f9777fb4ac27702ac76ea4a9c4fdf7f7c5092e79c85ed9a69a831b1c378036e09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31f55de4e67c10b7f7998d30d5008d0adcd723ca653795dcad54edfe4653079724d6bcb44926be3426879d889d1febf0b366fdbf8b1d4e9b024e09bd47bf4d95"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-09 17:16:15.870948) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 17:16:15.871274) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1502321685.446847-1999808819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004385 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 17:16:15.955636) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-09 17:16:15.955957) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-09 17:16:15.956259) ========= ========= Total master_lag: 0.18 =========