builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1500896791.32 results: success (0) revision: 758016d026077ebaf65aaecc8df437a7164dd9b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:31.322797) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:31.323263) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-07-24 04:46:31.323550) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-07-24 04:46:32.670192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:32.670592) ========= 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=db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-24 04:46:32-- 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% 42.4M=0s 2017-07-24 04:46:33 (42.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.334290 ========= master_lag: 0.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:33.241671) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:33.242044) ========= 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=db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018110 ========= master_lag: 0.43 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:33.694303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 04:46:33.694703) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 758016d026077ebaf65aaecc8df437a7164dd9b5 --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 758016d026077ebaf65aaecc8df437a7164dd9b5 --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=db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-24 04:46:33,875 truncating revision to first 12 chars 2017-07-24 04:46:33,875 Setting DEBUG logging. 2017-07-24 04:46:33,875 attempt 1/10 2017-07-24 04:46:33,875 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/758016d02607?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-24 04:46:34,927 unpacking tar archive at: mozilla-central-758016d02607/testing/mozharness/ program finished with exit code 0 elapsedTime=1.431608 ========= master_lag: 0.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 04:46:35.339229) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:35.339556) ========= script_repo_revision: 758016d026077ebaf65aaecc8df437a7164dd9b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:35.340023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:35.340297) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 04:46:36.144558) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-07-24 04:46:36.145056) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:46:36 INFO - MultiFileLogger online at 20170724 04:46:36 in /builds/slave/test 04:46:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:46:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:46:36 INFO - {'append_to_log': False, 04:46:36 INFO - 'base_work_dir': '/builds/slave/test', 04:46:36 INFO - 'blob_upload_branch': 'Firefox', 04:46:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:46:36 INFO - 'branch': 'Firefox', 04:46:36 INFO - 'buildbot_json_path': 'buildprops.json', 04:46:36 INFO - 'code_coverage': False, 04:46:36 INFO - 'config_files': ('talos/linux_config.py',), 04:46:36 INFO - 'default_actions': ('clobber', 04:46:36 INFO - 'read-buildbot-config', 04:46:36 INFO - 'download-and-extract', 04:46:36 INFO - 'populate-webroot', 04:46:36 INFO - 'create-virtualenv', 04:46:36 INFO - 'install', 04:46:36 INFO - 'setup-mitmproxy', 04:46:36 INFO - 'run-tests'), 04:46:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:46:36 INFO - 'disable_ccov_upload': False, 04:46:36 INFO - 'download_minidump_stackwalk': True, 04:46:36 INFO - 'download_symbols': 'ondemand', 04:46:36 INFO - 'enable_stylo': False, 04:46:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:46:36 INFO - 'tooltool.py': '/tools/tooltool.py', 04:46:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:46:36 INFO - '/tools/misc-python/virtualenv.py')}, 04:46:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:46:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:46:36 INFO - 'gecko_profile': False, 04:46:36 INFO - 'gecko_profile_interval': 0, 04:46:36 INFO - 'installer_path': 'installer.exe', 04:46:36 INFO - 'log_level': 'info', 04:46:36 INFO - 'log_name': 'talos', 04:46:36 INFO - 'log_to_console': True, 04:46:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:46:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:46:36 INFO - 'opt_config_files': (), 04:46:36 INFO - 'pip_index': False, 04:46:36 INFO - 'suite': 'dromaeojs-e10s', 04:46:36 INFO - 'system_bits': '32', 04:46:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:46:36 INFO - 'title': 'talos-linux64-ix-049', 04:46:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:46:36 INFO - 'use_talos_json': True, 04:46:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:46:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:46:36 INFO - 'work_dir': 'build'} 04:46:36 INFO - [mozharness: 2017-07-24 11:46:36.445584Z] Running clobber step. 04:46:36 INFO - Running pre-action listener: _resource_record_pre_action 04:46:36 INFO - Running main action method: clobber 04:46:36 INFO - rmtree: /builds/slave/test/build 04:46:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:46:38 INFO - Running post-action listener: _resource_record_post_action 04:46:38 INFO - [mozharness: 2017-07-24 11:46:38.026785Z] Finished clobber step (success) 04:46:38 INFO - [mozharness: 2017-07-24 11:46:38.026887Z] Running read-buildbot-config step. 04:46:38 INFO - Running pre-action listener: _resource_record_pre_action 04:46:38 INFO - Running main action method: read_buildbot_config 04:46:38 INFO - Using buildbot properties: 04:46:38 INFO - { 04:46:38 INFO - "project": "", 04:46:38 INFO - "product": "firefox", 04:46:38 INFO - "who": "cbook@mozilla.com", 04:46:38 INFO - "installer_path": "public/build/target.tar.bz2", 04:46:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 04:46:38 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:46:38 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 04:46:38 INFO - "stage_platform": "linux64-stylosequential", 04:46:38 INFO - "basedir": "/builds/slave/test", 04:46:38 INFO - "buildnumber": 120, 04:46:38 INFO - "platform": "ubuntu64_hw_styloseq", 04:46:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:46:38 INFO - "slavebuilddir": "test", 04:46:38 INFO - "taskId": "Jkm-ASKZRpO0HpCrMRCkDQ", 04:46:38 INFO - "branch": "mozilla-central", 04:46:38 INFO - "script_repo_revision": "production", 04:46:38 INFO - "revision": "758016d026077ebaf65aaecc8df437a7164dd9b5", 04:46:38 INFO - "slavename": "talos-linux64-ix-049", 04:46:38 INFO - "repo_path": "mozilla-central" 04:46:38 INFO - } 04:46:38 INFO - Finding installer, test and symbols from parent task. 04:46:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jkm-ASKZRpO0HpCrMRCkDQ'}, attempt #1 04:46:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jkm-ASKZRpO0HpCrMRCkDQ'}, attempt #1 04:46:39 INFO - Task dependencies: Qxjkh3A0R969zOj7BNm3zw 04:46:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw'}, attempt #1 04:46:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2 04:46:39 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/test_packages.json 04:46:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.crashreporter-symbols.zip 04:46:39 INFO - Running post-action listener: _resource_record_post_action 04:46:39 INFO - [mozharness: 2017-07-24 11:46:39.849813Z] Finished read-buildbot-config step (success) 04:46:39 INFO - [mozharness: 2017-07-24 11:46:39.850035Z] Running download-and-extract step. 04:46:39 INFO - Running pre-action listener: _resource_record_pre_action 04:46:39 INFO - Running main action method: download_and_extract 04:46:39 INFO - mkdir: /builds/slave/test/build/tests 04:46: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')]} 04:46:39 INFO - trying https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.test_packages.json 04:46:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:46:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:46:40 INFO - Downloaded 989 bytes. 04:46:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:46:40 INFO - Using the following test package requirements: 04:46:40 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:46:40 INFO - u'common': [u'target.common.tests.zip'], 04:46:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:46:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:46:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:46:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:46:40 INFO - u'mozbase': [u'target.common.tests.zip'], 04:46:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:46:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:46:40 INFO - u'web-platform': [u'target.common.tests.zip', 04:46:40 INFO - u'target.web-platform.tests.tar.gz'], 04:46:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:46:40 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:46:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.common.tests.zip 04:46:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:46:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.common.tests.zip into memory 04:46:43 INFO - Content-Length response header: 72760922 04:46:43 INFO - Bytes received: 72760922 04:46:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:46:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.common.tests.zip 04:46:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:46:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.common.tests.zip into memory 04:46:55 INFO - Content-Length response header: 72760922 04:46:55 INFO - Bytes received: 72760922 04:47:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.talos.tests.zip 04:47:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:47:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.talos.tests.zip into memory 04:47:08 INFO - Content-Length response header: 14498880 04:47:08 INFO - Bytes received: 14498880 04:47:08 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')]} 04:47:08 INFO - trying https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2 04:47:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:47:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:47:10 INFO - Downloaded 61961168 bytes. 04:47:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2 04:47:10 INFO - mkdir: /builds/slave/test/properties 04:47:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:47:10 INFO - Writing to file /builds/slave/test/properties/build_url 04:47:10 INFO - Contents: 04:47:10 INFO - build_url:https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2 04:47:10 INFO - Running post-action listener: _resource_record_post_action 04:47:10 INFO - Running post-action listener: set_extra_try_arguments 04:47:10 INFO - [mozharness: 2017-07-24 11:47:10.991301Z] Finished download-and-extract step (success) 04:47:10 INFO - [mozharness: 2017-07-24 11:47:10.991399Z] Running populate-webroot step. 04:47:10 INFO - Running pre-action listener: _resource_record_pre_action 04:47:10 INFO - Running main action method: populate_webroot 04:47:10 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:47:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:47:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:47:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:47:10 INFO - 'tests': ['damp', 'tps']}, 04:47:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:47:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:47:10 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:47:10 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:47:10 INFO - 'other-e10s': {'tests': ['a11yr', 04:47:10 INFO - 'ts_paint', 04:47:10 INFO - 'tpaint', 04:47:10 INFO - 'sessionrestore', 04:47:10 INFO - 'sessionrestore_many_windows', 04:47:10 INFO - 'sessionrestore_no_auto_restore', 04:47:10 INFO - 'tabpaint']}, 04:47:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:47:10 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:47:10 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:47:10 INFO - 'talos_options': ['--mitmproxy', 04:47:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:47:10 INFO - '--firstNonBlankPaint'], 04:47:10 INFO - 'tests': ['quantum_pageload_google', 04:47:10 INFO - 'quantum_pageload_youtube', 04:47:10 INFO - 'quantum_pageload_amazon', 04:47:10 INFO - 'quantum_pageload_facebook']}, 04:47:10 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:47:10 INFO - 'talos_options': ['--stylo', 04:47:10 INFO - '--mitmproxy', 04:47:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:47:10 INFO - '--firstNonBlankPaint'], 04:47:10 INFO - 'tests': ['quantum_pageload_google', 04:47:10 INFO - 'quantum_pageload_youtube', 04:47:10 INFO - 'quantum_pageload_amazon', 04:47:10 INFO - 'quantum_pageload_facebook']}, 04:47:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:47:10 INFO - 'tsvgr_opacity', 04:47:10 INFO - 'tart', 04:47:10 INFO - 'tscrollx', 04:47:10 INFO - 'cart', 04:47:10 INFO - 'tsvg_static']}, 04:47:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:47:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:47:10 INFO - 'talos_options': ['--xperf_path', 04:47:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:10 INFO - 'tests': ['tp5n']}}} 04:47:10 INFO - Running post-action listener: _resource_record_post_action 04:47:10 INFO - [mozharness: 2017-07-24 11:47:10.998688Z] Finished populate-webroot step (success) 04:47:10 INFO - [mozharness: 2017-07-24 11:47:10.998777Z] Running create-virtualenv step. 04:47:10 INFO - Running pre-action listener: _resource_record_pre_action 04:47:10 INFO - Running main action method: create_virtualenv 04:47:10 INFO - Creating virtualenv /builds/slave/test/build/venv 04:47:10 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 04:47:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:47:10 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:47:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:47:11 INFO - Using real prefix '/usr' 04:47:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:47:11 INFO - Installing distribute.............................................................................................................................................................................................done. 04:47:13 INFO - Installing pip.................done. 04:47:13 INFO - Return code: 0 04:47:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:47:13 INFO - Reading from file tmpfile_stdout 04:47:13 INFO - Output received: 04:47:13 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) 04:47:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:14 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 0x27051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a71eb0>, '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 0x2a72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, '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': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', '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 04:47:14 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 04:47:14 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 04:47:14 INFO - Using env: {'DISPLAY': ':0', 04:47:14 INFO - 'HOME': '/home/cltbld', 04:47:14 INFO - 'LANG': 'en_US.UTF-8', 04:47:14 INFO - 'LANGUAGE': 'en_US:en', 04:47:14 INFO - 'LOGNAME': 'cltbld', 04:47:14 INFO - 'MAIL': '/var/mail/cltbld', 04:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:14 INFO - 'MOZ_NO_REMOTE': '1', 04:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:14 INFO - 'NO_EM_RESTART': '1', 04:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:14 INFO - 'PWD': '/builds/slave/test', 04:47:14 INFO - 'SHELL': '/bin/bash', 04:47:14 INFO - 'SHLVL': '1', 04:47:14 INFO - 'TERM': 'linux', 04:47:14 INFO - 'TMOUT': '86400', 04:47:14 INFO - 'USER': 'cltbld', 04:47:14 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', 04:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:14 INFO - '_': '/tools/buildbot/bin/python'} 04:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:14 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 04:47:14 INFO - Cleaning up... 04:47:14 INFO - Return code: 0 04:47:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:47:14 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')]} 04:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:14 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')]} 04:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:14 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 0x27051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a71eb0>, '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 0x2a72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, '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': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', '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 04:47:14 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 04:47:14 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 04:47:14 INFO - Using env: {'DISPLAY': ':0', 04:47:14 INFO - 'HOME': '/home/cltbld', 04:47:14 INFO - 'LANG': 'en_US.UTF-8', 04:47:14 INFO - 'LANGUAGE': 'en_US:en', 04:47:14 INFO - 'LOGNAME': 'cltbld', 04:47:14 INFO - 'MAIL': '/var/mail/cltbld', 04:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:14 INFO - 'MOZ_NO_REMOTE': '1', 04:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:14 INFO - 'NO_EM_RESTART': '1', 04:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:14 INFO - 'PWD': '/builds/slave/test', 04:47:14 INFO - 'SHELL': '/bin/bash', 04:47:14 INFO - 'SHLVL': '1', 04:47:14 INFO - 'TERM': 'linux', 04:47:14 INFO - 'TMOUT': '86400', 04:47:14 INFO - 'USER': 'cltbld', 04:47:14 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', 04:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:14 INFO - '_': '/tools/buildbot/bin/python'} 04:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:14 INFO - Downloading/unpacking psutil>=3.1.1 04:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:47:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:16 INFO - Installing collected packages: psutil 04:47:16 INFO - Running setup.py install for psutil 04:47:16 INFO - building 'psutil._psutil_linux' extension 04:47:16 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 04:47:16 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 04:47:16 INFO - building 'psutil._psutil_posix' extension 04:47:16 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 04:47:16 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 04:47:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:16 INFO - Successfully installed psutil 04:47:16 INFO - Cleaning up... 04:47:16 INFO - Return code: 0 04:47:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:47:16 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')]} 04:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:16 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')]} 04:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:16 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 0x27051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a71eb0>, '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 0x2a72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, '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': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', '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 04:47:16 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 04:47:16 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 04:47:16 INFO - Using env: {'DISPLAY': ':0', 04:47:16 INFO - 'HOME': '/home/cltbld', 04:47:16 INFO - 'LANG': 'en_US.UTF-8', 04:47:16 INFO - 'LANGUAGE': 'en_US:en', 04:47:16 INFO - 'LOGNAME': 'cltbld', 04:47:16 INFO - 'MAIL': '/var/mail/cltbld', 04:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:16 INFO - 'MOZ_NO_REMOTE': '1', 04:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:16 INFO - 'NO_EM_RESTART': '1', 04:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:16 INFO - 'PWD': '/builds/slave/test', 04:47:16 INFO - 'SHELL': '/bin/bash', 04:47:16 INFO - 'SHLVL': '1', 04:47:16 INFO - 'TERM': 'linux', 04:47:16 INFO - 'TMOUT': '86400', 04:47:16 INFO - 'USER': 'cltbld', 04:47:16 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', 04:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:16 INFO - '_': '/tools/buildbot/bin/python'} 04:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:47:16 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 04:47:16 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 04:47:16 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 04:47:16 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 04:47:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:47:17 INFO - Installing collected packages: mozsystemmonitor 04:47:17 INFO - Running setup.py install for mozsystemmonitor 04:47:18 INFO - Successfully installed mozsystemmonitor 04:47:18 INFO - Cleaning up... 04:47:18 INFO - Return code: 0 04:47:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:18 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 0x27051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a71eb0>, '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 0x2a72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, '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': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', '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 04:47:18 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 04:47:18 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 04:47:18 INFO - Using env: {'DISPLAY': ':0', 04:47:18 INFO - 'HOME': '/home/cltbld', 04:47:18 INFO - 'LANG': 'en_US.UTF-8', 04:47:18 INFO - 'LANGUAGE': 'en_US:en', 04:47:18 INFO - 'LOGNAME': 'cltbld', 04:47:18 INFO - 'MAIL': '/var/mail/cltbld', 04:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:18 INFO - 'MOZ_NO_REMOTE': '1', 04:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:18 INFO - 'NO_EM_RESTART': '1', 04:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:18 INFO - 'PWD': '/builds/slave/test', 04:47:18 INFO - 'SHELL': '/bin/bash', 04:47:18 INFO - 'SHLVL': '1', 04:47:18 INFO - 'TERM': 'linux', 04:47:18 INFO - 'TMOUT': '86400', 04:47:18 INFO - 'USER': 'cltbld', 04:47:18 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', 04:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:18 INFO - '_': '/tools/buildbot/bin/python'} 04:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:18 INFO - Downloading/unpacking jsonschema==2.5.1 04:47:18 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 04:47:18 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 04:47:18 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 04:47:18 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 04:47:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:47:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:47:23 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 04:47:23 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 04:47:23 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 04:47:23 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 04:47:24 INFO - Downloading functools32-3.2.3-2.tar.gz 04:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:47:24 INFO - warning: no files found matching '*.txt' 04:47:24 INFO - no previously-included directories found matching 'build' 04:47:24 INFO - no previously-included directories found matching 'dist' 04:47:24 INFO - no previously-included directories found matching '.git*' 04:47:24 INFO - Installing collected packages: jsonschema, functools32 04:47:24 INFO - Running setup.py install for functools32 04:47:24 INFO - warning: no files found matching '*.txt' 04:47:24 INFO - no previously-included directories found matching 'build' 04:47:24 INFO - no previously-included directories found matching 'dist' 04:47:24 INFO - no previously-included directories found matching '.git*' 04:47:24 INFO - Successfully installed jsonschema functools32 04:47:24 INFO - Cleaning up... 04:47:24 INFO - Return code: 0 04:47:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a71eb0>, '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 0x2a72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, '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': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', '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 04:47:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:47:24 INFO - Using env: {'DISPLAY': ':0', 04:47:24 INFO - 'HOME': '/home/cltbld', 04:47:24 INFO - 'LANG': 'en_US.UTF-8', 04:47:24 INFO - 'LANGUAGE': 'en_US:en', 04:47:24 INFO - 'LOGNAME': 'cltbld', 04:47:24 INFO - 'MAIL': '/var/mail/cltbld', 04:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:24 INFO - 'MOZ_NO_REMOTE': '1', 04:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:24 INFO - 'NO_EM_RESTART': '1', 04:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:24 INFO - 'PWD': '/builds/slave/test', 04:47:24 INFO - 'SHELL': '/bin/bash', 04:47:24 INFO - 'SHLVL': '1', 04:47:24 INFO - 'TERM': 'linux', 04:47:24 INFO - 'TMOUT': '86400', 04:47:24 INFO - 'USER': 'cltbld', 04:47:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', 04:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:24 INFO - '_': '/tools/buildbot/bin/python'} 04:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:47:24 INFO - Cleaning up... 04:47:24 INFO - Return code: 0 04:47:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a71eb0>, '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 0x2a72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, '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': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', '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 04:47:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:47:24 INFO - Using env: {'DISPLAY': ':0', 04:47:24 INFO - 'HOME': '/home/cltbld', 04:47:24 INFO - 'LANG': 'en_US.UTF-8', 04:47:24 INFO - 'LANGUAGE': 'en_US:en', 04:47:24 INFO - 'LOGNAME': 'cltbld', 04:47:24 INFO - 'MAIL': '/var/mail/cltbld', 04:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:24 INFO - 'MOZ_NO_REMOTE': '1', 04:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:24 INFO - 'NO_EM_RESTART': '1', 04:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:24 INFO - 'PWD': '/builds/slave/test', 04:47:24 INFO - 'SHELL': '/bin/bash', 04:47:24 INFO - 'SHLVL': '1', 04:47:24 INFO - 'TERM': 'linux', 04:47:24 INFO - 'TMOUT': '86400', 04:47:24 INFO - 'USER': 'cltbld', 04:47:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', 04:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:24 INFO - '_': '/tools/buildbot/bin/python'} 04:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:25 INFO - Downloading/unpacking blobuploader==1.2.4 04:47:25 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 04:47:25 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 04:47:25 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 04:47:25 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 04:47:26 INFO - Downloading blobuploader-1.2.4.tar.gz 04:47:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:47:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:47:26 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 04:47:26 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 04:47:26 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 04:47:26 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 04:47:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:47:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:47:26 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 04:47:26 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 04:47:26 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 04:47:26 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 04:47:26 INFO - Downloading docopt-0.6.1.tar.gz 04:47:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:47:26 INFO - Installing collected packages: blobuploader, requests, docopt 04:47:26 INFO - Running setup.py install for blobuploader 04:47:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:47:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:47:26 INFO - Running setup.py install for requests 04:47:27 INFO - Running setup.py install for docopt 04:47:27 INFO - Successfully installed blobuploader requests docopt 04:47:27 INFO - Cleaning up... 04:47:27 INFO - Return code: 0 04:47:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47: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')]} 04:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:27 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 0x27051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a71eb0>, '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 0x2a72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, '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': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', '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 04:47:27 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 04:47:27 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 04:47:27 INFO - Using env: {'DISPLAY': ':0', 04:47:27 INFO - 'HOME': '/home/cltbld', 04:47:27 INFO - 'LANG': 'en_US.UTF-8', 04:47:27 INFO - 'LANGUAGE': 'en_US:en', 04:47:27 INFO - 'LOGNAME': 'cltbld', 04:47:27 INFO - 'MAIL': '/var/mail/cltbld', 04:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:27 INFO - 'MOZ_NO_REMOTE': '1', 04:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:27 INFO - 'NO_EM_RESTART': '1', 04:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:27 INFO - 'PWD': '/builds/slave/test', 04:47:27 INFO - 'SHELL': '/bin/bash', 04:47:27 INFO - 'SHLVL': '1', 04:47:27 INFO - 'TERM': 'linux', 04:47:27 INFO - 'TMOUT': '86400', 04:47:27 INFO - 'USER': 'cltbld', 04:47:27 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', 04:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:27 INFO - '_': '/tools/buildbot/bin/python'} 04:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:27 INFO - Running setup.py (path:/tmp/pip-iPKIXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:27 INFO - Running setup.py (path:/tmp/pip-pAS3C9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:27 INFO - Running setup.py (path:/tmp/pip-SxKxiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:28 INFO - Running setup.py (path:/tmp/pip-5O2p1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:28 INFO - Running setup.py (path:/tmp/pip-6QdwcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:28 INFO - Running setup.py (path:/tmp/pip-nbXZ2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:28 INFO - Running setup.py (path:/tmp/pip-nyhlcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:28 INFO - Running setup.py (path:/tmp/pip-0UMiCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:28 INFO - Running setup.py (path:/tmp/pip-vjHpA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:28 INFO - Running setup.py (path:/tmp/pip-W2fMhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:28 INFO - Running setup.py (path:/tmp/pip-puX_Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:28 INFO - Running setup.py (path:/tmp/pip-QmTAFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:28 INFO - Running setup.py (path:/tmp/pip-ghq5CW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:28 INFO - Running setup.py (path:/tmp/pip-t4TlED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:28 INFO - Running setup.py (path:/tmp/pip-JvmSRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:28 INFO - Running setup.py (path:/tmp/pip-IXwimL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:29 INFO - Running setup.py (path:/tmp/pip-IaT3sM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:47:29 INFO - Running setup.py install for manifestparser 04:47:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:47:29 INFO - Running setup.py install for mozcrash 04:47:29 INFO - Running setup.py install for mozdebug 04:47:29 INFO - Running setup.py install for mozdevice 04:47:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:47:29 INFO - Running setup.py install for mozfile 04:47:29 INFO - Running setup.py install for mozhttpd 04:47:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:47:29 INFO - Running setup.py install for mozinfo 04:47:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:47:29 INFO - Running setup.py install for mozInstall 04:47:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:47:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:47:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:47:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:47:29 INFO - Running setup.py install for mozleak 04:47:29 INFO - Running setup.py install for mozlog 04:47:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:47:30 INFO - Running setup.py install for moznetwork 04:47:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:47:30 INFO - Running setup.py install for mozprocess 04:47:30 INFO - Running setup.py install for mozprofile 04:47:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:47:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:47:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:47:30 INFO - Running setup.py install for mozrunner 04:47:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:47:30 INFO - Running setup.py install for mozscreenshot 04:47:30 INFO - Running setup.py install for moztest 04:47:30 INFO - Running setup.py install for mozversion 04:47:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:47:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:47:30 INFO - Cleaning up... 04:47:30 INFO - Return code: 0 04:47:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47: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')]} 04:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:30 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 0x27051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a71eb0>, '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 0x2a72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, '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': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', '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 04:47:30 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 04:47:30 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 04:47:30 INFO - Using env: {'DISPLAY': ':0', 04:47:30 INFO - 'HOME': '/home/cltbld', 04:47:30 INFO - 'LANG': 'en_US.UTF-8', 04:47:30 INFO - 'LANGUAGE': 'en_US:en', 04:47:30 INFO - 'LOGNAME': 'cltbld', 04:47:30 INFO - 'MAIL': '/var/mail/cltbld', 04:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:30 INFO - 'MOZ_NO_REMOTE': '1', 04:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:30 INFO - 'NO_EM_RESTART': '1', 04:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:30 INFO - 'PWD': '/builds/slave/test', 04:47:30 INFO - 'SHELL': '/bin/bash', 04:47:30 INFO - 'SHLVL': '1', 04:47:30 INFO - 'TERM': 'linux', 04:47:30 INFO - 'TMOUT': '86400', 04:47:30 INFO - 'USER': 'cltbld', 04:47:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', 04:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:30 INFO - '_': '/tools/buildbot/bin/python'} 04:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:31 INFO - Running setup.py (path:/tmp/pip-aDj_9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:31 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)) 04:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:31 INFO - Running setup.py (path:/tmp/pip-fYgWUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:31 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)) 04:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:31 INFO - Running setup.py (path:/tmp/pip-QyIRvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:31 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)) 04:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:31 INFO - Running setup.py (path:/tmp/pip-O69yh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:31 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)) 04:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:31 INFO - Running setup.py (path:/tmp/pip-HFiNQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:31 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)) 04:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:31 INFO - Running setup.py (path:/tmp/pip-mMaY4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:31 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)) 04:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:31 INFO - Running setup.py (path:/tmp/pip-rhf7gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:31 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)) 04:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:31 INFO - Running setup.py (path:/tmp/pip-97_x3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:31 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)) 04:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:31 INFO - Running setup.py (path:/tmp/pip-uDUFt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:31 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)) 04:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:31 INFO - Running setup.py (path:/tmp/pip-osbz1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:31 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)) 04:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:31 INFO - Running setup.py (path:/tmp/pip-aKiE1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:31 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)) 04:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:31 INFO - Running setup.py (path:/tmp/pip-JjC7N9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:31 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)) 04:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:31 INFO - Running setup.py (path:/tmp/pip-Mz7zCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:32 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)) 04:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:32 INFO - Running setup.py (path:/tmp/pip-XVcTfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:32 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)) 04:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:32 INFO - Running setup.py (path:/tmp/pip-VPk4Fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:32 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)) 04:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:32 INFO - Running setup.py (path:/tmp/pip-yCo51x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:32 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)) 04:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:32 INFO - Running setup.py (path:/tmp/pip-B3UEIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:32 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)) 04:47:32 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)) 04:47:32 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)) 04:47:32 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)) 04:47:32 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)) 04:47:32 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)) 04:47:32 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)) 04:47:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:47:32 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 04:47:32 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 04:47:32 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 04:47:32 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 04:47:33 INFO - Downloading blessings-1.6.tar.gz 04:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:47:33 INFO - Installing collected packages: blessings 04:47:33 INFO - Running setup.py install for blessings 04:47:33 INFO - Successfully installed blessings 04:47:33 INFO - Cleaning up... 04:47:33 INFO - Return code: 0 04:47:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:47:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:34 INFO - Reading from file tmpfile_stdout 04:47:34 INFO - Current package versions: 04:47:34 INFO - argparse == 1.2.1 04:47:34 INFO - blessings == 1.6 04:47:34 INFO - blobuploader == 1.2.4 04:47:34 INFO - docopt == 0.6.1 04:47:34 INFO - functools32 == 3.2.3-2 04:47:34 INFO - jsonschema == 2.5.1 04:47:34 INFO - manifestparser == 1.1 04:47:34 INFO - mozInstall == 1.13 04:47:34 INFO - mozcrash == 1.0 04:47:34 INFO - mozdebug == 0.1 04:47:34 INFO - mozdevice == 0.51 04:47:34 INFO - mozfile == 1.2 04:47:34 INFO - mozhttpd == 0.7 04:47:34 INFO - mozinfo == 0.10 04:47:34 INFO - mozleak == 0.1 04:47:34 INFO - mozlog == 3.5 04:47:34 INFO - moznetwork == 0.27 04:47:34 INFO - mozprocess == 0.25 04:47:34 INFO - mozprofile == 0.28 04:47:34 INFO - mozrunner == 6.13 04:47:34 INFO - mozscreenshot == 0.1 04:47:34 INFO - mozsystemmonitor == 0.3 04:47:34 INFO - moztest == 0.8 04:47:34 INFO - mozversion == 1.4 04:47:34 INFO - psutil == 3.1.1 04:47:34 INFO - requests == 1.2.3 04:47:34 INFO - wsgiref == 0.1.2 04:47:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47: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')]} 04:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:34 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 0x27051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a71eb0>, '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 0x2a72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, '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': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', '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 04:47:34 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 04:47:34 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 04:47:34 INFO - Using env: {'DISPLAY': ':0', 04:47:34 INFO - 'HOME': '/home/cltbld', 04:47:34 INFO - 'LANG': 'en_US.UTF-8', 04:47:34 INFO - 'LANGUAGE': 'en_US:en', 04:47:34 INFO - 'LOGNAME': 'cltbld', 04:47:34 INFO - 'MAIL': '/var/mail/cltbld', 04:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:34 INFO - 'MOZ_NO_REMOTE': '1', 04:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:34 INFO - 'NO_EM_RESTART': '1', 04:47:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:34 INFO - 'PWD': '/builds/slave/test', 04:47:34 INFO - 'SHELL': '/bin/bash', 04:47:34 INFO - 'SHLVL': '1', 04:47:34 INFO - 'TERM': 'linux', 04:47:34 INFO - 'TMOUT': '86400', 04:47:34 INFO - 'USER': 'cltbld', 04:47:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', 04:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:34 INFO - '_': '/tools/buildbot/bin/python'} 04:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:34 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)) 04:47:34 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)) 04:47:34 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)) 04:47:34 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)) 04:47:34 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)) 04:47:34 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)) 04:47:34 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)) 04:47:34 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)) 04:47:34 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)) 04:47:34 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:47: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 04:47: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 04:47: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 04:47: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 04:47:35 INFO - Downloading marionette_driver-1.4.0.tar.gz 04:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 04:47:35 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 04:47: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 04:47: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 04:47: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 04:47: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 04:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:47:35 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)) 04:47:35 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)) 04:47:35 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)) 04:47:35 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)) 04:47:35 INFO - Installing collected packages: marionette-driver, simplejson 04:47:35 INFO - Running setup.py install for marionette-driver 04:47:36 INFO - Running setup.py install for simplejson 04:47:36 INFO - building 'simplejson._speedups' extension 04:47:36 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 04:47:36 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 04:47:37 INFO - Successfully installed marionette-driver simplejson 04:47:37 INFO - Cleaning up... 04:47:37 INFO - Return code: 0 04:47:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:47:37 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')]} 04:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:37 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')]} 04:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:37 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 0x27051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a71eb0>, '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 0x2a72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, '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': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', '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 04:47:37 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 04:47:37 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 04:47:37 INFO - Using env: {'DISPLAY': ':0', 04:47:37 INFO - 'HOME': '/home/cltbld', 04:47:37 INFO - 'LANG': 'en_US.UTF-8', 04:47:37 INFO - 'LANGUAGE': 'en_US:en', 04:47:37 INFO - 'LOGNAME': 'cltbld', 04:47:37 INFO - 'MAIL': '/var/mail/cltbld', 04:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:37 INFO - 'MOZ_NO_REMOTE': '1', 04:47:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:37 INFO - 'NO_EM_RESTART': '1', 04:47:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:37 INFO - 'PWD': '/builds/slave/test', 04:47:37 INFO - 'SHELL': '/bin/bash', 04:47:37 INFO - 'SHLVL': '1', 04:47:37 INFO - 'TERM': 'linux', 04:47:37 INFO - 'TMOUT': '86400', 04:47:37 INFO - 'USER': 'cltbld', 04:47:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', 04:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:37 INFO - '_': '/tools/buildbot/bin/python'} 04:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:47:37 INFO - Cleaning up... 04:47:37 INFO - Return code: 0 04:47:37 INFO - Running post-action listener: _resource_record_post_action 04:47:37 INFO - Running post-action listener: _start_resource_monitoring 04:47:37 INFO - Starting resource monitoring. 04:47:37 INFO - [mozharness: 2017-07-24 11:47:37.407620Z] Finished create-virtualenv step (success) 04:47:37 INFO - [mozharness: 2017-07-24 11:47:37.408132Z] Running install step. 04:47:37 INFO - Running pre-action listener: _resource_record_pre_action 04:47:37 INFO - Running main action method: install 04:47:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:37 INFO - Reading from file tmpfile_stdout 04:47:37 INFO - Detecting whether we're running mozinstall >=1.0... 04:47:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:47:37 INFO - Reading from file tmpfile_stdout 04:47:37 INFO - Output received: 04:47:37 INFO - Usage: mozinstall [options] installer 04:47:37 INFO - Options: 04:47:37 INFO - -h, --help show this help message and exit 04:47:37 INFO - -d DEST, --destination=DEST 04:47:37 INFO - Directory to install application into. [default: 04:47:37 INFO - "/builds/slave/test"] 04:47:37 INFO - --app=APP Application being installed. [default: firefox] 04:47:37 INFO - mkdir: /builds/slave/test/build/application 04:47:37 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'] 04:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:47:55 INFO - Reading from file tmpfile_stdout 04:47:55 INFO - Output received: 04:47:55 INFO - /builds/slave/test/build/application/firefox/firefox 04:47:55 INFO - Running post-action listener: _resource_record_post_action 04:47:55 INFO - [mozharness: 2017-07-24 11:47:55.683105Z] Finished install step (success) 04:47:55 INFO - [mozharness: 2017-07-24 11:47:55.683357Z] Running setup-mitmproxy step. 04:47:55 INFO - Running pre-action listener: _resource_record_pre_action 04:47:55 INFO - Running main action method: setup_mitmproxy 04:47:55 INFO - Skipping: mitmproxy is not required 04:47:55 INFO - Running post-action listener: _resource_record_post_action 04:47:55 INFO - [mozharness: 2017-07-24 11:47:55.684485Z] Finished setup-mitmproxy step (success) 04:47:55 INFO - [mozharness: 2017-07-24 11:47:55.684707Z] Running run-tests step. 04:47:55 INFO - Running pre-action listener: _resource_record_pre_action 04:47:55 INFO - Running pre-action listener: _set_gcov_prefix 04:47:55 INFO - Running main action method: run_tests 04:47:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:55 INFO - Python 2.7.3 04:47:55 INFO - Return code: 0 04:47:55 INFO - grabbing minidump binary from tooltool 04:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:55 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 0x2a71eb0>, '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 0x2a72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:55 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 04:47:55 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 04:47:55 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 04:47:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:55 INFO - Return code: 0 04:47:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:47:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:55 INFO - ENV: RUST_BACKTRACE is now 1 04:47:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:47:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 04:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 04:47:55 INFO - Using env: {'DISPLAY': ':0', 04:47:55 INFO - 'HOME': '/home/cltbld', 04:47:55 INFO - 'LANG': 'en_US.UTF-8', 04:47:55 INFO - 'LANGUAGE': 'en_US:en', 04:47:55 INFO - 'LOGNAME': 'cltbld', 04:47:55 INFO - 'MAIL': '/var/mail/cltbld', 04:47:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:55 INFO - 'MOZ_NO_REMOTE': '1', 04:47:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:55 INFO - 'NO_EM_RESTART': '1', 04:47:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:55 INFO - 'PWD': '/builds/slave/test', 04:47:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:55 INFO - 'RUST_BACKTRACE': '1', 04:47:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:47:55 INFO - 'SHELL': '/bin/bash', 04:47:55 INFO - 'SHLVL': '1', 04:47:55 INFO - 'STYLO_FORCE_ENABLED': '1', 04:47:55 INFO - 'TERM': 'linux', 04:47:55 INFO - 'TMOUT': '86400', 04:47:55 INFO - 'USER': 'cltbld', 04:47:55 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809', 04:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:55 INFO - '_': '/tools/buildbot/bin/python'} 04:47:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 04:47:56 INFO - mozversion application_buildid: 20170724105843 04:47:56 INFO - mozversion application_changeset: 758016d026077ebaf65aaecc8df437a7164dd9b5 04:47:56 INFO - mozversion application_display_name: Nightly 04:47:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:56 INFO - mozversion application_name: Firefox 04:47:56 INFO - mozversion application_remotingname: firefox 04:47:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:47:56 INFO - mozversion application_vendor: Mozilla 04:47:56 INFO - mozversion application_version: 56.0a1 04:47:56 INFO - mozversion platform_buildid: 20170724105843 04:47:56 INFO - mozversion platform_changeset: 758016d026077ebaf65aaecc8df437a7164dd9b5 04:47:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:47:56 INFO - mozversion platform_version: 56.0a1 04:47:56 INFO - using testdate: 1500896876 04:47:56 INFO - actual date: 1500896876 04:47:56 INFO - starting webserver on 'localhost:53343' 04:47:56 INFO - SUITE-START | Running 2 tests 04:47:56 INFO - TEST-START | dromaeo_css 04:47:56 INFO - Initialising browser for dromaeo_css test... 04:47:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53343/getInfo.html -profile /tmp/tmpncZte_/profile 04:47:56 INFO - TEST-INFO | started process 27655 (/builds/slave/test/build/application/firefox/firefox http://localhost:53343/getInfo.html) 04:48:02 INFO - TEST-INFO | 27655: exit 0 04:48:02 INFO - Browser initialized. 04:48:02 INFO - Running cycle 1/1 for dromaeo_css test... 04:48:02 INFO - TEST-INFO | started process 27879 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpncZte_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:13 INFO - PID 27879 | RSS: Main: 179482624 04:48:13 INFO - PID 27879 | 04:51:12 INFO - PID 27879 | Cycle 1(1): loaded http://localhost:53343/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53343/tests/dromaeo/cssquery-ext.html) 04:51:14 INFO - PID 27879 | RSS: Main: 179310592 04:51:14 INFO - PID 27879 | 04:54:16 INFO - PID 27879 | Cycle 1(1): loaded http://localhost:53343/tests/dromaeo/cssquery-ext.html (next: http://localhost:53343/tests/dromaeo/cssquery-jquery.html) 04:54:16 INFO - PID 27879 | RSS: Main: 179384320 04:54:16 INFO - PID 27879 | 04:57:18 INFO - PID 27879 | Cycle 1(1): loaded http://localhost:53343/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53343/tests/dromaeo/cssquery-mootools.html) 04:57:19 INFO - PID 27879 | RSS: Main: 179654656 04:57:19 INFO - PID 27879 | 05:00:21 INFO - PID 27879 | Cycle 1(1): loaded http://localhost:53343/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53343/tests/dromaeo/cssquery-prototype.html) 05:00:21 INFO - PID 27879 | RSS: Main: 179568640 05:00:21 INFO - PID 27879 | 05:03:25 INFO - PID 27879 | Cycle 1(1): loaded http://localhost:53343/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53343/tests/dromaeo/cssquery-yui.html) 05:03:26 INFO - PID 27879 | RSS: Main: 180543488 05:03:26 INFO - PID 27879 | 05:06:28 INFO - PID 27879 | Cycle 1(1): loaded http://localhost:53343/tests/dromaeo/cssquery-yui.html (next: http://localhost:53343/tests/dromaeo/cssquery-dojo.html) 05:06:28 INFO - PID 27879 | RSS: Main: 183304192 05:06:28 INFO - PID 27879 | 05:06:28 INFO - PID 27879 | __start_tp_report 05:06:28 INFO - PID 27879 | _x_x_mozilla_page_load 05:06:28 INFO - PID 27879 | _x_x_mozilla_page_load_details 05:06:28 INFO - PID 27879 | |i|pagename|runs| 05:06:28 INFO - PID 27879 | |0;dojo.html;3105.8602362893666;3127.374525094981;3135.608048993876;3144.7484201263896;3173.7937034092784;6014.428629280223;6120;6175.814725558229;6191.13324134621;6212.192414986057;6059.2728872535245;6201.410865967737;6206.813795586128;6208.503319734422;6213.378662133784;5497.312835895523;5543.861403464925;5604.271444712182;5670.177824215507;5742.167385729067;5623.875224955005;5651.32184137904;5684.744186511596;5713.4572215639655;5730.713464326788;5450.781968721247;5452.836414907559;5525.11598144299;5706.343770466408;5708.400617935098;5160.664556803796;5557.861053473655;5601.60788744788;5623.212750214973;5643.351014633287;5532.806351777668;5539.196816461631;5541.141123125922;5591.329040515124;5633.887322253573;6009.909851352233;6048.1834952281315;6061.302950160743;6064.696765161724;6087.147799308056;6478.093066970628;6511.186101737283;6554.180727409074;6578.440832529241;6589.374009469141;6481.902771458384;6553.9344606553805;6641.103451034145;6650.600963942131;6727.058211850345;6054.636721796706;6123.9387606124255;6124.724387402578;6159.630422174729;6160.969195154085;6715.3620406061345;6822.283660215705;6839.863202735917;6840.384365407038;6843.657817109125;6456.612603243821;6467.062275969958;6517.283098859121;6531.3142120077655;6564.540482166202;6368.5860419072615;6478.967605161944;6522.902156467657;6527.771527996498;6580.177477815273;6518.902216466757;6530.2816690164045;6610.702518386588;6611.834704132339;6612.900806487906;6535;6556.082148499214;6556.967215163989;6660.433863121592;6660.60036397808;5292;5321.175217841163;5367.78528858849;5369.060414427459;5406.945930540723;4630.86107416778;4660.277656963176;4672.369230153954;4675.111728771522;4711.986922811612;5734.541236701054;5791.420857914259;5798.043322851767;5803.477687008105;5803.767849285981;6450.2259728831905;6615.040819081302;6620.602763834186;6667.799966001027;6704.932950670528;5662.915056274159;5663.348714897839;5674.546036317167;5679.318481782213;5689.886202276014;5814.912776308359;5816.389279125716;5863.179154918314;5870.354261031283;5885.735141918624;6381.776637817654;6384.425401713868;6452.22573291208;6480.51396145291;6484.286728459866;6474.223093228654;6500.3174666659315;6562.8359291018105;6675.666216689049;6682.899756503559;6294.464970477377;6310.179676642191;6316.494680425647;6318.052292156213;6425.742970281136;6468.094466774562;6492.805215843532;6571.080048793077;6577.967110164419;6598.3401659833635;6592.934070659232;6608.107905432705;6611.900821487778;6709.396154346132;6712.295209002984;6293.685315734104;6344.651044192614;6370.140031095742;6380.074889141141;6447.9355206447335;6273.780417685542;6287.402696743802;6287.434130928238;6288.874222515616;6298.968505157445;6232.470240029648;6249.1563638908165;6260.154879091265;6310.085037669604;6331.240251169705;6295;6329.335419780857;6409.551331406943;6423.389777971085;6468.708908099053;6132.908006379818;6157.568970172045;6205.379462053758;6210.130581718473;6241.656708881055 05:06:28 INFO - PID 27879 | |1;ext.html;830.3647709502231;860.1785295043234;877.083447797052;886.4725488334439;1149.499967514131;31228.531572026437;44058;45198.77400613001;45403.31895021569;45405.09189816202;44813;45296;45342.319865201964;45474;45519.08961820762;7636.427267954898;7835.0989636192;7836.177201393857;7840.4511684182135;7866.1347251802545;7714.6142692865415;7729.922700773005;7731;7750.302472777449;7774.222577742209;7779.455438119334;7823.647935842901;7854.6465409056445;7863.292303692667;7865.370770338359;7779.572123533203;7803;7805.882911756356;7819.687212511492;7831.6475758591005;7672.232776722339;7715.228477152296;7716.498427602188;7725.768226953201;7742.651580678883;40299.395509067384;41133.588664113275;41199.1760164798;41211;41259.7937010313;3616.6021737608844;3624.3294990426857;3626.0934766308424;3655.8720444784303;3662.8901132966053;32497.6750232497;32511;32535.186620334443;32552.511712324333;32748.508772368434;4960.6527543072;5000.149974504343;5034.320366750479;5039.773210205512;5040.84877453677;197224;197836;197963;198350;198893;50790.49209507932;51282.23076653853;51287;51540.74229628828;51654.741726291126;53958.19062713984;54114.45885541094;54211.72894135504;54229.45770542323;54369;14549.563513094412;14764.630884227765;15418.845811541965;15465.845341546665;15866.603334916488;12656.36718164088;12685.112042156961;12710.110292279453;12710.936445317715;12727.554535591395;14793.63015924589;14866;15024.248787560578;15058.472953446577;15121.621959451102;5944.375840536682;6014.879702405928;6076.270847498328;6151.5386346024225;6174.475169610543;978.574320170728;984.8522721591676;1011.701548043329;1017.7455636090978;1037.2635428845454;22453.887730561244;22729.204477843195;23506.9421876016;27257.1822845311;28450.857745711553;1076.8330908709006;1100.878903320634;1101.983470247947;1131.9151063670258;1135.1429670598645;12498.50005999768;12506.249625022347;12537.93731031339;12571.120021598583;12736.172148810298;231034;232411;233066;234907;235961;54492.45507544953;54612;54989.175162372594;55012.174817377774;55319;1434.103685196752;1458.0668372241773;1498.1460567476652;1500.7073620643869;1503.3159912239905;22757.658635120817;22873.885630572408;23019.309420717404;23365.649515256944;23546.136081364;38783.612163878;38992.80503597464;39007;39015.219695606494;39024.80487597544;197425;197991;198588;198863;198919;35392.46911296384;36078.819605902856;37807.81096094502;37998;38161.6183838158;46749.76625116853;48140.518594813606;48356.27465587949;48720;49053.50946490489;34425.31149377049;34493;35259.47110793289;35409;35430.114247144025;33659.49510757292;33870.66129338675;34244.82877585596;34656.82671586626;34677.65322346845;38595.03512412212;38642.42036369401;38745;38779;39593.20813583655;33702;34188.48717269193;34708.305833883685;34756.56704030694;34930.825345873105;23868.761312386654;23980.76019239855;24413.023479060637;24563.87718061398;24797.504049919262 05:06:28 INFO - PID 27879 | |2;jquery.html;570.566369559135;579.6000759475961;586.3725813379683;588.9116632505123;612.966286854223;22414.66378004329;23109.653355199687;23492.530149397;23615.409614759617;23703.762962370372;25052.74947250527;27134.050308239166;27145.185644430698;27186.72813271867;27284.181474555746;6666.400023997851;6843.486738494608;6849.1438570178725;6852.486063545229;6853.383195512403;6321.5890967087225;6595.20857497101;6607.900881486781;6712.395884370406;6762.966185169092;6569;6585.0780890675105;6585.57193782405;6592.835179120536;6592.93407065928;6573.539852210347;6582.967085164543;6588.308227636101;6595.802125936254;6596.769113081067;6163.352847950945;6164.4760195383;6166.07508873668;6171.907421388682;6177.845553861144;28778;29750.553741693893;30396.088117356514;30403.847980759954;30727.078187654406;1844.9538761530935;1887.5281179705073;1889.8015708350563;1891.877027993176;1892.7728672559244;18780.342688005854;19329.51676208092;19365.419037428757;19426.70859937102;19478.90260548688;2246.146464343555;2322.8606283622867;2324.2213858357472;2334.6147885598857;2481.6649752283392;139494.30252848772;142289;142434.2878285602;142471;142609;14439.783403248959;15481.458148964957;15507.069575825486;15515.922420388051;16111.758323625156;24123.396915077265;24131.15540956093;24202.87898560496;24215.75784242135;24223.7577624225;10001.24990625706;10075.546600402999;10224.335418197794;10269;10271.794564108826;8175;9370.39092458988;9381.953090234641;9402;9422.528873556295;8120.187981201832;9114.270858331318;9306.302027347841;9409.294302927308;9442.15020648145;2774.16774967513;2809.5083360411845;2849.3731379096566;2855.814372065809;2874.7125287471085;931.9580618872167;942.7501712046313;977.1449981266392;978.7198066431562;985.9063388978036;23203.883980580325;24368.390790230387;24609.63085553718;24895.253142405756;24995.250142495755;1015.7003683913264;1019.9292014629136;1032.4270030133198;1056.144522936424;1066.418801753031;11346.149038822121;11372.31766094037;11495.195336326544;11554.133439992034;11578.189526733217;524282;530499;551288;552550;554865;121371;126475;127476;129528;131271.34364328117;1227.459917636255;1267.8288431061874;1281.128832393981;1295.740851829619;1297.4031945305076;17334.133293335533;18058.367957121438;18156.364527241483;18524.351647692267;18562.907185463988;58455.4154458467;58521.414785853296;59096.11355829752;59894.401055988885;61814;72574.63712681402;72951.63524182345;73364;74478;74632.62683686547;15098.39606415731;15100.924495377452;15208.543743687707;15230.390784368945;15307.311170997109;23789.405264868517;23806.16678416247;23809.404764880324;23968.92139853676;24148.154814581405;18540.814591854447;18693.158807853408;18757.81242187615;18965.241390344232;19122.61754764869;15294.923525382303;15319.77020344718;15835.208239588204;16059.598510036874;16922.661546768748;18889.338873139925;19376.61246775085;19714.309999149962;19727.40817775469;19739.506512337306;15030.17334046638;15198.696026079637;15337.923310383376;15354.769678454608;15377.538673839803;17855.821441785414;19016.809831902057;19115.235390584778;19145.329913452963;19147.521311967314 05:06:28 INFO - PID 27879 | |3;mootools.html;1356.3150608942485;1417.5747275817253;1418.3971811979907;1435.389959267311;1441.3802065112002;13816.585502434931;13977.371018304175;14395.78406323906;14403.63990900228;14412.279386030683;13802.792958105636;14334.283285835718;14350.210738409383;14372;14403.711925761478;2638.3667919699324;2697.905573304935;2698.1635692935156;2699.78509670648;2699.878505467249;2452.5340185364726;2555.1184841229747;2570.9742902571015;2643.524165650182;2695.689995650496;2688.9058882939103;2725.74105459981;2728.5088684036964;2729.235813972081;2731.4810186064583;2583.4703885703384;2598.961015584777;2621.331560452082;2623.396618777692;2629.447815958651;2612.2163350994624;2651.973480265192;2652.907148249802;2653.9336516587045;2656.3093595665073;13404.46382144713;13704.10923289983;13714.382852771649;13719.45122195111;13729.931350343284;7570.810729731801;7843.215678432168;7844.176361482077;7850.214978502104;7852.3325517331095;5050;5236.816711415082;5289.761960711778;5331.653442526223;5350.117230656937;1898.7057006164066;1924.6054558815408;1928.1034319041573;1941.2720229913782;1948.6882098864255;22409.32772016842;22509.77490225093;22526.88736556323;22624.54750904989;22638.886805565868;6419.775307864203;6665.400113989765;6856.108705868305;7129.7861064168155;7179.748708795167;15947.44183953556;16133.354665813236;16162.434314798926;16181.514554563382;16221.513354599381;7659.961700191463;7673.577953212627;7868.960655196687;7939;7942.324902383362;6929.722811087601;7104.040954471184;7150.177729561167;7158.964205178941;7179.641017949081;4999.850004499798;5061.114304996611;5134.2298655201275;5171.198464237974;5191.065608190562;1332.4536939854613;1340.1289162044554;1469.0818238600875;1477.866991970728;1493.4474244529595;855.7432770168924;857.4340934982881;893.4326702543931;904.7738065483629;927.4296307770672;8237.258646721704;8259.545724985184;8375.790605234795;8518.616662250213;8547.316214702809;981.5337714585658;990.2078337330107;1016.9593216271414;1028.6348346337093;1032.230987914009;4937.432195297515;5101.591872650179;5162.8641698826195;5340.75966581497;5374.3013408256675;18459.261629534936;18510.259589616264;18686.43940681782;18866.056697165088;18894.433167005012;18160.091995400177;18523;18566.53583660392;18655.160517776734;18657.533561660795;10884.836727449094;10961.890381096246;11023;11044.668659940375;11045.171612129123;7409.851802964018;7629.351505121905;7688.192739762245;7730.724430468909;7804.726834560764;15761.605959850636;16732.498025059267;16780.32878684839;17347.653046939242;17420.912895435442;16632.168391580613;16968.321267149175;17123.828761712222;17155.399561015303;17264.136793160542;10337.9483102584;10385.117265032255;10432.634857779942;10608.469576521298;10620.256582039183;12911.935440322739;13209.207447553177;13215;13223.206607603575;13230.536931207362;10294.838084002444;10944.945275273572;10987.560497580007;11139.387333696724;11305.547778088785;10283.794324113625;10385.324953877975;10624.575016999233;10853.728656783327;11248.381339026104;9504.192143667866;9511.239100872051;9576.856347154659;9613.327067105236;9621.470819105016;6786.491013174131;7072.575645461289;7250.347468727839;7267.345938865527;7289.489735718449;7177.461690373348;7227.8554428912175;7334.779956601311;7399.519031262951;7442.144153422426 05:06:28 INFO - PID 27879 | |4;prototype.html;497.5696022940158;508.37723788359267;518.688175996264;519.6648161935551;529.068838843635;6107.38926107389;6243.219597550306;6273.874522509547;6298.079085878805;6340.936590634093;6075.848103797407;6120.47975922046;6121.969390153043;6136.785212517563;6162.291336496304;4949.109160351135;4951.885825689209;4960.181570040939;4994.425641051289;5012.172991456424;4772.355731976191;4915.729634870081;4937.432195297551;4968.950310496885;5007.724575148365;4852.320675105488;4923.950760492403;4951.3810773653295;4983.875403114915;5014.495651304613;4901.632377571696;4930.679505832145;4933.703977761345;4946.678465899723;4979.676321039121;4438.312061630452;4447.844325448594;4454.933176002362;4460.8661740147845;4545.840895568673;6086.786962456337;6125.203723515914;6125.632462052291;6134.533988296598;6164.815055548341;5651.993542292509;5731;5745.856353591152;5760.3951585083805;5797.652140871562;6406.423421892052;6412.519061070392;6458.160439142881;6515.348465153446;6547;4820.614350851958;4831.420229572439;4863.805447782084;4868.464468908453;4913.852584422473;6739.9904099736705;6849.212340580847;6880.139982502187;6885.724571017154;6924.826879328007;4909.729964851896;4922.1140194765285;4946.332245146931;4973.154563724175;4975.626827987843;5038.672486288379;5065.265536497261;5066.859956509756;5087.669301495391;5114.746887012706;5567.777288908479;5673.574481913873;5682.857928551819;5704.401037890962;5726;6245.750169993149;6430.485561155097;6448.548601597843;6526.7227041848;6577.177852768404;1672.6403823177832;1692.1708362902089;1740.7911050674;1746.9213885375189;1757.016071000244;971.7570607348163;1216.191232830158;1226.2090951336338;1231.2612432540584;1248.5505218121468;5517.393086760453;5674.943250567524;5723.7996670116345;5744.712764361849;5748.741306641211;6529.706163222666;6543.345665433419;6552.770653027121;6562.179727534059;6636.104125943032;5683.147527870769;5694.743736531866;5723.255976723;5765.3946335634155;5774.740136693859;3499.685028347461;3505.36903357393;3520.894373168809;3522.6437821438417;3569.7501174918025;6356.173697419306;6368.681565921685;6401.263854656681;6451.258105317855;6453.903191452132;6780.321967803279;6806.625635589991;6866.553674011173;6914.723411063501;6960.199577048705;6446.8388290293115;6452.387023232785;6536.581464858033;6551.312112228243;6559.311272316433;6680.32991752062;6701.363370479797;6748.662566871735;6754;6774.796756097127;6633.734650613921;6650.434713049445;6690.464762818866;6691.76578819739;6735.663216839041;6449.7097630605795;6476.125723027331;6506.892089709555;6507;6523.347665233438;4937.555619994074;4982.4768399317545;5021.748912554431;5028;5032.27032080339;6691.665416729242;6711.355717849158;6738.326167383222;6747.939045715713;6761.391474767098;6357.965451055617;6475.740970361321;6491.92883174271;6525.771597994048;6526.9347306528225;6307.24313082433;6355.364463553793;6413.518986075969;6414;6461.547691661539;6377.713002914973;6378.202724659418;6382.234131904202;6468.611883287018;6488.416042556192;6505.902411463737;6508.9349106508325;6563.245226798979;6563.982582699689;6584.901226481511;5731.283589551306;6237.5321850860455;6268.843278917881;6298.622082675054;6354.17395738551 05:06:28 INFO - PID 27879 | |5;yui.html;916.5921165081533;917.9127982841629;931.7856892914625;934.7522906429797;936.5036530638762;17738.11309434528;18812.43562693118;18828;18863.811361886375;21429;19754.209831606753;20432.28487002955;20454.693179602316;20503.69244461334;20518.794812051874;1004.4932601098334;1023.8361862102065;1027.794441111777;1029.2075102171323;1035.3735989726183;1038.672818062308;1044.1542350695922;1044.3681572648513;1045.3205416479311;1045.3362115056955;773.9342155916754;802.3821657323857;1043.572135424476;1094.3433939636234;1105.8562386889694;1086.5002099034455;1086.9565217391296;1090.6237348114928;1090.91818113641;1093.081811278526;793.1830214878685;797.6051854332085;798.0582912163644;798.2695833312512;798.4091772088613;18331.633367332714;18550.907245463823;19647.705284420746;19945.80054199454;20082.09630566628;20222.292219772386;20454.5909081819;20981.790182098135;20993.055312510973;21047.368578942504;16318.428854990138;16338.34646614134;16389.754153687703;16390.918045409697;16404.83595164045;3578.5169002184634;3618.7285953553323;3623.61951995042;3629.3648611493145;3637.217998130415;120504.99999999913;126952.36523817414;128114.3594282032;129655;133353;16660.41688540895;17118.743218851727;17292.740608890876;17302.22140003703;17439.389621363192;30999.380012400077;31035.534466983012;31434.685653143177;31450.685493145233;31624.525632115536;7541.962290188624;7923.405744569181;7927.128015918244;9029.367944243972;9082.863757043517;4110.958890411118;4192.45498085247;4211.157768446323;4228.9154216915485;4299.441072660534;4946.183879659888;4980.626453016038;5110.182370820651;5126.5898728101665;5136.101182293084;1029.4389557691077;1041.5937784264142;1044.639599338227;1045.3988956349976;1046.2414749306693;672.2705864137465;691.6126968897433;692.4938259286033;698.3819319901924;710.6375748368266;11347.319160850375;11871.169018168817;13390.330483475787;13485;13772.655683607789;675.8445557521798;686.4405509509834;696.1020283833899;710.1549156503744;715.9606221657859;5226.712530810842;5289.259503669489;5371.838844834661;5373.140297552451;5399.973000135053;101872.49063754633;102473;103719.48140259401;106505.46747266369;107864.46067769612;91365;92604;95149.5242523783;95185;96298.51850740702;80671.19328806754;80918.59540702259;82579;82806.58596706978;83898.16101839025;10404.583816647551;10480.947595261974;10754.085902698045;12242.877571224173;12645.241285522898;31401.115780677646;35745.67741292603;36460.088497787765;36706.8164659175;38184.618153818104;61279.08081378872;64931;67546;69716;69948;19360;19759.81441113538;19795.208191672173;19826.206951721768;19976.300829471482;20814.895925520275;21119.788802111783;21193.258235961668;21241.78758212398;21797;18715.532111697317;18825.623487529898;18913.810861891205;19203.423897283104;19351.12919918635;19158.13788379554;19316.806831932063;19328;20090.497737556678;20161.193552258334;17682.91158544199;18300.816991830445;18497;19193.32823351176;19547.8045219546;13678.31608419555;14843.480478183212;14988.2505874708;15088.094714316738;15175.62060948441;13079.280639564915;14447.638809029859;14584.927075364556;14803.777943330644;14840.7773883394 05:06:28 INFO - PID 27879 | __end_tp_report 05:06:28 INFO - PID 27879 | __start_cc_report 05:06:28 INFO - PID 27879 | _x_x_mozilla_cycle_collect,386 05:06:28 INFO - PID 27879 | __end_cc_report 05:06:28 INFO - PID 27879 | __startTimestamp1500897988475__endTimestamp 05:06:28 INFO - PID 27879 | 05:06:28 INFO - PID 27879 | ------- Summary: start ------- 05:06:28 INFO - PID 27879 | Number of tests: 6 05:06:28 INFO - PID 27879 | 05:06:28 INFO - PID 27879 | [#0] dojo.html Cycles:165 Average:6051.80 Median:6260.15 stddev:703.75 (11.2%) stddev-sans-first:666.89 05:06:28 INFO - PID 27879 | Values: 3105.9 3127.4 3135.6 3144.7 3173.8 6014.4 6120.0 6175.8 6191.1 6212.2 6059.3 6201.4 6206.8 6208.5 6213.4 5497.3 5543.9 5604.3 5670.2 5742.2 5623.9 5651.3 5684.7 5713.5 5730.7 5450.8 5452.8 5525.1 5706.3 5708.4 5160.7 5557.9 5601.6 5623.2 5643.4 5532.8 5539.2 5541.1 5591.3 5633.9 6009.9 6048.2 6061.3 6064.7 6087.1 6478.1 6511.2 6554.2 6578.4 6589.4 6481.9 6553.9 6641.1 6650.6 6727.1 6054.6 6123.9 6124.7 6159.6 6161.0 6715.4 6822.3 6839.9 6840.4 6843.7 6456.6 6467.1 6517.3 6531.3 6564.5 6368.6 6479.0 6522.9 6527.8 6580.2 6518.9 6530.3 6610.7 6611.8 6612.9 6535.0 6556.1 6557.0 6660.4 6660.6 5292.0 5321.2 5367.8 5369.1 5406.9 4630.9 4660.3 4672.4 4675.1 4712.0 5734.5 5791.4 5798.0 5803.5 5803.8 6450.2 6615.0 6620.6 6667.8 6704.9 5662.9 5663.3 5674.5 5679.3 5689.9 5814.9 5816.4 5863.2 5870.4 5885.7 6381.8 6384.4 6452.2 6480.5 6484.3 6474.2 6500.3 6562.8 6675.7 6682.9 6294.5 6310.2 6316.5 6318.1 6425.7 6468.1 6492.8 6571.1 6578.0 6598.3 6592.9 6608.1 6611.9 6709.4 6712.3 6293.7 6344.7 6370.1 6380.1 6447.9 6273.8 6287.4 6287.4 6288.9 6299.0 6232.5 6249.2 6260.2 6310.1 6331.2 6295.0 6329.3 6409.6 6423.4 6468.7 6132.9 6157.6 6205.4 6210.1 6241.7 05:06:28 INFO - PID 27879 | 05:06:28 INFO - PID 27879 | [#1] ext.html Cycles:180 Average:39003.30 Median:3659.38 stddev:54602.67 (1492.1%) stddev-sans-first:54680.61 05:06:28 INFO - PID 27879 | Values: 830.4 860.2 877.1 886.5 1149.5 31228.5 44058.0 45198.8 45403.3 45405.1 44813.0 45296.0 45342.3 45474.0 45519.1 7636.4 7835.1 7836.2 7840.5 7866.1 7714.6 7729.9 7731.0 7750.3 7774.2 7779.5 7823.6 7854.6 7863.3 7865.4 7779.6 7803.0 7805.9 7819.7 7831.6 7672.2 7715.2 7716.5 7725.8 7742.7 40299.4 41133.6 41199.2 41211.0 41259.8 3616.6 3624.3 3626.1 3655.9 3662.9 32497.7 32511.0 32535.2 32552.5 32748.5 4960.7 5000.1 5034.3 5039.8 5040.8 197224.0 197836.0 197963.0 198350.0 198893.0 50790.5 51282.2 51287.0 51540.7 51654.7 53958.2 54114.5 54211.7 54229.5 54369.0 14549.6 14764.6 15418.8 15465.8 15866.6 12656.4 12685.1 12710.1 12710.9 12727.6 14793.6 14866.0 15024.2 15058.5 15121.6 5944.4 6014.9 6076.3 6151.5 6174.5 978.6 984.9 1011.7 1017.7 1037.3 22453.9 22729.2 23506.9 27257.2 28450.9 1076.8 1100.9 1102.0 1131.9 1135.1 12498.5 12506.2 12537.9 12571.1 12736.2 231034.0 232411.0 233066.0 234907.0 235961.0 54492.5 54612.0 54989.2 55012.2 55319.0 1434.1 1458.1 1498.1 1500.7 1503.3 22757.7 22873.9 23019.3 23365.6 23546.1 38783.6 38992.8 39007.0 39015.2 39024.8 197425.0 197991.0 198588.0 198863.0 198919.0 35392.5 36078.8 37807.8 37998.0 38161.6 46749.8 48140.5 48356.3 48720.0 49053.5 34425.3 34493.0 35259.5 35409.0 35430.1 33659.5 33870.7 34244.8 34656.8 34677.7 38595.0 38642.4 38745.0 38779.0 39593.2 33702.0 34188.5 34708.3 34756.6 34930.8 23868.8 23980.8 24413.0 24563.9 24797.5 05:06:28 INFO - PID 27879 | 05:06:28 INFO - PID 27879 | [#2] jquery.html Cycles:180 Average:37147.93 Median:23797.79 stddev:91172.58 (383.1%) stddev-sans-first:91386.98 05:06:28 INFO - PID 27879 | Values: 570.6 579.6 586.4 588.9 613.0 22414.7 23109.7 23492.5 23615.4 23703.8 25052.7 27134.1 27145.2 27186.7 27284.2 6666.4 6843.5 6849.1 6852.5 6853.4 6321.6 6595.2 6607.9 6712.4 6763.0 6569.0 6585.1 6585.6 6592.8 6592.9 6573.5 6583.0 6588.3 6595.8 6596.8 6163.4 6164.5 6166.1 6171.9 6177.8 28778.0 29750.6 30396.1 30403.8 30727.1 1845.0 1887.5 1889.8 1891.9 1892.8 18780.3 19329.5 19365.4 19426.7 19478.9 2246.1 2322.9 2324.2 2334.6 2481.7 139494.3 142289.0 142434.3 142471.0 142609.0 14439.8 15481.5 15507.1 15515.9 16111.8 24123.4 24131.2 24202.9 24215.8 24223.8 10001.2 10075.5 10224.3 10269.0 10271.8 8175.0 9370.4 9382.0 9402.0 9422.5 8120.2 9114.3 9306.3 9409.3 9442.2 2774.2 2809.5 2849.4 2855.8 2874.7 932.0 942.8 977.1 978.7 985.9 23203.9 24368.4 24609.6 24895.3 24995.3 1015.7 1019.9 1032.4 1056.1 1066.4 11346.1 11372.3 11495.2 11554.1 11578.2 524282.0 530499.0 551288.0 552550.0 554865.0 121371.0 126475.0 127476.0 129528.0 131271.3 1227.5 1267.8 1281.1 1295.7 1297.4 17334.1 18058.4 18156.4 18524.4 18562.9 58455.4 58521.4 59096.1 59894.4 61814.0 72574.6 72951.6 73364.0 74478.0 74632.6 15098.4 15100.9 15208.5 15230.4 15307.3 23789.4 23806.2 23809.4 23968.9 24148.2 18540.8 18693.2 18757.8 18965.2 19122.6 15294.9 15319.8 15835.2 16059.6 16922.7 18889.3 19376.6 19714.3 19727.4 19739.5 15030.2 15198.7 15337.9 15354.8 15377.5 17855.8 19016.8 19115.2 19145.3 19147.5 05:06:28 INFO - PID 27879 | 05:06:28 INFO - PID 27879 | [#3] mootools.html Cycles:180 Average:8698.02 Median:2577.22 stddev:5808.83 (225.4%) stddev-sans-first:5798.93 05:06:28 INFO - PID 27879 | Values: 1356.3 1417.6 1418.4 1435.4 1441.4 13816.6 13977.4 14395.8 14403.6 14412.3 13802.8 14334.3 14350.2 14372.0 14403.7 2638.4 2697.9 2698.2 2699.8 2699.9 2452.5 2555.1 2571.0 2643.5 2695.7 2688.9 2725.7 2728.5 2729.2 2731.5 2583.5 2599.0 2621.3 2623.4 2629.4 2612.2 2652.0 2652.9 2653.9 2656.3 13404.5 13704.1 13714.4 13719.5 13729.9 7570.8 7843.2 7844.2 7850.2 7852.3 5050.0 5236.8 5289.8 5331.7 5350.1 1898.7 1924.6 1928.1 1941.3 1948.7 22409.3 22509.8 22526.9 22624.5 22638.9 6419.8 6665.4 6856.1 7129.8 7179.7 15947.4 16133.4 16162.4 16181.5 16221.5 7660.0 7673.6 7869.0 7939.0 7942.3 6929.7 7104.0 7150.2 7159.0 7179.6 4999.9 5061.1 5134.2 5171.2 5191.1 1332.5 1340.1 1469.1 1477.9 1493.4 855.7 857.4 893.4 904.8 927.4 8237.3 8259.5 8375.8 8518.6 8547.3 981.5 990.2 1017.0 1028.6 1032.2 4937.4 5101.6 5162.9 5340.8 5374.3 18459.3 18510.3 18686.4 18866.1 18894.4 18160.1 18523.0 18566.5 18655.2 18657.5 10884.8 10961.9 11023.0 11044.7 11045.2 7409.9 7629.4 7688.2 7730.7 7804.7 15761.6 16732.5 16780.3 17347.7 17420.9 16632.2 16968.3 17123.8 17155.4 17264.1 10337.9 10385.1 10432.6 10608.5 10620.3 12911.9 13209.2 13215.0 13223.2 13230.5 10294.8 10944.9 10987.6 11139.4 11305.5 10283.8 10385.3 10624.6 10853.7 11248.4 9504.2 9511.2 9576.9 9613.3 9621.5 6786.5 7072.6 7250.3 7267.3 7289.5 7177.5 7227.9 7334.8 7399.5 7442.1 05:06:28 INFO - PID 27879 | 05:06:28 INFO - PID 27879 | [#4] prototype.html Cycles:180 Average:5476.32 Median:6125.42 stddev:1539.58 (25.1%) stddev-sans-first:1497.86 05:06:28 INFO - PID 27879 | Values: 497.6 508.4 518.7 519.7 529.1 6107.4 6243.2 6273.9 6298.1 6340.9 6075.8 6120.5 6122.0 6136.8 6162.3 4949.1 4951.9 4960.2 4994.4 5012.2 4772.4 4915.7 4937.4 4969.0 5007.7 4852.3 4924.0 4951.4 4983.9 5014.5 4901.6 4930.7 4933.7 4946.7 4979.7 4438.3 4447.8 4454.9 4460.9 4545.8 6086.8 6125.2 6125.6 6134.5 6164.8 5652.0 5731.0 5745.9 5760.4 5797.7 6406.4 6412.5 6458.2 6515.3 6547.0 4820.6 4831.4 4863.8 4868.5 4913.9 6740.0 6849.2 6880.1 6885.7 6924.8 4909.7 4922.1 4946.3 4973.2 4975.6 5038.7 5065.3 5066.9 5087.7 5114.7 5567.8 5673.6 5682.9 5704.4 5726.0 6245.8 6430.5 6448.5 6526.7 6577.2 1672.6 1692.2 1740.8 1746.9 1757.0 971.8 1216.2 1226.2 1231.3 1248.6 5517.4 5674.9 5723.8 5744.7 5748.7 6529.7 6543.3 6552.8 6562.2 6636.1 5683.1 5694.7 5723.3 5765.4 5774.7 3499.7 3505.4 3520.9 3522.6 3569.8 6356.2 6368.7 6401.3 6451.3 6453.9 6780.3 6806.6 6866.6 6914.7 6960.2 6446.8 6452.4 6536.6 6551.3 6559.3 6680.3 6701.4 6748.7 6754.0 6774.8 6633.7 6650.4 6690.5 6691.8 6735.7 6449.7 6476.1 6506.9 6507.0 6523.3 4937.6 4982.5 5021.7 5028.0 5032.3 6691.7 6711.4 6738.3 6747.9 6761.4 6358.0 6475.7 6491.9 6525.8 6526.9 6307.2 6355.4 6413.5 6414.0 6461.5 6377.7 6378.2 6382.2 6468.6 6488.4 6505.9 6508.9 6563.2 6564.0 6584.9 5731.3 6237.5 6268.8 6298.6 6354.2 05:06:28 INFO - PID 27879 | 05:06:28 INFO - PID 27879 | [#5] yui.html Cycles:180 Average:23373.77 Median:20086.30 stddev:31213.27 (155.4%) stddev-sans-first:31255.28 05:06:28 INFO - PID 27879 | Values: 916.6 917.9 931.8 934.8 936.5 17738.1 18812.4 18828.0 18863.8 21429.0 19754.2 20432.3 20454.7 20503.7 20518.8 1004.5 1023.8 1027.8 1029.2 1035.4 1038.7 1044.2 1044.4 1045.3 1045.3 773.9 802.4 1043.6 1094.3 1105.9 1086.5 1087.0 1090.6 1090.9 1093.1 793.2 797.6 798.1 798.3 798.4 18331.6 18550.9 19647.7 19945.8 20082.1 20222.3 20454.6 20981.8 20993.1 21047.4 16318.4 16338.3 16389.8 16390.9 16404.8 3578.5 3618.7 3623.6 3629.4 3637.2 120505.0 126952.4 128114.4 129655.0 133353.0 16660.4 17118.7 17292.7 17302.2 17439.4 30999.4 31035.5 31434.7 31450.7 31624.5 7542.0 7923.4 7927.1 9029.4 9082.9 4111.0 4192.5 4211.2 4228.9 4299.4 4946.2 4980.6 5110.2 5126.6 5136.1 1029.4 1041.6 1044.6 1045.4 1046.2 672.3 691.6 692.5 698.4 710.6 11347.3 11871.2 13390.3 13485.0 13772.7 675.8 686.4 696.1 710.2 716.0 5226.7 5289.3 5371.8 5373.1 5400.0 101872.5 102473.0 103719.5 106505.5 107864.5 91365.0 92604.0 95149.5 95185.0 96298.5 80671.2 80918.6 82579.0 82806.6 83898.2 10404.6 10480.9 10754.1 12242.9 12645.2 31401.1 35745.7 36460.1 36706.8 38184.6 61279.1 64931.0 67546.0 69716.0 69948.0 19360.0 19759.8 19795.2 19826.2 19976.3 20814.9 21119.8 21193.3 21241.8 21797.0 18715.5 18825.6 18913.8 19203.4 19351.1 19158.1 19316.8 19328.0 20090.5 20161.2 17682.9 18300.8 18497.0 19193.3 19547.8 13678.3 14843.5 14988.3 15088.1 15175.6 13079.3 14447.6 14584.9 14803.8 14840.8 05:06:28 INFO - PID 27879 | -------- Summary: end -------- 05:06:28 INFO - PID 27879 | 05:06:29 INFO - TEST-INFO | 27879: exit 0 05:06:29 INFO - TEST-OK | dromaeo_css | took 1113146ms 05:06:29 INFO - TEST-START | kraken 05:06:29 INFO - Initialising browser for kraken test... 05:06:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53343/getInfo.html -profile /tmp/tmpt7UIoT/profile 05:06:29 INFO - TEST-INFO | started process 28254 (/builds/slave/test/build/application/firefox/firefox http://localhost:53343/getInfo.html) 05:06:35 INFO - TEST-INFO | 28254: exit 0 05:06:35 INFO - Browser initialized. 05:06:35 INFO - Running cycle 1/1 for kraken test... 05:06:35 INFO - TEST-INFO | started process 28481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt7UIoT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:46 INFO - PID 28481 | RSS: Main: 175939584 05:06:46 INFO - PID 28481 | 05:06:49 INFO - PID 28481 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53343/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:50 INFO - PID 28481 | RSS: Main: 182386688 05:06:50 INFO - PID 28481 | 05:06:53 INFO - PID 28481 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53343/tests/kraken/driver.html?testName=audio-dft) 05:06:53 INFO - PID 28481 | RSS: Main: 182439936 05:06:53 INFO - PID 28481 | 05:06:56 INFO - PID 28481 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53343/tests/kraken/driver.html?testName=audio-fft) 05:06:57 INFO - PID 28481 | RSS: Main: 177131520 05:06:57 INFO - PID 28481 | 05:06:59 INFO - PID 28481 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53343/tests/kraken/driver.html?testName=audio-oscillator) 05:07:00 INFO - PID 28481 | RSS: Main: 177561600 05:07:00 INFO - PID 28481 | 05:07:02 INFO - PID 28481 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53343/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:07:03 INFO - PID 28481 | RSS: Main: 178147328 05:07:03 INFO - PID 28481 | 05:07:06 INFO - PID 28481 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53343/tests/kraken/driver.html?testName=imaging-darkroom) 05:07:06 INFO - PID 28481 | RSS: Main: 180871168 05:07:06 INFO - PID 28481 | 05:07:10 INFO - PID 28481 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53343/tests/kraken/driver.html?testName=imaging-desaturate) 05:07:10 INFO - PID 28481 | RSS: Main: 180547584 05:07:10 INFO - PID 28481 | 05:07:13 INFO - PID 28481 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53343/tests/kraken/driver.html?testName=json-parse-financial) 05:07:14 INFO - PID 28481 | RSS: Main: 181678080 05:07:14 INFO - PID 28481 | 05:07:16 INFO - PID 28481 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53343/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:07:16 INFO - PID 28481 | RSS: Main: 181346304 05:07:16 INFO - PID 28481 | 05:07:18 INFO - PID 28481 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:07:19 INFO - PID 28481 | RSS: Main: 178335744 05:07:19 INFO - PID 28481 | 05:07:21 INFO - PID 28481 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:07:21 INFO - PID 28481 | RSS: Main: 177934336 05:07:21 INFO - PID 28481 | 05:07:24 INFO - PID 28481 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:07:25 INFO - PID 28481 | RSS: Main: 178270208 05:07:25 INFO - PID 28481 | 05:07:28 INFO - PID 28481 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:07:29 INFO - PID 28481 | RSS: Main: 179109888 05:07:29 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53343/tests/kraken/driver.html?testName=ai-astar) 05:07:31 INFO - PID 28481 | RSS: Main: 180477952 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | __start_tp_report 05:07:31 INFO - PID 28481 | _x_x_mozilla_page_load 05:07:31 INFO - PID 28481 | _x_x_mozilla_page_load_details 05:07:31 INFO - PID 28481 | |i|pagename|runs| 05:07:31 INFO - PID 28481 | |0;ai-astar;100;110;102;109;110;110;115;102;109;111 05:07:31 INFO - PID 28481 | |1;audio-beat-detection;144;125;151;180;121;150;141;126;165;121 05:07:31 INFO - PID 28481 | |2;audio-dft;164;164;163;165;164;164;165;164;175;164 05:07:31 INFO - PID 28481 | |3;audio-fft;75;74;74;172;77;74;81;75;145;76 05:07:31 INFO - PID 28481 | |4;audio-oscillator;81;81;140;82;81;81;140;83;82;131 05:07:31 INFO - PID 28481 | |5;imaging-gaussian-blur;114;113;114;114;113;114;115;114;115;118 05:07:31 INFO - PID 28481 | |6;imaging-darkroom;151;152;152;151;151;153;153;151;150;151 05:07:31 INFO - PID 28481 | |7;imaging-desaturate;96;95;98;99;98;99;94;95;95;94 05:07:31 INFO - PID 28481 | |8;json-parse-financial;55;56;54;56;54;55;54;54;55;54 05:07:31 INFO - PID 28481 | |9;json-stringify-tinderbox;54;61;58;54;54;55;55;59;54;54 05:07:31 INFO - PID 28481 | |10;stanford-crypto-aes;85;90;79;80;78;87;80;78;81;78 05:07:31 INFO - PID 28481 | |11;stanford-crypto-ccm;145;132;144;133;134;132;125;131;136;179 05:07:31 INFO - PID 28481 | |12;stanford-crypto-pbkdf2;188;177;181;177;182;177;180;176;196;181 05:07:31 INFO - PID 28481 | |13;stanford-crypto-sha256-iterative;71;72;81;76;70;68;68;68;69;68 05:07:31 INFO - PID 28481 | __end_tp_report 05:07:31 INFO - PID 28481 | __start_cc_report 05:07:31 INFO - PID 28481 | _x_x_mozilla_cycle_collect,976 05:07:31 INFO - PID 28481 | __end_cc_report 05:07:31 INFO - PID 28481 | __startTimestamp1500898051258__endTimestamp 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | ------- Summary: start ------- 05:07:31 INFO - PID 28481 | Number of tests: 14 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | [#0] ai-astar Cycles:10 Average:107.80 Median:110.00 stddev:4.80 (4.4%) stddev-sans-first:4.18 05:07:31 INFO - PID 28481 | Values: 100.0 110.0 102.0 109.0 110.0 110.0 115.0 102.0 109.0 111.0 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:147.00 stddev:19.86 (13.5%) stddev-sans-first:21.05 05:07:31 INFO - PID 28481 | Values: 144.0 125.0 151.0 180.0 121.0 150.0 141.0 126.0 165.0 121.0 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.00 stddev:3.49 (2.1%) stddev-sans-first:3.67 05:07:31 INFO - PID 28481 | Values: 164.0 164.0 163.0 165.0 164.0 164.0 165.0 164.0 175.0 164.0 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.00 stddev:35.53 (47.4%) stddev-sans-first:37.13 05:07:31 INFO - PID 28481 | Values: 75.0 74.0 74.0 172.0 77.0 74.0 81.0 75.0 145.0 76.0 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:81.00 stddev:26.89 (33.2%) stddev-sans-first:27.80 05:07:31 INFO - PID 28481 | Values: 81.0 81.0 140.0 82.0 81.0 81.0 140.0 83.0 82.0 131.0 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.43 (1.3%) stddev-sans-first:1.51 05:07:31 INFO - PID 28481 | Values: 114.0 113.0 114.0 114.0 113.0 114.0 115.0 114.0 115.0 118.0 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 05:07:31 INFO - PID 28481 | Values: 151.0 152.0 152.0 151.0 151.0 153.0 153.0 151.0 150.0 151.0 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:97.00 stddev:2.00 (2.1%) stddev-sans-first:2.12 05:07:31 INFO - PID 28481 | Values: 96.0 95.0 98.0 99.0 98.0 99.0 94.0 95.0 95.0 94.0 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 05:07:31 INFO - PID 28481 | Values: 55.0 56.0 54.0 56.0 54.0 55.0 54.0 54.0 55.0 54.0 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:55.00 stddev:2.57 (4.7%) stddev-sans-first:2.65 05:07:31 INFO - PID 28481 | Values: 54.0 61.0 58.0 54.0 54.0 55.0 55.0 59.0 54.0 54.0 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:80.50 stddev:4.25 (5.3%) stddev-sans-first:4.32 05:07:31 INFO - PID 28481 | Values: 85.0 90.0 79.0 80.0 78.0 87.0 80.0 78.0 81.0 78.0 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:135.00 stddev:15.23 (11.3%) stddev-sans-first:16.01 05:07:31 INFO - PID 28481 | Values: 145.0 132.0 144.0 133.0 134.0 132.0 125.0 131.0 136.0 179.0 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.50 Median:181.00 stddev:6.20 (3.4%) stddev-sans-first:6.12 05:07:31 INFO - PID 28481 | Values: 188.0 177.0 181.0 177.0 182.0 177.0 180.0 176.0 196.0 181.0 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:70.50 stddev:4.31 (6.1%) stddev-sans-first:4.57 05:07:31 INFO - PID 28481 | Values: 71.0 72.0 81.0 76.0 70.0 68.0 68.0 68.0 69.0 68.0 05:07:31 INFO - PID 28481 | -------- Summary: end -------- 05:07:31 INFO - PID 28481 | 05:07:31 INFO - PID 28481 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:07:32 INFO - TEST-INFO | 28481: exit 0 05:07:32 INFO - TEST-OK | kraken | took 62860ms 05:07:32 INFO - SUITE-END | took 1176s 05:07:32 INFO - Completed test suite (00:19:36) 05:07:32 INFO - javascript benchmark 05:07:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8533.490609721552, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.8602362893666, 3127.374525094981, 3135.608048993876, 3144.7484201263896, 3173.7937034092784, 6014.428629280223, 6120.0, 6175.814725558229, 6191.13324134621, 6212.192414986057, 6059.2728872535245, 6201.410865967737, 6206.813795586128, 6208.503319734422, 6213.378662133784, 5497.312835895523, 5543.861403464925, 5604.271444712182, 5670.177824215507, 5742.167385729067, 5623.875224955005, 5651.32184137904, 5684.744186511596, 5713.4572215639655, 5730.713464326788, 5450.781968721247, 5452.836414907559, 5525.11598144299, 5706.343770466408, 5708.400617935098, 5160.664556803796, 5557.861053473655, 5601.60788744788, 5623.212750214973, 5643.351014633287, 5532.806351777668, 5539.196816461631, 5541.141123125922, 5591.329040515124, 5633.887322253573, 6009.909851352233, 6048.1834952281315, 6061.302950160743, 6064.696765161724, 6087.147799308056, 6478.093066970628, 6511.186101737283, 6554.180727409074, 6578.440832529241, 6589.374009469141, 6481.902771458384, 6553.9344606553805, 6641.103451034145, 6650.600963942131, 6727.058211850345, 6054.636721796706, 6123.9387606124255, 6124.724387402578, 6159.630422174729, 6160.969195154085, 6715.3620406061345, 6822.283660215705, 6839.863202735917, 6840.384365407038, 6843.657817109125, 6456.612603243821, 6467.062275969958, 6517.283098859121, 6531.3142120077655, 6564.540482166202, 6368.5860419072615, 6478.967605161944, 6522.902156467657, 6527.771527996498, 6580.177477815273, 6518.902216466757, 6530.2816690164045, 6610.702518386588, 6611.834704132339, 6612.900806487906, 6535.0, 6556.082148499214, 6556.967215163989, 6660.433863121592, 6660.60036397808, 5292.0, 5321.175217841163, 5367.78528858849, 5369.060414427459, 5406.945930540723, 4630.86107416778, 4660.277656963176, 4672.369230153954, 4675.111728771522, 4711.986922811612, 5734.541236701054, 5791.420857914259, 5798.043322851767, 5803.477687008105, 5803.767849285981, 6450.2259728831905, 6615.040819081302, 6620.602763834186, 6667.799966001027, 6704.932950670528, 5662.915056274159, 5663.348714897839, 5674.546036317167, 5679.318481782213, 5689.886202276014, 5814.912776308359, 5816.389279125716, 5863.179154918314, 5870.354261031283, 5885.735141918624, 6381.776637817654, 6384.425401713868, 6452.22573291208, 6480.51396145291, 6484.286728459866, 6474.223093228654, 6500.3174666659315, 6562.8359291018105, 6675.666216689049, 6682.899756503559, 6294.464970477377, 6310.179676642191, 6316.494680425647, 6318.052292156213, 6425.742970281136, 6468.094466774562, 6492.805215843532, 6571.080048793077, 6577.967110164419, 6598.3401659833635, 6592.934070659232, 6608.107905432705, 6611.900821487778, 6709.396154346132, 6712.295209002984, 6293.685315734104, 6344.651044192614, 6370.140031095742, 6380.074889141141, 6447.9355206447335, 6273.780417685542, 6287.402696743802, 6287.434130928238, 6288.874222515616, 6298.968505157445, 6232.470240029648, 6249.1563638908165, 6260.154879091265, 6310.085037669604, 6331.240251169705, 6295.0, 6329.335419780857, 6409.551331406943, 6423.389777971085, 6468.708908099053, 6132.908006379818, 6157.568970172045, 6205.379462053758, 6210.130581718473, 6241.656708881055], "value": 6000.158284030301, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.3647709502231, 860.1785295043234, 877.083447797052, 886.4725488334439, 1149.499967514131, 31228.531572026437, 44058.0, 45198.77400613001, 45403.31895021569, 45405.09189816202, 44813.0, 45296.0, 45342.319865201964, 45474.0, 45519.08961820762, 7636.427267954898, 7835.0989636192, 7836.177201393857, 7840.4511684182135, 7866.1347251802545, 7714.6142692865415, 7729.922700773005, 7731.0, 7750.302472777449, 7774.222577742209, 7779.455438119334, 7823.647935842901, 7854.6465409056445, 7863.292303692667, 7865.370770338359, 7779.572123533203, 7803.0, 7805.882911756356, 7819.687212511492, 7831.6475758591005, 7672.232776722339, 7715.228477152296, 7716.498427602188, 7725.768226953201, 7742.651580678883, 40299.395509067384, 41133.588664113275, 41199.1760164798, 41211.0, 41259.7937010313, 3616.6021737608844, 3624.3294990426857, 3626.0934766308424, 3655.8720444784303, 3662.8901132966053, 32497.6750232497, 32511.0, 32535.186620334443, 32552.511712324333, 32748.508772368434, 4960.6527543072, 5000.149974504343, 5034.320366750479, 5039.773210205512, 5040.84877453677, 197224.0, 197836.0, 197963.0, 198350.0, 198893.0, 50790.49209507932, 51282.23076653853, 51287.0, 51540.74229628828, 51654.741726291126, 53958.19062713984, 54114.45885541094, 54211.72894135504, 54229.45770542323, 54369.0, 14549.563513094412, 14764.630884227765, 15418.845811541965, 15465.845341546665, 15866.603334916488, 12656.36718164088, 12685.112042156961, 12710.110292279453, 12710.936445317715, 12727.554535591395, 14793.63015924589, 14866.0, 15024.248787560578, 15058.472953446577, 15121.621959451102, 5944.375840536682, 6014.879702405928, 6076.270847498328, 6151.5386346024225, 6174.475169610543, 978.574320170728, 984.8522721591676, 1011.701548043329, 1017.7455636090978, 1037.2635428845454, 22453.887730561244, 22729.204477843195, 23506.9421876016, 27257.1822845311, 28450.857745711553, 1076.8330908709006, 1100.878903320634, 1101.983470247947, 1131.9151063670258, 1135.1429670598645, 12498.50005999768, 12506.249625022347, 12537.93731031339, 12571.120021598583, 12736.172148810298, 231034.0, 232411.0, 233066.0, 234907.0, 235961.0, 54492.45507544953, 54612.0, 54989.175162372594, 55012.174817377774, 55319.0, 1434.103685196752, 1458.0668372241773, 1498.1460567476652, 1500.7073620643869, 1503.3159912239905, 22757.658635120817, 22873.885630572408, 23019.309420717404, 23365.649515256944, 23546.136081364, 38783.612163878, 38992.80503597464, 39007.0, 39015.219695606494, 39024.80487597544, 197425.0, 197991.0, 198588.0, 198863.0, 198919.0, 35392.46911296384, 36078.819605902856, 37807.81096094502, 37998.0, 38161.6183838158, 46749.76625116853, 48140.518594813606, 48356.27465587949, 48720.0, 49053.50946490489, 34425.31149377049, 34493.0, 35259.47110793289, 35409.0, 35430.114247144025, 33659.49510757292, 33870.66129338675, 34244.82877585596, 34656.82671586626, 34677.65322346845, 38595.03512412212, 38642.42036369401, 38745.0, 38779.0, 39593.20813583655, 33702.0, 34188.48717269193, 34708.305833883685, 34756.56704030694, 34930.825345873105, 23868.761312386654, 23980.76019239855, 24413.023479060637, 24563.87718061398, 24797.504049919262], "value": 17772.60343072863, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.566369559135, 579.6000759475961, 586.3725813379683, 588.9116632505123, 612.966286854223, 22414.66378004329, 23109.653355199687, 23492.530149397, 23615.409614759617, 23703.762962370372, 25052.74947250527, 27134.050308239166, 27145.185644430698, 27186.72813271867, 27284.181474555746, 6666.400023997851, 6843.486738494608, 6849.1438570178725, 6852.486063545229, 6853.383195512403, 6321.5890967087225, 6595.20857497101, 6607.900881486781, 6712.395884370406, 6762.966185169092, 6569.0, 6585.0780890675105, 6585.57193782405, 6592.835179120536, 6592.93407065928, 6573.539852210347, 6582.967085164543, 6588.308227636101, 6595.802125936254, 6596.769113081067, 6163.352847950945, 6164.4760195383, 6166.07508873668, 6171.907421388682, 6177.845553861144, 28778.0, 29750.553741693893, 30396.088117356514, 30403.847980759954, 30727.078187654406, 1844.9538761530935, 1887.5281179705073, 1889.8015708350563, 1891.877027993176, 1892.7728672559244, 18780.342688005854, 19329.51676208092, 19365.419037428757, 19426.70859937102, 19478.90260548688, 2246.146464343555, 2322.8606283622867, 2324.2213858357472, 2334.6147885598857, 2481.6649752283392, 139494.30252848772, 142289.0, 142434.2878285602, 142471.0, 142609.0, 14439.783403248959, 15481.458148964957, 15507.069575825486, 15515.922420388051, 16111.758323625156, 24123.396915077265, 24131.15540956093, 24202.87898560496, 24215.75784242135, 24223.7577624225, 10001.24990625706, 10075.546600402999, 10224.335418197794, 10269.0, 10271.794564108826, 8175.0, 9370.39092458988, 9381.953090234641, 9402.0, 9422.528873556295, 8120.187981201832, 9114.270858331318, 9306.302027347841, 9409.294302927308, 9442.15020648145, 2774.16774967513, 2809.5083360411845, 2849.3731379096566, 2855.814372065809, 2874.7125287471085, 931.9580618872167, 942.7501712046313, 977.1449981266392, 978.7198066431562, 985.9063388978036, 23203.883980580325, 24368.390790230387, 24609.63085553718, 24895.253142405756, 24995.250142495755, 1015.7003683913264, 1019.9292014629136, 1032.4270030133198, 1056.144522936424, 1066.418801753031, 11346.149038822121, 11372.31766094037, 11495.195336326544, 11554.133439992034, 11578.189526733217, 524282.0, 530499.0, 551288.0, 552550.0, 554865.0, 121371.0, 126475.0, 127476.0, 129528.0, 131271.34364328117, 1227.459917636255, 1267.8288431061874, 1281.128832393981, 1295.740851829619, 1297.4031945305076, 17334.133293335533, 18058.367957121438, 18156.364527241483, 18524.351647692267, 18562.907185463988, 58455.4154458467, 58521.414785853296, 59096.11355829752, 59894.401055988885, 61814.0, 72574.63712681402, 72951.63524182345, 73364.0, 74478.0, 74632.62683686547, 15098.39606415731, 15100.924495377452, 15208.543743687707, 15230.390784368945, 15307.311170997109, 23789.405264868517, 23806.16678416247, 23809.404764880324, 23968.92139853676, 24148.154814581405, 18540.814591854447, 18693.158807853408, 18757.81242187615, 18965.241390344232, 19122.61754764869, 15294.923525382303, 15319.77020344718, 15835.208239588204, 16059.598510036874, 16922.661546768748, 18889.338873139925, 19376.61246775085, 19714.309999149962, 19727.40817775469, 19739.506512337306, 15030.17334046638, 15198.696026079637, 15337.923310383376, 15354.769678454608, 15377.538673839803, 17855.821441785414, 19016.809831902057, 19115.235390584778, 19145.329913452963, 19147.521311967314], "value": 12294.977763592153, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.3150608942485, 1417.5747275817253, 1418.3971811979907, 1435.389959267311, 1441.3802065112002, 13816.585502434931, 13977.371018304175, 14395.78406323906, 14403.63990900228, 14412.279386030683, 13802.792958105636, 14334.283285835718, 14350.210738409383, 14372.0, 14403.711925761478, 2638.3667919699324, 2697.905573304935, 2698.1635692935156, 2699.78509670648, 2699.878505467249, 2452.5340185364726, 2555.1184841229747, 2570.9742902571015, 2643.524165650182, 2695.689995650496, 2688.9058882939103, 2725.74105459981, 2728.5088684036964, 2729.235813972081, 2731.4810186064583, 2583.4703885703384, 2598.961015584777, 2621.331560452082, 2623.396618777692, 2629.447815958651, 2612.2163350994624, 2651.973480265192, 2652.907148249802, 2653.9336516587045, 2656.3093595665073, 13404.46382144713, 13704.10923289983, 13714.382852771649, 13719.45122195111, 13729.931350343284, 7570.810729731801, 7843.215678432168, 7844.176361482077, 7850.214978502104, 7852.3325517331095, 5050.0, 5236.816711415082, 5289.761960711778, 5331.653442526223, 5350.117230656937, 1898.7057006164066, 1924.6054558815408, 1928.1034319041573, 1941.2720229913782, 1948.6882098864255, 22409.32772016842, 22509.77490225093, 22526.88736556323, 22624.54750904989, 22638.886805565868, 6419.775307864203, 6665.400113989765, 6856.108705868305, 7129.7861064168155, 7179.748708795167, 15947.44183953556, 16133.354665813236, 16162.434314798926, 16181.514554563382, 16221.513354599381, 7659.961700191463, 7673.577953212627, 7868.960655196687, 7939.0, 7942.324902383362, 6929.722811087601, 7104.040954471184, 7150.177729561167, 7158.964205178941, 7179.641017949081, 4999.850004499798, 5061.114304996611, 5134.2298655201275, 5171.198464237974, 5191.065608190562, 1332.4536939854613, 1340.1289162044554, 1469.0818238600875, 1477.866991970728, 1493.4474244529595, 855.7432770168924, 857.4340934982881, 893.4326702543931, 904.7738065483629, 927.4296307770672, 8237.258646721704, 8259.545724985184, 8375.790605234795, 8518.616662250213, 8547.316214702809, 981.5337714585658, 990.2078337330107, 1016.9593216271414, 1028.6348346337093, 1032.230987914009, 4937.432195297515, 5101.591872650179, 5162.8641698826195, 5340.75966581497, 5374.3013408256675, 18459.261629534936, 18510.259589616264, 18686.43940681782, 18866.056697165088, 18894.433167005012, 18160.091995400177, 18523.0, 18566.53583660392, 18655.160517776734, 18657.533561660795, 10884.836727449094, 10961.890381096246, 11023.0, 11044.668659940375, 11045.171612129123, 7409.851802964018, 7629.351505121905, 7688.192739762245, 7730.724430468909, 7804.726834560764, 15761.605959850636, 16732.498025059267, 16780.32878684839, 17347.653046939242, 17420.912895435442, 16632.168391580613, 16968.321267149175, 17123.828761712222, 17155.399561015303, 17264.136793160542, 10337.9483102584, 10385.117265032255, 10432.634857779942, 10608.469576521298, 10620.256582039183, 12911.935440322739, 13209.207447553177, 13215.0, 13223.206607603575, 13230.536931207362, 10294.838084002444, 10944.945275273572, 10987.560497580007, 11139.387333696724, 11305.547778088785, 10283.794324113625, 10385.324953877975, 10624.575016999233, 10853.728656783327, 11248.381339026104, 9504.192143667866, 9511.239100872051, 9576.856347154659, 9613.327067105236, 9621.470819105016, 6786.491013174131, 7072.575645461289, 7250.347468727839, 7267.345938865527, 7289.489735718449, 7177.461690373348, 7227.8554428912175, 7334.779956601311, 7399.519031262951, 7442.144153422426], "value": 6400.923758722745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.5696022940158, 508.37723788359267, 518.688175996264, 519.6648161935551, 529.068838843635, 6107.38926107389, 6243.219597550306, 6273.874522509547, 6298.079085878805, 6340.936590634093, 6075.848103797407, 6120.47975922046, 6121.969390153043, 6136.785212517563, 6162.291336496304, 4949.109160351135, 4951.885825689209, 4960.181570040939, 4994.425641051289, 5012.172991456424, 4772.355731976191, 4915.729634870081, 4937.432195297551, 4968.950310496885, 5007.724575148365, 4852.320675105488, 4923.950760492403, 4951.3810773653295, 4983.875403114915, 5014.495651304613, 4901.632377571696, 4930.679505832145, 4933.703977761345, 4946.678465899723, 4979.676321039121, 4438.312061630452, 4447.844325448594, 4454.933176002362, 4460.8661740147845, 4545.840895568673, 6086.786962456337, 6125.203723515914, 6125.632462052291, 6134.533988296598, 6164.815055548341, 5651.993542292509, 5731.0, 5745.856353591152, 5760.3951585083805, 5797.652140871562, 6406.423421892052, 6412.519061070392, 6458.160439142881, 6515.348465153446, 6547.0, 4820.614350851958, 4831.420229572439, 4863.805447782084, 4868.464468908453, 4913.852584422473, 6739.9904099736705, 6849.212340580847, 6880.139982502187, 6885.724571017154, 6924.826879328007, 4909.729964851896, 4922.1140194765285, 4946.332245146931, 4973.154563724175, 4975.626827987843, 5038.672486288379, 5065.265536497261, 5066.859956509756, 5087.669301495391, 5114.746887012706, 5567.777288908479, 5673.574481913873, 5682.857928551819, 5704.401037890962, 5726.0, 6245.750169993149, 6430.485561155097, 6448.548601597843, 6526.7227041848, 6577.177852768404, 1672.6403823177832, 1692.1708362902089, 1740.7911050674, 1746.9213885375189, 1757.016071000244, 971.7570607348163, 1216.191232830158, 1226.2090951336338, 1231.2612432540584, 1248.5505218121468, 5517.393086760453, 5674.943250567524, 5723.7996670116345, 5744.712764361849, 5748.741306641211, 6529.706163222666, 6543.345665433419, 6552.770653027121, 6562.179727534059, 6636.104125943032, 5683.147527870769, 5694.743736531866, 5723.255976723, 5765.3946335634155, 5774.740136693859, 3499.685028347461, 3505.36903357393, 3520.894373168809, 3522.6437821438417, 3569.7501174918025, 6356.173697419306, 6368.681565921685, 6401.263854656681, 6451.258105317855, 6453.903191452132, 6780.321967803279, 6806.625635589991, 6866.553674011173, 6914.723411063501, 6960.199577048705, 6446.8388290293115, 6452.387023232785, 6536.581464858033, 6551.312112228243, 6559.311272316433, 6680.32991752062, 6701.363370479797, 6748.662566871735, 6754.0, 6774.796756097127, 6633.734650613921, 6650.434713049445, 6690.464762818866, 6691.76578819739, 6735.663216839041, 6449.7097630605795, 6476.125723027331, 6506.892089709555, 6507.0, 6523.347665233438, 4937.555619994074, 4982.4768399317545, 5021.748912554431, 5028.0, 5032.27032080339, 6691.665416729242, 6711.355717849158, 6738.326167383222, 6747.939045715713, 6761.391474767098, 6357.965451055617, 6475.740970361321, 6491.92883174271, 6525.771597994048, 6526.9347306528225, 6307.24313082433, 6355.364463553793, 6413.518986075969, 6414.0, 6461.547691661539, 6377.713002914973, 6378.202724659418, 6382.234131904202, 6468.611883287018, 6488.416042556192, 6505.902411463737, 6508.9349106508325, 6563.245226798979, 6563.982582699689, 6584.901226481511, 5731.283589551306, 6237.5321850860455, 6268.843278917881, 6298.622082675054, 6354.17395738551], "value": 5021.040634687572, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [916.5921165081533, 917.9127982841629, 931.7856892914625, 934.7522906429797, 936.5036530638762, 17738.11309434528, 18812.43562693118, 18828.0, 18863.811361886375, 21429.0, 19754.209831606753, 20432.28487002955, 20454.693179602316, 20503.69244461334, 20518.794812051874, 1004.4932601098334, 1023.8361862102065, 1027.794441111777, 1029.2075102171323, 1035.3735989726183, 1038.672818062308, 1044.1542350695922, 1044.3681572648513, 1045.3205416479311, 1045.3362115056955, 773.9342155916754, 802.3821657323857, 1043.572135424476, 1094.3433939636234, 1105.8562386889694, 1086.5002099034455, 1086.9565217391296, 1090.6237348114928, 1090.91818113641, 1093.081811278526, 793.1830214878685, 797.6051854332085, 798.0582912163644, 798.2695833312512, 798.4091772088613, 18331.633367332714, 18550.907245463823, 19647.705284420746, 19945.80054199454, 20082.09630566628, 20222.292219772386, 20454.5909081819, 20981.790182098135, 20993.055312510973, 21047.368578942504, 16318.428854990138, 16338.34646614134, 16389.754153687703, 16390.918045409697, 16404.83595164045, 3578.5169002184634, 3618.7285953553323, 3623.61951995042, 3629.3648611493145, 3637.217998130415, 120504.99999999913, 126952.36523817414, 128114.3594282032, 129655.0, 133353.0, 16660.41688540895, 17118.743218851727, 17292.740608890876, 17302.22140003703, 17439.389621363192, 30999.380012400077, 31035.534466983012, 31434.685653143177, 31450.685493145233, 31624.525632115536, 7541.962290188624, 7923.405744569181, 7927.128015918244, 9029.367944243972, 9082.863757043517, 4110.958890411118, 4192.45498085247, 4211.157768446323, 4228.9154216915485, 4299.441072660534, 4946.183879659888, 4980.626453016038, 5110.182370820651, 5126.5898728101665, 5136.101182293084, 1029.4389557691077, 1041.5937784264142, 1044.639599338227, 1045.3988956349976, 1046.2414749306693, 672.2705864137465, 691.6126968897433, 692.4938259286033, 698.3819319901924, 710.6375748368266, 11347.319160850375, 11871.169018168817, 13390.330483475787, 13485.0, 13772.655683607789, 675.8445557521798, 686.4405509509834, 696.1020283833899, 710.1549156503744, 715.9606221657859, 5226.712530810842, 5289.259503669489, 5371.838844834661, 5373.140297552451, 5399.973000135053, 101872.49063754633, 102473.0, 103719.48140259401, 106505.46747266369, 107864.46067769612, 91365.0, 92604.0, 95149.5242523783, 95185.0, 96298.51850740702, 80671.19328806754, 80918.59540702259, 82579.0, 82806.58596706978, 83898.16101839025, 10404.583816647551, 10480.947595261974, 10754.085902698045, 12242.877571224173, 12645.241285522898, 31401.115780677646, 35745.67741292603, 36460.088497787765, 36706.8164659175, 38184.618153818104, 61279.08081378872, 64931.0, 67546.0, 69716.0, 69948.0, 19360.0, 19759.81441113538, 19795.208191672173, 19826.206951721768, 19976.300829471482, 20814.895925520275, 21119.788802111783, 21193.258235961668, 21241.78758212398, 21797.0, 18715.532111697317, 18825.623487529898, 18913.810861891205, 19203.423897283104, 19351.12919918635, 19158.13788379554, 19316.806831932063, 19328.0, 20090.497737556678, 20161.193552258334, 17682.91158544199, 18300.816991830445, 18497.0, 19193.32823351176, 19547.8045219546, 13678.31608419555, 14843.480478183212, 14988.2505874708, 15088.094714316738, 15175.62060948441, 13079.280639564915, 14447.638809029859, 14584.927075364556, 14803.777943330644, 14840.7773883394], "value": 9163.341672512603, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.8999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 102.0, 109.0, 110.0, 110.0, 115.0, 102.0, 109.0, 111.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 125.0, 151.0, 180.0, 121.0, 150.0, 141.0, 126.0, 165.0, 121.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 165.0, 164.0, 164.0, 165.0, 164.0, 175.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 172.0, 77.0, 74.0, 81.0, 75.0, 145.0, 76.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 140.0, 82.0, 81.0, 81.0, 140.0, 83.0, 82.0, 131.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 115.0, 114.0, 115.0, 118.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 152.0, 151.0, 151.0, 153.0, 153.0, 151.0, 150.0, 151.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 98.0, 99.0, 98.0, 99.0, 94.0, 95.0, 95.0, 94.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 56.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 61.0, 58.0, 54.0, 54.0, 55.0, 55.0, 59.0, 54.0, 54.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 90.0, 79.0, 80.0, 78.0, 87.0, 80.0, 78.0, 81.0, 78.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 132.0, 144.0, 133.0, 134.0, 132.0, 125.0, 131.0, 136.0, 179.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 177.0, 181.0, 177.0, 182.0, 177.0, 180.0, 176.0, 196.0, 181.0], "value": 181.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 81.0, 76.0, 70.0, 68.0, 68.0, 68.0, 69.0, 68.0], "value": 71.1, "unit": "score"}]}]} 05:07:32 INFO - Return code: 0 05:07:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:07:32 INFO - # TBPL SUCCESS # 05:07:32 INFO - Running post-action listener: _package_coverage_data 05:07:32 INFO - Running post-action listener: _resource_record_post_action 05:07:32 INFO - [mozharness: 2017-07-24 12:07:32.575671Z] Finished run-tests step (success) 05:07:32 INFO - Running post-run listener: _resource_record_post_run 05:07:32 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 439746560; Read time: 160; Write time: 268368 05:07:32 INFO - TinderboxPrint: CPU usage
13.2% 05:07:32 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 160 05:07:32 INFO - TinderboxPrint: I/O write bytes / time
439,746,560 / 268,368 05:07:32 INFO - TinderboxPrint: CPU idle
8,273.2 (86.8%) 05:07:32 INFO - TinderboxPrint: CPU user
1,204.1 (12.6%) 05:07:32 INFO - TinderboxPrint: Swap in / out
0 / 0 05:07:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108064768; Read time: 0; Write time: 86800 05:07:32 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:07:32 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 331681792; Read time: 148; Write time: 181568 05:07:33 INFO - Running post-run listener: _upload_blobber_files 05:07:33 INFO - Blob upload gear active. 05:07:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07:33 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 05:07:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:07:33 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:07:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:07:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:34 INFO - (blobuploader) - INFO - Done attempting. 05:07:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:07:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:07:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:35 INFO - (blobuploader) - INFO - Done attempting. 05:07:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:07:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:07:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:35 INFO - (blobuploader) - INFO - Done attempting. 05:07:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:07:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:07:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:42 INFO - (blobuploader) - INFO - Done attempting. 05:07:42 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:42 INFO - Return code: 0 05:07:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a8ad4c964cd3a2563f135c29c18d31441b60824a187e21f499dfa90cf3df3344cd87f3412ca5426f83c340a6dba1872bb2e18687a40fb1c81676b7f8ea11067", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec7703ed429cb5649ee14aa532b88334b2df5b66a13880f508a34cdff35b942d1d2da0d24bd1598e72ba7289d43cd6596b0a491d7feaffeaed4a5d74d0bcf101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1cf0da051066e321052a9b3384446341a9b45b7ed7d63dc10d5d38dd8e5a1ef52820cb1a8fbee379bd6b02a665977b9809555e9bee446a4bf1870e4b1d66722", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa56481d99fa1ee4cc92376604221d67803fed4c135c932e53bd93f8dc803f1941cd4058a62575f24bd7994c19e00aa29aa36ae863fba4503438dfafe3a06873"} 05:07:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:42 INFO - Contents: 05:07:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a8ad4c964cd3a2563f135c29c18d31441b60824a187e21f499dfa90cf3df3344cd87f3412ca5426f83c340a6dba1872bb2e18687a40fb1c81676b7f8ea11067", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec7703ed429cb5649ee14aa532b88334b2df5b66a13880f508a34cdff35b942d1d2da0d24bd1598e72ba7289d43cd6596b0a491d7feaffeaed4a5d74d0bcf101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1cf0da051066e321052a9b3384446341a9b45b7ed7d63dc10d5d38dd8e5a1ef52820cb1a8fbee379bd6b02a665977b9809555e9bee446a4bf1870e4b1d66722", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa56481d99fa1ee4cc92376604221d67803fed4c135c932e53bd93f8dc803f1941cd4058a62575f24bd7994c19e00aa29aa36ae863fba4503438dfafe3a06873"} 05:07:42 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:42 INFO - Copying logs to upload dir... 05:07:42 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.601371 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-07-24 05:07:42.878136) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 05:07:42.886042) ========= 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=db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a8ad4c964cd3a2563f135c29c18d31441b60824a187e21f499dfa90cf3df3344cd87f3412ca5426f83c340a6dba1872bb2e18687a40fb1c81676b7f8ea11067", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec7703ed429cb5649ee14aa532b88334b2df5b66a13880f508a34cdff35b942d1d2da0d24bd1598e72ba7289d43cd6596b0a491d7feaffeaed4a5d74d0bcf101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1cf0da051066e321052a9b3384446341a9b45b7ed7d63dc10d5d38dd8e5a1ef52820cb1a8fbee379bd6b02a665977b9809555e9bee446a4bf1870e4b1d66722", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa56481d99fa1ee4cc92376604221d67803fed4c135c932e53bd93f8dc803f1941cd4058a62575f24bd7994c19e00aa29aa36ae863fba4503438dfafe3a06873"} build_url:https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/Qxjkh3A0R969zOj7BNm3zw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a8ad4c964cd3a2563f135c29c18d31441b60824a187e21f499dfa90cf3df3344cd87f3412ca5426f83c340a6dba1872bb2e18687a40fb1c81676b7f8ea11067", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec7703ed429cb5649ee14aa532b88334b2df5b66a13880f508a34cdff35b942d1d2da0d24bd1598e72ba7289d43cd6596b0a491d7feaffeaed4a5d74d0bcf101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1cf0da051066e321052a9b3384446341a9b45b7ed7d63dc10d5d38dd8e5a1ef52820cb1a8fbee379bd6b02a665977b9809555e9bee446a4bf1870e4b1d66722", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa56481d99fa1ee4cc92376604221d67803fed4c135c932e53bd93f8dc803f1941cd4058a62575f24bd7994c19e00aa29aa36ae863fba4503438dfafe3a06873"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 05:07:42.913132) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 05:07:42.913446) ========= 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=db7e7c15f3ca076d53731445000001ba-1500896784.312926-1865164809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 05:07:42.994520) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 05:07:42.997869) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 05:07:42.998182) ========= ========= Total master_lag: 1.11 =========