builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1500946794.18 results: success (0) revision: f6528783c52507e29d5be409cc8fbf9a394a5ac8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:54.184328) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:54.184765) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:54.185057) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:54.200914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:54.201186) ========= 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=9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-24 18:39:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2017-07-24 18:39:54 (229 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080035 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:54.294667) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:54.294977) ========= 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=9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013821 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:54.344892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 18:39:54.345237) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f6528783c52507e29d5be409cc8fbf9a394a5ac8 --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 f6528783c52507e29d5be409cc8fbf9a394a5ac8 --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=9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-24 18:39:54,784 truncating revision to first 12 chars 2017-07-24 18:39:54,784 Setting DEBUG logging. 2017-07-24 18:39:54,784 attempt 1/10 2017-07-24 18:39:54,784 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f6528783c525?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-24 18:39:55,833 unpacking tar archive at: mozilla-central-f6528783c525/testing/mozharness/ program finished with exit code 0 elapsedTime=1.546745 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 18:39:55.904010) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:55.904303) ========= script_repo_revision: f6528783c52507e29d5be409cc8fbf9a394a5ac8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:55.904647) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:55.904913) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:55.912305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-24 18:39:55.912574) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:39:56 INFO - MultiFileLogger online at 20170724 18:39:56 in /builds/slave/test 18:39:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:39:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:39:56 INFO - {'append_to_log': False, 18:39:56 INFO - 'base_work_dir': '/builds/slave/test', 18:39:56 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:39:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:39:56 INFO - 'branch': 'Firefox-Non-PGO', 18:39:56 INFO - 'buildbot_json_path': 'buildprops.json', 18:39:56 INFO - 'code_coverage': False, 18:39:56 INFO - 'config_files': ('talos/linux_config.py',), 18:39:56 INFO - 'default_actions': ('clobber', 18:39:56 INFO - 'read-buildbot-config', 18:39:56 INFO - 'download-and-extract', 18:39:56 INFO - 'populate-webroot', 18:39:56 INFO - 'create-virtualenv', 18:39:56 INFO - 'install', 18:39:56 INFO - 'setup-mitmproxy', 18:39:56 INFO - 'run-tests'), 18:39:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:39:56 INFO - 'disable_ccov_upload': False, 18:39:56 INFO - 'download_minidump_stackwalk': True, 18:39:56 INFO - 'download_symbols': 'ondemand', 18:39:56 INFO - 'enable_stylo': False, 18:39:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:39:56 INFO - 'tooltool.py': '/tools/tooltool.py', 18:39:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:39:56 INFO - '/tools/misc-python/virtualenv.py')}, 18:39:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:39:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:39:56 INFO - 'gecko_profile': False, 18:39:56 INFO - 'gecko_profile_interval': 0, 18:39:56 INFO - 'installer_path': 'installer.exe', 18:39:56 INFO - 'log_level': 'info', 18:39:56 INFO - 'log_name': 'talos', 18:39:56 INFO - 'log_to_console': True, 18:39:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:39:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:39:56 INFO - 'opt_config_files': (), 18:39:56 INFO - 'pip_index': False, 18:39:56 INFO - 'suite': 'dromaeojs-e10s', 18:39:56 INFO - 'system_bits': '32', 18:39:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:39:56 INFO - 'title': 'talos-linux64-ix-088', 18:39:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:39:56 INFO - 'use_talos_json': True, 18:39:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:39:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:39:56 INFO - 'work_dir': 'build'} 18:39:56 INFO - [mozharness: 2017-07-25 01:39:56.455598Z] Running clobber step. 18:39:56 INFO - Running pre-action listener: _resource_record_pre_action 18:39:56 INFO - Running main action method: clobber 18:39:56 INFO - rmtree: /builds/slave/test/build 18:39:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:39:58 INFO - Running post-action listener: _resource_record_post_action 18:39:58 INFO - [mozharness: 2017-07-25 01:39:58.014871Z] Finished clobber step (success) 18:39:58 INFO - [mozharness: 2017-07-25 01:39:58.014973Z] Running read-buildbot-config step. 18:39:58 INFO - Running pre-action listener: _resource_record_pre_action 18:39:58 INFO - Running main action method: read_buildbot_config 18:39:58 INFO - Using buildbot properties: 18:39:58 INFO - { 18:39:58 INFO - "project": "", 18:39:58 INFO - "product": "firefox", 18:39:58 INFO - "who": "kwierso@gmail.com", 18:39:58 INFO - "installer_path": "public/build/target.tar.bz2", 18:39:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:39:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:39:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:39:58 INFO - "stage_platform": "linux64", 18:39:58 INFO - "basedir": "/builds/slave/test", 18:39:58 INFO - "buildnumber": 1033, 18:39:58 INFO - "platform": "ubuntu64_hw", 18:39:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:39:58 INFO - "slavebuilddir": "test", 18:39:58 INFO - "taskId": "Ld4A5izyQESvSD-4w0oeSQ", 18:39:58 INFO - "branch": "mozilla-central", 18:39:58 INFO - "script_repo_revision": "production", 18:39:58 INFO - "revision": "f6528783c52507e29d5be409cc8fbf9a394a5ac8", 18:39:58 INFO - "slavename": "talos-linux64-ix-088", 18:39:58 INFO - "repo_path": "mozilla-central" 18:39:58 INFO - } 18:39:58 INFO - Finding installer, test and symbols from parent task. 18:39:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ld4A5izyQESvSD-4w0oeSQ'}, attempt #1 18:39:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ld4A5izyQESvSD-4w0oeSQ'}, attempt #1 18:39:58 INFO - Task dependencies: Dmp9ImL6RGu0AuUgN83OtA 18:39:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA'}, attempt #1 18:39:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2 18:39:59 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/test_packages.json 18:39:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.crashreporter-symbols.zip 18:39:59 INFO - Running post-action listener: _resource_record_post_action 18:39:59 INFO - [mozharness: 2017-07-25 01:39:59.379336Z] Finished read-buildbot-config step (success) 18:39:59 INFO - [mozharness: 2017-07-25 01:39:59.379556Z] Running download-and-extract step. 18:39:59 INFO - Running pre-action listener: _resource_record_pre_action 18:39:59 INFO - Running main action method: download_and_extract 18:39:59 INFO - mkdir: /builds/slave/test/build/tests 18:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:59 INFO - trying https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.test_packages.json 18:39:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:39:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:39:59 INFO - Downloaded 989 bytes. 18:39:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:39:59 INFO - Using the following test package requirements: 18:39:59 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:39:59 INFO - u'common': [u'target.common.tests.zip'], 18:39:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:39:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:39:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:39:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:39:59 INFO - u'mozbase': [u'target.common.tests.zip'], 18:39:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:39:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:39:59 INFO - u'web-platform': [u'target.common.tests.zip', 18:39:59 INFO - u'target.web-platform.tests.tar.gz'], 18:39:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:39:59 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:39:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.common.tests.zip 18:39:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:39:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.common.tests.zip into memory 18:40:01 INFO - Content-Length response header: 72765760 18:40:01 INFO - Bytes received: 72765760 18:40:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:40:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.common.tests.zip 18:40:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:40:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.common.tests.zip into memory 18:40:13 INFO - Content-Length response header: 72765760 18:40:13 INFO - Bytes received: 72765760 18:40:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.talos.tests.zip 18:40:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:40:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.talos.tests.zip into memory 18:40:26 INFO - Content-Length response header: 14498976 18:40:26 INFO - Bytes received: 14498976 18:40:27 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')]} 18:40:27 INFO - trying https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2 18:40:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:40:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:40:28 INFO - Downloaded 62021248 bytes. 18:40:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2 18:40:28 INFO - mkdir: /builds/slave/test/properties 18:40:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:40:28 INFO - Writing to file /builds/slave/test/properties/build_url 18:40:28 INFO - Contents: 18:40:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2 18:40:28 INFO - Running post-action listener: _resource_record_post_action 18:40:28 INFO - Running post-action listener: set_extra_try_arguments 18:40:28 INFO - [mozharness: 2017-07-25 01:40:28.136731Z] Finished download-and-extract step (success) 18:40:28 INFO - [mozharness: 2017-07-25 01:40:28.136828Z] Running populate-webroot step. 18:40:28 INFO - Running pre-action listener: _resource_record_pre_action 18:40:28 INFO - Running main action method: populate_webroot 18:40:28 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:40:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:40:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:40:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:40:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:40:28 INFO - 'tests': ['damp', 'tps']}, 18:40:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:40:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:40:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:40:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:40:28 INFO - 'other-e10s': {'tests': ['a11yr', 18:40:28 INFO - 'ts_paint', 18:40:28 INFO - 'tpaint', 18:40:28 INFO - 'sessionrestore', 18:40:28 INFO - 'sessionrestore_many_windows', 18:40:28 INFO - 'sessionrestore_no_auto_restore', 18:40:28 INFO - 'tabpaint']}, 18:40:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:40:28 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:40:28 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:40:28 INFO - 'talos_options': ['--mitmproxy', 18:40:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:40:28 INFO - '--firstNonBlankPaint'], 18:40:28 INFO - 'tests': ['quantum_pageload_google', 18:40:28 INFO - 'quantum_pageload_youtube', 18:40:28 INFO - 'quantum_pageload_amazon', 18:40:28 INFO - 'quantum_pageload_facebook']}, 18:40:28 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:40:28 INFO - 'talos_options': ['--stylo', 18:40:28 INFO - '--mitmproxy', 18:40:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:40:28 INFO - '--firstNonBlankPaint'], 18:40:28 INFO - 'tests': ['quantum_pageload_google', 18:40:28 INFO - 'quantum_pageload_youtube', 18:40:28 INFO - 'quantum_pageload_amazon', 18:40:28 INFO - 'quantum_pageload_facebook']}, 18:40:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:40:28 INFO - 'tsvgr_opacity', 18:40:28 INFO - 'tart', 18:40:28 INFO - 'tscrollx', 18:40:28 INFO - 'cart', 18:40:28 INFO - 'tsvg_static']}, 18:40:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:40:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:40:28 INFO - 'talos_options': ['--xperf_path', 18:40:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:40:28 INFO - 'tests': ['tp5n']}}} 18:40:28 INFO - Running post-action listener: _resource_record_post_action 18:40:28 INFO - [mozharness: 2017-07-25 01:40:28.144118Z] Finished populate-webroot step (success) 18:40:28 INFO - [mozharness: 2017-07-25 01:40:28.144208Z] Running create-virtualenv step. 18:40:28 INFO - Running pre-action listener: _resource_record_pre_action 18:40:28 INFO - Running main action method: create_virtualenv 18:40:28 INFO - Creating virtualenv /builds/slave/test/build/venv 18:40:28 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 18:40:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:40:28 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:40:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:40:28 INFO - Using real prefix '/usr' 18:40:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:40:28 INFO - Installing distribute.............................................................................................................................................................................................done. 18:40:30 INFO - Installing pip.................done. 18:40:30 INFO - Return code: 0 18:40:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:40:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:40:30 INFO - Reading from file tmpfile_stdout 18:40:30 INFO - Output received: 18:40:30 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) 18:40:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:40:30 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')]} 18:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:30 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')]} 18:40:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:30 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 0xa031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70eb0>, '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 0xd71db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd72240>, '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': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', '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 18:40:30 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 18:40:30 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 18:40:30 INFO - Using env: {'DISPLAY': ':0', 18:40:30 INFO - 'HOME': '/home/cltbld', 18:40:30 INFO - 'LANG': 'en_US.UTF-8', 18:40:30 INFO - 'LANGUAGE': 'en_US:en', 18:40:30 INFO - 'LOGNAME': 'cltbld', 18:40:30 INFO - 'MAIL': '/var/mail/cltbld', 18:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:30 INFO - 'MOZ_NO_REMOTE': '1', 18:40:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:30 INFO - 'NO_EM_RESTART': '1', 18:40:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:30 INFO - 'PWD': '/builds/slave/test', 18:40:30 INFO - 'SHELL': '/bin/bash', 18:40:30 INFO - 'SHLVL': '1', 18:40:30 INFO - 'TERM': 'linux', 18:40:30 INFO - 'TMOUT': '86400', 18:40:30 INFO - 'USER': 'cltbld', 18:40:30 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', 18:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:30 INFO - '_': '/tools/buildbot/bin/python'} 18:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:31 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 18:40:31 INFO - Cleaning up... 18:40:31 INFO - Return code: 0 18:40:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:40:31 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')]} 18:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:31 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')]} 18:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:31 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 0xa031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70eb0>, '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 0xd71db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd72240>, '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': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', '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 18:40:31 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 18:40:31 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 18:40:31 INFO - Using env: {'DISPLAY': ':0', 18:40:31 INFO - 'HOME': '/home/cltbld', 18:40:31 INFO - 'LANG': 'en_US.UTF-8', 18:40:31 INFO - 'LANGUAGE': 'en_US:en', 18:40:31 INFO - 'LOGNAME': 'cltbld', 18:40:31 INFO - 'MAIL': '/var/mail/cltbld', 18:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:31 INFO - 'MOZ_NO_REMOTE': '1', 18:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:31 INFO - 'NO_EM_RESTART': '1', 18:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:31 INFO - 'PWD': '/builds/slave/test', 18:40:31 INFO - 'SHELL': '/bin/bash', 18:40:31 INFO - 'SHLVL': '1', 18:40:31 INFO - 'TERM': 'linux', 18:40:31 INFO - 'TMOUT': '86400', 18:40:31 INFO - 'USER': 'cltbld', 18:40:31 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', 18:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:31 INFO - '_': '/tools/buildbot/bin/python'} 18:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:31 INFO - Downloading/unpacking psutil>=3.1.1 18:40:31 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 18:40:31 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 18:40:31 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 18:40:31 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 18:40:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:40:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:32 INFO - Installing collected packages: psutil 18:40:32 INFO - Running setup.py install for psutil 18:40:32 INFO - building 'psutil._psutil_linux' extension 18:40:32 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 18:40:32 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 18:40:32 INFO - building 'psutil._psutil_posix' extension 18:40:32 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 18:40:32 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 18:40:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:33 INFO - Successfully installed psutil 18:40:33 INFO - Cleaning up... 18:40:33 INFO - Return code: 0 18:40:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:33 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 0xa031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70eb0>, '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 0xd71db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd72240>, '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': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', '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 18:40:33 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 18:40:33 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 18:40:33 INFO - Using env: {'DISPLAY': ':0', 18:40:33 INFO - 'HOME': '/home/cltbld', 18:40:33 INFO - 'LANG': 'en_US.UTF-8', 18:40:33 INFO - 'LANGUAGE': 'en_US:en', 18:40:33 INFO - 'LOGNAME': 'cltbld', 18:40:33 INFO - 'MAIL': '/var/mail/cltbld', 18:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:33 INFO - 'MOZ_NO_REMOTE': '1', 18:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:33 INFO - 'NO_EM_RESTART': '1', 18:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:33 INFO - 'PWD': '/builds/slave/test', 18:40:33 INFO - 'SHELL': '/bin/bash', 18:40:33 INFO - 'SHLVL': '1', 18:40:33 INFO - 'TERM': 'linux', 18:40:33 INFO - 'TMOUT': '86400', 18:40:33 INFO - 'USER': 'cltbld', 18:40:33 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', 18:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:33 INFO - '_': '/tools/buildbot/bin/python'} 18:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:40:33 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 18:40:33 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 18:40:33 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 18:40:33 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 18:40:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:40:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:40:34 INFO - Installing collected packages: mozsystemmonitor 18:40:34 INFO - Running setup.py install for mozsystemmonitor 18:40:34 INFO - Successfully installed mozsystemmonitor 18:40:34 INFO - Cleaning up... 18:40:34 INFO - Return code: 0 18:40:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:34 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 0xa031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70eb0>, '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 0xd71db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd72240>, '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': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', '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 18:40:34 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 18:40:34 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 18:40:34 INFO - Using env: {'DISPLAY': ':0', 18:40:34 INFO - 'HOME': '/home/cltbld', 18:40:34 INFO - 'LANG': 'en_US.UTF-8', 18:40:34 INFO - 'LANGUAGE': 'en_US:en', 18:40:34 INFO - 'LOGNAME': 'cltbld', 18:40:34 INFO - 'MAIL': '/var/mail/cltbld', 18:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:34 INFO - 'MOZ_NO_REMOTE': '1', 18:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:34 INFO - 'NO_EM_RESTART': '1', 18:40:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:34 INFO - 'PWD': '/builds/slave/test', 18:40:34 INFO - 'SHELL': '/bin/bash', 18:40:34 INFO - 'SHLVL': '1', 18:40:34 INFO - 'TERM': 'linux', 18:40:34 INFO - 'TMOUT': '86400', 18:40:34 INFO - 'USER': 'cltbld', 18:40:34 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', 18:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:34 INFO - '_': '/tools/buildbot/bin/python'} 18:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:34 INFO - Downloading/unpacking jsonschema==2.5.1 18:40:34 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 18:40:34 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 18:40:34 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 18:40:34 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 18:40:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:40:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:40:35 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 18:40:35 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 18:40:35 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 18:40:35 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 18:40:36 INFO - Downloading functools32-3.2.3-2.tar.gz 18:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:40:36 INFO - warning: no files found matching '*.txt' 18:40:36 INFO - no previously-included directories found matching 'build' 18:40:36 INFO - no previously-included directories found matching 'dist' 18:40:36 INFO - no previously-included directories found matching '.git*' 18:40:36 INFO - Installing collected packages: jsonschema, functools32 18:40:36 INFO - Running setup.py install for functools32 18:40:36 INFO - warning: no files found matching '*.txt' 18:40:36 INFO - no previously-included directories found matching 'build' 18:40:36 INFO - no previously-included directories found matching 'dist' 18:40:36 INFO - no previously-included directories found matching '.git*' 18:40:36 INFO - Successfully installed jsonschema functools32 18:40:36 INFO - Cleaning up... 18:40:36 INFO - Return code: 0 18:40:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:36 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 0xa031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70eb0>, '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 0xd71db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd72240>, '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': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', '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 18:40:36 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 18:40:36 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 18:40:36 INFO - Using env: {'DISPLAY': ':0', 18:40:36 INFO - 'HOME': '/home/cltbld', 18:40:36 INFO - 'LANG': 'en_US.UTF-8', 18:40:36 INFO - 'LANGUAGE': 'en_US:en', 18:40:36 INFO - 'LOGNAME': 'cltbld', 18:40:36 INFO - 'MAIL': '/var/mail/cltbld', 18:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:36 INFO - 'MOZ_NO_REMOTE': '1', 18:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:36 INFO - 'NO_EM_RESTART': '1', 18:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:36 INFO - 'PWD': '/builds/slave/test', 18:40:36 INFO - 'SHELL': '/bin/bash', 18:40:36 INFO - 'SHLVL': '1', 18:40:36 INFO - 'TERM': 'linux', 18:40:36 INFO - 'TMOUT': '86400', 18:40:36 INFO - 'USER': 'cltbld', 18:40:36 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', 18:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:36 INFO - '_': '/tools/buildbot/bin/python'} 18:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:40:36 INFO - Cleaning up... 18:40:36 INFO - Return code: 0 18:40:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:36 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 0xa031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70eb0>, '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 0xd71db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd72240>, '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': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', '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 18:40:36 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 18:40:36 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 18:40:36 INFO - Using env: {'DISPLAY': ':0', 18:40:36 INFO - 'HOME': '/home/cltbld', 18:40:36 INFO - 'LANG': 'en_US.UTF-8', 18:40:36 INFO - 'LANGUAGE': 'en_US:en', 18:40:36 INFO - 'LOGNAME': 'cltbld', 18:40:36 INFO - 'MAIL': '/var/mail/cltbld', 18:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:36 INFO - 'MOZ_NO_REMOTE': '1', 18:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:36 INFO - 'NO_EM_RESTART': '1', 18:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:36 INFO - 'PWD': '/builds/slave/test', 18:40:36 INFO - 'SHELL': '/bin/bash', 18:40:36 INFO - 'SHLVL': '1', 18:40:36 INFO - 'TERM': 'linux', 18:40:36 INFO - 'TMOUT': '86400', 18:40:36 INFO - 'USER': 'cltbld', 18:40:36 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', 18:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:36 INFO - '_': '/tools/buildbot/bin/python'} 18:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:36 INFO - Downloading/unpacking blobuploader==1.2.4 18:40:36 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 18:40:36 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 18:40:36 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 18:40:36 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 18:40:37 INFO - Downloading blobuploader-1.2.4.tar.gz 18:40:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:40:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:40:37 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 18:40:37 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 18:40:37 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 18:40:37 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 18:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:40:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:40:38 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 18:40:38 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 18:40:38 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 18:40:38 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 18:40:38 INFO - Downloading docopt-0.6.1.tar.gz 18:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:40:38 INFO - Installing collected packages: blobuploader, requests, docopt 18:40:38 INFO - Running setup.py install for blobuploader 18:40:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:40:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:40:38 INFO - Running setup.py install for requests 18:40:38 INFO - Running setup.py install for docopt 18:40:38 INFO - Successfully installed blobuploader requests docopt 18:40:38 INFO - Cleaning up... 18:40:39 INFO - Return code: 0 18:40:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:39 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')]} 18:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:39 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')]} 18:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:39 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 0xa031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70eb0>, '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 0xd71db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd72240>, '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': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', '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 18:40:39 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 18:40:39 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 18:40:39 INFO - Using env: {'DISPLAY': ':0', 18:40:39 INFO - 'HOME': '/home/cltbld', 18:40:39 INFO - 'LANG': 'en_US.UTF-8', 18:40:39 INFO - 'LANGUAGE': 'en_US:en', 18:40:39 INFO - 'LOGNAME': 'cltbld', 18:40:39 INFO - 'MAIL': '/var/mail/cltbld', 18:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:39 INFO - 'MOZ_NO_REMOTE': '1', 18:40:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:39 INFO - 'NO_EM_RESTART': '1', 18:40:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:39 INFO - 'PWD': '/builds/slave/test', 18:40:39 INFO - 'SHELL': '/bin/bash', 18:40:39 INFO - 'SHLVL': '1', 18:40:39 INFO - 'TERM': 'linux', 18:40:39 INFO - 'TMOUT': '86400', 18:40:39 INFO - 'USER': 'cltbld', 18:40:39 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', 18:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:39 INFO - '_': '/tools/buildbot/bin/python'} 18:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:40:39 INFO - Running setup.py (path:/tmp/pip-BGoSgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:40:39 INFO - Running setup.py (path:/tmp/pip-EoVcXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:40:39 INFO - Running setup.py (path:/tmp/pip-9sHjxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:40:39 INFO - Running setup.py (path:/tmp/pip-DlHinr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:40:39 INFO - Running setup.py (path:/tmp/pip-EAT6A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:40:39 INFO - Running setup.py (path:/tmp/pip-HnZXzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:40:39 INFO - Running setup.py (path:/tmp/pip-kCe3OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:40:39 INFO - Running setup.py (path:/tmp/pip-BDgXCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:40:39 INFO - Running setup.py (path:/tmp/pip-JqAoDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:40:39 INFO - Running setup.py (path:/tmp/pip-PyrbfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:40:39 INFO - Running setup.py (path:/tmp/pip-nXw_CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:40:40 INFO - Running setup.py (path:/tmp/pip-k6XqRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:40:40 INFO - Running setup.py (path:/tmp/pip-65icxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:40:40 INFO - Running setup.py (path:/tmp/pip-flHpFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:40 INFO - Running setup.py (path:/tmp/pip-bUbUOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:40:40 INFO - Running setup.py (path:/tmp/pip-M3_P8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:40:40 INFO - Running setup.py (path:/tmp/pip-okOXWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:40:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:40:40 INFO - Running setup.py install for manifestparser 18:40:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:40:40 INFO - Running setup.py install for mozcrash 18:40:40 INFO - Running setup.py install for mozdebug 18:40:40 INFO - Running setup.py install for mozdevice 18:40:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:40:40 INFO - Running setup.py install for mozfile 18:40:40 INFO - Running setup.py install for mozhttpd 18:40:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:40:41 INFO - Running setup.py install for mozinfo 18:40:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:40:41 INFO - Running setup.py install for mozInstall 18:40:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:40:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:40:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:40:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:40:41 INFO - Running setup.py install for mozleak 18:40:41 INFO - Running setup.py install for mozlog 18:40:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:40:41 INFO - Running setup.py install for moznetwork 18:40:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:40:41 INFO - Running setup.py install for mozprocess 18:40:41 INFO - Running setup.py install for mozprofile 18:40:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:40:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:40:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:40:41 INFO - Running setup.py install for mozrunner 18:40:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:40:41 INFO - Running setup.py install for mozscreenshot 18:40:42 INFO - Running setup.py install for moztest 18:40:42 INFO - Running setup.py install for mozversion 18:40:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:40:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:40:42 INFO - Cleaning up... 18:40:42 INFO - Return code: 0 18:40:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:42 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 0xa031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70eb0>, '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 0xd71db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd72240>, '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': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', '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 18:40:42 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 18:40:42 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 18:40:42 INFO - Using env: {'DISPLAY': ':0', 18:40:42 INFO - 'HOME': '/home/cltbld', 18:40:42 INFO - 'LANG': 'en_US.UTF-8', 18:40:42 INFO - 'LANGUAGE': 'en_US:en', 18:40:42 INFO - 'LOGNAME': 'cltbld', 18:40:42 INFO - 'MAIL': '/var/mail/cltbld', 18:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:42 INFO - 'MOZ_NO_REMOTE': '1', 18:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:42 INFO - 'NO_EM_RESTART': '1', 18:40:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:42 INFO - 'PWD': '/builds/slave/test', 18:40:42 INFO - 'SHELL': '/bin/bash', 18:40:42 INFO - 'SHLVL': '1', 18:40:42 INFO - 'TERM': 'linux', 18:40:42 INFO - 'TMOUT': '86400', 18:40:42 INFO - 'USER': 'cltbld', 18:40:42 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', 18:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:42 INFO - '_': '/tools/buildbot/bin/python'} 18:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:40:42 INFO - Running setup.py (path:/tmp/pip-qSNodP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:40:42 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)) 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:40:42 INFO - Running setup.py (path:/tmp/pip-4NYaWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:40:42 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)) 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:40:42 INFO - Running setup.py (path:/tmp/pip-mqN0Qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:40:42 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)) 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:40:42 INFO - Running setup.py (path:/tmp/pip-fiAX52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:40:42 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)) 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:40:42 INFO - Running setup.py (path:/tmp/pip-JmRxwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:40:42 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)) 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:40:42 INFO - Running setup.py (path:/tmp/pip-XGk8QB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:40:42 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)) 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:40:42 INFO - Running setup.py (path:/tmp/pip-EAmWgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:40:42 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)) 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:40:42 INFO - Running setup.py (path:/tmp/pip-O7qVh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:40:43 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)) 18:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:40:43 INFO - Running setup.py (path:/tmp/pip-6ERzhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:40:43 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)) 18:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:40:43 INFO - Running setup.py (path:/tmp/pip-GQD1Pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:40:43 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)) 18:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:40:43 INFO - Running setup.py (path:/tmp/pip-c_GRJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:40:43 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)) 18:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:40:43 INFO - Running setup.py (path:/tmp/pip-jRrdAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:40:43 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)) 18:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:40:43 INFO - Running setup.py (path:/tmp/pip-qPkVSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:40:43 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)) 18:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:40:43 INFO - Running setup.py (path:/tmp/pip-oge_wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:40:43 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)) 18:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:43 INFO - Running setup.py (path:/tmp/pip-YeuwFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:43 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)) 18:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:40:43 INFO - Running setup.py (path:/tmp/pip-deo2ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:40:43 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)) 18:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:40:43 INFO - Running setup.py (path:/tmp/pip-5s6FqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:40:43 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)) 18:40:43 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)) 18:40:43 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)) 18:40:43 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)) 18:40:43 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)) 18:40:43 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)) 18:40:43 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)) 18:40:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:40:43 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 18:40:43 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 18:40:43 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 18:40:43 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 18:40:44 INFO - Downloading blessings-1.6.tar.gz 18:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:40:44 INFO - Installing collected packages: blessings 18:40:44 INFO - Running setup.py install for blessings 18:40:44 INFO - Successfully installed blessings 18:40:44 INFO - Cleaning up... 18:40:44 INFO - Return code: 0 18:40:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:40:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:40:45 INFO - Reading from file tmpfile_stdout 18:40:45 INFO - Current package versions: 18:40:45 INFO - argparse == 1.2.1 18:40:45 INFO - blessings == 1.6 18:40:45 INFO - blobuploader == 1.2.4 18:40:45 INFO - docopt == 0.6.1 18:40:45 INFO - functools32 == 3.2.3-2 18:40:45 INFO - jsonschema == 2.5.1 18:40:45 INFO - manifestparser == 1.1 18:40:45 INFO - mozInstall == 1.13 18:40:45 INFO - mozcrash == 1.0 18:40:45 INFO - mozdebug == 0.1 18:40:45 INFO - mozdevice == 0.51 18:40:45 INFO - mozfile == 1.2 18:40:45 INFO - mozhttpd == 0.7 18:40:45 INFO - mozinfo == 0.10 18:40:45 INFO - mozleak == 0.1 18:40:45 INFO - mozlog == 3.5 18:40:45 INFO - moznetwork == 0.27 18:40:45 INFO - mozprocess == 0.25 18:40:45 INFO - mozprofile == 0.28 18:40:45 INFO - mozrunner == 6.13 18:40:45 INFO - mozscreenshot == 0.1 18:40:45 INFO - mozsystemmonitor == 0.3 18:40:45 INFO - moztest == 0.8 18:40:45 INFO - mozversion == 1.4 18:40:45 INFO - psutil == 3.1.1 18:40:45 INFO - requests == 1.2.3 18:40:45 INFO - wsgiref == 0.1.2 18:40:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:45 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')]} 18:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:45 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')]} 18:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:45 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 0xa031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70eb0>, '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 0xd71db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd72240>, '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': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', '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 18:40:45 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 18:40:45 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 18:40:45 INFO - Using env: {'DISPLAY': ':0', 18:40:45 INFO - 'HOME': '/home/cltbld', 18:40:45 INFO - 'LANG': 'en_US.UTF-8', 18:40:45 INFO - 'LANGUAGE': 'en_US:en', 18:40:45 INFO - 'LOGNAME': 'cltbld', 18:40:45 INFO - 'MAIL': '/var/mail/cltbld', 18:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:45 INFO - 'MOZ_NO_REMOTE': '1', 18:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:45 INFO - 'NO_EM_RESTART': '1', 18:40:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:45 INFO - 'PWD': '/builds/slave/test', 18:40:45 INFO - 'SHELL': '/bin/bash', 18:40:45 INFO - 'SHLVL': '1', 18:40:45 INFO - 'TERM': 'linux', 18:40:45 INFO - 'TMOUT': '86400', 18:40:45 INFO - 'USER': 'cltbld', 18:40:45 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', 18:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:45 INFO - '_': '/tools/buildbot/bin/python'} 18:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:45 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)) 18:40:45 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)) 18:40:45 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)) 18:40:45 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)) 18:40:45 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)) 18:40:45 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)) 18:40:45 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)) 18:40:45 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)) 18:40:45 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)) 18:40:45 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:40:45 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 18:40:45 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 18:40:45 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 18:40:45 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 18:40:46 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:40:46 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 18:40: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 18:40: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 18:40: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 18:40: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 18:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:40:46 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)) 18:40:46 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)) 18:40:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:40:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:40:46 INFO - Installing collected packages: marionette-driver, simplejson 18:40:46 INFO - Running setup.py install for marionette-driver 18:40:46 INFO - Running setup.py install for simplejson 18:40:47 INFO - building 'simplejson._speedups' extension 18:40:47 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 18:40:47 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 18:40:47 INFO - Successfully installed marionette-driver simplejson 18:40:47 INFO - Cleaning up... 18:40:47 INFO - Return code: 0 18:40:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:40:47 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')]} 18:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:47 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')]} 18:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:47 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 0xa031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70eb0>, '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 0xd71db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd72240>, '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': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', '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 18:40:47 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 18:40:47 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 18:40:47 INFO - Using env: {'DISPLAY': ':0', 18:40:47 INFO - 'HOME': '/home/cltbld', 18:40:47 INFO - 'LANG': 'en_US.UTF-8', 18:40:47 INFO - 'LANGUAGE': 'en_US:en', 18:40:47 INFO - 'LOGNAME': 'cltbld', 18:40:47 INFO - 'MAIL': '/var/mail/cltbld', 18:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:47 INFO - 'MOZ_NO_REMOTE': '1', 18:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:47 INFO - 'NO_EM_RESTART': '1', 18:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:47 INFO - 'PWD': '/builds/slave/test', 18:40:47 INFO - 'SHELL': '/bin/bash', 18:40:47 INFO - 'SHLVL': '1', 18:40:47 INFO - 'TERM': 'linux', 18:40:47 INFO - 'TMOUT': '86400', 18:40:47 INFO - 'USER': 'cltbld', 18:40:47 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', 18:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:47 INFO - '_': '/tools/buildbot/bin/python'} 18:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:40:48 INFO - Cleaning up... 18:40:48 INFO - Return code: 0 18:40:48 INFO - Running post-action listener: _resource_record_post_action 18:40:48 INFO - Running post-action listener: _start_resource_monitoring 18:40:48 INFO - Starting resource monitoring. 18:40:48 INFO - [mozharness: 2017-07-25 01:40:48.258106Z] Finished create-virtualenv step (success) 18:40:48 INFO - [mozharness: 2017-07-25 01:40:48.258631Z] Running install step. 18:40:48 INFO - Running pre-action listener: _resource_record_pre_action 18:40:48 INFO - Running main action method: install 18:40:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:40:48 INFO - Reading from file tmpfile_stdout 18:40:48 INFO - Detecting whether we're running mozinstall >=1.0... 18:40:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:40:48 INFO - Reading from file tmpfile_stdout 18:40:48 INFO - Output received: 18:40:48 INFO - Usage: mozinstall [options] installer 18:40:48 INFO - Options: 18:40:48 INFO - -h, --help show this help message and exit 18:40:48 INFO - -d DEST, --destination=DEST 18:40:48 INFO - Directory to install application into. [default: 18:40:48 INFO - "/builds/slave/test"] 18:40:48 INFO - --app=APP Application being installed. [default: firefox] 18:40:48 INFO - mkdir: /builds/slave/test/build/application 18:40:48 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'] 18:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:41:06 INFO - Reading from file tmpfile_stdout 18:41:06 INFO - Output received: 18:41:06 INFO - /builds/slave/test/build/application/firefox/firefox 18:41:06 INFO - Running post-action listener: _resource_record_post_action 18:41:06 INFO - [mozharness: 2017-07-25 01:41:06.599739Z] Finished install step (success) 18:41:06 INFO - [mozharness: 2017-07-25 01:41:06.599993Z] Running setup-mitmproxy step. 18:41:06 INFO - Running pre-action listener: _resource_record_pre_action 18:41:06 INFO - Running main action method: setup_mitmproxy 18:41:06 INFO - Skipping: mitmproxy is not required 18:41:06 INFO - Running post-action listener: _resource_record_post_action 18:41:06 INFO - [mozharness: 2017-07-25 01:41:06.601124Z] Finished setup-mitmproxy step (success) 18:41:06 INFO - [mozharness: 2017-07-25 01:41:06.601346Z] Running run-tests step. 18:41:06 INFO - Running pre-action listener: _resource_record_pre_action 18:41:06 INFO - Running pre-action listener: _set_gcov_prefix 18:41:06 INFO - Running main action method: run_tests 18:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:41:06 INFO - Python 2.7.3 18:41:06 INFO - Return code: 0 18:41:06 INFO - grabbing minidump binary from tooltool 18:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:06 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 0xd70eb0>, '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 0xd71db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd72240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:41:06 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 18:41:06 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 18:41:06 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 18:41:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:41:06 INFO - Return code: 0 18:41:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:41:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:41:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:41:06 INFO - ENV: RUST_BACKTRACE is now 1 18:41:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:41:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 18:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --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 18:41:06 INFO - Using env: {'DISPLAY': ':0', 18:41:06 INFO - 'HOME': '/home/cltbld', 18:41:06 INFO - 'LANG': 'en_US.UTF-8', 18:41:06 INFO - 'LANGUAGE': 'en_US:en', 18:41:06 INFO - 'LOGNAME': 'cltbld', 18:41:06 INFO - 'MAIL': '/var/mail/cltbld', 18:41:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:41:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:06 INFO - 'MOZ_NO_REMOTE': '1', 18:41:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:06 INFO - 'NO_EM_RESTART': '1', 18:41:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:06 INFO - 'PWD': '/builds/slave/test', 18:41:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:41:06 INFO - 'RUST_BACKTRACE': '1', 18:41:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:41:06 INFO - 'SHELL': '/bin/bash', 18:41:06 INFO - 'SHLVL': '1', 18:41:06 INFO - 'TERM': 'linux', 18:41:06 INFO - 'TMOUT': '86400', 18:41:06 INFO - 'USER': 'cltbld', 18:41:06 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983', 18:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:06 INFO - '_': '/tools/buildbot/bin/python'} 18:41:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 18:41:06 INFO - mozversion application_buildid: 20170725005803 18:41:06 INFO - mozversion application_changeset: f6528783c52507e29d5be409cc8fbf9a394a5ac8 18:41:06 INFO - mozversion application_display_name: Nightly 18:41:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:41:06 INFO - mozversion application_name: Firefox 18:41:06 INFO - mozversion application_remotingname: firefox 18:41:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:41:06 INFO - mozversion application_vendor: Mozilla 18:41:06 INFO - mozversion application_version: 56.0a1 18:41:06 INFO - mozversion platform_buildid: 20170725005803 18:41:06 INFO - mozversion platform_changeset: f6528783c52507e29d5be409cc8fbf9a394a5ac8 18:41:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:41:06 INFO - mozversion platform_version: 56.0a1 18:41:06 INFO - using testdate: 1500946866 18:41:06 INFO - actual date: 1500946866 18:41:06 INFO - starting webserver on 'localhost:33289' 18:41:06 INFO - SUITE-START | Running 2 tests 18:41:06 INFO - TEST-START | dromaeo_css 18:41:06 INFO - Initialising browser for dromaeo_css test... 18:41:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33289/getInfo.html -profile /tmp/tmpeNi2EZ/profile 18:41:06 INFO - TEST-INFO | started process 11258 (/builds/slave/test/build/application/firefox/firefox http://localhost:33289/getInfo.html) 18:41:13 INFO - TEST-INFO | 11258: exit 0 18:41:13 INFO - Browser initialized. 18:41:13 INFO - Running cycle 1/1 for dromaeo_css test... 18:41:13 INFO - TEST-INFO | started process 11466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeNi2EZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:41:24 INFO - PID 11466 | RSS: Main: 173387776 18:41:24 INFO - PID 11466 | 18:44:24 INFO - PID 11466 | Cycle 1(1): loaded http://localhost:33289/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33289/tests/dromaeo/cssquery-ext.html) 18:44:25 INFO - PID 11466 | RSS: Main: 178139136 18:44:25 INFO - PID 11466 | 18:47:27 INFO - PID 11466 | Cycle 1(1): loaded http://localhost:33289/tests/dromaeo/cssquery-ext.html (next: http://localhost:33289/tests/dromaeo/cssquery-jquery.html) 18:47:27 INFO - PID 11466 | RSS: Main: 176635904 18:47:27 INFO - PID 11466 | 18:50:29 INFO - PID 11466 | Cycle 1(1): loaded http://localhost:33289/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33289/tests/dromaeo/cssquery-mootools.html) 18:50:30 INFO - PID 11466 | RSS: Main: 178106368 18:50:30 INFO - PID 11466 | 18:53:32 INFO - PID 11466 | Cycle 1(1): loaded http://localhost:33289/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33289/tests/dromaeo/cssquery-prototype.html) 18:53:32 INFO - PID 11466 | RSS: Main: 176807936 18:53:32 INFO - PID 11466 | 18:56:36 INFO - PID 11466 | Cycle 1(1): loaded http://localhost:33289/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33289/tests/dromaeo/cssquery-yui.html) 18:56:37 INFO - PID 11466 | RSS: Main: 178221056 18:56:37 INFO - PID 11466 | 18:59:39 INFO - PID 11466 | Cycle 1(1): loaded http://localhost:33289/tests/dromaeo/cssquery-yui.html (next: http://localhost:33289/tests/dromaeo/cssquery-dojo.html) 18:59:39 INFO - PID 11466 | RSS: Main: 180834304 18:59:39 INFO - PID 11466 | 18:59:39 INFO - PID 11466 | __start_tp_report 18:59:39 INFO - PID 11466 | _x_x_mozilla_page_load 18:59:39 INFO - PID 11466 | _x_x_mozilla_page_load_details 18:59:39 INFO - PID 11466 | |i|pagename|runs| 18:59:39 INFO - PID 11466 | |0;dojo.html;3094.226443389153;3160.0203936779585;3175.2538153533915;3192.4732419150832;3204.391165678521;6008.609440386372;6241.937580624192;6255.624662520252;6256.03031530113;6295.244570651516;5947.940520594792;6087.330393656705;6091.086337049444;6127.417895299951;6135.202423684915;5590.18942253374;5623.100303951348;5658.405867383927;5674.460926212024;5748.798792042279;5714.000049991256;5731.828045158652;5757.68332741699;5778.075507918734;5784.363719990798;5479.958807826501;5531.115021596565;5665.178549110397;5750.022496175639;5790.449907258803;5603.691796951166;5646.802361917313;5656.858578535528;5672.602917795756;5700.3159620845345;5571.6378435401975;5626.2967129108865;5659.801906933238;5682.829515114553;5684;5974.880502389928;6080.665563394012;6090.878182436327;6123.387661233885;6165.660888651122;6459.5478316517865;6480.15757951468;6498.122753428322;6504.674766261715;6507.479401647857;6553.967230163867;6556.311587283314;6558.409743123142;6563.737450502022;6569.93430065698;6073.058675905242;6081.2094427725;6083.543734219907;6103.816885493442;6109.266887973427;6647.767328143492;6693.564918280394;6808.148981377328;6879.862402751917;6881.587104773729;6543.280239173687;6592.077109204715;6624.072629831828;6625.668716564152;6641.169853768279;6675.9332406676285;6677.131972843499;6726.730930762715;6756.763513277012;6795.38841504267;6467.708953097122;6549.181352330958;6642.701078451481;6730.46156307504;6733.158355205599;6610.768623098168;6636.270010298863;6640.833979150463;6642.833929151713;6661.26726060133;5328.254044433782;5363.168708850135;5387.326584176978;5405.918911216335;5413.891722165535;4497.2129877271345;4556.476005259437;4572.314152877028;4581.312803079498;4677.298405239241;5769.278840144982;5799.159121927381;5817.38917413674;5823.359430462646;5835.591508594358;6450.3549645036055;6663.06717059612;6668.933310666928;6741.056252124707;6750.932490675129;5605.467480589337;5695.060315048054;5700.914486282709;5782.190493330937;5795.565332600072;5815.360310365856;5884.499817515473;5885.61743486672;5901.262342207224;5908.970455147783;6524.054012168209;6526.967365163144;6534.150560427209;6554.410103090745;6586.407223350017;6641.369069938348;6703.631300278532;6798.626075565891;6815.795526134224;6818.590884546745;6413.358664133736;6469.320721324381;6469.8706025880165;6554.4756419485375;6555.147830781968;6417.1657684500715;6515.120458738199;6521.673916304071;6532.5753826001155;6576.309487503934;6709.664516774044;6730.528862979544;6740.494462915203;6746.628935408599;6829.385355318045;6416.935830641633;6498.642574658439;6504.739810407531;6516.934830651633;6522.739090436519;6487.351264873475;6528;6588.505862060269;6598.27418983921;6613.966930165318;6197.349278325711;6297.96851015742;6305.90541141874;6409.615423074631;6441.355864413521;6430.067640192239;6513.055606937062;6566.606003639797;6639.734410623521;6656.201255849329;6267.341929097379;6326.114343991753;6367.235931688227;6367.649779261999;6373.74505019794 18:59:39 INFO - PID 11466 | |1;ext.html;831.1522247307746;864.0927026622047;886.5434301334809;889.8531742262527;1165.8367828504017;31156;39814.40278395826;43496.347554786706;43603.12793744123;43668.344974825406;43098.56901430985;43518.78240608793;43547.78226108873;43587.564124358825;43780.12439751203;7296.781096567085;7450.4039676826;7660.540367577949;7789.065312162548;7801.453898227126;7683.654235559413;7722.922770772277;7755.224477552256;7755.302022817945;7827.295543401093;7810.570418626973;7827.373810095207;7839.568823714693;7851.5681637509915;7854.960725196366;7757.185495522974;7770.145284018753;7793.1817159198035;7800;7833.843323133534;7565.394768418513;7595.810104747426;7599.316061554487;7600.771976840703;7614.428917831129;39512.40731389031;39584.20831583352;39584.604153958666;39675.80162099171;39767.40348894769;3409.403354412968;3411.5906091268957;3436.879709210166;3441.0365097772665;3450.964710586839;31850.362992740014;31945.201369965704;31983.680163198303;32037.83981080103;32214.838925805456;4757.1437141314545;4765.594924431428;4767.070421267854;4780.760961951889;4839.612830973514;196456;198298;198622;198677;198712;49614.25578616324;49838;49874.25188622173;49994;50001.24998125031;52189.21716174261;52589.737051315264;52594.211086833726;52610;52619.210711839354;15688.450904218298;15985.680286394207;16004.679906401807;16006.759898601531;16007.759883601755;11112.44437778108;11401.087912966943;12934.482620695255;12955.805662915063;12959.611211663665;14686;14822.925885370503;14934.253287335807;15039.849601503845;15067.849321506865;5819.854503637358;5848.298204215436;5904.911426328608;6011.338752737195;6036.215292012011;955.694177863091;970.4322971062007;988.3180605382407;1018.6129270877019;1020.698893826323;22172.77827221707;22329.55340893173;22494.100235990376;22625.4343641407;22652.433689157573;1050.5581089954112;1067.4929408530886;1096.2107282756563;1098;1110.8611423572054;11923.403829808474;11931.463084161234;12085.45615447307;12196.939015305044;12317.815232771516;226013;226108;227525;227615;227869;54455.455445445834;54783.726081369336;55166.17250741242;55190.44809551853;55299.44700552943;1405.3886559346718;1453.6729235921832;1457.0747575289768;1468.860458256464;1471.6468047668482;21292.787072129082;21987.23044693428;22071.558568828856;22088.779112209315;22117.115315387204;38486.6151338483;38545.6145438542;38548.614513855624;38632;38660.6133938657;189080;190239;190713;190772;191484.0425797862;34850.82574587111;35026.299474010884;35045.12387190239;35065.64934350624;36414;45767.313490297005;47693.28460073032;47776;48111.278330825764;48373.51626483831;30970.84514577413;33929.321413572085;34028.82985585056;34129.48805767965;34411.13972150716;31329.8433507831;32420.351592967538;33733.83133084319;33748.662513374555;34358.48462273018;35998.640013600576;37143.814280928425;37198.62801371951;37469;37479.063023424635;30474.390512189188;32311.35377292488;33109.006729798144;33338.66661333355;33453.498197527544;24139.396515087265;24153.75846241515;24430.755692442846;24439.633405499288;24479.755202447748 18:59:39 INFO - PID 11466 | |2;jquery.html;577.3620149734543;581.1979468333699;584.4856526256893;587.3715124816447;609.6768712582331;22124.446888827766;22860.65709014364;22934.426639334026;22950.88524557379;22959.54080918383;22722.88638556805;23493.295201143992;24854.37864053395;24883.875580622072;25686.614700779457;6598.571092878971;6750.257471678112;6766.966165169168;6778.661066946633;6790.728370865159;5824.24284842972;6374.203224596926;6607.405333519982;6678.332166783307;6685.732570697166;6335.714892829834;6340.841478963017;6345.809625711213;6346.174997250351;6352.078948552457;6282.87434251317;6298.842528936768;6319.399657032574;6324.873502529947;6339.334369891164;5911.586188966774;5921.052631578927;5928.081147422156;5930.1994230779155;5936.762529498815;29153.854230728924;29813.55279670785;29836.701632983608;30985;32163.19592010195;1959.7452331196853;2014.9697754533693;2017.757869055708;2018.6467368210504;2019.5960807838492;20823.16707331705;21179.78820211809;21180.364589062352;21204.36386908395;21256.46858828526;2450.791682706972;2502.724700282967;2561.705403878559;2569.11365578875;2597.922062338133;141733;142519;144716.27641861828;145989;147073;20039.899800501196;21306.78693213079;22213.333599991704;22596.322110336718;23382.298531043754;45003.099938001054;45346.77326613346;45634.771826140655;45685.543144568794;45752.08495830065;10107;10230.130438912776;10239.539220735085;10359.513716708087;10394;8076.8384632307025;8224.342052635775;8249.175082491824;8290.170982901662;8374.916250837536;9022.593983270768;9726.465044422624;9777.608895644236;11206.271592346471;12318;2749.134022782817;2763.8479883606597;2764.7652246871207;2872.3250036241466;2894.594756734059;958.2289014836222;962.1773383756927;963.9035098660386;1000.4547521600745;1002.2382988928321;19312.71030934537;19770.20919163246;19839.38592852817;19969.301074462324;20340.49148771263;1015.8222311095528;1034.6068493972393;1064.4730858225228;1065.227709910309;1069.1713921710736;10955;11199.272047316897;11295.661130166109;11404.201705880509;11446.255993360404;489377;490402;535825;543062;548744;116028;122134.38932805278;125133;125565.37217313854;126147.36926315493;1234.3766397969148;1249.8000319948765;1287.1826390242263;1288.8037666586918;1293.4502836294348;19521.316753913547;20565.280215192397;20824;20935.58128837445;21425;58989.70505147447;59044.40955590389;59113;60946.695266523384;62413;80063.59968200355;80766;80793;80962.59518702605;82066.58966705129;12721.363931803558;13814.171149731048;14692.706145877237;15080.472183473526;15098.471553495576;23945;23992.520149596563;24045.398865028514;24088.51822963496;24407.38981525476;18417.171227294537;18558.721619175994;18595.44213673538;18598.721019184995;18725.719114213025;16207.675846482769;17359.652806944043;17406.12969351502;17647.823521764618;17911;18613;19364.903175484033;19800;19935.900320498306;20067.498312542302;14400.927995359956;15155.318010689325;15269.312880920608;15289.159096249814;15316.463923762614;16526.752098718287;16762.916185418995;16786.32854685799;16812.57968550796;18311.450656480327 18:59:39 INFO - PID 11466 | |3;mootools.html;1316.7629826631205;1354.077210361287;1357.3077730357516;1366.275873786893;1369.4043091255305;13537.999999999987;14159.929200353996;14215.289235538208;14233.857661423383;14260.358283877224;13794;14812.555623331291;14828.036177648446;14829.629259268524;14838.035527690692;2567.8330908490934;2631.1843328568207;2639.986800065997;2640.102365195833;2640.801939854509;2519.4583164619603;2528.797696184301;2605.257501612041;2678.504476671822;2680.0351873325585;2669.599560065986;2685.261553072901;2710.864456777163;2715.7420045095782;2717.8233414827973;2588.8446693198375;2598.9610155847677;2606.504764094816;2647.7484638959268;2665.2404064841426;2528.5575024370846;2593.1961092061333;2593.8314009589503;2594.727553606882;2595.3641357867255;13785.862141378559;14124.081934674316;14126.293685315693;14140.939429542825;14148.717025659429;7280.708771649128;7489;7569.7350592729545;7576.242375762435;7580.924190758132;4670.556297151765;4937.432195297515;5031.06925218832;5053.46938571452;5059.215821547666;1846;1875.1093230715437;1902.1345287893976;1927.6048410076041;1961.4507937777446;22717.886410568008;22916.77083229163;22932.426689332733;22943.885280573657;22951.196708115134;6882;7044.54466642639;7158.570485770871;7255.129384473897;7261.857751963184;15798.447054353042;15839.762403563956;15848.603784905239;15856.841431585768;15858.207089645472;7307.707691692379;7405.259474052552;7458.328750412489;7463.888041679379;7478.3643390311345;6675.933240667531;6774.187097548326;6793.184817821893;6930.341617546325;6939.479539034593;4793.976030119897;4919.975400122977;4964.875878103004;4983.576396006308;4987.351644286292;1245.103525461666;1276.5787290194214;1277.2208952538945;1383.833939927195;1413.5264686329988;809.3282575462352;827.2430725885747;842.8819965204876;847.9654821118226;859.1108203009854;7832.960835195788;8087.433879628369;8178.7955301117945;8180.427370084037;8228.876566851503;938.8967213606497;965.0831709875646;975.3465178330536;983.1593987141034;1002.4486532407146;4750.358701575312;5001.9499805002215;5109.029284435946;5137.460566640524;5212.40057393397;18348.63302733938;18493.352732654294;19171.424857254304;19184;19199;19453.902730486257;19845.420095387795;19950.30173943905;19988.50028749264;20024.199032038847;10117.797644047225;10413.42726150069;10627.14982801374;10721.571137154582;10722.678319650424;7626;7697.461177717506;8165.183481651788;8279;8417.789555260922;16018.318076601789;16654.916725416297;16837.989720616803;17009.74485382745;17526.82473175252;17016.744748829024;17543.649127017645;17782.466526004242;17831.375901843374;17839;11023.173262005543;11302.491387887729;11711.824322634997;11715.941420292844;11731.472083756422;12749.87250127487;12951.417186226454;12954.157979731288;12956.740865182455;12973.221606703628;9197.632094716137;10448.216383771096;10997.505112270128;11281.379524126252;11375.943120284346;10222;10448;10456.58173673075;10606.681799546026;10843.078338341329;9259.76850578741;9534.475603841855;9578.808423831346;9588.568514417007;9596.376235544667;6855;7164.641767911688;7319.158296795724;7410.962945185455;7414.295641914009;6809.216940051958;6961.6519174042105;7218.494705370784;7281.162666293232;7320.853582928418 18:59:39 INFO - PID 11466 | |4;prototype.html;480.24121887417886;495.2472242191867;512.8717820544864;515.760171520243;518.6369541321076;6173.290071641763;6201.844953876155;6256.687165641717;6267.2165979252595;6310.905336419957;5853.268341457318;6061.484773794222;6118.418750218733;6137.6931153442265;6215.254169499655;4869.440014398337;4951.455339912607;4983.127952608297;4986.10250154972;5007.549320561149;4893.510648935096;4908.141075311806;4935.35840340757;5023.773930173133;5045.949540504603;4787.976060119695;4860.9756951215195;4928.679635823678;4944.752762361867;4947.1589829728855;4817;4819.277108433728;4895.265710143472;4907.938665760389;4971.204607262856;4456.799444024994;4458.063806600618;4468.3074123510905;4471.597556219924;4474.7091439056685;5991.6405015698765;6012.188354572164;6047.818565443044;6061;6069.393060693939;5713.0863259737835;5718.656880587137;5718.971405142947;5735.340435849889;5758.337791154029;6394.456471199954;6445.581037232565;6458.61248325102;6506.642134682591;6618.966905165492;4814.518548145193;4834.444038935532;4873.390826146731;4886.315915771795;4895.681780684244;6775;6957.61733104679;6970.8871765658505;6973.65131743421;6979.127609048869;4916.631252656065;4925.581325587365;4946.975265123651;4969.875753106201;4988.201887698024;5041.210370318558;5076.644634875597;5077.822276220315;5096.694198348111;5105.2342148678;5674.460926212003;5677.318721753416;5694.4590263924865;5695.772169113272;5729;6463.418292353711;6508.251551071593;6518.543701940818;6589.507560992682;6610.405063544208;1638.172722774991;1664.6587449572808;1730.368415528323;1750.1511766793096;1775.4673597920573;1152.792497350485;1195.3664557784389;1197.6167626359481;1200.321818172747;1215.6292330839003;5578.470045345685;5644.6613203207935;5659.518940889988;5710.771569137271;5743.798967036134;6441.838954026093;6536.934630653633;6563.556017676104;6662.56693314933;6688.699008544627;5654.886902261932;5697.666864884007;5766.4233576642;5766.567507436959;5772.624779389326;3515.5254040704176;3529.8941031769086;3547.8758243461357;3589.820508974593;3628.546431696038;6480.51396145291;6513.8829880289095;6520.804375868732;6564.212294524687;6585.637789921505;6772.72909083641;6795.762148324785;6826.351496607815;6939.722411103499;6952.914125762251;6475.7733479328;6513.12072870166;6526.41262286387;6532.150820393318;6532.379423954621;6594.043573855648;6667.633280169637;6740.8651826962205;6780.1524809398825;6794;6660.600363978177;6672.666366681744;6691.59850408977;6745.460363170836;6761.425278851353;6460.219437616224;6490.935090649033;6500.349965003651;6536.901946470712;6550.868982620225;4927.802887884444;4945.4312754033745;4952.826651067196;4959.454460009324;4987.551120399182;6687.665616719242;6720.798376048726;6734.393904548614;6746.595204287759;6782.593044417351;6442.613443193423;6486.643234622141;6498.577592456475;6534.660394619187;6582.308857569887;6447.451966582893;6487.156669632917;6520.347965203442;6588.703508342041;6616.735330586723;6205.393734631375;6264.968675156777;6335.936640633535;6382.585131966407;6442.645654489048;6544.018397240452;6547.181602299713;6550.148480697479;6565.212174538895;6624.635645039569;6353.936460635519;6356.745730170742;6366.649834258975;6382.744690212339;6387.297397286202 18:59:39 INFO - PID 11466 | |5;yui.html;821.2903735291795;836.9832603347937;859.9957000215002;907.1155623267315;925.0749250749253;17972.73040904386;19144.13851376688;19150.329738459157;19164.904175479103;19171.61656766864;19579.314723984662;21730.782692173074;21821.563568728616;21890.89054554729;21934.45163870904;1054.4727636181908;1080.4219742437758;1080.8378743188507;1081.416035340915;1082.1342925659442;1021.2697920986493;1054.4674939155716;1063.0273299930593;1072.3565860483725;1073.3398959639844;1114.0363585498526;1116.0680831505701;1119.0991252042143;1119.6696974392573;1119.8600174978128;1097.314178638351;1098.6209757633603;1103.7130346109989;1105.6682995101437;1108.2020944919645;809.2595275323073;810.0401024785589;810.5379933437943;811.663159788687;811.7524155132683;18889.62220755591;19531.90234048835;19848.106835192306;20314.593708125904;20353.694694579593;20556.794432055787;20675.896620516953;21106.15575376983;21116;21149.365519034454;15684.137372444511;15855.920720396323;16075.758863617055;16087.11520866352;16412.343506259735;3435.7594968352223;3462.6883580477624;3466;3466.272082862602;3467.7572569920117;116895.41552292184;120938.39530802377;123409.38295308556;123510;124345.37827310806;15400.22998850053;15489.302981365865;15745.842541574666;15752.291146898417;15759.842401575837;30018.24954376158;30764.846175769424;30954.380912381625;31081.222969425944;31113.688863111533;8203.671853125808;8596.8710469343;8633.05036446003;8650.09174036717;8671.653133874574;4258.723182993095;4329.636164608139;4330.17726631939;4352.5865042821515;4388.232059389594;4344.543822898613;5208.218767184952;5838.7080645967535;5843.2403787507355;5880.852978675567;1042.4266653340633;1069.5133714160038;1075.0324707763075;1079.9568017279378;1085.6417382263835;646.4085361893908;662.3178126529682;672.2470832667444;683.5684861992769;684.0662495693343;11114.222004459773;11786.764264714659;12050;12404.81392779109;12739.61781146567;653.3662347522895;674.2425716565207;690.2166041542885;709.8970649255932;713.0445203427432;5429.864253393696;5475.917861232085;5539.473749993744;5787;5827.854303642358;98249.65075191148;101337;102369.48815256025;105290.47354763177;105508;86544.56727716321;89367;89879.55060224657;90417;94047;72421.91367129392;75056.62471687715;75584;77310;80171.19828801637;10590.470476475992;11061.446927653424;11273.379964102052;11491.08071354273;11626.70933226676;36806.815965919996;38197;39210.60789392069;39397;39530;44735.77632111819;47867.042659147315;48085;48409.515904840504;49453;16240.837591623933;18088.819111808712;19129.90435047816;19274.421767347;19318.32385866488;20712;21261.36215913525;21377.786222138202;21416;21645.13419463267;17546.82453175452;17767.378141764977;18560.350387736366;18862.622747544698;19065.523361915508;18669.626607468046;19221.32725354606;19470.707939381206;19797;20007.499812504222;18198.363057292932;18992.14535345885;19160.616787664447;19208;19361.32235371755;13218.537351192663;13250.403731832284;13642.976776741585;13929.30353482342;14196.645083872985;13962.720745585235;14609.196494192922;14674.266286685837;14678;14749.041312314665 18:59:39 INFO - PID 11466 | __end_tp_report 18:59:39 INFO - PID 11466 | __start_cc_report 18:59:39 INFO - PID 11466 | _x_x_mozilla_cycle_collect,379 18:59:39 INFO - PID 11466 | __end_cc_report 18:59:39 INFO - PID 11466 | __startTimestamp1500947979260__endTimestamp 18:59:39 INFO - PID 11466 | 18:59:39 INFO - PID 11466 | ------- Summary: start ------- 18:59:39 INFO - PID 11466 | Number of tests: 6 18:59:39 INFO - PID 11466 | 18:59:39 INFO - PID 11466 | [#0] dojo.html Cycles:165 Average:6114.41 Median:6373.75 stddev:724.27 (11.4%) stddev-sans-first:686.64 18:59:39 INFO - PID 11466 | Values: 3094.2 3160.0 3175.3 3192.5 3204.4 6008.6 6241.9 6255.6 6256.0 6295.2 5947.9 6087.3 6091.1 6127.4 6135.2 5590.2 5623.1 5658.4 5674.5 5748.8 5714.0 5731.8 5757.7 5778.1 5784.4 5480.0 5531.1 5665.2 5750.0 5790.4 5603.7 5646.8 5656.9 5672.6 5700.3 5571.6 5626.3 5659.8 5682.8 5684.0 5974.9 6080.7 6090.9 6123.4 6165.7 6459.5 6480.2 6498.1 6504.7 6507.5 6554.0 6556.3 6558.4 6563.7 6569.9 6073.1 6081.2 6083.5 6103.8 6109.3 6647.8 6693.6 6808.1 6879.9 6881.6 6543.3 6592.1 6624.1 6625.7 6641.2 6675.9 6677.1 6726.7 6756.8 6795.4 6467.7 6549.2 6642.7 6730.5 6733.2 6610.8 6636.3 6640.8 6642.8 6661.3 5328.3 5363.2 5387.3 5405.9 5413.9 4497.2 4556.5 4572.3 4581.3 4677.3 5769.3 5799.2 5817.4 5823.4 5835.6 6450.4 6663.1 6668.9 6741.1 6750.9 5605.5 5695.1 5700.9 5782.2 5795.6 5815.4 5884.5 5885.6 5901.3 5909.0 6524.1 6527.0 6534.2 6554.4 6586.4 6641.4 6703.6 6798.6 6815.8 6818.6 6413.4 6469.3 6469.9 6554.5 6555.1 6417.2 6515.1 6521.7 6532.6 6576.3 6709.7 6730.5 6740.5 6746.6 6829.4 6416.9 6498.6 6504.7 6516.9 6522.7 6487.4 6528.0 6588.5 6598.3 6614.0 6197.3 6298.0 6305.9 6409.6 6441.4 6430.1 6513.1 6566.6 6639.7 6656.2 6267.3 6326.1 6367.2 6367.6 6373.7 18:59:39 INFO - PID 11466 | 18:59:39 INFO - PID 11466 | [#1] ext.html Cycles:180 Average:37976.72 Median:35035.71 stddev:53361.75 (152.3%) stddev-sans-first:53438.55 18:59:39 INFO - PID 11466 | Values: 831.2 864.1 886.5 889.9 1165.8 31156.0 39814.4 43496.3 43603.1 43668.3 43098.6 43518.8 43547.8 43587.6 43780.1 7296.8 7450.4 7660.5 7789.1 7801.5 7683.7 7722.9 7755.2 7755.3 7827.3 7810.6 7827.4 7839.6 7851.6 7855.0 7757.2 7770.1 7793.2 7800.0 7833.8 7565.4 7595.8 7599.3 7600.8 7614.4 39512.4 39584.2 39584.6 39675.8 39767.4 3409.4 3411.6 3436.9 3441.0 3451.0 31850.4 31945.2 31983.7 32037.8 32214.8 4757.1 4765.6 4767.1 4780.8 4839.6 196456.0 198298.0 198622.0 198677.0 198712.0 49614.3 49838.0 49874.3 49994.0 50001.2 52189.2 52589.7 52594.2 52610.0 52619.2 15688.5 15985.7 16004.7 16006.8 16007.8 11112.4 11401.1 12934.5 12955.8 12959.6 14686.0 14822.9 14934.3 15039.8 15067.8 5819.9 5848.3 5904.9 6011.3 6036.2 955.7 970.4 988.3 1018.6 1020.7 22172.8 22329.6 22494.1 22625.4 22652.4 1050.6 1067.5 1096.2 1098.0 1110.9 11923.4 11931.5 12085.5 12196.9 12317.8 226013.0 226108.0 227525.0 227615.0 227869.0 54455.5 54783.7 55166.2 55190.4 55299.4 1405.4 1453.7 1457.1 1468.9 1471.6 21292.8 21987.2 22071.6 22088.8 22117.1 38486.6 38545.6 38548.6 38632.0 38660.6 189080.0 190239.0 190713.0 190772.0 191484.0 34850.8 35026.3 35045.1 35065.6 36414.0 45767.3 47693.3 47776.0 48111.3 48373.5 30970.8 33929.3 34028.8 34129.5 34411.1 31329.8 32420.4 33733.8 33748.7 34358.5 35998.6 37143.8 37198.6 37469.0 37479.1 30474.4 32311.4 33109.0 33338.7 33453.5 24139.4 24153.8 24430.8 24439.6 24479.8 18:59:39 INFO - PID 11466 | 18:59:39 INFO - PID 11466 | [#2] jquery.html Cycles:180 Average:37376.21 Median:22897.54 stddev:88013.32 (384.4%) stddev-sans-first:88216.85 18:59:39 INFO - PID 11466 | Values: 577.4 581.2 584.5 587.4 609.7 22124.4 22860.7 22934.4 22950.9 22959.5 22722.9 23493.3 24854.4 24883.9 25686.6 6598.6 6750.3 6767.0 6778.7 6790.7 5824.2 6374.2 6607.4 6678.3 6685.7 6335.7 6340.8 6345.8 6346.2 6352.1 6282.9 6298.8 6319.4 6324.9 6339.3 5911.6 5921.1 5928.1 5930.2 5936.8 29153.9 29813.6 29836.7 30985.0 32163.2 1959.7 2015.0 2017.8 2018.6 2019.6 20823.2 21179.8 21180.4 21204.4 21256.5 2450.8 2502.7 2561.7 2569.1 2597.9 141733.0 142519.0 144716.3 145989.0 147073.0 20039.9 21306.8 22213.3 22596.3 23382.3 45003.1 45346.8 45634.8 45685.5 45752.1 10107.0 10230.1 10239.5 10359.5 10394.0 8076.8 8224.3 8249.2 8290.2 8374.9 9022.6 9726.5 9777.6 11206.3 12318.0 2749.1 2763.8 2764.8 2872.3 2894.6 958.2 962.2 963.9 1000.5 1002.2 19312.7 19770.2 19839.4 19969.3 20340.5 1015.8 1034.6 1064.5 1065.2 1069.2 10955.0 11199.3 11295.7 11404.2 11446.3 489377.0 490402.0 535825.0 543062.0 548744.0 116028.0 122134.4 125133.0 125565.4 126147.4 1234.4 1249.8 1287.2 1288.8 1293.5 19521.3 20565.3 20824.0 20935.6 21425.0 58989.7 59044.4 59113.0 60946.7 62413.0 80063.6 80766.0 80793.0 80962.6 82066.6 12721.4 13814.2 14692.7 15080.5 15098.5 23945.0 23992.5 24045.4 24088.5 24407.4 18417.2 18558.7 18595.4 18598.7 18725.7 16207.7 17359.7 17406.1 17647.8 17911.0 18613.0 19364.9 19800.0 19935.9 20067.5 14400.9 15155.3 15269.3 15289.2 15316.5 16526.8 16762.9 16786.3 16812.6 18311.5 18:59:39 INFO - PID 11466 | 18:59:39 INFO - PID 11466 | [#3] mootools.html Cycles:180 Average:8723.79 Median:2593.51 stddev:5964.88 (230.0%) stddev-sans-first:5955.65 18:59:39 INFO - PID 11466 | Values: 1316.8 1354.1 1357.3 1366.3 1369.4 13538.0 14159.9 14215.3 14233.9 14260.4 13794.0 14812.6 14828.0 14829.6 14838.0 2567.8 2631.2 2640.0 2640.1 2640.8 2519.5 2528.8 2605.3 2678.5 2680.0 2669.6 2685.3 2710.9 2715.7 2717.8 2588.8 2599.0 2606.5 2647.7 2665.2 2528.6 2593.2 2593.8 2594.7 2595.4 13785.9 14124.1 14126.3 14140.9 14148.7 7280.7 7489.0 7569.7 7576.2 7580.9 4670.6 4937.4 5031.1 5053.5 5059.2 1846.0 1875.1 1902.1 1927.6 1961.5 22717.9 22916.8 22932.4 22943.9 22951.2 6882.0 7044.5 7158.6 7255.1 7261.9 15798.4 15839.8 15848.6 15856.8 15858.2 7307.7 7405.3 7458.3 7463.9 7478.4 6675.9 6774.2 6793.2 6930.3 6939.5 4794.0 4920.0 4964.9 4983.6 4987.4 1245.1 1276.6 1277.2 1383.8 1413.5 809.3 827.2 842.9 848.0 859.1 7833.0 8087.4 8178.8 8180.4 8228.9 938.9 965.1 975.3 983.2 1002.4 4750.4 5001.9 5109.0 5137.5 5212.4 18348.6 18493.4 19171.4 19184.0 19199.0 19453.9 19845.4 19950.3 19988.5 20024.2 10117.8 10413.4 10627.1 10721.6 10722.7 7626.0 7697.5 8165.2 8279.0 8417.8 16018.3 16654.9 16838.0 17009.7 17526.8 17016.7 17543.6 17782.5 17831.4 17839.0 11023.2 11302.5 11711.8 11715.9 11731.5 12749.9 12951.4 12954.2 12956.7 12973.2 9197.6 10448.2 10997.5 11281.4 11375.9 10222.0 10448.0 10456.6 10606.7 10843.1 9259.8 9534.5 9578.8 9588.6 9596.4 6855.0 7164.6 7319.2 7411.0 7414.3 6809.2 6961.7 7218.5 7281.2 7320.9 18:59:39 INFO - PID 11466 | 18:59:39 INFO - PID 11466 | [#4] prototype.html Cycles:180 Average:5487.84 Median:6065.44 stddev:1549.66 (25.5%) stddev-sans-first:1507.74 18:59:39 INFO - PID 11466 | Values: 480.2 495.2 512.9 515.8 518.6 6173.3 6201.8 6256.7 6267.2 6310.9 5853.3 6061.5 6118.4 6137.7 6215.3 4869.4 4951.5 4983.1 4986.1 5007.5 4893.5 4908.1 4935.4 5023.8 5045.9 4788.0 4861.0 4928.7 4944.8 4947.2 4817.0 4819.3 4895.3 4907.9 4971.2 4456.8 4458.1 4468.3 4471.6 4474.7 5991.6 6012.2 6047.8 6061.0 6069.4 5713.1 5718.7 5719.0 5735.3 5758.3 6394.5 6445.6 6458.6 6506.6 6619.0 4814.5 4834.4 4873.4 4886.3 4895.7 6775.0 6957.6 6970.9 6973.7 6979.1 4916.6 4925.6 4947.0 4969.9 4988.2 5041.2 5076.6 5077.8 5096.7 5105.2 5674.5 5677.3 5694.5 5695.8 5729.0 6463.4 6508.3 6518.5 6589.5 6610.4 1638.2 1664.7 1730.4 1750.2 1775.5 1152.8 1195.4 1197.6 1200.3 1215.6 5578.5 5644.7 5659.5 5710.8 5743.8 6441.8 6536.9 6563.6 6662.6 6688.7 5654.9 5697.7 5766.4 5766.6 5772.6 3515.5 3529.9 3547.9 3589.8 3628.5 6480.5 6513.9 6520.8 6564.2 6585.6 6772.7 6795.8 6826.4 6939.7 6952.9 6475.8 6513.1 6526.4 6532.2 6532.4 6594.0 6667.6 6740.9 6780.2 6794.0 6660.6 6672.7 6691.6 6745.5 6761.4 6460.2 6490.9 6500.3 6536.9 6550.9 4927.8 4945.4 4952.8 4959.5 4987.6 6687.7 6720.8 6734.4 6746.6 6782.6 6442.6 6486.6 6498.6 6534.7 6582.3 6447.5 6487.2 6520.3 6588.7 6616.7 6205.4 6265.0 6335.9 6382.6 6442.6 6544.0 6547.2 6550.1 6565.2 6624.6 6353.9 6356.7 6366.6 6382.7 6387.3 18:59:39 INFO - PID 11466 | 18:59:39 INFO - PID 11466 | [#5] yui.html Cycles:180 Average:22334.70 Median:19822.55 stddev:29381.63 (148.2%) stddev-sans-first:29419.64 18:59:39 INFO - PID 11466 | Values: 821.3 837.0 860.0 907.1 925.1 17972.7 19144.1 19150.3 19164.9 19171.6 19579.3 21730.8 21821.6 21890.9 21934.5 1054.5 1080.4 1080.8 1081.4 1082.1 1021.3 1054.5 1063.0 1072.4 1073.3 1114.0 1116.1 1119.1 1119.7 1119.9 1097.3 1098.6 1103.7 1105.7 1108.2 809.3 810.0 810.5 811.7 811.8 18889.6 19531.9 19848.1 20314.6 20353.7 20556.8 20675.9 21106.2 21116.0 21149.4 15684.1 15855.9 16075.8 16087.1 16412.3 3435.8 3462.7 3466.0 3466.3 3467.8 116895.4 120938.4 123409.4 123510.0 124345.4 15400.2 15489.3 15745.8 15752.3 15759.8 30018.2 30764.8 30954.4 31081.2 31113.7 8203.7 8596.9 8633.1 8650.1 8671.7 4258.7 4329.6 4330.2 4352.6 4388.2 4344.5 5208.2 5838.7 5843.2 5880.9 1042.4 1069.5 1075.0 1080.0 1085.6 646.4 662.3 672.2 683.6 684.1 11114.2 11786.8 12050.0 12404.8 12739.6 653.4 674.2 690.2 709.9 713.0 5429.9 5475.9 5539.5 5787.0 5827.9 98249.7 101337.0 102369.5 105290.5 105508.0 86544.6 89367.0 89879.6 90417.0 94047.0 72421.9 75056.6 75584.0 77310.0 80171.2 10590.5 11061.4 11273.4 11491.1 11626.7 36806.8 38197.0 39210.6 39397.0 39530.0 44735.8 47867.0 48085.0 48409.5 49453.0 16240.8 18088.8 19129.9 19274.4 19318.3 20712.0 21261.4 21377.8 21416.0 21645.1 17546.8 17767.4 18560.4 18862.6 19065.5 18669.6 19221.3 19470.7 19797.0 20007.5 18198.4 18992.1 19160.6 19208.0 19361.3 13218.5 13250.4 13643.0 13929.3 14196.6 13962.7 14609.2 14674.3 14678.0 14749.0 18:59:39 INFO - PID 11466 | -------- Summary: end -------- 18:59:39 INFO - PID 11466 | 18:59:39 INFO - TEST-INFO | 11466: exit 0 18:59:39 INFO - TEST-OK | dromaeo_css | took 1112974ms 18:59:39 INFO - TEST-START | kraken 18:59:39 INFO - Initialising browser for kraken test... 18:59:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33289/getInfo.html -profile /tmp/tmpk1N7xI/profile 18:59:39 INFO - TEST-INFO | started process 11828 (/builds/slave/test/build/application/firefox/firefox http://localhost:33289/getInfo.html) 18:59:45 INFO - TEST-INFO | 11828: exit 0 18:59:45 INFO - Browser initialized. 18:59:45 INFO - Running cycle 1/1 for kraken test... 18:59:45 INFO - TEST-INFO | started process 12035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk1N7xI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:59:57 INFO - PID 12035 | RSS: Main: 173367296 18:59:57 INFO - PID 12035 | 18:59:59 INFO - PID 12035 | Cycle 1(1): loaded http://localhost:33289/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33289/tests/kraken/driver.html?testName=audio-beat-detection) 19:00:00 INFO - PID 12035 | RSS: Main: 177635328 19:00:00 INFO - PID 12035 | 19:00:03 INFO - PID 12035 | Cycle 1(1): loaded http://localhost:33289/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33289/tests/kraken/driver.html?testName=audio-dft) 19:00:03 INFO - PID 12035 | RSS: Main: 177557504 19:00:03 INFO - PID 12035 | 19:00:06 INFO - PID 12035 | Cycle 1(1): loaded http://localhost:33289/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33289/tests/kraken/driver.html?testName=audio-fft) 19:00:07 INFO - PID 12035 | RSS: Main: 172044288 19:00:07 INFO - PID 12035 | 19:00:09 INFO - PID 12035 | Cycle 1(1): loaded http://localhost:33289/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33289/tests/kraken/driver.html?testName=audio-oscillator) 19:00:10 INFO - PID 12035 | RSS: Main: 172855296 19:00:10 INFO - PID 12035 | 19:00:12 INFO - PID 12035 | Cycle 1(1): loaded http://localhost:33289/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33289/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:00:13 INFO - PID 12035 | RSS: Main: 173105152 19:00:13 INFO - PID 12035 | 19:00:16 INFO - PID 12035 | Cycle 1(1): loaded http://localhost:33289/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33289/tests/kraken/driver.html?testName=imaging-darkroom) 19:00:16 INFO - PID 12035 | RSS: Main: 175407104 19:00:16 INFO - PID 12035 | 19:00:20 INFO - PID 12035 | Cycle 1(1): loaded http://localhost:33289/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33289/tests/kraken/driver.html?testName=imaging-desaturate) 19:00:20 INFO - PID 12035 | RSS: Main: 175435776 19:00:20 INFO - PID 12035 | 19:00:23 INFO - PID 12035 | Cycle 1(1): loaded http://localhost:33289/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33289/tests/kraken/driver.html?testName=json-parse-financial) 19:00:24 INFO - PID 12035 | RSS: Main: 176332800 19:00:24 INFO - PID 12035 | 19:00:26 INFO - PID 12035 | Cycle 1(1): loaded http://localhost:33289/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33289/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:00:26 INFO - PID 12035 | RSS: Main: 176103424 19:00:26 INFO - PID 12035 | 19:00:28 INFO - PID 12035 | Cycle 1(1): loaded http://localhost:33289/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33289/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:00:29 INFO - PID 12035 | RSS: Main: 176164864 19:00:29 INFO - PID 12035 | 19:00:31 INFO - PID 12035 | Cycle 1(1): loaded http://localhost:33289/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33289/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:00:31 INFO - PID 12035 | RSS: Main: 175906816 19:00:31 INFO - PID 12035 | 19:00:34 INFO - PID 12035 | Cycle 1(1): loaded http://localhost:33289/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33289/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:00:35 INFO - PID 12035 | RSS: Main: 176549888 19:00:35 INFO - PID 12035 | 19:00:38 INFO - PID 12035 | Cycle 1(1): loaded http://localhost:33289/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33289/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:00:39 INFO - PID 12035 | RSS: Main: 176553984 19:00:39 INFO - PID 12035 | 19:00:40 INFO - PID 12035 | Cycle 1(1): loaded http://localhost:33289/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33289/tests/kraken/driver.html?testName=ai-astar) 19:00:41 INFO - PID 12035 | RSS: Main: 178196480 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | __start_tp_report 19:00:41 INFO - PID 12035 | _x_x_mozilla_page_load 19:00:41 INFO - PID 12035 | _x_x_mozilla_page_load_details 19:00:41 INFO - PID 12035 | |i|pagename|runs| 19:00:41 INFO - PID 12035 | |0;ai-astar;104;110;96;110;114;112;115;113;110;110 19:00:41 INFO - PID 12035 | |1;audio-beat-detection;143;118;152;181;119;152;150;127;179;125 19:00:41 INFO - PID 12035 | |2;audio-dft;164;163;162;163;163;163;166;166;168;164 19:00:41 INFO - PID 12035 | |3;audio-fft;76;76;75;185;79;76;77;86;153;76 19:00:41 INFO - PID 12035 | |4;audio-oscillator;81;80;134;79;80;80;136;82;86;128 19:00:41 INFO - PID 12035 | |5;imaging-gaussian-blur;117;117;113;114;114;114;114;114;114;116 19:00:41 INFO - PID 12035 | |6;imaging-darkroom;152;153;150;151;150;150;150;150;149;151 19:00:41 INFO - PID 12035 | |7;imaging-desaturate;94;94;94;93;100;94;95;94;93;94 19:00:41 INFO - PID 12035 | |8;json-parse-financial;54;53;53;53;53;53;53;54;53;53 19:00:41 INFO - PID 12035 | |9;json-stringify-tinderbox;54;58;54;54;54;55;53;54;54;54 19:00:41 INFO - PID 12035 | |10;stanford-crypto-aes;80;87;85;87;78;77;77;79;77;79 19:00:41 INFO - PID 12035 | |11;stanford-crypto-ccm;136;150;128;132;127;132;128;126;132;177 19:00:41 INFO - PID 12035 | |12;stanford-crypto-pbkdf2;174;206;178;172;178;177;174;177;174;171 19:00:41 INFO - PID 12035 | |13;stanford-crypto-sha256-iterative;71;73;68;70;68;69;67;69;66;66 19:00:41 INFO - PID 12035 | __end_tp_report 19:00:41 INFO - PID 12035 | __start_cc_report 19:00:41 INFO - PID 12035 | _x_x_mozilla_cycle_collect,959 19:00:41 INFO - PID 12035 | __end_cc_report 19:00:41 INFO - PID 12035 | __startTimestamp1500948041060__endTimestamp 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | ------- Summary: start ------- 19:00:41 INFO - PID 12035 | Number of tests: 14 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | [#0] ai-astar Cycles:10 Average:109.40 Median:112.50 stddev:5.60 (5.0%) stddev-sans-first:5.59 19:00:41 INFO - PID 12035 | Values: 104.0 110.0 96.0 110.0 114.0 112.0 115.0 113.0 110.0 110.0 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:151.00 stddev:22.87 (15.1%) stddev-sans-first:24.25 19:00:41 INFO - PID 12035 | Values: 143.0 118.0 152.0 181.0 119.0 152.0 150.0 127.0 179.0 125.0 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:1.87 (1.1%) stddev-sans-first:1.99 19:00:41 INFO - PID 12035 | Values: 164.0 163.0 162.0 163.0 163.0 163.0 166.0 166.0 168.0 164.0 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | [#3] audio-fft Cycles:10 Average:95.90 Median:76.00 stddev:39.39 (51.8%) stddev-sans-first:41.11 19:00:41 INFO - PID 12035 | Values: 76.0 76.0 75.0 185.0 79.0 76.0 77.0 86.0 153.0 76.0 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:80.00 stddev:25.04 (31.3%) stddev-sans-first:25.91 19:00:41 INFO - PID 12035 | Values: 81.0 80.0 134.0 79.0 80.0 80.0 136.0 82.0 86.0 128.0 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.00 stddev:1.42 (1.2%) stddev-sans-first:1.24 19:00:41 INFO - PID 12035 | Values: 117.0 117.0 113.0 114.0 114.0 114.0 114.0 114.0 114.0 116.0 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:150.50 stddev:1.17 (0.8%) stddev-sans-first:1.13 19:00:41 INFO - PID 12035 | Values: 152.0 153.0 150.0 151.0 150.0 150.0 150.0 150.0 149.0 151.0 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:2.01 (2.1%) stddev-sans-first:2.13 19:00:41 INFO - PID 12035 | Values: 94.0 94.0 94.0 93.0 100.0 94.0 95.0 94.0 93.0 94.0 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:0.42 (0.8%) stddev-sans-first:0.33 19:00:41 INFO - PID 12035 | Values: 54.0 53.0 53.0 53.0 53.0 53.0 53.0 54.0 53.0 53.0 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.00 stddev:1.35 (2.5%) stddev-sans-first:1.42 19:00:41 INFO - PID 12035 | Values: 54.0 58.0 54.0 54.0 54.0 55.0 53.0 54.0 54.0 54.0 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:79.50 stddev:4.12 (5.2%) stddev-sans-first:4.36 19:00:41 INFO - PID 12035 | Values: 80.0 87.0 85.0 87.0 78.0 77.0 77.0 79.0 77.0 79.0 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:132.00 stddev:15.73 (11.9%) stddev-sans-first:16.68 19:00:41 INFO - PID 12035 | Values: 136.0 150.0 128.0 132.0 127.0 132.0 128.0 126.0 132.0 177.0 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.10 Median:177.00 stddev:10.10 (5.7%) stddev-sans-first:10.61 19:00:41 INFO - PID 12035 | Values: 174.0 206.0 178.0 172.0 178.0 177.0 174.0 177.0 174.0 171.0 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:2.21 (3.2%) stddev-sans-first:2.19 19:00:41 INFO - PID 12035 | Values: 71.0 73.0 68.0 70.0 68.0 69.0 67.0 69.0 66.0 66.0 19:00:41 INFO - PID 12035 | -------- Summary: end -------- 19:00:41 INFO - PID 12035 | 19:00:41 INFO - PID 12035 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:00:41 INFO - TEST-INFO | 12035: exit 0 19:00:41 INFO - TEST-OK | kraken | took 61867ms 19:00:41 INFO - SUITE-END | took 1174s 19:00:42 INFO - Completed test suite (00:19:35) 19:00:42 INFO - javascript benchmark 19:00:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8516.542356055055, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.226443389153, 3160.0203936779585, 3175.2538153533915, 3192.4732419150832, 3204.391165678521, 6008.609440386372, 6241.937580624192, 6255.624662520252, 6256.03031530113, 6295.244570651516, 5947.940520594792, 6087.330393656705, 6091.086337049444, 6127.417895299951, 6135.202423684915, 5590.18942253374, 5623.100303951348, 5658.405867383927, 5674.460926212024, 5748.798792042279, 5714.000049991256, 5731.828045158652, 5757.68332741699, 5778.075507918734, 5784.363719990798, 5479.958807826501, 5531.115021596565, 5665.178549110397, 5750.022496175639, 5790.449907258803, 5603.691796951166, 5646.802361917313, 5656.858578535528, 5672.602917795756, 5700.3159620845345, 5571.6378435401975, 5626.2967129108865, 5659.801906933238, 5682.829515114553, 5684.0, 5974.880502389928, 6080.665563394012, 6090.878182436327, 6123.387661233885, 6165.660888651122, 6459.5478316517865, 6480.15757951468, 6498.122753428322, 6504.674766261715, 6507.479401647857, 6553.967230163867, 6556.311587283314, 6558.409743123142, 6563.737450502022, 6569.93430065698, 6073.058675905242, 6081.2094427725, 6083.543734219907, 6103.816885493442, 6109.266887973427, 6647.767328143492, 6693.564918280394, 6808.148981377328, 6879.862402751917, 6881.587104773729, 6543.280239173687, 6592.077109204715, 6624.072629831828, 6625.668716564152, 6641.169853768279, 6675.9332406676285, 6677.131972843499, 6726.730930762715, 6756.763513277012, 6795.38841504267, 6467.708953097122, 6549.181352330958, 6642.701078451481, 6730.46156307504, 6733.158355205599, 6610.768623098168, 6636.270010298863, 6640.833979150463, 6642.833929151713, 6661.26726060133, 5328.254044433782, 5363.168708850135, 5387.326584176978, 5405.918911216335, 5413.891722165535, 4497.2129877271345, 4556.476005259437, 4572.314152877028, 4581.312803079498, 4677.298405239241, 5769.278840144982, 5799.159121927381, 5817.38917413674, 5823.359430462646, 5835.591508594358, 6450.3549645036055, 6663.06717059612, 6668.933310666928, 6741.056252124707, 6750.932490675129, 5605.467480589337, 5695.060315048054, 5700.914486282709, 5782.190493330937, 5795.565332600072, 5815.360310365856, 5884.499817515473, 5885.61743486672, 5901.262342207224, 5908.970455147783, 6524.054012168209, 6526.967365163144, 6534.150560427209, 6554.410103090745, 6586.407223350017, 6641.369069938348, 6703.631300278532, 6798.626075565891, 6815.795526134224, 6818.590884546745, 6413.358664133736, 6469.320721324381, 6469.8706025880165, 6554.4756419485375, 6555.147830781968, 6417.1657684500715, 6515.120458738199, 6521.673916304071, 6532.5753826001155, 6576.309487503934, 6709.664516774044, 6730.528862979544, 6740.494462915203, 6746.628935408599, 6829.385355318045, 6416.935830641633, 6498.642574658439, 6504.739810407531, 6516.934830651633, 6522.739090436519, 6487.351264873475, 6528.0, 6588.505862060269, 6598.27418983921, 6613.966930165318, 6197.349278325711, 6297.96851015742, 6305.90541141874, 6409.615423074631, 6441.355864413521, 6430.067640192239, 6513.055606937062, 6566.606003639797, 6639.734410623521, 6656.201255849329, 6267.341929097379, 6326.114343991753, 6367.235931688227, 6367.649779261999, 6373.74505019794], "value": 6060.318378411056, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [831.1522247307746, 864.0927026622047, 886.5434301334809, 889.8531742262527, 1165.8367828504017, 31156.0, 39814.40278395826, 43496.347554786706, 43603.12793744123, 43668.344974825406, 43098.56901430985, 43518.78240608793, 43547.78226108873, 43587.564124358825, 43780.12439751203, 7296.781096567085, 7450.4039676826, 7660.540367577949, 7789.065312162548, 7801.453898227126, 7683.654235559413, 7722.922770772277, 7755.224477552256, 7755.302022817945, 7827.295543401093, 7810.570418626973, 7827.373810095207, 7839.568823714693, 7851.5681637509915, 7854.960725196366, 7757.185495522974, 7770.145284018753, 7793.1817159198035, 7800.0, 7833.843323133534, 7565.394768418513, 7595.810104747426, 7599.316061554487, 7600.771976840703, 7614.428917831129, 39512.40731389031, 39584.20831583352, 39584.604153958666, 39675.80162099171, 39767.40348894769, 3409.403354412968, 3411.5906091268957, 3436.879709210166, 3441.0365097772665, 3450.964710586839, 31850.362992740014, 31945.201369965704, 31983.680163198303, 32037.83981080103, 32214.838925805456, 4757.1437141314545, 4765.594924431428, 4767.070421267854, 4780.760961951889, 4839.612830973514, 196456.0, 198298.0, 198622.0, 198677.0, 198712.0, 49614.25578616324, 49838.0, 49874.25188622173, 49994.0, 50001.24998125031, 52189.21716174261, 52589.737051315264, 52594.211086833726, 52610.0, 52619.210711839354, 15688.450904218298, 15985.680286394207, 16004.679906401807, 16006.759898601531, 16007.759883601755, 11112.44437778108, 11401.087912966943, 12934.482620695255, 12955.805662915063, 12959.611211663665, 14686.0, 14822.925885370503, 14934.253287335807, 15039.849601503845, 15067.849321506865, 5819.854503637358, 5848.298204215436, 5904.911426328608, 6011.338752737195, 6036.215292012011, 955.694177863091, 970.4322971062007, 988.3180605382407, 1018.6129270877019, 1020.698893826323, 22172.77827221707, 22329.55340893173, 22494.100235990376, 22625.4343641407, 22652.433689157573, 1050.5581089954112, 1067.4929408530886, 1096.2107282756563, 1098.0, 1110.8611423572054, 11923.403829808474, 11931.463084161234, 12085.45615447307, 12196.939015305044, 12317.815232771516, 226013.0, 226108.0, 227525.0, 227615.0, 227869.0, 54455.455445445834, 54783.726081369336, 55166.17250741242, 55190.44809551853, 55299.44700552943, 1405.3886559346718, 1453.6729235921832, 1457.0747575289768, 1468.860458256464, 1471.6468047668482, 21292.787072129082, 21987.23044693428, 22071.558568828856, 22088.779112209315, 22117.115315387204, 38486.6151338483, 38545.6145438542, 38548.614513855624, 38632.0, 38660.6133938657, 189080.0, 190239.0, 190713.0, 190772.0, 191484.0425797862, 34850.82574587111, 35026.299474010884, 35045.12387190239, 35065.64934350624, 36414.0, 45767.313490297005, 47693.28460073032, 47776.0, 48111.278330825764, 48373.51626483831, 30970.84514577413, 33929.321413572085, 34028.82985585056, 34129.48805767965, 34411.13972150716, 31329.8433507831, 32420.351592967538, 33733.83133084319, 33748.662513374555, 34358.48462273018, 35998.640013600576, 37143.814280928425, 37198.62801371951, 37469.0, 37479.063023424635, 30474.390512189188, 32311.35377292488, 33109.006729798144, 33338.66661333355, 33453.498197527544, 24139.396515087265, 24153.75846241515, 24430.755692442846, 24439.633405499288, 24479.755202447748], "value": 17319.41873938034, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.3620149734543, 581.1979468333699, 584.4856526256893, 587.3715124816447, 609.6768712582331, 22124.446888827766, 22860.65709014364, 22934.426639334026, 22950.88524557379, 22959.54080918383, 22722.88638556805, 23493.295201143992, 24854.37864053395, 24883.875580622072, 25686.614700779457, 6598.571092878971, 6750.257471678112, 6766.966165169168, 6778.661066946633, 6790.728370865159, 5824.24284842972, 6374.203224596926, 6607.405333519982, 6678.332166783307, 6685.732570697166, 6335.714892829834, 6340.841478963017, 6345.809625711213, 6346.174997250351, 6352.078948552457, 6282.87434251317, 6298.842528936768, 6319.399657032574, 6324.873502529947, 6339.334369891164, 5911.586188966774, 5921.052631578927, 5928.081147422156, 5930.1994230779155, 5936.762529498815, 29153.854230728924, 29813.55279670785, 29836.701632983608, 30985.0, 32163.19592010195, 1959.7452331196853, 2014.9697754533693, 2017.757869055708, 2018.6467368210504, 2019.5960807838492, 20823.16707331705, 21179.78820211809, 21180.364589062352, 21204.36386908395, 21256.46858828526, 2450.791682706972, 2502.724700282967, 2561.705403878559, 2569.11365578875, 2597.922062338133, 141733.0, 142519.0, 144716.27641861828, 145989.0, 147073.0, 20039.899800501196, 21306.78693213079, 22213.333599991704, 22596.322110336718, 23382.298531043754, 45003.099938001054, 45346.77326613346, 45634.771826140655, 45685.543144568794, 45752.08495830065, 10107.0, 10230.130438912776, 10239.539220735085, 10359.513716708087, 10394.0, 8076.8384632307025, 8224.342052635775, 8249.175082491824, 8290.170982901662, 8374.916250837536, 9022.593983270768, 9726.465044422624, 9777.608895644236, 11206.271592346471, 12318.0, 2749.134022782817, 2763.8479883606597, 2764.7652246871207, 2872.3250036241466, 2894.594756734059, 958.2289014836222, 962.1773383756927, 963.9035098660386, 1000.4547521600745, 1002.2382988928321, 19312.71030934537, 19770.20919163246, 19839.38592852817, 19969.301074462324, 20340.49148771263, 1015.8222311095528, 1034.6068493972393, 1064.4730858225228, 1065.227709910309, 1069.1713921710736, 10955.0, 11199.272047316897, 11295.661130166109, 11404.201705880509, 11446.255993360404, 489377.0, 490402.0, 535825.0, 543062.0, 548744.0, 116028.0, 122134.38932805278, 125133.0, 125565.37217313854, 126147.36926315493, 1234.3766397969148, 1249.8000319948765, 1287.1826390242263, 1288.8037666586918, 1293.4502836294348, 19521.316753913547, 20565.280215192397, 20824.0, 20935.58128837445, 21425.0, 58989.70505147447, 59044.40955590389, 59113.0, 60946.695266523384, 62413.0, 80063.59968200355, 80766.0, 80793.0, 80962.59518702605, 82066.58966705129, 12721.363931803558, 13814.171149731048, 14692.706145877237, 15080.472183473526, 15098.471553495576, 23945.0, 23992.520149596563, 24045.398865028514, 24088.51822963496, 24407.38981525476, 18417.171227294537, 18558.721619175994, 18595.44213673538, 18598.721019184995, 18725.719114213025, 16207.675846482769, 17359.652806944043, 17406.12969351502, 17647.823521764618, 17911.0, 18613.0, 19364.903175484033, 19800.0, 19935.900320498306, 20067.498312542302, 14400.927995359956, 15155.318010689325, 15269.312880920608, 15289.159096249814, 15316.463923762614, 16526.752098718287, 16762.916185418995, 16786.32854685799, 16812.57968550796, 18311.450656480327], "value": 12598.780549250396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.7629826631205, 1354.077210361287, 1357.3077730357516, 1366.275873786893, 1369.4043091255305, 13537.999999999987, 14159.929200353996, 14215.289235538208, 14233.857661423383, 14260.358283877224, 13794.0, 14812.555623331291, 14828.036177648446, 14829.629259268524, 14838.035527690692, 2567.8330908490934, 2631.1843328568207, 2639.986800065997, 2640.102365195833, 2640.801939854509, 2519.4583164619603, 2528.797696184301, 2605.257501612041, 2678.504476671822, 2680.0351873325585, 2669.599560065986, 2685.261553072901, 2710.864456777163, 2715.7420045095782, 2717.8233414827973, 2588.8446693198375, 2598.9610155847677, 2606.504764094816, 2647.7484638959268, 2665.2404064841426, 2528.5575024370846, 2593.1961092061333, 2593.8314009589503, 2594.727553606882, 2595.3641357867255, 13785.862141378559, 14124.081934674316, 14126.293685315693, 14140.939429542825, 14148.717025659429, 7280.708771649128, 7489.0, 7569.7350592729545, 7576.242375762435, 7580.924190758132, 4670.556297151765, 4937.432195297515, 5031.06925218832, 5053.46938571452, 5059.215821547666, 1846.0, 1875.1093230715437, 1902.1345287893976, 1927.6048410076041, 1961.4507937777446, 22717.886410568008, 22916.77083229163, 22932.426689332733, 22943.885280573657, 22951.196708115134, 6882.0, 7044.54466642639, 7158.570485770871, 7255.129384473897, 7261.857751963184, 15798.447054353042, 15839.762403563956, 15848.603784905239, 15856.841431585768, 15858.207089645472, 7307.707691692379, 7405.259474052552, 7458.328750412489, 7463.888041679379, 7478.3643390311345, 6675.933240667531, 6774.187097548326, 6793.184817821893, 6930.341617546325, 6939.479539034593, 4793.976030119897, 4919.975400122977, 4964.875878103004, 4983.576396006308, 4987.351644286292, 1245.103525461666, 1276.5787290194214, 1277.2208952538945, 1383.833939927195, 1413.5264686329988, 809.3282575462352, 827.2430725885747, 842.8819965204876, 847.9654821118226, 859.1108203009854, 7832.960835195788, 8087.433879628369, 8178.7955301117945, 8180.427370084037, 8228.876566851503, 938.8967213606497, 965.0831709875646, 975.3465178330536, 983.1593987141034, 1002.4486532407146, 4750.358701575312, 5001.9499805002215, 5109.029284435946, 5137.460566640524, 5212.40057393397, 18348.63302733938, 18493.352732654294, 19171.424857254304, 19184.0, 19199.0, 19453.902730486257, 19845.420095387795, 19950.30173943905, 19988.50028749264, 20024.199032038847, 10117.797644047225, 10413.42726150069, 10627.14982801374, 10721.571137154582, 10722.678319650424, 7626.0, 7697.461177717506, 8165.183481651788, 8279.0, 8417.789555260922, 16018.318076601789, 16654.916725416297, 16837.989720616803, 17009.74485382745, 17526.82473175252, 17016.744748829024, 17543.649127017645, 17782.466526004242, 17831.375901843374, 17839.0, 11023.173262005543, 11302.491387887729, 11711.824322634997, 11715.941420292844, 11731.472083756422, 12749.87250127487, 12951.417186226454, 12954.157979731288, 12956.740865182455, 12973.221606703628, 9197.632094716137, 10448.216383771096, 10997.505112270128, 11281.379524126252, 11375.943120284346, 10222.0, 10448.0, 10456.58173673075, 10606.681799546026, 10843.078338341329, 9259.76850578741, 9534.475603841855, 9578.808423831346, 9588.568514417007, 9596.376235544667, 6855.0, 7164.641767911688, 7319.158296795724, 7410.962945185455, 7414.295641914009, 6809.216940051958, 6961.6519174042105, 7218.494705370784, 7281.162666293232, 7320.853582928418], "value": 6339.737697179589, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.24121887417886, 495.2472242191867, 512.8717820544864, 515.760171520243, 518.6369541321076, 6173.290071641763, 6201.844953876155, 6256.687165641717, 6267.2165979252595, 6310.905336419957, 5853.268341457318, 6061.484773794222, 6118.418750218733, 6137.6931153442265, 6215.254169499655, 4869.440014398337, 4951.455339912607, 4983.127952608297, 4986.10250154972, 5007.549320561149, 4893.510648935096, 4908.141075311806, 4935.35840340757, 5023.773930173133, 5045.949540504603, 4787.976060119695, 4860.9756951215195, 4928.679635823678, 4944.752762361867, 4947.1589829728855, 4817.0, 4819.277108433728, 4895.265710143472, 4907.938665760389, 4971.204607262856, 4456.799444024994, 4458.063806600618, 4468.3074123510905, 4471.597556219924, 4474.7091439056685, 5991.6405015698765, 6012.188354572164, 6047.818565443044, 6061.0, 6069.393060693939, 5713.0863259737835, 5718.656880587137, 5718.971405142947, 5735.340435849889, 5758.337791154029, 6394.456471199954, 6445.581037232565, 6458.61248325102, 6506.642134682591, 6618.966905165492, 4814.518548145193, 4834.444038935532, 4873.390826146731, 4886.315915771795, 4895.681780684244, 6775.0, 6957.61733104679, 6970.8871765658505, 6973.65131743421, 6979.127609048869, 4916.631252656065, 4925.581325587365, 4946.975265123651, 4969.875753106201, 4988.201887698024, 5041.210370318558, 5076.644634875597, 5077.822276220315, 5096.694198348111, 5105.2342148678, 5674.460926212003, 5677.318721753416, 5694.4590263924865, 5695.772169113272, 5729.0, 6463.418292353711, 6508.251551071593, 6518.543701940818, 6589.507560992682, 6610.405063544208, 1638.172722774991, 1664.6587449572808, 1730.368415528323, 1750.1511766793096, 1775.4673597920573, 1152.792497350485, 1195.3664557784389, 1197.6167626359481, 1200.321818172747, 1215.6292330839003, 5578.470045345685, 5644.6613203207935, 5659.518940889988, 5710.771569137271, 5743.798967036134, 6441.838954026093, 6536.934630653633, 6563.556017676104, 6662.56693314933, 6688.699008544627, 5654.886902261932, 5697.666864884007, 5766.4233576642, 5766.567507436959, 5772.624779389326, 3515.5254040704176, 3529.8941031769086, 3547.8758243461357, 3589.820508974593, 3628.546431696038, 6480.51396145291, 6513.8829880289095, 6520.804375868732, 6564.212294524687, 6585.637789921505, 6772.72909083641, 6795.762148324785, 6826.351496607815, 6939.722411103499, 6952.914125762251, 6475.7733479328, 6513.12072870166, 6526.41262286387, 6532.150820393318, 6532.379423954621, 6594.043573855648, 6667.633280169637, 6740.8651826962205, 6780.1524809398825, 6794.0, 6660.600363978177, 6672.666366681744, 6691.59850408977, 6745.460363170836, 6761.425278851353, 6460.219437616224, 6490.935090649033, 6500.349965003651, 6536.901946470712, 6550.868982620225, 4927.802887884444, 4945.4312754033745, 4952.826651067196, 4959.454460009324, 4987.551120399182, 6687.665616719242, 6720.798376048726, 6734.393904548614, 6746.595204287759, 6782.593044417351, 6442.613443193423, 6486.643234622141, 6498.577592456475, 6534.660394619187, 6582.308857569887, 6447.451966582893, 6487.156669632917, 6520.347965203442, 6588.703508342041, 6616.735330586723, 6205.393734631375, 6264.968675156777, 6335.936640633535, 6382.585131966407, 6442.645654489048, 6544.018397240452, 6547.181602299713, 6550.148480697479, 6565.212174538895, 6624.635645039569, 6353.936460635519, 6356.745730170742, 6366.649834258975, 6382.744690212339, 6387.297397286202], "value": 5027.80571220332, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.2903735291795, 836.9832603347937, 859.9957000215002, 907.1155623267315, 925.0749250749253, 17972.73040904386, 19144.13851376688, 19150.329738459157, 19164.904175479103, 19171.61656766864, 19579.314723984662, 21730.782692173074, 21821.563568728616, 21890.89054554729, 21934.45163870904, 1054.4727636181908, 1080.4219742437758, 1080.8378743188507, 1081.416035340915, 1082.1342925659442, 1021.2697920986493, 1054.4674939155716, 1063.0273299930593, 1072.3565860483725, 1073.3398959639844, 1114.0363585498526, 1116.0680831505701, 1119.0991252042143, 1119.6696974392573, 1119.8600174978128, 1097.314178638351, 1098.6209757633603, 1103.7130346109989, 1105.6682995101437, 1108.2020944919645, 809.2595275323073, 810.0401024785589, 810.5379933437943, 811.663159788687, 811.7524155132683, 18889.62220755591, 19531.90234048835, 19848.106835192306, 20314.593708125904, 20353.694694579593, 20556.794432055787, 20675.896620516953, 21106.15575376983, 21116.0, 21149.365519034454, 15684.137372444511, 15855.920720396323, 16075.758863617055, 16087.11520866352, 16412.343506259735, 3435.7594968352223, 3462.6883580477624, 3466.0, 3466.272082862602, 3467.7572569920117, 116895.41552292184, 120938.39530802377, 123409.38295308556, 123510.0, 124345.37827310806, 15400.22998850053, 15489.302981365865, 15745.842541574666, 15752.291146898417, 15759.842401575837, 30018.24954376158, 30764.846175769424, 30954.380912381625, 31081.222969425944, 31113.688863111533, 8203.671853125808, 8596.8710469343, 8633.05036446003, 8650.09174036717, 8671.653133874574, 4258.723182993095, 4329.636164608139, 4330.17726631939, 4352.5865042821515, 4388.232059389594, 4344.543822898613, 5208.218767184952, 5838.7080645967535, 5843.2403787507355, 5880.852978675567, 1042.4266653340633, 1069.5133714160038, 1075.0324707763075, 1079.9568017279378, 1085.6417382263835, 646.4085361893908, 662.3178126529682, 672.2470832667444, 683.5684861992769, 684.0662495693343, 11114.222004459773, 11786.764264714659, 12050.0, 12404.81392779109, 12739.61781146567, 653.3662347522895, 674.2425716565207, 690.2166041542885, 709.8970649255932, 713.0445203427432, 5429.864253393696, 5475.917861232085, 5539.473749993744, 5787.0, 5827.854303642358, 98249.65075191148, 101337.0, 102369.48815256025, 105290.47354763177, 105508.0, 86544.56727716321, 89367.0, 89879.55060224657, 90417.0, 94047.0, 72421.91367129392, 75056.62471687715, 75584.0, 77310.0, 80171.19828801637, 10590.470476475992, 11061.446927653424, 11273.379964102052, 11491.08071354273, 11626.70933226676, 36806.815965919996, 38197.0, 39210.60789392069, 39397.0, 39530.0, 44735.77632111819, 47867.042659147315, 48085.0, 48409.515904840504, 49453.0, 16240.837591623933, 18088.819111808712, 19129.90435047816, 19274.421767347, 19318.32385866488, 20712.0, 21261.36215913525, 21377.786222138202, 21416.0, 21645.13419463267, 17546.82453175452, 17767.378141764977, 18560.350387736366, 18862.622747544698, 19065.523361915508, 18669.626607468046, 19221.32725354606, 19470.707939381206, 19797.0, 20007.499812504222, 18198.363057292932, 18992.14535345885, 19160.616787664447, 19208.0, 19361.32235371755, 13218.537351192663, 13250.403731832284, 13642.976776741585, 13929.30353482342, 14196.645083872985, 13962.720745585235, 14609.196494192922, 14674.266286685837, 14678.0, 14749.041312314665], "value": 9052.003783061524, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 96.0, 110.0, 114.0, 112.0, 115.0, 113.0, 110.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 152.0, 181.0, 119.0, 152.0, 150.0, 127.0, 179.0, 125.0], "value": 144.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 163.0, 163.0, 163.0, 166.0, 166.0, 168.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 185.0, 79.0, 76.0, 77.0, 86.0, 153.0, 76.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 134.0, 79.0, 80.0, 80.0, 136.0, 82.0, 86.0, 128.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 116.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 150.0, 151.0, 150.0, 150.0, 150.0, 150.0, 149.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 100.0, 94.0, 95.0, 94.0, 93.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 54.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 54.0, 54.0, 54.0, 55.0, 53.0, 54.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 87.0, 85.0, 87.0, 78.0, 77.0, 77.0, 79.0, 77.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 150.0, 128.0, 132.0, 127.0, 132.0, 128.0, 126.0, 132.0, 177.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 206.0, 178.0, 172.0, 178.0, 177.0, 174.0, 177.0, 174.0, 171.0], "value": 178.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 68.0, 70.0, 68.0, 69.0, 67.0, 69.0, 66.0, 66.0], "value": 68.7, "unit": "score"}]}]} 19:00:42 INFO - Return code: 0 19:00:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:00:42 INFO - # TBPL SUCCESS # 19:00:42 INFO - Running post-action listener: _package_coverage_data 19:00:42 INFO - Running post-action listener: _resource_record_post_action 19:00:42 INFO - [mozharness: 2017-07-25 02:00:42.336306Z] Finished run-tests step (success) 19:00:42 INFO - Running post-run listener: _resource_record_post_run 19:00:42 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 440975360; Read time: 204; Write time: 289512 19:00:42 INFO - TinderboxPrint: CPU usage
13.1% 19:00:42 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 204 19:00:42 INFO - TinderboxPrint: I/O write bytes / time
440,975,360 / 289,512 19:00:42 INFO - TinderboxPrint: CPU idle
8,270.3 (86.9%) 19:00:42 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 19:00:42 INFO - TinderboxPrint: Swap in / out
0 / 0 19:00:42 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107421696; Read time: 184; Write time: 79164 19:00:42 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:00:42 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 333553664; Read time: 0; Write time: 210348 19:00:42 INFO - Running post-run listener: _upload_blobber_files 19:00:42 INFO - Blob upload gear active. 19:00:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:00:42 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 19:00:42 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:00:42 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:00:43 INFO - (blobuploader) - INFO - Open directory for files ... 19:00:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:00:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:00:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:44 INFO - (blobuploader) - INFO - Done attempting. 19:00:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:00:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:00:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:48 INFO - (blobuploader) - INFO - Done attempting. 19:00:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:00:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:00:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:49 INFO - (blobuploader) - INFO - Done attempting. 19:00:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:00:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:00:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:49 INFO - (blobuploader) - INFO - Done attempting. 19:00:49 INFO - (blobuploader) - INFO - Iteration through files over. 19:00:49 INFO - Return code: 0 19:00:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:00:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:00:49 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5843ad3041ee73148135e6090ae5a78cfdb8cc60e50f59ac01eb268ac6bd2e26600f3308a4896411a1d589bf506784a0624dad8aec2d758a5c4cf6692de9816d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31bfc925eb02c441c3d19b642877786be89fa0a4837df92b88ed387d62aa89e702b12dd2250adc5d3a9f1e89112b25f3e57a9569684ad740dbe64f217a0e5719", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78dc058af1a628851158bcb9016564f8c07a968101fde9ea8b834370de45af3157f0d48b83b199d68e28c7dbcb67008d2682241ff887531e1620feb9a32770c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/983598301a77ed7f3ec31b8909d4b63f2a5046a3e9ca4388a2672c4eb04b0e4ef5edb216054c433e91acc558effb2703e22da8c0f9aca08bbb53641d9da8c517"} 19:00:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:00:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:00:49 INFO - Contents: 19:00:49 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5843ad3041ee73148135e6090ae5a78cfdb8cc60e50f59ac01eb268ac6bd2e26600f3308a4896411a1d589bf506784a0624dad8aec2d758a5c4cf6692de9816d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31bfc925eb02c441c3d19b642877786be89fa0a4837df92b88ed387d62aa89e702b12dd2250adc5d3a9f1e89112b25f3e57a9569684ad740dbe64f217a0e5719", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78dc058af1a628851158bcb9016564f8c07a968101fde9ea8b834370de45af3157f0d48b83b199d68e28c7dbcb67008d2682241ff887531e1620feb9a32770c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/983598301a77ed7f3ec31b8909d4b63f2a5046a3e9ca4388a2672c4eb04b0e4ef5edb216054c433e91acc558effb2703e22da8c0f9aca08bbb53641d9da8c517"} 19:00:49 INFO - Running post-run listener: copy_logs_to_upload_dir 19:00:49 INFO - Copying logs to upload dir... 19:00:49 INFO - mkdir: /builds/slave/test/build/upload/logs 19:00:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.503071 ========= master_lag: 0.87 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-24 19:00:50.282860) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 19:00:50.286432) ========= 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=9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5843ad3041ee73148135e6090ae5a78cfdb8cc60e50f59ac01eb268ac6bd2e26600f3308a4896411a1d589bf506784a0624dad8aec2d758a5c4cf6692de9816d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31bfc925eb02c441c3d19b642877786be89fa0a4837df92b88ed387d62aa89e702b12dd2250adc5d3a9f1e89112b25f3e57a9569684ad740dbe64f217a0e5719", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78dc058af1a628851158bcb9016564f8c07a968101fde9ea8b834370de45af3157f0d48b83b199d68e28c7dbcb67008d2682241ff887531e1620feb9a32770c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/983598301a77ed7f3ec31b8909d4b63f2a5046a3e9ca4388a2672c4eb04b0e4ef5edb216054c433e91acc558effb2703e22da8c0f9aca08bbb53641d9da8c517"} build_url:https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011167 build_url: 'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5843ad3041ee73148135e6090ae5a78cfdb8cc60e50f59ac01eb268ac6bd2e26600f3308a4896411a1d589bf506784a0624dad8aec2d758a5c4cf6692de9816d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31bfc925eb02c441c3d19b642877786be89fa0a4837df92b88ed387d62aa89e702b12dd2250adc5d3a9f1e89112b25f3e57a9569684ad740dbe64f217a0e5719", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78dc058af1a628851158bcb9016564f8c07a968101fde9ea8b834370de45af3157f0d48b83b199d68e28c7dbcb67008d2682241ff887531e1620feb9a32770c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/983598301a77ed7f3ec31b8909d4b63f2a5046a3e9ca4388a2672c4eb04b0e4ef5edb216054c433e91acc558effb2703e22da8c0f9aca08bbb53641d9da8c517"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 19:00:50.321446) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 19:00:50.321768) ========= 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=9f7544b6a75ada7b6b576032000001a7-1500944256.554632-830599983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 19:00:50.376130) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 19:00:50.376437) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 19:00:50.376757) ========= ========= Total master_lag: 1.00 =========