builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1502853308.53 results: success (0) revision: 4e93516e92e58d166ad37b8544c3230024afb587 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 20:15:08.534747) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 20:15:08.535405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 20:15:08.535748) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 20:15:08.578361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:15:08.578682) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 20:15:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-08-15 20:15:08 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074119 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:15:08.809594) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:15:08.809926) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018350 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:15:08.866950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-15 20:15:08.867327) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4e93516e92e58d166ad37b8544c3230024afb587 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 4e93516e92e58d166ad37b8544c3230024afb587 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 20:15:08,955 truncating revision to first 12 chars 2017-08-15 20:15:08,955 Setting DEBUG logging. 2017-08-15 20:15:08,955 attempt 1/10 2017-08-15 20:15:08,955 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4e93516e92e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-15 20:15:09,897 unpacking tar archive at: mozilla-central-4e93516e92e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.312323 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-15 20:15:10.202638) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 20:15:10.203008) ========= script_repo_revision: 4e93516e92e58d166ad37b8544c3230024afb587 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 20:15:10.203444) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 20:15:10.203767) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 20:15:10.216759) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-15 20:15:10.217519) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:15:10 INFO - MultiFileLogger online at 20170815 20:15:10 in /builds/slave/test 20:15:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 20:15:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:15:10 INFO - {'append_to_log': False, 20:15:10 INFO - 'base_work_dir': '/builds/slave/test', 20:15:10 INFO - 'blob_upload_branch': 'Firefox', 20:15:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:15:10 INFO - 'branch': 'Firefox', 20:15:10 INFO - 'buildbot_json_path': 'buildprops.json', 20:15:10 INFO - 'code_coverage': False, 20:15:10 INFO - 'config_files': ('talos/linux_config.py',), 20:15:10 INFO - 'default_actions': ('clobber', 20:15:10 INFO - 'read-buildbot-config', 20:15:10 INFO - 'download-and-extract', 20:15:10 INFO - 'populate-webroot', 20:15:10 INFO - 'create-virtualenv', 20:15:10 INFO - 'install', 20:15:10 INFO - 'setup-mitmproxy', 20:15:10 INFO - 'run-tests'), 20:15:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:15:10 INFO - 'disable_ccov_upload': False, 20:15:10 INFO - 'download_minidump_stackwalk': True, 20:15:10 INFO - 'download_symbols': 'ondemand', 20:15:10 INFO - 'enable_stylo': False, 20:15:10 INFO - 'enable_webrender': False, 20:15:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:15:10 INFO - 'tooltool.py': '/tools/tooltool.py', 20:15:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:15:10 INFO - '/tools/misc-python/virtualenv.py')}, 20:15:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:15:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:15:10 INFO - 'gecko_profile': False, 20:15:10 INFO - 'gecko_profile_interval': 0, 20:15:10 INFO - 'installer_path': 'installer.exe', 20:15:10 INFO - 'log_level': 'info', 20:15:10 INFO - 'log_name': 'talos', 20:15:10 INFO - 'log_to_console': True, 20:15:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:15:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:15:10 INFO - 'opt_config_files': (), 20:15:10 INFO - 'pip_index': False, 20:15:10 INFO - 'suite': 'dromaeojs-e10s', 20:15:10 INFO - 'system_bits': '32', 20:15:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:15:10 INFO - 'title': 'talos-linux64-ix-005', 20:15:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:15:10 INFO - 'use_talos_json': True, 20:15:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:15:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:15:10 INFO - 'work_dir': 'build'} 20:15:10 INFO - [mozharness: 2017-08-16 03:15:10.410133Z] Running clobber step. 20:15:10 INFO - Running pre-action listener: _resource_record_pre_action 20:15:10 INFO - Running main action method: clobber 20:15:10 INFO - rmtree: /builds/slave/test/build 20:15:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:15:11 INFO - Running post-action listener: _resource_record_post_action 20:15:11 INFO - [mozharness: 2017-08-16 03:15:11.438232Z] Finished clobber step (success) 20:15:11 INFO - [mozharness: 2017-08-16 03:15:11.438334Z] Running read-buildbot-config step. 20:15:11 INFO - Running pre-action listener: _resource_record_pre_action 20:15:11 INFO - Running main action method: read_buildbot_config 20:15:11 INFO - Using buildbot properties: 20:15:11 INFO - { 20:15:11 INFO - "project": "", 20:15:11 INFO - "product": "firefox", 20:15:11 INFO - "who": "kwierso@gmail.com", 20:15:11 INFO - "installer_path": "public/build/target.tar.bz2", 20:15:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 20:15:11 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 20:15:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 20:15:11 INFO - "stage_platform": "linux64-pgo", 20:15:11 INFO - "basedir": "/builds/slave/test", 20:15:11 INFO - "buildnumber": 121, 20:15:11 INFO - "platform": "ubuntu64_hw", 20:15:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:15:11 INFO - "slavebuilddir": "test", 20:15:11 INFO - "taskId": "NLvrYZroQNmTMDa2WWpAXw", 20:15:11 INFO - "branch": "mozilla-central", 20:15:11 INFO - "script_repo_revision": "production", 20:15:11 INFO - "revision": "4e93516e92e58d166ad37b8544c3230024afb587", 20:15:11 INFO - "slavename": "talos-linux64-ix-005", 20:15:11 INFO - "repo_path": "mozilla-central" 20:15:11 INFO - } 20:15:11 INFO - Finding installer, test and symbols from parent task. 20:15:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NLvrYZroQNmTMDa2WWpAXw'}, attempt #1 20:15:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NLvrYZroQNmTMDa2WWpAXw'}, attempt #1 20:15:12 INFO - Task dependencies: Dj1rJa8YSTaD8DJ0ubbRJA 20:15:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA'}, attempt #1 20:15:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.tar.bz2 20:15:12 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.test_packages.json 20:15:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.crashreporter-symbols.zip 20:15:12 INFO - Running post-action listener: _resource_record_post_action 20:15:12 INFO - [mozharness: 2017-08-16 03:15:12.815114Z] Finished read-buildbot-config step (success) 20:15:12 INFO - [mozharness: 2017-08-16 03:15:12.815333Z] Running download-and-extract step. 20:15:12 INFO - Running pre-action listener: _resource_record_pre_action 20:15:12 INFO - Running main action method: download_and_extract 20:15:12 INFO - mkdir: /builds/slave/test/build/tests 20:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:12 INFO - trying https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.test_packages.json 20:15:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:15:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:15:13 INFO - Downloaded 989 bytes. 20:15:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:15:13 INFO - Using the following test package requirements: 20:15:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:15:13 INFO - u'common': [u'target.common.tests.zip'], 20:15:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:15:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:15:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:15:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:15:13 INFO - u'mozbase': [u'target.common.tests.zip'], 20:15:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:15:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:15:13 INFO - u'web-platform': [u'target.common.tests.zip', 20:15:13 INFO - u'target.web-platform.tests.tar.gz'], 20:15:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:15:13 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 20:15:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.common.tests.zip 20:15:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:15:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.common.tests.zip into memory 20:15:14 INFO - Content-Length response header: 54611568 20:15:14 INFO - Bytes received: 54611568 20:15:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 20:15:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.common.tests.zip 20:15:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:15:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.common.tests.zip into memory 20:15:26 INFO - Content-Length response header: 54611568 20:15:26 INFO - Bytes received: 54611568 20:15:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.talos.tests.zip 20:15:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:15:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.talos.tests.zip into memory 20:15:40 INFO - Content-Length response header: 14496050 20:15:40 INFO - Bytes received: 14496050 20:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:40 INFO - trying https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.tar.bz2 20:15:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:15:41 INFO - Downloaded 62731776 bytes. 20:15:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.tar.bz2 20:15:41 INFO - mkdir: /builds/slave/test/properties 20:15:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:15:41 INFO - Writing to file /builds/slave/test/properties/build_url 20:15:41 INFO - Contents: 20:15:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.tar.bz2 20:15:41 INFO - Running post-action listener: _resource_record_post_action 20:15:41 INFO - Running post-action listener: set_extra_try_arguments 20:15:41 INFO - [mozharness: 2017-08-16 03:15:41.559581Z] Finished download-and-extract step (success) 20:15:41 INFO - [mozharness: 2017-08-16 03:15:41.559678Z] Running populate-webroot step. 20:15:41 INFO - Running pre-action listener: _resource_record_pre_action 20:15:41 INFO - Running main action method: populate_webroot 20:15:41 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:15:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:15:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:15:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:15:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:15:41 INFO - 'tests': ['damp', 'tps']}, 20:15:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:15:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:15:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 20:15:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 20:15:41 INFO - 'other-e10s': {'tests': ['a11yr', 20:15:41 INFO - 'ts_paint', 20:15:41 INFO - 'tpaint', 20:15:41 INFO - 'sessionrestore', 20:15:41 INFO - 'sessionrestore_many_windows', 20:15:41 INFO - 'sessionrestore_no_auto_restore', 20:15:41 INFO - 'tabpaint']}, 20:15:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 20:15:41 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 20:15:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:15:41 INFO - 'tsvgr_opacity', 20:15:41 INFO - 'tart', 20:15:41 INFO - 'tscrollx', 20:15:41 INFO - 'tsvg_static']}, 20:15:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:15:41 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:15:41 INFO - 'talos_options': ['--mitmproxy', 20:15:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:15:41 INFO - '--firstNonBlankPaint'], 20:15:41 INFO - 'tests': ['tp6_google', 20:15:41 INFO - 'tp6_youtube', 20:15:41 INFO - 'tp6_amazon', 20:15:41 INFO - 'tp6_facebook']}, 20:15:41 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:15:41 INFO - 'talos_options': ['--stylo', 20:15:41 INFO - '--mitmproxy', 20:15:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:15:41 INFO - '--firstNonBlankPaint'], 20:15:41 INFO - 'tests': ['tp6_google', 20:15:41 INFO - 'tp6_youtube', 20:15:41 INFO - 'tp6_amazon', 20:15:41 INFO - 'tp6_facebook']}, 20:15:41 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:15:41 INFO - 'talos_options': ['--stylo', 20:15:41 INFO - '--stylo-threads=1', 20:15:41 INFO - '--mitmproxy', 20:15:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:15:41 INFO - '--firstNonBlankPaint'], 20:15:41 INFO - 'tests': ['tp6_google', 20:15:41 INFO - 'tp6_youtube', 20:15:41 INFO - 'tp6_amazon', 20:15:41 INFO - 'tp6_facebook']}, 20:15:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:15:41 INFO - 'talos_options': ['--xperf_path', 20:15:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:15:41 INFO - 'tests': ['tp5n']}}} 20:15:41 INFO - Running post-action listener: _resource_record_post_action 20:15:41 INFO - [mozharness: 2017-08-16 03:15:41.568089Z] Finished populate-webroot step (success) 20:15:41 INFO - [mozharness: 2017-08-16 03:15:41.568179Z] Running create-virtualenv step. 20:15:41 INFO - Running pre-action listener: _resource_record_pre_action 20:15:41 INFO - Running main action method: create_virtualenv 20:15:41 INFO - Creating virtualenv /builds/slave/test/build/venv 20:15:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:15:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:15:41 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 20:15:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:15:41 INFO - Using real prefix '/usr' 20:15:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:15:42 INFO - Installing distribute.............................................................................................................................................................................................done. 20:15:44 INFO - Installing pip.................done. 20:15:44 INFO - Return code: 0 20:15:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:15:44 INFO - Reading from file tmpfile_stdout 20:15:44 INFO - Output received: 20:15:44 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:15:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:44 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 0x16811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1928ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19260b0>, '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 0x1926fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:15:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:15:44 INFO - Using env: {'DISPLAY': ':0', 20:15:44 INFO - 'HOME': '/home/cltbld', 20:15:44 INFO - 'LANG': 'en_US.UTF-8', 20:15:44 INFO - 'LANGUAGE': 'en_US:en', 20:15:44 INFO - 'LOGNAME': 'cltbld', 20:15:44 INFO - 'MAIL': '/var/mail/cltbld', 20:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:44 INFO - 'MOZ_NO_REMOTE': '1', 20:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:44 INFO - 'NO_EM_RESTART': '1', 20:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:44 INFO - 'PWD': '/builds/slave/test', 20:15:44 INFO - 'SHELL': '/bin/bash', 20:15:44 INFO - 'SHLVL': '1', 20:15:44 INFO - 'TERM': 'linux', 20:15:44 INFO - 'TMOUT': '86400', 20:15:44 INFO - 'USER': 'cltbld', 20:15:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 20:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:44 INFO - '_': '/tools/buildbot/bin/python'} 20:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:15:44 INFO - Cleaning up... 20:15:44 INFO - Return code: 0 20:15:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:44 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 0x16811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1928ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19260b0>, '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 0x1926fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:15:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:15:44 INFO - Using env: {'DISPLAY': ':0', 20:15:44 INFO - 'HOME': '/home/cltbld', 20:15:44 INFO - 'LANG': 'en_US.UTF-8', 20:15:44 INFO - 'LANGUAGE': 'en_US:en', 20:15:44 INFO - 'LOGNAME': 'cltbld', 20:15:44 INFO - 'MAIL': '/var/mail/cltbld', 20:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:44 INFO - 'MOZ_NO_REMOTE': '1', 20:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:44 INFO - 'NO_EM_RESTART': '1', 20:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:44 INFO - 'PWD': '/builds/slave/test', 20:15:44 INFO - 'SHELL': '/bin/bash', 20:15:44 INFO - 'SHLVL': '1', 20:15:44 INFO - 'TERM': 'linux', 20:15:44 INFO - 'TMOUT': '86400', 20:15:44 INFO - 'USER': 'cltbld', 20:15:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 20:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:44 INFO - '_': '/tools/buildbot/bin/python'} 20:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:44 INFO - Downloading/unpacking psutil>=3.1.1 20:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:15:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:15:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:15:45 INFO - Installing collected packages: psutil 20:15:45 INFO - Running setup.py install for psutil 20:15:46 INFO - building 'psutil._psutil_linux' extension 20:15:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:15:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:15:46 INFO - building 'psutil._psutil_posix' extension 20:15:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:15:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:15:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:15:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:15:46 INFO - Successfully installed psutil 20:15:46 INFO - Cleaning up... 20:15:46 INFO - Return code: 0 20:15:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:46 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 0x16811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1928ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19260b0>, '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 0x1926fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:15:46 INFO - Using env: {'DISPLAY': ':0', 20:15:46 INFO - 'HOME': '/home/cltbld', 20:15:46 INFO - 'LANG': 'en_US.UTF-8', 20:15:46 INFO - 'LANGUAGE': 'en_US:en', 20:15:46 INFO - 'LOGNAME': 'cltbld', 20:15:46 INFO - 'MAIL': '/var/mail/cltbld', 20:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:46 INFO - 'MOZ_NO_REMOTE': '1', 20:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:46 INFO - 'NO_EM_RESTART': '1', 20:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:46 INFO - 'PWD': '/builds/slave/test', 20:15:46 INFO - 'SHELL': '/bin/bash', 20:15:46 INFO - 'SHLVL': '1', 20:15:46 INFO - 'TERM': 'linux', 20:15:46 INFO - 'TMOUT': '86400', 20:15:46 INFO - 'USER': 'cltbld', 20:15:46 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 20:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:46 INFO - '_': '/tools/buildbot/bin/python'} 20:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:15:47 INFO - Installing collected packages: mozsystemmonitor 20:15:47 INFO - Running setup.py install for mozsystemmonitor 20:15:47 INFO - Successfully installed mozsystemmonitor 20:15:47 INFO - Cleaning up... 20:15:48 INFO - Return code: 0 20:15:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:48 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 0x16811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1928ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19260b0>, '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 0x1926fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:15:48 INFO - Using env: {'DISPLAY': ':0', 20:15:48 INFO - 'HOME': '/home/cltbld', 20:15:48 INFO - 'LANG': 'en_US.UTF-8', 20:15:48 INFO - 'LANGUAGE': 'en_US:en', 20:15:48 INFO - 'LOGNAME': 'cltbld', 20:15:48 INFO - 'MAIL': '/var/mail/cltbld', 20:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:48 INFO - 'MOZ_NO_REMOTE': '1', 20:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:48 INFO - 'NO_EM_RESTART': '1', 20:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:48 INFO - 'PWD': '/builds/slave/test', 20:15:48 INFO - 'SHELL': '/bin/bash', 20:15:48 INFO - 'SHLVL': '1', 20:15:48 INFO - 'TERM': 'linux', 20:15:48 INFO - 'TMOUT': '86400', 20:15:48 INFO - 'USER': 'cltbld', 20:15:48 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 20:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:48 INFO - '_': '/tools/buildbot/bin/python'} 20:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:48 INFO - Downloading/unpacking jsonschema==2.5.1 20:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:15:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:49 INFO - Downloading functools32-3.2.3-2.tar.gz 20:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:15:49 INFO - warning: no files found matching '*.txt' 20:15:49 INFO - no previously-included directories found matching 'build' 20:15:49 INFO - no previously-included directories found matching 'dist' 20:15:49 INFO - no previously-included directories found matching '.git*' 20:15:49 INFO - Installing collected packages: jsonschema, functools32 20:15:49 INFO - Running setup.py install for functools32 20:15:49 INFO - warning: no files found matching '*.txt' 20:15:49 INFO - no previously-included directories found matching 'build' 20:15:49 INFO - no previously-included directories found matching 'dist' 20:15:49 INFO - no previously-included directories found matching '.git*' 20:15:49 INFO - Successfully installed jsonschema functools32 20:15:49 INFO - Cleaning up... 20:15:49 INFO - Return code: 0 20:15:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:49 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 0x16811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1928ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19260b0>, '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 0x1926fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:15:49 INFO - Using env: {'DISPLAY': ':0', 20:15:49 INFO - 'HOME': '/home/cltbld', 20:15:49 INFO - 'LANG': 'en_US.UTF-8', 20:15:49 INFO - 'LANGUAGE': 'en_US:en', 20:15:49 INFO - 'LOGNAME': 'cltbld', 20:15:49 INFO - 'MAIL': '/var/mail/cltbld', 20:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:49 INFO - 'MOZ_NO_REMOTE': '1', 20:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:49 INFO - 'NO_EM_RESTART': '1', 20:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:49 INFO - 'PWD': '/builds/slave/test', 20:15:49 INFO - 'SHELL': '/bin/bash', 20:15:49 INFO - 'SHLVL': '1', 20:15:49 INFO - 'TERM': 'linux', 20:15:49 INFO - 'TMOUT': '86400', 20:15:49 INFO - 'USER': 'cltbld', 20:15:49 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 20:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:49 INFO - '_': '/tools/buildbot/bin/python'} 20:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:15:49 INFO - Cleaning up... 20:15:49 INFO - Return code: 0 20:15:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:49 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 0x16811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1928ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19260b0>, '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 0x1926fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:15:49 INFO - Using env: {'DISPLAY': ':0', 20:15:49 INFO - 'HOME': '/home/cltbld', 20:15:49 INFO - 'LANG': 'en_US.UTF-8', 20:15:49 INFO - 'LANGUAGE': 'en_US:en', 20:15:49 INFO - 'LOGNAME': 'cltbld', 20:15:49 INFO - 'MAIL': '/var/mail/cltbld', 20:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:49 INFO - 'MOZ_NO_REMOTE': '1', 20:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:49 INFO - 'NO_EM_RESTART': '1', 20:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:49 INFO - 'PWD': '/builds/slave/test', 20:15:49 INFO - 'SHELL': '/bin/bash', 20:15:49 INFO - 'SHLVL': '1', 20:15:49 INFO - 'TERM': 'linux', 20:15:49 INFO - 'TMOUT': '86400', 20:15:49 INFO - 'USER': 'cltbld', 20:15:49 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 20:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:49 INFO - '_': '/tools/buildbot/bin/python'} 20:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:50 INFO - Downloading/unpacking blobuploader==1.2.4 20:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:51 INFO - Downloading blobuploader-1.2.4.tar.gz 20:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:15:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:15:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:51 INFO - Downloading docopt-0.6.1.tar.gz 20:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:15:51 INFO - Installing collected packages: blobuploader, requests, docopt 20:15:51 INFO - Running setup.py install for blobuploader 20:15:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:15:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:15:51 INFO - Running setup.py install for requests 20:15:52 INFO - Running setup.py install for docopt 20:15:52 INFO - Successfully installed blobuploader requests docopt 20:15:52 INFO - Cleaning up... 20:15:52 INFO - Return code: 0 20:15:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:52 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 0x16811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1928ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19260b0>, '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 0x1926fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:15:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:15:52 INFO - Using env: {'DISPLAY': ':0', 20:15:52 INFO - 'HOME': '/home/cltbld', 20:15:52 INFO - 'LANG': 'en_US.UTF-8', 20:15:52 INFO - 'LANGUAGE': 'en_US:en', 20:15:52 INFO - 'LOGNAME': 'cltbld', 20:15:52 INFO - 'MAIL': '/var/mail/cltbld', 20:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:52 INFO - 'MOZ_NO_REMOTE': '1', 20:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:52 INFO - 'NO_EM_RESTART': '1', 20:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:52 INFO - 'PWD': '/builds/slave/test', 20:15:52 INFO - 'SHELL': '/bin/bash', 20:15:52 INFO - 'SHLVL': '1', 20:15:52 INFO - 'TERM': 'linux', 20:15:52 INFO - 'TMOUT': '86400', 20:15:52 INFO - 'USER': 'cltbld', 20:15:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 20:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:52 INFO - '_': '/tools/buildbot/bin/python'} 20:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:15:52 INFO - Running setup.py (path:/tmp/pip-hLrcYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:15:52 INFO - Running setup.py (path:/tmp/pip-Ui6MA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:15:52 INFO - Running setup.py (path:/tmp/pip-lDognY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:15:52 INFO - Running setup.py (path:/tmp/pip-zsv9m6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:15:52 INFO - Running setup.py (path:/tmp/pip-guVKXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:15:53 INFO - Running setup.py (path:/tmp/pip-zvCiT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:15:53 INFO - Running setup.py (path:/tmp/pip-EKTYnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:15:53 INFO - Running setup.py (path:/tmp/pip-HtaHxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:15:53 INFO - Running setup.py (path:/tmp/pip-C8YryS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:15:53 INFO - Running setup.py (path:/tmp/pip-twzoD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:15:53 INFO - Running setup.py (path:/tmp/pip-HKsWlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:15:53 INFO - Running setup.py (path:/tmp/pip-1vMgT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:15:53 INFO - Running setup.py (path:/tmp/pip-RusGN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:15:53 INFO - Running setup.py (path:/tmp/pip-n3kibP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:53 INFO - Running setup.py (path:/tmp/pip-HtnI3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:15:53 INFO - Running setup.py (path:/tmp/pip-ZssBqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:15:53 INFO - Running setup.py (path:/tmp/pip-bv3dJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:15:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:15:53 INFO - Running setup.py install for manifestparser 20:15:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:15:53 INFO - Running setup.py install for mozcrash 20:15:54 INFO - Running setup.py install for mozdebug 20:15:54 INFO - Running setup.py install for mozdevice 20:15:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:15:54 INFO - Running setup.py install for mozfile 20:15:54 INFO - Running setup.py install for mozhttpd 20:15:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:15:54 INFO - Running setup.py install for mozinfo 20:15:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:15:54 INFO - Running setup.py install for mozInstall 20:15:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:15:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:15:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:15:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:15:54 INFO - Running setup.py install for mozleak 20:15:54 INFO - Running setup.py install for mozlog 20:15:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:15:54 INFO - Running setup.py install for moznetwork 20:15:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:15:55 INFO - Running setup.py install for mozprocess 20:15:55 INFO - Running setup.py install for mozprofile 20:15:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:15:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:15:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:15:55 INFO - Running setup.py install for mozrunner 20:15:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:15:55 INFO - Running setup.py install for mozscreenshot 20:15:55 INFO - Running setup.py install for moztest 20:15:55 INFO - Running setup.py install for mozversion 20:15:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:15:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:15:55 INFO - Cleaning up... 20:15:55 INFO - Return code: 0 20:15:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:55 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 0x16811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1928ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19260b0>, '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 0x1926fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:15:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:15:55 INFO - Using env: {'DISPLAY': ':0', 20:15:55 INFO - 'HOME': '/home/cltbld', 20:15:55 INFO - 'LANG': 'en_US.UTF-8', 20:15:55 INFO - 'LANGUAGE': 'en_US:en', 20:15:55 INFO - 'LOGNAME': 'cltbld', 20:15:55 INFO - 'MAIL': '/var/mail/cltbld', 20:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:55 INFO - 'MOZ_NO_REMOTE': '1', 20:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:55 INFO - 'NO_EM_RESTART': '1', 20:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:55 INFO - 'PWD': '/builds/slave/test', 20:15:55 INFO - 'SHELL': '/bin/bash', 20:15:55 INFO - 'SHLVL': '1', 20:15:55 INFO - 'TERM': 'linux', 20:15:55 INFO - 'TMOUT': '86400', 20:15:55 INFO - 'USER': 'cltbld', 20:15:55 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 20:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:55 INFO - '_': '/tools/buildbot/bin/python'} 20:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:15:55 INFO - Running setup.py (path:/tmp/pip-2rSSIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:15:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:15:55 INFO - Running setup.py (path:/tmp/pip-1Yt49Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:15:56 INFO - Running setup.py (path:/tmp/pip-gc8If1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:15:56 INFO - Running setup.py (path:/tmp/pip-bwXMGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:15:56 INFO - Running setup.py (path:/tmp/pip-5K6Ht2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:15:56 INFO - Running setup.py (path:/tmp/pip-7c35eT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:15:56 INFO - Running setup.py (path:/tmp/pip-Qr6DVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:15:56 INFO - Running setup.py (path:/tmp/pip-WTw5AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:15:56 INFO - Running setup.py (path:/tmp/pip-8UkEkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:15:56 INFO - Running setup.py (path:/tmp/pip-mHARKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:15:56 INFO - Running setup.py (path:/tmp/pip-8xhHDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:15:56 INFO - Running setup.py (path:/tmp/pip-zfzviu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:15:56 INFO - Running setup.py (path:/tmp/pip-y1FUjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:15:56 INFO - Running setup.py (path:/tmp/pip-LSzoff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:56 INFO - Running setup.py (path:/tmp/pip-2CwWxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:15:57 INFO - Running setup.py (path:/tmp/pip-Q6WWnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:15:57 INFO - Running setup.py (path:/tmp/pip-4O7YxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:15:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:58 INFO - Downloading blessings-1.6.tar.gz 20:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:15:58 INFO - Installing collected packages: blessings 20:15:58 INFO - Running setup.py install for blessings 20:15:58 INFO - Successfully installed blessings 20:15:58 INFO - Cleaning up... 20:15:58 INFO - Return code: 0 20:15:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:15:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:15:58 INFO - Reading from file tmpfile_stdout 20:15:58 INFO - Current package versions: 20:15:58 INFO - argparse == 1.2.1 20:15:58 INFO - blessings == 1.6 20:15:58 INFO - blobuploader == 1.2.4 20:15:58 INFO - docopt == 0.6.1 20:15:58 INFO - functools32 == 3.2.3-2 20:15:58 INFO - jsonschema == 2.5.1 20:15:58 INFO - manifestparser == 1.1 20:15:58 INFO - mozInstall == 1.13 20:15:58 INFO - mozcrash == 1.0 20:15:58 INFO - mozdebug == 0.1 20:15:58 INFO - mozdevice == 0.51 20:15:58 INFO - mozfile == 1.2 20:15:58 INFO - mozhttpd == 0.7 20:15:58 INFO - mozinfo == 0.10 20:15:58 INFO - mozleak == 0.1 20:15:58 INFO - mozlog == 3.5 20:15:58 INFO - moznetwork == 0.27 20:15:58 INFO - mozprocess == 0.25 20:15:58 INFO - mozprofile == 0.28 20:15:58 INFO - mozrunner == 6.13 20:15:58 INFO - mozscreenshot == 0.1 20:15:58 INFO - mozsystemmonitor == 0.3 20:15:58 INFO - moztest == 0.8 20:15:58 INFO - mozversion == 1.4 20:15:58 INFO - psutil == 3.1.1 20:15:58 INFO - requests == 1.2.3 20:15:58 INFO - wsgiref == 0.1.2 20:15:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15: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')]} 20:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15: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')]} 20:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:58 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 0x16811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1928ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19260b0>, '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 0x1926fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:15:58 INFO - Using env: {'DISPLAY': ':0', 20:15:58 INFO - 'HOME': '/home/cltbld', 20:15:58 INFO - 'LANG': 'en_US.UTF-8', 20:15:58 INFO - 'LANGUAGE': 'en_US:en', 20:15:58 INFO - 'LOGNAME': 'cltbld', 20:15:58 INFO - 'MAIL': '/var/mail/cltbld', 20:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:58 INFO - 'MOZ_NO_REMOTE': '1', 20:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:58 INFO - 'NO_EM_RESTART': '1', 20:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:58 INFO - 'PWD': '/builds/slave/test', 20:15:58 INFO - 'SHELL': '/bin/bash', 20:15:58 INFO - 'SHLVL': '1', 20:15:58 INFO - 'TERM': 'linux', 20:15:58 INFO - 'TMOUT': '86400', 20:15:58 INFO - 'USER': 'cltbld', 20:15:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 20:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:58 INFO - '_': '/tools/buildbot/bin/python'} 20:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:15:58 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 20:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 20:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:16:00 INFO - Installing collected packages: simplejson 20:16:00 INFO - Running setup.py install for simplejson 20:16:00 INFO - building 'simplejson._speedups' extension 20:16:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 20:16:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 20:16:01 INFO - Successfully installed simplejson 20:16:01 INFO - Cleaning up... 20:16:01 INFO - Return code: 0 20:16:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1928ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19260b0>, '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 0x1926fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:16:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:16:01 INFO - Using env: {'DISPLAY': ':0', 20:16:01 INFO - 'HOME': '/home/cltbld', 20:16:01 INFO - 'LANG': 'en_US.UTF-8', 20:16:01 INFO - 'LANGUAGE': 'en_US:en', 20:16:01 INFO - 'LOGNAME': 'cltbld', 20:16:01 INFO - 'MAIL': '/var/mail/cltbld', 20:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:01 INFO - 'MOZ_NO_REMOTE': '1', 20:16:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:01 INFO - 'NO_EM_RESTART': '1', 20:16:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:01 INFO - 'PWD': '/builds/slave/test', 20:16:01 INFO - 'SHELL': '/bin/bash', 20:16:01 INFO - 'SHLVL': '1', 20:16:01 INFO - 'TERM': 'linux', 20:16:01 INFO - 'TMOUT': '86400', 20:16:01 INFO - 'USER': 'cltbld', 20:16:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 20:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:01 INFO - '_': '/tools/buildbot/bin/python'} 20:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:16:01 INFO - Cleaning up... 20:16:01 INFO - Return code: 0 20:16:01 INFO - Running post-action listener: _resource_record_post_action 20:16:01 INFO - Running post-action listener: _start_resource_monitoring 20:16:01 INFO - Starting resource monitoring. 20:16:01 INFO - [mozharness: 2017-08-16 03:16:01.389559Z] Finished create-virtualenv step (success) 20:16:01 INFO - [mozharness: 2017-08-16 03:16:01.390023Z] Running install step. 20:16:01 INFO - Running pre-action listener: _resource_record_pre_action 20:16:01 INFO - Running main action method: install 20:16:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:16:01 INFO - Reading from file tmpfile_stdout 20:16:01 INFO - Detecting whether we're running mozinstall >=1.0... 20:16:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:16:01 INFO - Reading from file tmpfile_stdout 20:16:01 INFO - Output received: 20:16:01 INFO - Usage: mozinstall [options] installer 20:16:01 INFO - Options: 20:16:01 INFO - -h, --help show this help message and exit 20:16:01 INFO - -d DEST, --destination=DEST 20:16:01 INFO - Directory to install application into. [default: 20:16:01 INFO - "/builds/slave/test"] 20:16:01 INFO - --app=APP Application being installed. [default: firefox] 20:16:01 INFO - mkdir: /builds/slave/test/build/application 20:16:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:16:19 INFO - Reading from file tmpfile_stdout 20:16:19 INFO - Output received: 20:16:19 INFO - /builds/slave/test/build/application/firefox/firefox 20:16:19 INFO - Running post-action listener: _resource_record_post_action 20:16:19 INFO - [mozharness: 2017-08-16 03:16:19.505449Z] Finished install step (success) 20:16:19 INFO - [mozharness: 2017-08-16 03:16:19.505740Z] Running setup-mitmproxy step. 20:16:19 INFO - Running pre-action listener: _resource_record_pre_action 20:16:19 INFO - Running main action method: setup_mitmproxy 20:16:19 INFO - Skipping: mitmproxy is not required 20:16:19 INFO - Running post-action listener: _resource_record_post_action 20:16:19 INFO - [mozharness: 2017-08-16 03:16:19.506885Z] Finished setup-mitmproxy step (success) 20:16:19 INFO - [mozharness: 2017-08-16 03:16:19.507105Z] Running run-tests step. 20:16:19 INFO - Running pre-action listener: _resource_record_pre_action 20:16:19 INFO - Running pre-action listener: _set_gcov_prefix 20:16:19 INFO - Running main action method: run_tests 20:16:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:16:19 INFO - Python 2.7.3 20:16:19 INFO - Return code: 0 20:16:19 INFO - grabbing minidump binary from tooltool 20:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:19 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 0x19260b0>, '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 0x1926fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:16:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:16:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:16:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:16:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:16:19 INFO - Return code: 0 20:16:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:16:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:16:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:16:19 INFO - ENV: RUST_BACKTRACE is now full 20:16:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:16:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:16:19 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/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:16:19 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/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:16:19 INFO - Using env: {'DISPLAY': ':0', 20:16:19 INFO - 'HOME': '/home/cltbld', 20:16:19 INFO - 'LANG': 'en_US.UTF-8', 20:16:19 INFO - 'LANGUAGE': 'en_US:en', 20:16:19 INFO - 'LOGNAME': 'cltbld', 20:16:19 INFO - 'MAIL': '/var/mail/cltbld', 20:16:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:16:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:19 INFO - 'MOZ_NO_REMOTE': '1', 20:16:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:16:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:19 INFO - 'NO_EM_RESTART': '1', 20:16:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:19 INFO - 'PWD': '/builds/slave/test', 20:16:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:16:19 INFO - 'RUST_BACKTRACE': 'full', 20:16:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:16:19 INFO - 'SHELL': '/bin/bash', 20:16:19 INFO - 'SHLVL': '1', 20:16:19 INFO - 'TERM': 'linux', 20:16:19 INFO - 'TMOUT': '86400', 20:16:19 INFO - 'USER': 'cltbld', 20:16:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122', 20:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:19 INFO - '_': '/tools/buildbot/bin/python'} 20:16:19 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/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:16:19 INFO - mozversion application_buildid: 20170816020308 20:16:19 INFO - mozversion application_changeset: 4e93516e92e58d166ad37b8544c3230024afb587 20:16:19 INFO - mozversion application_display_name: Nightly 20:16:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:16:19 INFO - mozversion application_name: Firefox 20:16:19 INFO - mozversion application_remotingname: firefox 20:16:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:16:19 INFO - mozversion application_vendor: Mozilla 20:16:19 INFO - mozversion application_version: 57.0a1 20:16:19 INFO - mozversion platform_buildid: 20170816020308 20:16:19 INFO - mozversion platform_changeset: 4e93516e92e58d166ad37b8544c3230024afb587 20:16:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:16:19 INFO - mozversion platform_version: 57.0a1 20:16:19 INFO - using testdate: 1502853379 20:16:19 INFO - actual date: 1502853379 20:16:19 INFO - starting webserver on 'localhost:42210' 20:16:19 INFO - SUITE-START | Running 2 tests 20:16:19 INFO - TEST-START | dromaeo_css 20:16:19 INFO - Initialising browser for dromaeo_css test... 20:16:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42210/getInfo.html -profile /tmp/tmpisimmF/profile 20:16:19 INFO - TEST-INFO | started process 12789 (/builds/slave/test/build/application/firefox/firefox http://localhost:42210/getInfo.html) 20:16:25 INFO - TEST-INFO | 12789: exit 0 20:16:26 INFO - Browser initialized. 20:16:26 INFO - Running cycle 1/1 for dromaeo_css test... 20:16:26 INFO - TEST-INFO | started process 12964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpisimmF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:16:26 INFO - PID 12964 | 20:16:26 INFO - PID 12964 | (/builds/slave/test/build/application/firefox/firefox:13012): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:16:26 INFO - PID 12964 | 20:16:37 INFO - PID 12964 | RSS: Main: 158146560 20:16:37 INFO - PID 12964 | 20:19:35 INFO - PID 12964 | Cycle 1(1): loaded http://localhost:42210/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42210/tests/dromaeo/cssquery-ext.html) 20:19:36 INFO - PID 12964 | RSS: Main: 165834752 20:19:36 INFO - PID 12964 | 20:22:37 INFO - PID 12964 | Cycle 1(1): loaded http://localhost:42210/tests/dromaeo/cssquery-ext.html (next: http://localhost:42210/tests/dromaeo/cssquery-jquery.html) 20:22:38 INFO - PID 12964 | RSS: Main: 163344384 20:22:38 INFO - PID 12964 | 20:25:39 INFO - PID 12964 | Cycle 1(1): loaded http://localhost:42210/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42210/tests/dromaeo/cssquery-mootools.html) 20:25:40 INFO - PID 12964 | RSS: Main: 165355520 20:25:40 INFO - PID 12964 | 20:28:42 INFO - PID 12964 | Cycle 1(1): loaded http://localhost:42210/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42210/tests/dromaeo/cssquery-prototype.html) 20:28:42 INFO - PID 12964 | RSS: Main: 164048896 20:28:42 INFO - PID 12964 | 20:31:45 INFO - PID 12964 | Cycle 1(1): loaded http://localhost:42210/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42210/tests/dromaeo/cssquery-yui.html) 20:31:46 INFO - PID 12964 | RSS: Main: 167337984 20:31:46 INFO - PID 12964 | 20:34:47 INFO - PID 12964 | Cycle 1(1): loaded http://localhost:42210/tests/dromaeo/cssquery-yui.html (next: http://localhost:42210/tests/dromaeo/cssquery-dojo.html) 20:34:48 INFO - PID 12964 | RSS: Main: 168124416 20:34:48 INFO - PID 12964 | 20:34:48 INFO - PID 12964 | __start_tp_report 20:34:48 INFO - PID 12964 | _x_x_mozilla_page_load 20:34:48 INFO - PID 12964 | _x_x_mozilla_page_load_details 20:34:48 INFO - PID 12964 | |i|pagename|runs| 20:34:48 INFO - PID 12964 | |0;dojo.html;3493.5807703075634;3517.314123745871;3524.665156810103;3537.380958332292;3580.6061333253356;6088.421599948003;6264.937350626498;6281.528885333595;6309.116723658686;6331.651759153245;6176.81469555914;6276.843078923029;6285.465735412496;6291.811245662626;6305.180326557553;5496.203050557667;5501.092319767244;5508.03609368361;5508.586855985797;5540.584456165783;5511.255980442649;5523.061079616455;5556.027695153352;5562.415946325638;5564.8052318168875;5520.861978450551;5529.668219906798;5538.280023596927;5538.723063846812;5593.04918163911;5549.77800887964;5602.24369710088;5609.35492418373;5615.691136987464;5622.550195984332;5422.40353561108;5525.392206857243;5589.217509548666;5594.104943209067;5596.58025648078;6023.006203976339;6122.755089796403;6187.504999600022;6275.8744825103695;6300.432961033529;6686.699098540577;6803.387695107464;6851.1778586569435;6880.58716477008;6887.035814985906;6894.793156205272;6921.204061532938;6985.615791131486;6986.650667466606;7000.894986575206;6150.876982460326;6169.444749972524;6176.135341052256;6206.937930620727;6320.494360451153;6972.895406568906;7003.649817509104;7004;7007.229204787469;7014.929850701427;6628.701708423133;6670.766523171763;6673.899891501631;6679;6692.498062645321;6814.352636499525;6883.931160688429;6891.862162756717;6892;6906.274841141708;6724.529282950147;6742.089817874622;6798.7280508779095;6834.2140653825445;6836.248012718696;6739.157605299338;6768.661566921634;6831.795046148623;6833.384995350442;6833.658317084126;4859.635527335464;4864.78108485119;4915;4940.456549779521;4945.381827271591;4373.540778218241;4431.33529970507;4436.467623885154;4475.910481790346;4518.9548104518535;6479.319671434431;6483.7730679425995;6554.115194448688;6560.901586476207;6562.934370656328;6832.692528836114;6840.110785597841;6853;6886.51794374399;6922.965385173042;6485;6509;6535.57518761279;6569.146011018537;6572.605643661395;5518.365387980353;5525.309336332958;5590.888182236333;5591.133374326986;5594.356648985418;7127.821804454827;7245.673944672397;7253.1296244451005;7306.232845551247;7333.88999165013;6793.252742198453;6810.897836532356;6816.795496135124;6817.965910170417;6832;7210.1708303545765;7216.134063912364;7221.205667376479;7221.350078492961;7222.169450513258;6654.667266636552;6677.332266773478;6712.530122891546;6739.393454589111;6759.932400676127;6916.55042422241;6967.059446974594;6996.685149168198;6999.475039371966;7003.509754317149;6685.064091027163;6700.363465470772;6765.729370825309;6768.56004359715;6771.89842152378;6566.11357466755;6656.633885136364;6664.233613134552;6676.499262555425;6757.358050985148;6699.162604674416;6706.597604143767;6708.664566771544;6709.36261055199;6716;6663.067170596218;6732.259451460238;6785.558938668971;6801.693923773541;6818.727250910107;6384.233891932998;6484;6503.967480162569;6506.902396463962;6595.967020164869 20:34:48 INFO - PID 12964 | |1;ext.html;915.9404638698486;942.3121121581245;974.4932635029785;1250.2186133666457;1287.7360141171062;42024;45473.77263113688;46181.30728039078;46340.768296158516;46382;47119.29321060187;47520;47758.283625745644;47940.52059479404;47950;7849.4897831640765;7875.566843823602;7940.841183176333;8003.959980200091;8004.959975200116;7614.619269036526;7673.884891726629;7679.846403071935;7681.116671582784;7682.116556595979;7654.655540500663;7655.464117511777;7719.112302085247;7719.768406947801;7724.07311122666;7585.506942048777;7597.164311925684;7601.125870524905;7650.885236721454;7667.079950405959;7730.536167829892;7778.6888524458955;7798.298153166243;7801.765947021541;7820.217978202191;41016.58983410158;41055.58944410548;41127;41212;41243.58756412457;3559.537260156163;3592.946105808415;3595.352836489431;3598.9100272493133;3599.7120230381506;33051;33150.502742458884;33164;33212.83393583017;33266.50100248498;5310.92033619496;5331.173668081454;5337.3061502004875;5345.812896548602;5376.677399356051;216979;220581;220614;221243;221260;54551.99964002018;54668;54757;55053.44946550483;55192.724036380365;57550.71224643934;57572.42427575754;57604.42395576074;57615.423845761004;57617.711911441016;14967.850321496646;15233.923830380778;17122.743158852627;17295.481135565955;17477.91261043712;14154.292285385896;14245.857541424453;14348.85651143496;14357.282135893372;14368.568942931728;15872.571468567885;15966.521004369888;16023.67952640964;16025.118618475863;16052.75920861188;6150.231221097363;6166.383361663888;6205.2553693557065;6207.6585787781205;6247.531435142382;1111.8332250162541;1114.570890207276;1121.7588218533056;1126;1133.4955944604571;25242.495150096896;25612.48775024489;25676.74323256781;25713.742862571507;25785.226443206735;1225.5710501324643;1244.2223610243598;1245.588955644635;1248.862625111237;1251.361805479212;13618;13677;13771.793423098661;13803.654908627364;13903.652408689864;279958;280208;280955;281173;282160;58709.41290587039;58789.70605146947;58826.11760823591;58837;59028.704856475444;1547.7368847295986;1557.509384543865;1596.5050834241422;1599.5121487946055;1602.4151184817458;25374.544472938407;25393.74606253914;25404.364890877874;25565;25644.743552564236;41579.37630935478;41611.16777664369;41619.167616648105;41700.79149604232;41812.163756725306;215918;217293;217491;217533;218529;36979.44530831986;39771;40050;40218.59781402149;40226.79886600548;50965.745171273906;51816;51941;51985;52382;37479.250414991;37660.62339376571;37757.244855103294;37848;37879.62120378761;37169.6283037177;37232.62767372291;37366.252674945805;37378.252434950606;37559;43555.56444435515;43614.34578481262;43872.56127438812;44027.79861007001;44180;35926.64073359233;36000.27999440049;36284.83157863223;36850.44724329084;36981.26037479182;26928;27419.725802741716;27459.450810984068;27762;28122.2969425766 20:34:48 INFO - PID 12964 | |2;jquery.html;564.8531381840722;574.3796699564471;575.3258019164231;580.4746704232671;593.4332712259792;24302.635460468086;25125.874370628146;25142.24573262805;25184.49631007381;25399.873000634972;27327.45345093097;28244.576331355045;28260.717392826067;28266.858665706644;28299.717002829966;5729.1119876419225;6429.839254018663;6587.077809106729;6606.669666516655;6608.537402381835;6260.436560709535;6288.968555157217;6293.748250069992;6305.590136641126;6309.495240380758;6265.436110750032;6266.154069200645;6268.122462855204;6270.435660790528;6278.780242691507;6263.937360626426;6267.2479302484;6277.7175027123885;6281.811545653615;6290.528210384194;5828.1549175369755;5828.300603927556;5830.0380437227805;5838.41615838417;5839.153322768175;27619.58570621422;27810.3047423814;31256.687433125604;32031.679683203103;32281.192970175933;2218.8890555472162;2256.5035692147867;2256.638937769965;2257.0181970842737;2258.1870526610405;19760.308389206308;20324.288649897182;20391.5921681567;20397.38807835767;20402.89798550998;2421.479381932893;2448.951020979588;2500.3874050857476;2567.7945764338997;2578.548753968048;155452;158147;158188.20905895397;158289.99999999884;158942.20528897396;14955;15998.360065597479;16022.599435014217;16113;16347.91826040886;24255.272341829772;24463.755362446504;24947.5010499789;24985.125520606693;25037.12370067039;10958.561657533768;10969.780604387868;11081.667549973514;11175.608853690082;11209.439528023566;10271.537780799881;10290.228232882564;10327.380357178594;10340.37957722539;10354.585816567404;10181.898181018243;10221.9488902555;10379.792404152025;10439.37363758177;10470.895291046992;2849.15949794811;2849.430113977213;2856.371598248382;2870.4689632417653;2948.6461624604754;1058.142904247562;1064.6646306413454;1078.5901357484106;1096.7641956979287;1097.8737445193744;21692.240771573233;21742.130314787548;21921.561568768855;22044.669329960063;22210.88894555517;1138.2942575603179;1141.2068612314529;1141.9371934543515;1147.6901236666054;1154.0306142839886;11706.590269340531;12072.939635301944;12152;12195.878041219474;12217.633470995885;554765;568540;568983;572822;575274;131500.3424982888;136972;138312.30843845918;138369.3081534606;139521.3023934894;1282.8845403913692;1299.4412402666944;1310.1156719214491;1314.2377421095741;1315.8223639808696;19061.714074289175;19098;19233.326833560757;19306.517337066685;19478;63758;63764;64051.35948640641;64400;64961;78169.98166384571;78215;78373;78883.21116788758;78926;14811.333489992761;14882;14920.403183872957;15066.472673456376;15095.622609434851;23586.88206558956;24150.154744583855;24208.031678732652;24259.272221833373;24553.263402097964;17804.46586602404;17821.465356039338;17954.5511362217;18212.544686382946;18342.81657183411;17067.48797536076;17173.31306747716;17489;17508.562285942953;17770.5557361067;17552.210150543;17956.191971361583;17959.820401796336;18055;18268.634627307645;14772;14794.63013424673;14875.925620371829;14951;14966.551003469913;17670.29318827284;18021.369252076114;18051.097445127954;18127.637447250716;18136.546586335448 20:34:48 INFO - PID 12964 | |3;mootools.html;1433.383645032636;1518.4533567915548;1520.6730552931117;1526.160611663584;1528.43447924268;15572.377104915804;15887.36450541977;16112.75830862535;16148.434804781835;16184.75722864158;16355.427560035401;16591;16599.41902033429;16603.750943735853;16641.583960400996;2766.1839757271655;2804.5933339665735;2805.5791631255374;2807.5507918733006;2808.775297976157;2685.073649590888;2725.7001729809704;2778.7915906307007;2780.7497325240724;2782.471330447219;2714.660667416573;2721.1972468121953;2755.3800394911186;2762.599423083652;2763.2124844419345;2642.1883020127802;2668.6397336359537;2670.052131493311;2670.1588999465303;2672.1716267956995;2620.606908963671;2625.0287393664275;2635.5124302004;2637.367031912346;2638.3140383500236;15590.454334098253;15838.128902910335;15845.683086338324;15865;15880.205989700584;8498.575071246474;8781.34139939507;8783.077776833468;8784.60469278884;8800.47197168172;5127.846164615067;5306.495882891119;5404.1083221268445;5421.539169170625;5430.022595932731;1898.4589392023206;1923.6729755941524;1926.6532024235632;1952.824245817869;1962.9901850490799;28630.85684571564;28799.56800647971;28799.712002880122;28820.567691484644;28870.711292887012;7138.107736532934;7177.461690373243;7225.277472252733;7268;7278.308560686726;18941;19115;19131.61736765257;19149.425517234504;19169;8042.517448953082;8318.875216871751;8360.45657032291;8365.372597055124;8374.581270936429;6563.704633291513;6838.623875686885;7028.613426261605;7871.448998570159;7905.683772649145;5397.649152805055;5517.475839795213;5582.553395728332;5595.272614560081;5600.52395546375;1608.8230294667578;1612.9516114516348;1619.408915745768;1622.2051194914407;1639.5655151384892;980.8185485685171;1002.518790980319;1003.6738060130486;1004.3120462483222;1023.3348323589578;8515.872261916076;8545.700900468579;8591.398602097917;8637.870431943526;8725.301975841918;746.123305116486;751.2975368030909;753.6834529497625;755.0788038592908;772.9536227826349;4986.825461108844;5052;5055.9494405055475;5107.284980102789;5140.3317568716575;22666.886665566897;22677;23208.18771342995;23294.06823727032;23473.295801125994;22749.31752047441;22879;22978.965946532113;23048.308550743506;23101;12444.440000200013;12464.626061218178;12524.060695447695;12806.167599106215;12877.742445151045;9336.859947100935;9830.852537212091;9867.901320986986;9897.109260166619;10328.122109620766;20708.896455517624;20716.378508644764;20956.68564971557;21012.05445754975;21062.57874842464;21044.579108418053;21277.46806329854;21304.786952130282;21353.67969480428;21702.240421585167;13104.737905242033;13408.932955335162;13414.725601067883;13418.39617217208;13428.93285533566;15041.247937602857;15455.61360965985;15504.457343992906;15507.379704811681;15521.68956620884;11778.528858845893;11814.527418903148;11847.644570662895;11921.34432606215;11978.341191234565;11705.414729263332;11778.587749428729;11805.76388472243;11886.524539018343;12102.818457722966;10928.562857485611;10964;11048.116150707763;11052.226344155832;11059.72350691239;7914.485558438683;7915.525068495908;7964.601769911597;8060.11338752725;8060.516369017878;7958.960205198937;8167.14245004266;8260.421770476009;8319.750407487785;8409.159084091541 20:34:48 INFO - PID 12964 | |4;prototype.html;513.4454788828066;517.3274742834315;532.8862677005063;535.6384440502661;541.3098299667926;6146.784862529812;6150.33940835974;6181.907271390927;6208.286047104579;6300.7794727184555;6129.724162412691;6133.907991380132;6152.723127459264;6210.9068363974575;6227.190465239512;4952.108620448318;4955;4961.082199793041;4974.950250497485;4984.6790600490895;4635.6986795858165;4889.8777530561665;4931.704097754128;4938.456769755324;4941.3329200558;4743.335932969387;4746.620270378378;4772.665913386064;4780.1873681474235;4795.352627395309;4721.480637129913;4773.856784296442;4783.851875549861;4791.904161916777;4798.928016079762;4172.144710334404;4288.957110428887;4295.506016808075;4297.312430011183;4324.113556720896;5884.440978107073;5898.469137777578;5903.734331955073;5931.970340148272;6046.213992181032;5651.773929042874;5654.575906807006;5696.344920334173;5711.742971566289;5771.797987070432;6505.154329937125;6527.314631963623;6527.4125328720165;6647;6662.367075127855;4857.562819346276;4873.220284754422;4893.584045356149;4898.628384052471;4919.581835543983;6594.142761440982;6604.141461610008;6733.027513766852;6787.423069039138;6843.213030501506;4990.201567749143;5016;5019.573336266459;5022.196448568212;5095.210242412432;5105.2342148678;5107;5113.667611605234;5127.53852153308;5148.768305426265;5649.491545760901;5652.802151924663;5682.318121825408;5710.2862142232225;5745.425457454221;6506.60960342381;6532.6733663316645;6563.901541476882;6572.934270657232;6602.933970660328;1758.9032603206947;1769.3099691120474;1782.6702060118919;1791.4894255137224;1812.4109664359137;1183.3964678014274;1237.9319137447346;1251.361805479194;1256.9245845249313;1265.1333836321965;6220.968895155585;6296.181496405529;6307.089604445182;6326.5255105867245;6441.871162576722;6632.1098486931;6648.434883034899;6652.600843949379;6755.932440675629;6833.145856767904;6247.062940558862;6259.530535209878;6344.175257216624;6345.238571371465;6348.936510634834;3568.750187486851;3588.4796704478226;3590.2101537661674;3591.1560783215923;3611.1694310308776;7164.462665300123;7168.032315637426;7245.8550828983125;7280.126384833854;7304.415646748247;6296.590721603081;6755.864882702417;6780.898286525706;6915.343042410963;6967.79096627102;7050.894236586558;7052.435805135474;7095.184053833772;7156.177039640508;7188.173360063555;6528.836779080561;6684.498662600422;6707.698153583003;6711.664416779044;6767.593944363354;6620.5034622402545;6695.598264104169;6698.330166983457;6704.76533321351;6737.663116844236;7175.820604484929;7224.855502890018;7230.276972302728;7240.660477811622;7272.272772722897;5101.438841727333;5120;5134.409542902614;5164.122099243213;5171.922421163761;6669.233038200475;6814.420774234048;6888.8644520198895;6897.275786042594;6898.344657257552;6583.934160658332;6622.10601568782;6632.568883022588;6639.734410623714;6644.468442524683;6538.444232240123;6560.622269323305;6592.373724496165;6620.735170593122;6715.9590263509235;6606.174228221473;6666.600003999775;6670.533062685566;6686.5653732507235;6692.364225398579;6617.735290588323;6641.136652235178;6680.265170831108;6682.264950855305;6698.464122870256;6449.645269510222;6476.287608363171;6493.610383377012;6568.343165683394;6573.704183311858 20:34:48 INFO - PID 12964 | |5;yui.html;929.3123088914206;943.0286804591271;947.3605316411421;958.338746265077;971.5725080964378;19431.31990380337;20259.088341024653;20283.08726107325;20284.695729564068;21224.363269101952;22310.107595696154;22807.08771649136;22829.77170228297;22902.312930612108;23018;998.6332392230406;1026.6560702164784;1030.4126647810751;1031.2214278219933;1031.6956497833119;1093.1145771924766;1093.5243169221374;1093.557109370706;1094.6497120921308;1095.4467993663188;1070.304302203566;1116.0457808573674;1118.815395459748;1118.8601424821898;1119.764849381631;1102.8731695854958;1104.4146602300714;1105.022055480897;1106.8893110688948;1107.8172101603225;808.8665370213907;809.4900212865857;809.8218391953761;810.7081450677751;811.6388207247777;19303.613927721366;19574.608507829762;19582.412527624194;19944.20223191085;19966.600667986706;22395.440113997116;22490.325290241155;23155.88422057896;23210.071597136095;23276.7672323278;16699.83300166995;16700.164991750364;16818;16850.915745421316;17045.318187272493;3774.1885494618514;3806.9809650951843;3810.599887011879;3821.789801560913;3846.653801157909;149681;150833;151150;151672;153063.9999999989;16796.748048779278;17095.230714617872;17285.56786080358;17381.739273910902;17683.20425580852;32949.50575741366;33037.17407064795;33379;33784.83107584495;33817.15457113543;8301.46040507365;8563.571821408905;8758.649654013896;8903.243224325875;8934.88313960755;4458.643308535309;4527.230370836965;4528.682992190581;4550.47669518003;4552.544745525421;5581.190727344512;5610.775568977277;5669.886602267931;5671.092625179951;5712.11462223356;1170.4381896689636;1187.6080893305189;1196.5991392883482;1210.6852218423273;1212.1030437476204;717.8851383778675;723.060021971435;730.846522230327;739.4638886807022;750.9061367329084;13058.477660893457;13231.73536529264;13843;14029.438822447191;14315.069520481135;725.6117976882342;732.6226993098559;737.5316673912105;753.9019927409402;759.6809340077181;6182.505399568024;6466.482681385478;6510.21877374718;6531.987541931008;6575.276719560845;127437.36281318535;130435;132753;132972.33513832564;139578;118198;118227;122588;124071.379643103;126683;105896.47051764691;107288;107878;107889.46055269674;110674;11636.825447618123;11706.180567360203;11784.4696988634;11791.76416471683;11895.940520297343;48466.303679371056;50552.24171637355;50570.49429505658;51327;51868;64481.67759161174;64884;65570.67214663896;66030.66984665046;66560;16190.595235119215;16629.16854157263;16728.665426691154;16737.66524669524;17282.22229999678;21382.572348553254;21469.355919322446;21600.67598985985;21714;21741.347759567238;19939.501512462306;20162.697559536326;20316.085776140404;20457.48856278605;20581.89709051505;19182.136803843583;19343.613127737648;19359;19476.805231948067;19522.21911123596;19592.510187245432;19776.11007504637;19865.30471433493;19918.30285939985;20068.397948060996;14640.926795365955;14646.63383415423;14692.926535367682;14701.191434470778;14841.109533428029;14865.688341008778;15167.62080947941;15203.087814731152;15312.157831319384;15483.458078967182 20:34:48 INFO - PID 12964 | __end_tp_report 20:34:48 INFO - PID 12964 | __start_cc_report 20:34:48 INFO - PID 12964 | _x_x_mozilla_cycle_collect,353 20:34:48 INFO - PID 12964 | __end_cc_report 20:34:48 INFO - PID 12964 | __startTimestamp1502854488201__endTimestamp 20:34:48 INFO - PID 12964 | 20:34:48 INFO - PID 12964 | ------- Summary: start ------- 20:34:48 INFO - PID 12964 | Number of tests: 6 20:34:48 INFO - PID 12964 | 20:34:48 INFO - PID 12964 | [#0] dojo.html Cycles:165 Average:6281.27 Median:6654.67 stddev:827.64 (12.4%) stddev-sans-first:800.76 20:34:48 INFO - PID 12964 | Values: 3493.6 3517.3 3524.7 3537.4 3580.6 6088.4 6264.9 6281.5 6309.1 6331.7 6176.8 6276.8 6285.5 6291.8 6305.2 5496.2 5501.1 5508.0 5508.6 5540.6 5511.3 5523.1 5556.0 5562.4 5564.8 5520.9 5529.7 5538.3 5538.7 5593.0 5549.8 5602.2 5609.4 5615.7 5622.6 5422.4 5525.4 5589.2 5594.1 5596.6 6023.0 6122.8 6187.5 6275.9 6300.4 6686.7 6803.4 6851.2 6880.6 6887.0 6894.8 6921.2 6985.6 6986.7 7000.9 6150.9 6169.4 6176.1 6206.9 6320.5 6972.9 7003.6 7004.0 7007.2 7014.9 6628.7 6670.8 6673.9 6679.0 6692.5 6814.4 6883.9 6891.9 6892.0 6906.3 6724.5 6742.1 6798.7 6834.2 6836.2 6739.2 6768.7 6831.8 6833.4 6833.7 4859.6 4864.8 4915.0 4940.5 4945.4 4373.5 4431.3 4436.5 4475.9 4519.0 6479.3 6483.8 6554.1 6560.9 6562.9 6832.7 6840.1 6853.0 6886.5 6923.0 6485.0 6509.0 6535.6 6569.1 6572.6 5518.4 5525.3 5590.9 5591.1 5594.4 7127.8 7245.7 7253.1 7306.2 7333.9 6793.3 6810.9 6816.8 6818.0 6832.0 7210.2 7216.1 7221.2 7221.4 7222.2 6654.7 6677.3 6712.5 6739.4 6759.9 6916.6 6967.1 6996.7 6999.5 7003.5 6685.1 6700.4 6765.7 6768.6 6771.9 6566.1 6656.6 6664.2 6676.5 6757.4 6699.2 6706.6 6708.7 6709.4 6716.0 6663.1 6732.3 6785.6 6801.7 6818.7 6384.2 6484.0 6504.0 6506.9 6596.0 20:34:48 INFO - PID 12964 | 20:34:48 INFO - PID 12964 | [#1] ext.html Cycles:180 Average:42863.15 Median:37802.62 stddev:62709.31 (165.9%) stddev-sans-first:62806.12 20:34:48 INFO - PID 12964 | Values: 915.9 942.3 974.5 1250.2 1287.7 42024.0 45473.8 46181.3 46340.8 46382.0 47119.3 47520.0 47758.3 47940.5 47950.0 7849.5 7875.6 7940.8 8004.0 8005.0 7614.6 7673.9 7679.8 7681.1 7682.1 7654.7 7655.5 7719.1 7719.8 7724.1 7585.5 7597.2 7601.1 7650.9 7667.1 7730.5 7778.7 7798.3 7801.8 7820.2 41016.6 41055.6 41127.0 41212.0 41243.6 3559.5 3592.9 3595.4 3598.9 3599.7 33051.0 33150.5 33164.0 33212.8 33266.5 5310.9 5331.2 5337.3 5345.8 5376.7 216979.0 220581.0 220614.0 221243.0 221260.0 54552.0 54668.0 54757.0 55053.4 55192.7 57550.7 57572.4 57604.4 57615.4 57617.7 14967.9 15233.9 17122.7 17295.5 17477.9 14154.3 14245.9 14348.9 14357.3 14368.6 15872.6 15966.5 16023.7 16025.1 16052.8 6150.2 6166.4 6205.3 6207.7 6247.5 1111.8 1114.6 1121.8 1126.0 1133.5 25242.5 25612.5 25676.7 25713.7 25785.2 1225.6 1244.2 1245.6 1248.9 1251.4 13618.0 13677.0 13771.8 13803.7 13903.7 279958.0 280208.0 280955.0 281173.0 282160.0 58709.4 58789.7 58826.1 58837.0 59028.7 1547.7 1557.5 1596.5 1599.5 1602.4 25374.5 25393.7 25404.4 25565.0 25644.7 41579.4 41611.2 41619.2 41700.8 41812.2 215918.0 217293.0 217491.0 217533.0 218529.0 36979.4 39771.0 40050.0 40218.6 40226.8 50965.7 51816.0 51941.0 51985.0 52382.0 37479.3 37660.6 37757.2 37848.0 37879.6 37169.6 37232.6 37366.3 37378.3 37559.0 43555.6 43614.3 43872.6 44027.8 44180.0 35926.6 36000.3 36284.8 36850.4 36981.3 26928.0 27419.7 27459.5 27762.0 28122.3 20:34:48 INFO - PID 12964 | 20:34:48 INFO - PID 12964 | [#2] jquery.html Cycles:180 Average:38967.57 Median:21717.19 stddev:95937.51 (441.8%) stddev-sans-first:96163.31 20:34:48 INFO - PID 12964 | Values: 564.9 574.4 575.3 580.5 593.4 24302.6 25125.9 25142.2 25184.5 25399.9 27327.5 28244.6 28260.7 28266.9 28299.7 5729.1 6429.8 6587.1 6606.7 6608.5 6260.4 6289.0 6293.7 6305.6 6309.5 6265.4 6266.2 6268.1 6270.4 6278.8 6263.9 6267.2 6277.7 6281.8 6290.5 5828.2 5828.3 5830.0 5838.4 5839.2 27619.6 27810.3 31256.7 32031.7 32281.2 2218.9 2256.5 2256.6 2257.0 2258.2 19760.3 20324.3 20391.6 20397.4 20402.9 2421.5 2449.0 2500.4 2567.8 2578.5 155452.0 158147.0 158188.2 158290.0 158942.2 14955.0 15998.4 16022.6 16113.0 16347.9 24255.3 24463.8 24947.5 24985.1 25037.1 10958.6 10969.8 11081.7 11175.6 11209.4 10271.5 10290.2 10327.4 10340.4 10354.6 10181.9 10221.9 10379.8 10439.4 10470.9 2849.2 2849.4 2856.4 2870.5 2948.6 1058.1 1064.7 1078.6 1096.8 1097.9 21692.2 21742.1 21921.6 22044.7 22210.9 1138.3 1141.2 1141.9 1147.7 1154.0 11706.6 12072.9 12152.0 12195.9 12217.6 554765.0 568540.0 568983.0 572822.0 575274.0 131500.3 136972.0 138312.3 138369.3 139521.3 1282.9 1299.4 1310.1 1314.2 1315.8 19061.7 19098.0 19233.3 19306.5 19478.0 63758.0 63764.0 64051.4 64400.0 64961.0 78170.0 78215.0 78373.0 78883.2 78926.0 14811.3 14882.0 14920.4 15066.5 15095.6 23586.9 24150.2 24208.0 24259.3 24553.3 17804.5 17821.5 17954.6 18212.5 18342.8 17067.5 17173.3 17489.0 17508.6 17770.6 17552.2 17956.2 17959.8 18055.0 18268.6 14772.0 14794.6 14875.9 14951.0 14966.6 17670.3 18021.4 18051.1 18127.6 18136.5 20:34:48 INFO - PID 12964 | 20:34:48 INFO - PID 12964 | [#3] mootools.html Cycles:180 Average:10085.69 Median:2622.82 stddev:7330.38 (279.5%) stddev-sans-first:7322.12 20:34:48 INFO - PID 12964 | Values: 1433.4 1518.5 1520.7 1526.2 1528.4 15572.4 15887.4 16112.8 16148.4 16184.8 16355.4 16591.0 16599.4 16603.8 16641.6 2766.2 2804.6 2805.6 2807.6 2808.8 2685.1 2725.7 2778.8 2780.7 2782.5 2714.7 2721.2 2755.4 2762.6 2763.2 2642.2 2668.6 2670.1 2670.2 2672.2 2620.6 2625.0 2635.5 2637.4 2638.3 15590.5 15838.1 15845.7 15865.0 15880.2 8498.6 8781.3 8783.1 8784.6 8800.5 5127.8 5306.5 5404.1 5421.5 5430.0 1898.5 1923.7 1926.7 1952.8 1963.0 28630.9 28799.6 28799.7 28820.6 28870.7 7138.1 7177.5 7225.3 7268.0 7278.3 18941.0 19115.0 19131.6 19149.4 19169.0 8042.5 8318.9 8360.5 8365.4 8374.6 6563.7 6838.6 7028.6 7871.4 7905.7 5397.6 5517.5 5582.6 5595.3 5600.5 1608.8 1613.0 1619.4 1622.2 1639.6 980.8 1002.5 1003.7 1004.3 1023.3 8515.9 8545.7 8591.4 8637.9 8725.3 746.1 751.3 753.7 755.1 773.0 4986.8 5052.0 5055.9 5107.3 5140.3 22666.9 22677.0 23208.2 23294.1 23473.3 22749.3 22879.0 22979.0 23048.3 23101.0 12444.4 12464.6 12524.1 12806.2 12877.7 9336.9 9830.9 9867.9 9897.1 10328.1 20708.9 20716.4 20956.7 21012.1 21062.6 21044.6 21277.5 21304.8 21353.7 21702.2 13104.7 13408.9 13414.7 13418.4 13428.9 15041.2 15455.6 15504.5 15507.4 15521.7 11778.5 11814.5 11847.6 11921.3 11978.3 11705.4 11778.6 11805.8 11886.5 12102.8 10928.6 10964.0 11048.1 11052.2 11059.7 7914.5 7915.5 7964.6 8060.1 8060.5 7959.0 8167.1 8260.4 8319.8 8409.2 20:34:48 INFO - PID 12964 | 20:34:48 INFO - PID 12964 | [#4] prototype.html Cycles:180 Average:5594.89 Median:6253.30 stddev:1611.19 (25.8%) stddev-sans-first:1569.92 20:34:48 INFO - PID 12964 | Values: 513.4 517.3 532.9 535.6 541.3 6146.8 6150.3 6181.9 6208.3 6300.8 6129.7 6133.9 6152.7 6210.9 6227.2 4952.1 4955.0 4961.1 4975.0 4984.7 4635.7 4889.9 4931.7 4938.5 4941.3 4743.3 4746.6 4772.7 4780.2 4795.4 4721.5 4773.9 4783.9 4791.9 4798.9 4172.1 4289.0 4295.5 4297.3 4324.1 5884.4 5898.5 5903.7 5932.0 6046.2 5651.8 5654.6 5696.3 5711.7 5771.8 6505.2 6527.3 6527.4 6647.0 6662.4 4857.6 4873.2 4893.6 4898.6 4919.6 6594.1 6604.1 6733.0 6787.4 6843.2 4990.2 5016.0 5019.6 5022.2 5095.2 5105.2 5107.0 5113.7 5127.5 5148.8 5649.5 5652.8 5682.3 5710.3 5745.4 6506.6 6532.7 6563.9 6572.9 6602.9 1758.9 1769.3 1782.7 1791.5 1812.4 1183.4 1237.9 1251.4 1256.9 1265.1 6221.0 6296.2 6307.1 6326.5 6441.9 6632.1 6648.4 6652.6 6755.9 6833.1 6247.1 6259.5 6344.2 6345.2 6348.9 3568.8 3588.5 3590.2 3591.2 3611.2 7164.5 7168.0 7245.9 7280.1 7304.4 6296.6 6755.9 6780.9 6915.3 6967.8 7050.9 7052.4 7095.2 7156.2 7188.2 6528.8 6684.5 6707.7 6711.7 6767.6 6620.5 6695.6 6698.3 6704.8 6737.7 7175.8 7224.9 7230.3 7240.7 7272.3 5101.4 5120.0 5134.4 5164.1 5171.9 6669.2 6814.4 6888.9 6897.3 6898.3 6583.9 6622.1 6632.6 6639.7 6644.5 6538.4 6560.6 6592.4 6620.7 6716.0 6606.2 6666.6 6670.5 6686.6 6692.4 6617.7 6641.1 6680.3 6682.3 6698.5 6449.6 6476.3 6493.6 6568.3 6573.7 20:34:48 INFO - PID 12964 | 20:34:48 INFO - PID 12964 | [#5] yui.html Cycles:180 Average:27056.67 Median:19891.80 stddev:38821.78 (195.2%) stddev-sans-first:38881.12 20:34:48 INFO - PID 12964 | Values: 929.3 943.0 947.4 958.3 971.6 19431.3 20259.1 20283.1 20284.7 21224.4 22310.1 22807.1 22829.8 22902.3 23018.0 998.6 1026.7 1030.4 1031.2 1031.7 1093.1 1093.5 1093.6 1094.6 1095.4 1070.3 1116.0 1118.8 1118.9 1119.8 1102.9 1104.4 1105.0 1106.9 1107.8 808.9 809.5 809.8 810.7 811.6 19303.6 19574.6 19582.4 19944.2 19966.6 22395.4 22490.3 23155.9 23210.1 23276.8 16699.8 16700.2 16818.0 16850.9 17045.3 3774.2 3807.0 3810.6 3821.8 3846.7 149681.0 150833.0 151150.0 151672.0 153064.0 16796.7 17095.2 17285.6 17381.7 17683.2 32949.5 33037.2 33379.0 33784.8 33817.2 8301.5 8563.6 8758.6 8903.2 8934.9 4458.6 4527.2 4528.7 4550.5 4552.5 5581.2 5610.8 5669.9 5671.1 5712.1 1170.4 1187.6 1196.6 1210.7 1212.1 717.9 723.1 730.8 739.5 750.9 13058.5 13231.7 13843.0 14029.4 14315.1 725.6 732.6 737.5 753.9 759.7 6182.5 6466.5 6510.2 6532.0 6575.3 127437.4 130435.0 132753.0 132972.3 139578.0 118198.0 118227.0 122588.0 124071.4 126683.0 105896.5 107288.0 107878.0 107889.5 110674.0 11636.8 11706.2 11784.5 11791.8 11895.9 48466.3 50552.2 50570.5 51327.0 51868.0 64481.7 64884.0 65570.7 66030.7 66560.0 16190.6 16629.2 16728.7 16737.7 17282.2 21382.6 21469.4 21600.7 21714.0 21741.3 19939.5 20162.7 20316.1 20457.5 20581.9 19182.1 19343.6 19359.0 19476.8 19522.2 19592.5 19776.1 19865.3 19918.3 20068.4 14640.9 14646.6 14692.9 14701.2 14841.1 14865.7 15167.6 15203.1 15312.2 15483.5 20:34:48 INFO - PID 12964 | -------- Summary: end -------- 20:34:48 INFO - PID 12964 | 20:34:48 INFO - TEST-INFO | 12964: exit 0 20:34:48 INFO - TEST-OK | dromaeo_css | took 1108967ms 20:34:48 INFO - TEST-START | kraken 20:34:48 INFO - Initialising browser for kraken test... 20:34:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42210/getInfo.html -profile /tmp/tmp3ySwve/profile 20:34:48 INFO - TEST-INFO | started process 13337 (/builds/slave/test/build/application/firefox/firefox http://localhost:42210/getInfo.html) 20:34:54 INFO - TEST-INFO | 13337: exit 0 20:34:54 INFO - Browser initialized. 20:34:54 INFO - Running cycle 1/1 for kraken test... 20:34:54 INFO - TEST-INFO | started process 13510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ySwve/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:34:55 INFO - PID 13510 | 20:34:55 INFO - PID 13510 | (/builds/slave/test/build/application/firefox/firefox:13559): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:34:55 INFO - PID 13510 | 20:35:05 INFO - PID 13510 | RSS: Main: 158105600 20:35:05 INFO - PID 13510 | 20:35:08 INFO - PID 13510 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42210/tests/kraken/driver.html?testName=audio-beat-detection) 20:35:09 INFO - PID 13510 | RSS: Main: 165027840 20:35:09 INFO - PID 13510 | 20:35:11 INFO - PID 13510 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42210/tests/kraken/driver.html?testName=audio-dft) 20:35:12 INFO - PID 13510 | RSS: Main: 169091072 20:35:12 INFO - PID 13510 | 20:35:15 INFO - PID 13510 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42210/tests/kraken/driver.html?testName=audio-fft) 20:35:15 INFO - PID 13510 | RSS: Main: 161685504 20:35:15 INFO - PID 13510 | 20:35:17 INFO - PID 13510 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42210/tests/kraken/driver.html?testName=audio-oscillator) 20:35:18 INFO - PID 13510 | RSS: Main: 162992128 20:35:18 INFO - PID 13510 | 20:35:20 INFO - PID 13510 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42210/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:35:21 INFO - PID 13510 | RSS: Main: 162590720 20:35:21 INFO - PID 13510 | 20:35:24 INFO - PID 13510 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42210/tests/kraken/driver.html?testName=imaging-darkroom) 20:35:24 INFO - PID 13510 | RSS: Main: 162439168 20:35:24 INFO - PID 13510 | 20:35:28 INFO - PID 13510 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42210/tests/kraken/driver.html?testName=imaging-desaturate) 20:35:28 INFO - PID 13510 | RSS: Main: 164380672 20:35:28 INFO - PID 13510 | 20:35:31 INFO - PID 13510 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42210/tests/kraken/driver.html?testName=json-parse-financial) 20:35:32 INFO - PID 13510 | RSS: Main: 164360192 20:35:32 INFO - PID 13510 | 20:35:33 INFO - PID 13510 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42210/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:35:34 INFO - PID 13510 | RSS: Main: 164462592 20:35:34 INFO - PID 13510 | 20:35:36 INFO - PID 13510 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:35:36 INFO - PID 13510 | RSS: Main: 164245504 20:35:36 INFO - PID 13510 | 20:35:38 INFO - PID 13510 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:35:39 INFO - PID 13510 | RSS: Main: 164556800 20:35:39 INFO - PID 13510 | 20:35:41 INFO - PID 13510 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:35:42 INFO - PID 13510 | RSS: Main: 164667392 20:35:42 INFO - PID 13510 | 20:35:45 INFO - PID 13510 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:35:46 INFO - PID 13510 | RSS: Main: 165310464 20:35:46 INFO - PID 13510 | 20:35:47 INFO - PID 13510 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42210/tests/kraken/driver.html?testName=ai-astar) 20:35:48 INFO - PID 13510 | RSS: Main: 166436864 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | __start_tp_report 20:35:48 INFO - PID 13510 | _x_x_mozilla_page_load 20:35:48 INFO - PID 13510 | _x_x_mozilla_page_load_details 20:35:48 INFO - PID 13510 | |i|pagename|runs| 20:35:48 INFO - PID 13510 | |0;ai-astar;96;105;98;105;106;110;106;98;107;107 20:35:48 INFO - PID 13510 | |1;audio-beat-detection;136;112;136;174;113;144;139;112;162;113 20:35:48 INFO - PID 13510 | |2;audio-dft;164;166;162;162;163;160;162;162;165;173 20:35:48 INFO - PID 13510 | |3;audio-fft;75;73;74;162;74;74;73;89;93;74 20:35:48 INFO - PID 13510 | |4;audio-oscillator;79;78;139;77;78;77;125;79;78;123 20:35:48 INFO - PID 13510 | |5;imaging-gaussian-blur;114;114;114;114;113;115;114;114;114;114 20:35:48 INFO - PID 13510 | |6;imaging-darkroom;148;147;147;147;147;147;148;148;147;148 20:35:48 INFO - PID 13510 | |7;imaging-desaturate;93;93;94;93;93;94;94;94;94;94 20:35:48 INFO - PID 13510 | |8;json-parse-financial;48;47;47;47;47;49;49;51;47;47 20:35:48 INFO - PID 13510 | |9;json-stringify-tinderbox;54;54;53;54;54;53;54;54;54;54 20:35:48 INFO - PID 13510 | |10;stanford-crypto-aes;74;74;74;74;73;73;76;79;75;73 20:35:48 INFO - PID 13510 | |11;stanford-crypto-ccm;119;120;116;121;125;114;122;113;119;160 20:35:48 INFO - PID 13510 | |12;stanford-crypto-pbkdf2;167;166;167;161;178;163;168;164;161;163 20:35:48 INFO - PID 13510 | |13;stanford-crypto-sha256-iterative;60;61;61;63;61;63;61;59;72;59 20:35:48 INFO - PID 13510 | __end_tp_report 20:35:48 INFO - PID 13510 | __start_cc_report 20:35:48 INFO - PID 13510 | _x_x_mozilla_cycle_collect,841 20:35:48 INFO - PID 13510 | __end_cc_report 20:35:48 INFO - PID 13510 | __startTimestamp1502854548133__endTimestamp 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | ------- Summary: start ------- 20:35:48 INFO - PID 13510 | Number of tests: 14 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | [#0] ai-astar Cycles:10 Average:103.80 Median:108.50 stddev:4.71 (4.3%) stddev-sans-first:4.06 20:35:48 INFO - PID 13510 | Values: 96.0 105.0 98.0 105.0 106.0 110.0 106.0 98.0 107.0 107.0 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:137.50 stddev:22.03 (16.0%) stddev-sans-first:23.35 20:35:48 INFO - PID 13510 | Values: 136.0 112.0 136.0 174.0 113.0 144.0 139.0 112.0 162.0 113.0 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:3.63 (2.2%) stddev-sans-first:3.86 20:35:48 INFO - PID 13510 | Values: 164.0 166.0 162.0 162.0 163.0 160.0 162.0 162.0 165.0 173.0 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | [#3] audio-fft Cycles:10 Average:86.10 Median:74.00 stddev:27.63 (37.3%) stddev-sans-first:29.01 20:35:48 INFO - PID 13510 | Values: 75.0 73.0 74.0 162.0 74.0 74.0 73.0 89.0 93.0 74.0 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:78.00 stddev:24.98 (32.0%) stddev-sans-first:25.96 20:35:48 INFO - PID 13510 | Values: 79.0 78.0 139.0 77.0 78.0 77.0 125.0 79.0 78.0 123.0 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 20:35:48 INFO - PID 13510 | Values: 114.0 114.0 114.0 114.0 113.0 115.0 114.0 114.0 114.0 114.0 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 20:35:48 INFO - PID 13510 | Values: 148.0 147.0 147.0 147.0 147.0 147.0 148.0 148.0 147.0 148.0 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:35:48 INFO - PID 13510 | Values: 93.0 93.0 94.0 93.0 93.0 94.0 94.0 94.0 94.0 94.0 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | [#8] json-parse-financial Cycles:10 Average:47.90 Median:47.50 stddev:1.37 (2.9%) stddev-sans-first:1.45 20:35:48 INFO - PID 13510 | Values: 48.0 47.0 47.0 47.0 47.0 49.0 49.0 51.0 47.0 47.0 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 20:35:48 INFO - PID 13510 | Values: 54.0 54.0 53.0 54.0 54.0 53.0 54.0 54.0 54.0 54.0 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:1.84 (2.5%) stddev-sans-first:1.94 20:35:48 INFO - PID 13510 | Values: 74.0 74.0 74.0 74.0 73.0 73.0 76.0 79.0 75.0 73.0 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:120.50 stddev:13.54 (11.2%) stddev-sans-first:14.28 20:35:48 INFO - PID 13510 | Values: 119.0 120.0 116.0 121.0 125.0 114.0 122.0 113.0 119.0 160.0 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:166.50 stddev:4.96 (3.0%) stddev-sans-first:5.24 20:35:48 INFO - PID 13510 | Values: 167.0 166.0 167.0 161.0 178.0 163.0 168.0 164.0 161.0 163.0 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:61.00 stddev:3.77 (6.2%) stddev-sans-first:3.93 20:35:48 INFO - PID 13510 | Values: 60.0 61.0 61.0 63.0 61.0 63.0 61.0 59.0 72.0 59.0 20:35:48 INFO - PID 13510 | -------- Summary: end -------- 20:35:48 INFO - PID 13510 | 20:35:48 INFO - PID 13510 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:35:48 INFO - TEST-INFO | 13510: exit 0 20:35:48 INFO - TEST-OK | kraken | took 60006ms 20:35:48 INFO - SUITE-END | took 1168s 20:35:49 INFO - Completed test suite (00:19:29) 20:35:49 INFO - javascript benchmark 20:35:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9007.96551851724, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3493.5807703075634, 3517.314123745871, 3524.665156810103, 3537.380958332292, 3580.6061333253356, 6088.421599948003, 6264.937350626498, 6281.528885333595, 6309.116723658686, 6331.651759153245, 6176.81469555914, 6276.843078923029, 6285.465735412496, 6291.811245662626, 6305.180326557553, 5496.203050557667, 5501.092319767244, 5508.03609368361, 5508.586855985797, 5540.584456165783, 5511.255980442649, 5523.061079616455, 5556.027695153352, 5562.415946325638, 5564.8052318168875, 5520.861978450551, 5529.668219906798, 5538.280023596927, 5538.723063846812, 5593.04918163911, 5549.77800887964, 5602.24369710088, 5609.35492418373, 5615.691136987464, 5622.550195984332, 5422.40353561108, 5525.392206857243, 5589.217509548666, 5594.104943209067, 5596.58025648078, 6023.006203976339, 6122.755089796403, 6187.504999600022, 6275.8744825103695, 6300.432961033529, 6686.699098540577, 6803.387695107464, 6851.1778586569435, 6880.58716477008, 6887.035814985906, 6894.793156205272, 6921.204061532938, 6985.615791131486, 6986.650667466606, 7000.894986575206, 6150.876982460326, 6169.444749972524, 6176.135341052256, 6206.937930620727, 6320.494360451153, 6972.895406568906, 7003.649817509104, 7004.0, 7007.229204787469, 7014.929850701427, 6628.701708423133, 6670.766523171763, 6673.899891501631, 6679.0, 6692.498062645321, 6814.352636499525, 6883.931160688429, 6891.862162756717, 6892.0, 6906.274841141708, 6724.529282950147, 6742.089817874622, 6798.7280508779095, 6834.2140653825445, 6836.248012718696, 6739.157605299338, 6768.661566921634, 6831.795046148623, 6833.384995350442, 6833.658317084126, 4859.635527335464, 4864.78108485119, 4915.0, 4940.456549779521, 4945.381827271591, 4373.540778218241, 4431.33529970507, 4436.467623885154, 4475.910481790346, 4518.9548104518535, 6479.319671434431, 6483.7730679425995, 6554.115194448688, 6560.901586476207, 6562.934370656328, 6832.692528836114, 6840.110785597841, 6853.0, 6886.51794374399, 6922.965385173042, 6485.0, 6509.0, 6535.57518761279, 6569.146011018537, 6572.605643661395, 5518.365387980353, 5525.309336332958, 5590.888182236333, 5591.133374326986, 5594.356648985418, 7127.821804454827, 7245.673944672397, 7253.1296244451005, 7306.232845551247, 7333.88999165013, 6793.252742198453, 6810.897836532356, 6816.795496135124, 6817.965910170417, 6832.0, 7210.1708303545765, 7216.134063912364, 7221.205667376479, 7221.350078492961, 7222.169450513258, 6654.667266636552, 6677.332266773478, 6712.530122891546, 6739.393454589111, 6759.932400676127, 6916.55042422241, 6967.059446974594, 6996.685149168198, 6999.475039371966, 7003.509754317149, 6685.064091027163, 6700.363465470772, 6765.729370825309, 6768.56004359715, 6771.89842152378, 6566.11357466755, 6656.633885136364, 6664.233613134552, 6676.499262555425, 6757.358050985148, 6699.162604674416, 6706.597604143767, 6708.664566771544, 6709.36261055199, 6716.0, 6663.067170596218, 6732.259451460238, 6785.558938668971, 6801.693923773541, 6818.727250910107, 6384.233891932998, 6484.0, 6503.967480162569, 6506.902396463962, 6595.967020164869], "value": 6217.0532742389205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [915.9404638698486, 942.3121121581245, 974.4932635029785, 1250.2186133666457, 1287.7360141171062, 42024.0, 45473.77263113688, 46181.30728039078, 46340.768296158516, 46382.0, 47119.29321060187, 47520.0, 47758.283625745644, 47940.52059479404, 47950.0, 7849.4897831640765, 7875.566843823602, 7940.841183176333, 8003.959980200091, 8004.959975200116, 7614.619269036526, 7673.884891726629, 7679.846403071935, 7681.116671582784, 7682.116556595979, 7654.655540500663, 7655.464117511777, 7719.112302085247, 7719.768406947801, 7724.07311122666, 7585.506942048777, 7597.164311925684, 7601.125870524905, 7650.885236721454, 7667.079950405959, 7730.536167829892, 7778.6888524458955, 7798.298153166243, 7801.765947021541, 7820.217978202191, 41016.58983410158, 41055.58944410548, 41127.0, 41212.0, 41243.58756412457, 3559.537260156163, 3592.946105808415, 3595.352836489431, 3598.9100272493133, 3599.7120230381506, 33051.0, 33150.502742458884, 33164.0, 33212.83393583017, 33266.50100248498, 5310.92033619496, 5331.173668081454, 5337.3061502004875, 5345.812896548602, 5376.677399356051, 216979.0, 220581.0, 220614.0, 221243.0, 221260.0, 54551.99964002018, 54668.0, 54757.0, 55053.44946550483, 55192.724036380365, 57550.71224643934, 57572.42427575754, 57604.42395576074, 57615.423845761004, 57617.711911441016, 14967.850321496646, 15233.923830380778, 17122.743158852627, 17295.481135565955, 17477.91261043712, 14154.292285385896, 14245.857541424453, 14348.85651143496, 14357.282135893372, 14368.568942931728, 15872.571468567885, 15966.521004369888, 16023.67952640964, 16025.118618475863, 16052.75920861188, 6150.231221097363, 6166.383361663888, 6205.2553693557065, 6207.6585787781205, 6247.531435142382, 1111.8332250162541, 1114.570890207276, 1121.7588218533056, 1126.0, 1133.4955944604571, 25242.495150096896, 25612.48775024489, 25676.74323256781, 25713.742862571507, 25785.226443206735, 1225.5710501324643, 1244.2223610243598, 1245.588955644635, 1248.862625111237, 1251.361805479212, 13618.0, 13677.0, 13771.793423098661, 13803.654908627364, 13903.652408689864, 279958.0, 280208.0, 280955.0, 281173.0, 282160.0, 58709.41290587039, 58789.70605146947, 58826.11760823591, 58837.0, 59028.704856475444, 1547.7368847295986, 1557.509384543865, 1596.5050834241422, 1599.5121487946055, 1602.4151184817458, 25374.544472938407, 25393.74606253914, 25404.364890877874, 25565.0, 25644.743552564236, 41579.37630935478, 41611.16777664369, 41619.167616648105, 41700.79149604232, 41812.163756725306, 215918.0, 217293.0, 217491.0, 217533.0, 218529.0, 36979.44530831986, 39771.0, 40050.0, 40218.59781402149, 40226.79886600548, 50965.745171273906, 51816.0, 51941.0, 51985.0, 52382.0, 37479.250414991, 37660.62339376571, 37757.244855103294, 37848.0, 37879.62120378761, 37169.6283037177, 37232.62767372291, 37366.252674945805, 37378.252434950606, 37559.0, 43555.56444435515, 43614.34578481262, 43872.56127438812, 44027.79861007001, 44180.0, 35926.64073359233, 36000.27999440049, 36284.83157863223, 36850.44724329084, 36981.26037479182, 26928.0, 27419.725802741716, 27459.450810984068, 27762.0, 28122.2969425766], "value": 18969.413462002947, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.8531381840722, 574.3796699564471, 575.3258019164231, 580.4746704232671, 593.4332712259792, 24302.635460468086, 25125.874370628146, 25142.24573262805, 25184.49631007381, 25399.873000634972, 27327.45345093097, 28244.576331355045, 28260.717392826067, 28266.858665706644, 28299.717002829966, 5729.1119876419225, 6429.839254018663, 6587.077809106729, 6606.669666516655, 6608.537402381835, 6260.436560709535, 6288.968555157217, 6293.748250069992, 6305.590136641126, 6309.495240380758, 6265.436110750032, 6266.154069200645, 6268.122462855204, 6270.435660790528, 6278.780242691507, 6263.937360626426, 6267.2479302484, 6277.7175027123885, 6281.811545653615, 6290.528210384194, 5828.1549175369755, 5828.300603927556, 5830.0380437227805, 5838.41615838417, 5839.153322768175, 27619.58570621422, 27810.3047423814, 31256.687433125604, 32031.679683203103, 32281.192970175933, 2218.8890555472162, 2256.5035692147867, 2256.638937769965, 2257.0181970842737, 2258.1870526610405, 19760.308389206308, 20324.288649897182, 20391.5921681567, 20397.38807835767, 20402.89798550998, 2421.479381932893, 2448.951020979588, 2500.3874050857476, 2567.7945764338997, 2578.548753968048, 155452.0, 158147.0, 158188.20905895397, 158289.99999999884, 158942.20528897396, 14955.0, 15998.360065597479, 16022.599435014217, 16113.0, 16347.91826040886, 24255.272341829772, 24463.755362446504, 24947.5010499789, 24985.125520606693, 25037.12370067039, 10958.561657533768, 10969.780604387868, 11081.667549973514, 11175.608853690082, 11209.439528023566, 10271.537780799881, 10290.228232882564, 10327.380357178594, 10340.37957722539, 10354.585816567404, 10181.898181018243, 10221.9488902555, 10379.792404152025, 10439.37363758177, 10470.895291046992, 2849.15949794811, 2849.430113977213, 2856.371598248382, 2870.4689632417653, 2948.6461624604754, 1058.142904247562, 1064.6646306413454, 1078.5901357484106, 1096.7641956979287, 1097.8737445193744, 21692.240771573233, 21742.130314787548, 21921.561568768855, 22044.669329960063, 22210.88894555517, 1138.2942575603179, 1141.2068612314529, 1141.9371934543515, 1147.6901236666054, 1154.0306142839886, 11706.590269340531, 12072.939635301944, 12152.0, 12195.878041219474, 12217.633470995885, 554765.0, 568540.0, 568983.0, 572822.0, 575274.0, 131500.3424982888, 136972.0, 138312.30843845918, 138369.3081534606, 139521.3023934894, 1282.8845403913692, 1299.4412402666944, 1310.1156719214491, 1314.2377421095741, 1315.8223639808696, 19061.714074289175, 19098.0, 19233.326833560757, 19306.517337066685, 19478.0, 63758.0, 63764.0, 64051.35948640641, 64400.0, 64961.0, 78169.98166384571, 78215.0, 78373.0, 78883.21116788758, 78926.0, 14811.333489992761, 14882.0, 14920.403183872957, 15066.472673456376, 15095.622609434851, 23586.88206558956, 24150.154744583855, 24208.031678732652, 24259.272221833373, 24553.263402097964, 17804.46586602404, 17821.465356039338, 17954.5511362217, 18212.544686382946, 18342.81657183411, 17067.48797536076, 17173.31306747716, 17489.0, 17508.562285942953, 17770.5557361067, 17552.210150543, 17956.191971361583, 17959.820401796336, 18055.0, 18268.634627307645, 14772.0, 14794.63013424673, 14875.925620371829, 14951.0, 14966.551003469913, 17670.29318827284, 18021.369252076114, 18051.097445127954, 18127.637447250716, 18136.546586335448], "value": 12653.856787016735, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.383645032636, 1518.4533567915548, 1520.6730552931117, 1526.160611663584, 1528.43447924268, 15572.377104915804, 15887.36450541977, 16112.75830862535, 16148.434804781835, 16184.75722864158, 16355.427560035401, 16591.0, 16599.41902033429, 16603.750943735853, 16641.583960400996, 2766.1839757271655, 2804.5933339665735, 2805.5791631255374, 2807.5507918733006, 2808.775297976157, 2685.073649590888, 2725.7001729809704, 2778.7915906307007, 2780.7497325240724, 2782.471330447219, 2714.660667416573, 2721.1972468121953, 2755.3800394911186, 2762.599423083652, 2763.2124844419345, 2642.1883020127802, 2668.6397336359537, 2670.052131493311, 2670.1588999465303, 2672.1716267956995, 2620.606908963671, 2625.0287393664275, 2635.5124302004, 2637.367031912346, 2638.3140383500236, 15590.454334098253, 15838.128902910335, 15845.683086338324, 15865.0, 15880.205989700584, 8498.575071246474, 8781.34139939507, 8783.077776833468, 8784.60469278884, 8800.47197168172, 5127.846164615067, 5306.495882891119, 5404.1083221268445, 5421.539169170625, 5430.022595932731, 1898.4589392023206, 1923.6729755941524, 1926.6532024235632, 1952.824245817869, 1962.9901850490799, 28630.85684571564, 28799.56800647971, 28799.712002880122, 28820.567691484644, 28870.711292887012, 7138.107736532934, 7177.461690373243, 7225.277472252733, 7268.0, 7278.308560686726, 18941.0, 19115.0, 19131.61736765257, 19149.425517234504, 19169.0, 8042.517448953082, 8318.875216871751, 8360.45657032291, 8365.372597055124, 8374.581270936429, 6563.704633291513, 6838.623875686885, 7028.613426261605, 7871.448998570159, 7905.683772649145, 5397.649152805055, 5517.475839795213, 5582.553395728332, 5595.272614560081, 5600.52395546375, 1608.8230294667578, 1612.9516114516348, 1619.408915745768, 1622.2051194914407, 1639.5655151384892, 980.8185485685171, 1002.518790980319, 1003.6738060130486, 1004.3120462483222, 1023.3348323589578, 8515.872261916076, 8545.700900468579, 8591.398602097917, 8637.870431943526, 8725.301975841918, 746.123305116486, 751.2975368030909, 753.6834529497625, 755.0788038592908, 772.9536227826349, 4986.825461108844, 5052.0, 5055.9494405055475, 5107.284980102789, 5140.3317568716575, 22666.886665566897, 22677.0, 23208.18771342995, 23294.06823727032, 23473.295801125994, 22749.31752047441, 22879.0, 22978.965946532113, 23048.308550743506, 23101.0, 12444.440000200013, 12464.626061218178, 12524.060695447695, 12806.167599106215, 12877.742445151045, 9336.859947100935, 9830.852537212091, 9867.901320986986, 9897.109260166619, 10328.122109620766, 20708.896455517624, 20716.378508644764, 20956.68564971557, 21012.05445754975, 21062.57874842464, 21044.579108418053, 21277.46806329854, 21304.786952130282, 21353.67969480428, 21702.240421585167, 13104.737905242033, 13408.932955335162, 13414.725601067883, 13418.39617217208, 13428.93285533566, 15041.247937602857, 15455.61360965985, 15504.457343992906, 15507.379704811681, 15521.68956620884, 11778.528858845893, 11814.527418903148, 11847.644570662895, 11921.34432606215, 11978.341191234565, 11705.414729263332, 11778.587749428729, 11805.76388472243, 11886.524539018343, 12102.818457722966, 10928.562857485611, 10964.0, 11048.116150707763, 11052.226344155832, 11059.72350691239, 7914.485558438683, 7915.525068495908, 7964.601769911597, 8060.11338752725, 8060.516369017878, 7958.960205198937, 8167.14245004266, 8260.421770476009, 8319.750407487785, 8409.159084091541], "value": 7062.801506886022, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.4454788828066, 517.3274742834315, 532.8862677005063, 535.6384440502661, 541.3098299667926, 6146.784862529812, 6150.33940835974, 6181.907271390927, 6208.286047104579, 6300.7794727184555, 6129.724162412691, 6133.907991380132, 6152.723127459264, 6210.9068363974575, 6227.190465239512, 4952.108620448318, 4955.0, 4961.082199793041, 4974.950250497485, 4984.6790600490895, 4635.6986795858165, 4889.8777530561665, 4931.704097754128, 4938.456769755324, 4941.3329200558, 4743.335932969387, 4746.620270378378, 4772.665913386064, 4780.1873681474235, 4795.352627395309, 4721.480637129913, 4773.856784296442, 4783.851875549861, 4791.904161916777, 4798.928016079762, 4172.144710334404, 4288.957110428887, 4295.506016808075, 4297.312430011183, 4324.113556720896, 5884.440978107073, 5898.469137777578, 5903.734331955073, 5931.970340148272, 6046.213992181032, 5651.773929042874, 5654.575906807006, 5696.344920334173, 5711.742971566289, 5771.797987070432, 6505.154329937125, 6527.314631963623, 6527.4125328720165, 6647.0, 6662.367075127855, 4857.562819346276, 4873.220284754422, 4893.584045356149, 4898.628384052471, 4919.581835543983, 6594.142761440982, 6604.141461610008, 6733.027513766852, 6787.423069039138, 6843.213030501506, 4990.201567749143, 5016.0, 5019.573336266459, 5022.196448568212, 5095.210242412432, 5105.2342148678, 5107.0, 5113.667611605234, 5127.53852153308, 5148.768305426265, 5649.491545760901, 5652.802151924663, 5682.318121825408, 5710.2862142232225, 5745.425457454221, 6506.60960342381, 6532.6733663316645, 6563.901541476882, 6572.934270657232, 6602.933970660328, 1758.9032603206947, 1769.3099691120474, 1782.6702060118919, 1791.4894255137224, 1812.4109664359137, 1183.3964678014274, 1237.9319137447346, 1251.361805479194, 1256.9245845249313, 1265.1333836321965, 6220.968895155585, 6296.181496405529, 6307.089604445182, 6326.5255105867245, 6441.871162576722, 6632.1098486931, 6648.434883034899, 6652.600843949379, 6755.932440675629, 6833.145856767904, 6247.062940558862, 6259.530535209878, 6344.175257216624, 6345.238571371465, 6348.936510634834, 3568.750187486851, 3588.4796704478226, 3590.2101537661674, 3591.1560783215923, 3611.1694310308776, 7164.462665300123, 7168.032315637426, 7245.8550828983125, 7280.126384833854, 7304.415646748247, 6296.590721603081, 6755.864882702417, 6780.898286525706, 6915.343042410963, 6967.79096627102, 7050.894236586558, 7052.435805135474, 7095.184053833772, 7156.177039640508, 7188.173360063555, 6528.836779080561, 6684.498662600422, 6707.698153583003, 6711.664416779044, 6767.593944363354, 6620.5034622402545, 6695.598264104169, 6698.330166983457, 6704.76533321351, 6737.663116844236, 7175.820604484929, 7224.855502890018, 7230.276972302728, 7240.660477811622, 7272.272772722897, 5101.438841727333, 5120.0, 5134.409542902614, 5164.122099243213, 5171.922421163761, 6669.233038200475, 6814.420774234048, 6888.8644520198895, 6897.275786042594, 6898.344657257552, 6583.934160658332, 6622.10601568782, 6632.568883022588, 6639.734410623714, 6644.468442524683, 6538.444232240123, 6560.622269323305, 6592.373724496165, 6620.735170593122, 6715.9590263509235, 6606.174228221473, 6666.600003999775, 6670.533062685566, 6686.5653732507235, 6692.364225398579, 6617.735290588323, 6641.136652235178, 6680.265170831108, 6682.264950855305, 6698.464122870256, 6449.645269510222, 6476.287608363171, 6493.610383377012, 6568.343165683394, 6573.704183311858], "value": 5124.04015074768, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [929.3123088914206, 943.0286804591271, 947.3605316411421, 958.338746265077, 971.5725080964378, 19431.31990380337, 20259.088341024653, 20283.08726107325, 20284.695729564068, 21224.363269101952, 22310.107595696154, 22807.08771649136, 22829.77170228297, 22902.312930612108, 23018.0, 998.6332392230406, 1026.6560702164784, 1030.4126647810751, 1031.2214278219933, 1031.6956497833119, 1093.1145771924766, 1093.5243169221374, 1093.557109370706, 1094.6497120921308, 1095.4467993663188, 1070.304302203566, 1116.0457808573674, 1118.815395459748, 1118.8601424821898, 1119.764849381631, 1102.8731695854958, 1104.4146602300714, 1105.022055480897, 1106.8893110688948, 1107.8172101603225, 808.8665370213907, 809.4900212865857, 809.8218391953761, 810.7081450677751, 811.6388207247777, 19303.613927721366, 19574.608507829762, 19582.412527624194, 19944.20223191085, 19966.600667986706, 22395.440113997116, 22490.325290241155, 23155.88422057896, 23210.071597136095, 23276.7672323278, 16699.83300166995, 16700.164991750364, 16818.0, 16850.915745421316, 17045.318187272493, 3774.1885494618514, 3806.9809650951843, 3810.599887011879, 3821.789801560913, 3846.653801157909, 149681.0, 150833.0, 151150.0, 151672.0, 153063.9999999989, 16796.748048779278, 17095.230714617872, 17285.56786080358, 17381.739273910902, 17683.20425580852, 32949.50575741366, 33037.17407064795, 33379.0, 33784.83107584495, 33817.15457113543, 8301.46040507365, 8563.571821408905, 8758.649654013896, 8903.243224325875, 8934.88313960755, 4458.643308535309, 4527.230370836965, 4528.682992190581, 4550.47669518003, 4552.544745525421, 5581.190727344512, 5610.775568977277, 5669.886602267931, 5671.092625179951, 5712.11462223356, 1170.4381896689636, 1187.6080893305189, 1196.5991392883482, 1210.6852218423273, 1212.1030437476204, 717.8851383778675, 723.060021971435, 730.846522230327, 739.4638886807022, 750.9061367329084, 13058.477660893457, 13231.73536529264, 13843.0, 14029.438822447191, 14315.069520481135, 725.6117976882342, 732.6226993098559, 737.5316673912105, 753.9019927409402, 759.6809340077181, 6182.505399568024, 6466.482681385478, 6510.21877374718, 6531.987541931008, 6575.276719560845, 127437.36281318535, 130435.0, 132753.0, 132972.33513832564, 139578.0, 118198.0, 118227.0, 122588.0, 124071.379643103, 126683.0, 105896.47051764691, 107288.0, 107878.0, 107889.46055269674, 110674.0, 11636.825447618123, 11706.180567360203, 11784.4696988634, 11791.76416471683, 11895.940520297343, 48466.303679371056, 50552.24171637355, 50570.49429505658, 51327.0, 51868.0, 64481.67759161174, 64884.0, 65570.67214663896, 66030.66984665046, 66560.0, 16190.595235119215, 16629.16854157263, 16728.665426691154, 16737.66524669524, 17282.22229999678, 21382.572348553254, 21469.355919322446, 21600.67598985985, 21714.0, 21741.347759567238, 19939.501512462306, 20162.697559536326, 20316.085776140404, 20457.48856278605, 20581.89709051505, 19182.136803843583, 19343.613127737648, 19359.0, 19476.805231948067, 19522.21911123596, 19592.510187245432, 19776.11007504637, 19865.30471433493, 19918.30285939985, 20068.397948060996, 14640.926795365955, 14646.63383415423, 14692.926535367682, 14701.191434470778, 14841.109533428029, 14865.688341008778, 15167.62080947941, 15203.087814731152, 15312.157831319384, 15483.458078967182], "value": 9891.938724441976, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1463.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 105.0, 98.0, 105.0, 106.0, 110.0, 106.0, 98.0, 107.0, 107.0], "value": 103.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 112.0, 136.0, 174.0, 113.0, 144.0, 139.0, 112.0, 162.0, 113.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 162.0, 162.0, 163.0, 160.0, 162.0, 162.0, 165.0, 173.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 162.0, 74.0, 74.0, 73.0, 89.0, 93.0, 74.0], "value": 86.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 139.0, 77.0, 78.0, 77.0, 125.0, 79.0, 78.0, 123.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 47.0, 47.0, 47.0, 49.0, 49.0, 51.0, 47.0, 47.0], "value": 47.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 74.0, 73.0, 73.0, 76.0, 79.0, 75.0, 73.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 116.0, 121.0, 125.0, 114.0, 122.0, 113.0, 119.0, 160.0], "value": 122.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 167.0, 161.0, 178.0, 163.0, 168.0, 164.0, 161.0, 163.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 63.0, 61.0, 63.0, 61.0, 59.0, 72.0, 59.0], "value": 62.0, "unit": "score"}]}]} 20:35:49 INFO - Return code: 0 20:35:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:35:49 INFO - # TBPL SUCCESS # 20:35:49 INFO - Running post-action listener: _package_coverage_data 20:35:49 INFO - Running post-action listener: _resource_record_post_action 20:35:49 INFO - [mozharness: 2017-08-16 03:35:49.425836Z] Finished run-tests step (success) 20:35:49 INFO - Running post-run listener: _resource_record_post_run 20:35:49 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 385024; Write bytes: 440246272; Read time: 456; Write time: 369084 20:35:49 INFO - TinderboxPrint: CPU usage
13.0% 20:35:49 INFO - TinderboxPrint: I/O read bytes / time
385,024 / 456 20:35:49 INFO - TinderboxPrint: I/O write bytes / time
440,246,272 / 369,084 20:35:49 INFO - TinderboxPrint: CPU idle
8,231.2 (87.0%) 20:35:49 INFO - TinderboxPrint: CPU user
1,186.2 (12.5%) 20:35:49 INFO - TinderboxPrint: Swap in / out
0 / 0 20:35:49 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 117919744; Read time: 104; Write time: 142996 20:35:49 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 20:35:49 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 376832; Write bytes: 321601536; Read time: 340; Write time: 226032 20:35:50 INFO - Running post-run listener: _upload_blobber_files 20:35:50 INFO - Blob upload gear active. 20:35:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:35:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:35:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:35:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:35:50 INFO - (blobuploader) - INFO - Open directory for files ... 20:35:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:35:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:35:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:51 INFO - (blobuploader) - INFO - Done attempting. 20:35:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:35:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:35:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:52 INFO - (blobuploader) - INFO - Done attempting. 20:35:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:35:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:35:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:59 INFO - (blobuploader) - INFO - Done attempting. 20:35:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:35:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:00 INFO - (blobuploader) - INFO - Done attempting. 20:36:00 INFO - (blobuploader) - INFO - Iteration through files over. 20:36:00 INFO - Return code: 0 20:36:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:36:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:36:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a89f3222c05003198258a4f48db48a701c37cb845437ff119ec8431677d7aeebc2c1ea6e2c27339cc8fe296713f06a5e96be3532ec963f5b322d2ef4d17a9ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b00b162d8415e5af2e87b8a061f607dac01a49aea380a5bcd46b418040a49b437d8bd6b030d1657a846af7d7280ed17de55601ddba5121c5fb35283dc03c325", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df39f1c0f729d36612482a1c56389e255c47fca818f2b487e2ca0e67c25d15568f1ebf3a9f7650c35c79c0509df87ea02f4fdd408f06ecd88d42a86a097ec301", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a16780bb27070860d1d1c06d2496dc1b6cf70ed5fe2421a7cebc03a6bb1cf797963084a852e5431fae18f60859237ed797ef7ed14a5c2c2ebc2ea8a0d05967e"} 20:36:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:36:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:36:00 INFO - Contents: 20:36:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a89f3222c05003198258a4f48db48a701c37cb845437ff119ec8431677d7aeebc2c1ea6e2c27339cc8fe296713f06a5e96be3532ec963f5b322d2ef4d17a9ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b00b162d8415e5af2e87b8a061f607dac01a49aea380a5bcd46b418040a49b437d8bd6b030d1657a846af7d7280ed17de55601ddba5121c5fb35283dc03c325", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df39f1c0f729d36612482a1c56389e255c47fca818f2b487e2ca0e67c25d15568f1ebf3a9f7650c35c79c0509df87ea02f4fdd408f06ecd88d42a86a097ec301", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a16780bb27070860d1d1c06d2496dc1b6cf70ed5fe2421a7cebc03a6bb1cf797963084a852e5431fae18f60859237ed797ef7ed14a5c2c2ebc2ea8a0d05967e"} 20:36:00 INFO - Running post-run listener: copy_logs_to_upload_dir 20:36:00 INFO - Copying logs to upload dir... 20:36:00 INFO - mkdir: /builds/slave/test/build/upload/logs 20:36:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.338361 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-15 20:36:00.575376) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:36:00.578628) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a89f3222c05003198258a4f48db48a701c37cb845437ff119ec8431677d7aeebc2c1ea6e2c27339cc8fe296713f06a5e96be3532ec963f5b322d2ef4d17a9ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b00b162d8415e5af2e87b8a061f607dac01a49aea380a5bcd46b418040a49b437d8bd6b030d1657a846af7d7280ed17de55601ddba5121c5fb35283dc03c325", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df39f1c0f729d36612482a1c56389e255c47fca818f2b487e2ca0e67c25d15568f1ebf3a9f7650c35c79c0509df87ea02f4fdd408f06ecd88d42a86a097ec301", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a16780bb27070860d1d1c06d2496dc1b6cf70ed5fe2421a7cebc03a6bb1cf797963084a852e5431fae18f60859237ed797ef7ed14a5c2c2ebc2ea8a0d05967e"} build_url:https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/Dj1rJa8YSTaD8DJ0ubbRJA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a89f3222c05003198258a4f48db48a701c37cb845437ff119ec8431677d7aeebc2c1ea6e2c27339cc8fe296713f06a5e96be3532ec963f5b322d2ef4d17a9ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b00b162d8415e5af2e87b8a061f607dac01a49aea380a5bcd46b418040a49b437d8bd6b030d1657a846af7d7280ed17de55601ddba5121c5fb35283dc03c325", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df39f1c0f729d36612482a1c56389e255c47fca818f2b487e2ca0e67c25d15568f1ebf3a9f7650c35c79c0509df87ea02f4fdd408f06ecd88d42a86a097ec301", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a16780bb27070860d1d1c06d2496dc1b6cf70ed5fe2421a7cebc03a6bb1cf797963084a852e5431fae18f60859237ed797ef7ed14a5c2c2ebc2ea8a0d05967e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:36:00.606836) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:36:00.607222) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1502852986.160433-1185973122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:36:00.690692) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:36:00.691186) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:36:00.691640) ========= ========= Total master_lag: 0.33 =========