builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1500897053.08 results: success (0) revision: 60a5308fa987676fa5ed9fd5b3ad6c9938af0539 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 04:50:53.077507) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 04:50:53.078005) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 04:50:53.078303) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 04:50:53.094630) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:50:53.094895) ========= 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=0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-24 04:50:53-- 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% 69.3M=0s 2017-07-24 04:50:53 (69.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160094 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:50:53.268296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:50:53.271638) ========= 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=0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015712 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:50:53.321439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:50:53.324803) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 60a5308fa987676fa5ed9fd5b3ad6c9938af0539 --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 60a5308fa987676fa5ed9fd5b3ad6c9938af0539 --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=0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-24 04:50:53,440 truncating revision to first 12 chars 2017-07-24 04:50:53,440 Setting DEBUG logging. 2017-07-24 04:50:53,441 attempt 1/10 2017-07-24 04:50:53,441 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/60a5308fa987?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-24 04:50:53,809 unpacking tar archive at: mozilla-central-60a5308fa987/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672421 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:50:54.011328) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 04:50:54.014657) ========= script_repo_revision: 60a5308fa987676fa5ed9fd5b3ad6c9938af0539 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 04:50:54.015077) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 04:50:54.015407) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 04:50:54.025683) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-24 04:50:54.026001) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:50:54 INFO - MultiFileLogger online at 20170724 04:50:54 in /builds/slave/test 04:50:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:50:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:50:54 INFO - {'append_to_log': False, 04:50:54 INFO - 'base_work_dir': '/builds/slave/test', 04:50:54 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:50:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:50:54 INFO - 'branch': 'Firefox-Non-PGO', 04:50:54 INFO - 'buildbot_json_path': 'buildprops.json', 04:50:54 INFO - 'code_coverage': False, 04:50:54 INFO - 'config_files': ('talos/linux_config.py',), 04:50:54 INFO - 'default_actions': ('clobber', 04:50:54 INFO - 'read-buildbot-config', 04:50:54 INFO - 'download-and-extract', 04:50:54 INFO - 'populate-webroot', 04:50:54 INFO - 'create-virtualenv', 04:50:54 INFO - 'install', 04:50:54 INFO - 'setup-mitmproxy', 04:50:54 INFO - 'run-tests'), 04:50:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:50:54 INFO - 'disable_ccov_upload': False, 04:50:54 INFO - 'download_minidump_stackwalk': True, 04:50:54 INFO - 'download_symbols': 'ondemand', 04:50:54 INFO - 'enable_stylo': False, 04:50:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:50:54 INFO - 'tooltool.py': '/tools/tooltool.py', 04:50:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:50:54 INFO - '/tools/misc-python/virtualenv.py')}, 04:50:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:50:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:50:54 INFO - 'gecko_profile': False, 04:50:54 INFO - 'gecko_profile_interval': 0, 04:50:54 INFO - 'installer_path': 'installer.exe', 04:50:54 INFO - 'log_level': 'info', 04:50:54 INFO - 'log_name': 'talos', 04:50:54 INFO - 'log_to_console': True, 04:50:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:50:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:50:54 INFO - 'opt_config_files': (), 04:50:54 INFO - 'pip_index': False, 04:50:54 INFO - 'suite': 'dromaeojs-e10s', 04:50:54 INFO - 'system_bits': '32', 04:50:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:50:54 INFO - 'title': 'talos-linux64-ix-017', 04:50:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:50:54 INFO - 'use_talos_json': True, 04:50:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:50:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:50:54 INFO - 'work_dir': 'build'} 04:50:54 INFO - [mozharness: 2017-07-24 11:50:54.247267Z] Running clobber step. 04:50:54 INFO - Running pre-action listener: _resource_record_pre_action 04:50:54 INFO - Running main action method: clobber 04:50:54 INFO - rmtree: /builds/slave/test/build 04:50:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:50:55 INFO - Running post-action listener: _resource_record_post_action 04:50:55 INFO - [mozharness: 2017-07-24 11:50:55.278454Z] Finished clobber step (success) 04:50:55 INFO - [mozharness: 2017-07-24 11:50:55.278569Z] Running read-buildbot-config step. 04:50:55 INFO - Running pre-action listener: _resource_record_pre_action 04:50:55 INFO - Running main action method: read_buildbot_config 04:50:55 INFO - Using buildbot properties: 04:50:55 INFO - { 04:50:55 INFO - "project": "", 04:50:55 INFO - "product": "firefox", 04:50:55 INFO - "who": "cbook@mozilla.com", 04:50:55 INFO - "installer_path": "public/build/target.tar.bz2", 04:50:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:50:55 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:50:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:50:55 INFO - "stage_platform": "linux64", 04:50:55 INFO - "basedir": "/builds/slave/test", 04:50:55 INFO - "buildnumber": 737, 04:50:55 INFO - "platform": "ubuntu64_hw", 04:50:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:50:55 INFO - "slavebuilddir": "test", 04:50:55 INFO - "taskId": "GwIZbzb4Q06PbU9PkW5KmQ", 04:50:55 INFO - "branch": "mozilla-central", 04:50:55 INFO - "script_repo_revision": "production", 04:50:55 INFO - "revision": "60a5308fa987676fa5ed9fd5b3ad6c9938af0539", 04:50:55 INFO - "slavename": "talos-linux64-ix-017", 04:50:55 INFO - "repo_path": "mozilla-central" 04:50:55 INFO - } 04:50:55 INFO - Finding installer, test and symbols from parent task. 04:50:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GwIZbzb4Q06PbU9PkW5KmQ'}, attempt #1 04:50:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GwIZbzb4Q06PbU9PkW5KmQ'}, attempt #1 04:50:56 INFO - Task dependencies: PE7z0GOQSrS6K7moteSUmw 04:50:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw'}, attempt #1 04:50:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2 04:50:56 INFO - Set test_url: https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/test_packages.json 04:50:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.crashreporter-symbols.zip 04:50:56 INFO - Running post-action listener: _resource_record_post_action 04:50:56 INFO - [mozharness: 2017-07-24 11:50:56.651909Z] Finished read-buildbot-config step (success) 04:50:56 INFO - [mozharness: 2017-07-24 11:50:56.652130Z] Running download-and-extract step. 04:50:56 INFO - Running pre-action listener: _resource_record_pre_action 04:50:56 INFO - Running main action method: download_and_extract 04:50:56 INFO - mkdir: /builds/slave/test/build/tests 04:50:56 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:50:56 INFO - trying https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.test_packages.json 04:50:56 INFO - Downloading https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:50:57 INFO - Downloaded 989 bytes. 04:50:57 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:50:57 INFO - Using the following test package requirements: 04:50:57 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:50:57 INFO - u'common': [u'target.common.tests.zip'], 04:50:57 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:50:57 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:50:57 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:50:57 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:50:57 INFO - u'mozbase': [u'target.common.tests.zip'], 04:50:57 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:50:57 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:50:57 INFO - u'web-platform': [u'target.common.tests.zip', 04:50:57 INFO - u'target.web-platform.tests.tar.gz'], 04:50:57 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:50:57 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:50:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.common.tests.zip 04:50:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:50:57 INFO - Fetch https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.common.tests.zip into memory 04:50:58 INFO - Content-Length response header: 72761289 04:50:58 INFO - Bytes received: 72761289 04:51:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:51:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.common.tests.zip 04:51:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:51:09 INFO - Fetch https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.common.tests.zip into memory 04:51:11 INFO - Content-Length response header: 72761289 04:51:11 INFO - Bytes received: 72761289 04:51:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.talos.tests.zip 04:51:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:51:23 INFO - Fetch https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.talos.tests.zip into memory 04:51:24 INFO - Content-Length response header: 14498976 04:51:24 INFO - Bytes received: 14498976 04:51: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:51:24 INFO - trying https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2 04:51:24 INFO - Downloading https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:51:25 INFO - Downloaded 62005184 bytes. 04:51:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2 04:51:25 INFO - mkdir: /builds/slave/test/properties 04:51:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:51:25 INFO - Writing to file /builds/slave/test/properties/build_url 04:51:25 INFO - Contents: 04:51:25 INFO - build_url:https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2 04:51:25 INFO - Running post-action listener: _resource_record_post_action 04:51:25 INFO - Running post-action listener: set_extra_try_arguments 04:51:25 INFO - [mozharness: 2017-07-24 11:51:25.804394Z] Finished download-and-extract step (success) 04:51:25 INFO - [mozharness: 2017-07-24 11:51:25.804493Z] Running populate-webroot step. 04:51:25 INFO - Running pre-action listener: _resource_record_pre_action 04:51:25 INFO - Running main action method: populate_webroot 04:51:25 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:51:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:51:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:51:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:51:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:51:25 INFO - 'tests': ['damp', 'tps']}, 04:51:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:51:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:51:25 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:51:25 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:51:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:51:25 INFO - 'ts_paint', 04:51:25 INFO - 'tpaint', 04:51:25 INFO - 'sessionrestore', 04:51:25 INFO - 'sessionrestore_many_windows', 04:51:25 INFO - 'sessionrestore_no_auto_restore', 04:51:25 INFO - 'tabpaint']}, 04:51:25 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:51:25 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:51:25 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:51:25 INFO - 'talos_options': ['--mitmproxy', 04:51:25 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:51:25 INFO - '--firstNonBlankPaint'], 04:51:25 INFO - 'tests': ['quantum_pageload_google', 04:51:25 INFO - 'quantum_pageload_youtube', 04:51:25 INFO - 'quantum_pageload_amazon', 04:51:25 INFO - 'quantum_pageload_facebook']}, 04:51:25 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:51:25 INFO - 'talos_options': ['--stylo', 04:51:25 INFO - '--mitmproxy', 04:51:25 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:51:25 INFO - '--firstNonBlankPaint'], 04:51:25 INFO - 'tests': ['quantum_pageload_google', 04:51:25 INFO - 'quantum_pageload_youtube', 04:51:25 INFO - 'quantum_pageload_amazon', 04:51:25 INFO - 'quantum_pageload_facebook']}, 04:51:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:51:25 INFO - 'tsvgr_opacity', 04:51:25 INFO - 'tart', 04:51:25 INFO - 'tscrollx', 04:51:25 INFO - 'cart', 04:51:25 INFO - 'tsvg_static']}, 04:51:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:51:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:51:25 INFO - 'talos_options': ['--xperf_path', 04:51:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:51:25 INFO - 'tests': ['tp5n']}}} 04:51:25 INFO - Running post-action listener: _resource_record_post_action 04:51:25 INFO - [mozharness: 2017-07-24 11:51:25.811900Z] Finished populate-webroot step (success) 04:51:25 INFO - [mozharness: 2017-07-24 11:51:25.811992Z] Running create-virtualenv step. 04:51:25 INFO - Running pre-action listener: _resource_record_pre_action 04:51:25 INFO - Running main action method: create_virtualenv 04:51:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:51:25 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:51:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:51:25 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:51:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:51:25 INFO - Using real prefix '/usr' 04:51:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:51:26 INFO - Installing distribute.............................................................................................................................................................................................done. 04:51:28 INFO - Installing pip.................done. 04:51:28 INFO - Return code: 0 04:51:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:51:28 INFO - Reading from file tmpfile_stdout 04:51:28 INFO - Output received: 04:51:28 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:51:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:51:28 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:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:28 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:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:28 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 0x21541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2321a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1eb0>, '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 0x24c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c3240>, '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': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', '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:51:28 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:51:28 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:51:28 INFO - Using env: {'DISPLAY': ':0', 04:51:28 INFO - 'HOME': '/home/cltbld', 04:51:28 INFO - 'LANG': 'en_US.UTF-8', 04:51:28 INFO - 'LANGUAGE': 'en_US:en', 04:51:28 INFO - 'LOGNAME': 'cltbld', 04:51:28 INFO - 'MAIL': '/var/mail/cltbld', 04:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:28 INFO - 'MOZ_NO_REMOTE': '1', 04:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:28 INFO - 'NO_EM_RESTART': '1', 04:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:28 INFO - 'PWD': '/builds/slave/test', 04:51:28 INFO - 'SHELL': '/bin/bash', 04:51:28 INFO - 'SHLVL': '1', 04:51:28 INFO - 'TERM': 'linux', 04:51:28 INFO - 'TMOUT': '86400', 04:51:28 INFO - 'USER': 'cltbld', 04:51:28 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', 04:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:28 INFO - '_': '/tools/buildbot/bin/python'} 04:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:28 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:51:28 INFO - Cleaning up... 04:51:28 INFO - Return code: 0 04:51:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:51:28 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:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:28 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:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:28 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 0x21541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2321a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1eb0>, '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 0x24c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c3240>, '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': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', '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:51:28 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:51:28 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:51:28 INFO - Using env: {'DISPLAY': ':0', 04:51:28 INFO - 'HOME': '/home/cltbld', 04:51:28 INFO - 'LANG': 'en_US.UTF-8', 04:51:28 INFO - 'LANGUAGE': 'en_US:en', 04:51:28 INFO - 'LOGNAME': 'cltbld', 04:51:28 INFO - 'MAIL': '/var/mail/cltbld', 04:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:28 INFO - 'MOZ_NO_REMOTE': '1', 04:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:28 INFO - 'NO_EM_RESTART': '1', 04:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:28 INFO - 'PWD': '/builds/slave/test', 04:51:28 INFO - 'SHELL': '/bin/bash', 04:51:28 INFO - 'SHLVL': '1', 04:51:28 INFO - 'TERM': 'linux', 04:51:28 INFO - 'TMOUT': '86400', 04:51:28 INFO - 'USER': 'cltbld', 04:51:28 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', 04:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:28 INFO - '_': '/tools/buildbot/bin/python'} 04:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:29 INFO - Downloading/unpacking psutil>=3.1.1 04:51:29 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:51:29 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:51:29 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:51:29 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:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:51:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:51:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:51:30 INFO - Installing collected packages: psutil 04:51:30 INFO - Running setup.py install for psutil 04:51:30 INFO - building 'psutil._psutil_linux' extension 04:51:30 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:51:30 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:51:30 INFO - building 'psutil._psutil_posix' extension 04:51:30 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:51:30 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:51:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:51:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:51:30 INFO - Successfully installed psutil 04:51:30 INFO - Cleaning up... 04:51:30 INFO - Return code: 0 04:51:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:51: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:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51: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:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2321a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1eb0>, '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 0x24c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c3240>, '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': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', '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:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:51:30 INFO - Using env: {'DISPLAY': ':0', 04:51:30 INFO - 'HOME': '/home/cltbld', 04:51:30 INFO - 'LANG': 'en_US.UTF-8', 04:51:30 INFO - 'LANGUAGE': 'en_US:en', 04:51:30 INFO - 'LOGNAME': 'cltbld', 04:51:30 INFO - 'MAIL': '/var/mail/cltbld', 04:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:30 INFO - 'MOZ_NO_REMOTE': '1', 04:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:30 INFO - 'NO_EM_RESTART': '1', 04:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:30 INFO - 'PWD': '/builds/slave/test', 04:51:30 INFO - 'SHELL': '/bin/bash', 04:51:30 INFO - 'SHLVL': '1', 04:51:30 INFO - 'TERM': 'linux', 04:51:30 INFO - 'TMOUT': '86400', 04:51:30 INFO - 'USER': 'cltbld', 04:51:30 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', 04:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:30 INFO - '_': '/tools/buildbot/bin/python'} 04:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:51:32 INFO - Installing collected packages: mozsystemmonitor 04:51:32 INFO - Running setup.py install for mozsystemmonitor 04:51:32 INFO - Successfully installed mozsystemmonitor 04:51:32 INFO - Cleaning up... 04:51:32 INFO - Return code: 0 04:51:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:51:32 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:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:32 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:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:32 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 0x21541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2321a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1eb0>, '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 0x24c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c3240>, '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': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', '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:51:32 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:51:32 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:51:32 INFO - Using env: {'DISPLAY': ':0', 04:51:32 INFO - 'HOME': '/home/cltbld', 04:51:32 INFO - 'LANG': 'en_US.UTF-8', 04:51:32 INFO - 'LANGUAGE': 'en_US:en', 04:51:32 INFO - 'LOGNAME': 'cltbld', 04:51:32 INFO - 'MAIL': '/var/mail/cltbld', 04:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:32 INFO - 'MOZ_NO_REMOTE': '1', 04:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:32 INFO - 'NO_EM_RESTART': '1', 04:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:32 INFO - 'PWD': '/builds/slave/test', 04:51:32 INFO - 'SHELL': '/bin/bash', 04:51:32 INFO - 'SHLVL': '1', 04:51:32 INFO - 'TERM': 'linux', 04:51:32 INFO - 'TMOUT': '86400', 04:51:32 INFO - 'USER': 'cltbld', 04:51:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', 04:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:32 INFO - '_': '/tools/buildbot/bin/python'} 04:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:32 INFO - Downloading/unpacking jsonschema==2.5.1 04:51: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:51: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:51: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:51: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:51:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:51:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:33 INFO - Downloading functools32-3.2.3-2.tar.gz 04:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:51:33 INFO - warning: no files found matching '*.txt' 04:51:33 INFO - no previously-included directories found matching 'build' 04:51:33 INFO - no previously-included directories found matching 'dist' 04:51:33 INFO - no previously-included directories found matching '.git*' 04:51:33 INFO - Installing collected packages: jsonschema, functools32 04:51:33 INFO - Running setup.py install for functools32 04:51:33 INFO - warning: no files found matching '*.txt' 04:51:33 INFO - no previously-included directories found matching 'build' 04:51:33 INFO - no previously-included directories found matching 'dist' 04:51:33 INFO - no previously-included directories found matching '.git*' 04:51:33 INFO - Successfully installed jsonschema functools32 04:51:33 INFO - Cleaning up... 04:51:33 INFO - Return code: 0 04:51:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2321a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1eb0>, '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 0x24c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c3240>, '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': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', '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:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:51:33 INFO - Using env: {'DISPLAY': ':0', 04:51:33 INFO - 'HOME': '/home/cltbld', 04:51:33 INFO - 'LANG': 'en_US.UTF-8', 04:51:33 INFO - 'LANGUAGE': 'en_US:en', 04:51:33 INFO - 'LOGNAME': 'cltbld', 04:51:33 INFO - 'MAIL': '/var/mail/cltbld', 04:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:33 INFO - 'MOZ_NO_REMOTE': '1', 04:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:33 INFO - 'NO_EM_RESTART': '1', 04:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:33 INFO - 'PWD': '/builds/slave/test', 04:51:33 INFO - 'SHELL': '/bin/bash', 04:51:33 INFO - 'SHLVL': '1', 04:51:33 INFO - 'TERM': 'linux', 04:51:33 INFO - 'TMOUT': '86400', 04:51:33 INFO - 'USER': 'cltbld', 04:51:33 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', 04:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:33 INFO - '_': '/tools/buildbot/bin/python'} 04:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:51:34 INFO - Cleaning up... 04:51:34 INFO - Return code: 0 04:51:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:51: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:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51: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:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2321a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1eb0>, '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 0x24c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c3240>, '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': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', '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:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:51:34 INFO - Using env: {'DISPLAY': ':0', 04:51:34 INFO - 'HOME': '/home/cltbld', 04:51:34 INFO - 'LANG': 'en_US.UTF-8', 04:51:34 INFO - 'LANGUAGE': 'en_US:en', 04:51:34 INFO - 'LOGNAME': 'cltbld', 04:51:34 INFO - 'MAIL': '/var/mail/cltbld', 04:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:34 INFO - 'MOZ_NO_REMOTE': '1', 04:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:34 INFO - 'NO_EM_RESTART': '1', 04:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:34 INFO - 'PWD': '/builds/slave/test', 04:51:34 INFO - 'SHELL': '/bin/bash', 04:51:34 INFO - 'SHLVL': '1', 04:51:34 INFO - 'TERM': 'linux', 04:51:34 INFO - 'TMOUT': '86400', 04:51:34 INFO - 'USER': 'cltbld', 04:51:34 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', 04:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:34 INFO - '_': '/tools/buildbot/bin/python'} 04:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:34 INFO - Downloading/unpacking blobuploader==1.2.4 04:51: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:51: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:51: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:51: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:51:35 INFO - Downloading blobuploader-1.2.4.tar.gz 04:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:51:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:51: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:51: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:51: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:51: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:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:51:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:51: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:51: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:51: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:51: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:51:35 INFO - Downloading docopt-0.6.1.tar.gz 04:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:51:36 INFO - Installing collected packages: blobuploader, requests, docopt 04:51:36 INFO - Running setup.py install for blobuploader 04:51:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:51:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:51:36 INFO - Running setup.py install for requests 04:51:36 INFO - Running setup.py install for docopt 04:51:36 INFO - Successfully installed blobuploader requests docopt 04:51:36 INFO - Cleaning up... 04:51:36 INFO - Return code: 0 04:51:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:36 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 0x21541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2321a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1eb0>, '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 0x24c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c3240>, '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': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', '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:51:36 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:51:36 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:51:36 INFO - Using env: {'DISPLAY': ':0', 04:51:36 INFO - 'HOME': '/home/cltbld', 04:51:36 INFO - 'LANG': 'en_US.UTF-8', 04:51:36 INFO - 'LANGUAGE': 'en_US:en', 04:51:36 INFO - 'LOGNAME': 'cltbld', 04:51:36 INFO - 'MAIL': '/var/mail/cltbld', 04:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:36 INFO - 'MOZ_NO_REMOTE': '1', 04:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:36 INFO - 'NO_EM_RESTART': '1', 04:51:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:36 INFO - 'PWD': '/builds/slave/test', 04:51:36 INFO - 'SHELL': '/bin/bash', 04:51:36 INFO - 'SHLVL': '1', 04:51:36 INFO - 'TERM': 'linux', 04:51:36 INFO - 'TMOUT': '86400', 04:51:36 INFO - 'USER': 'cltbld', 04:51:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', 04:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:36 INFO - '_': '/tools/buildbot/bin/python'} 04:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:51:36 INFO - Running setup.py (path:/tmp/pip-ouLApu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:51:36 INFO - Running setup.py (path:/tmp/pip-REeGFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:51:37 INFO - Running setup.py (path:/tmp/pip-1jJoot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:51:37 INFO - Running setup.py (path:/tmp/pip-0nJJwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:51:37 INFO - Running setup.py (path:/tmp/pip-o4Bbwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:51:37 INFO - Running setup.py (path:/tmp/pip-RLd5lU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:51:37 INFO - Running setup.py (path:/tmp/pip-oBR9gK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:51:37 INFO - Running setup.py (path:/tmp/pip-0BVWIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:51:37 INFO - Running setup.py (path:/tmp/pip-o4Oy24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:51:37 INFO - Running setup.py (path:/tmp/pip-x1cCG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:51:37 INFO - Running setup.py (path:/tmp/pip-ndEbLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:51:37 INFO - Running setup.py (path:/tmp/pip-rgN5Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:51:37 INFO - Running setup.py (path:/tmp/pip-d9Bs23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:51:37 INFO - Running setup.py (path:/tmp/pip-nKgirX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:37 INFO - Running setup.py (path:/tmp/pip-0HnEm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:51:37 INFO - Running setup.py (path:/tmp/pip-MYYXQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:51:38 INFO - Running setup.py (path:/tmp/pip-5ZFsRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:51:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:51:38 INFO - Running setup.py install for manifestparser 04:51:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Running setup.py install for mozcrash 04:51:38 INFO - Running setup.py install for mozdebug 04:51:38 INFO - Running setup.py install for mozdevice 04:51:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Running setup.py install for mozfile 04:51:38 INFO - Running setup.py install for mozhttpd 04:51:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Running setup.py install for mozinfo 04:51:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Running setup.py install for mozInstall 04:51:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Running setup.py install for mozleak 04:51:38 INFO - Running setup.py install for mozlog 04:51:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:51:39 INFO - Running setup.py install for moznetwork 04:51:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:51:39 INFO - Running setup.py install for mozprocess 04:51:39 INFO - Running setup.py install for mozprofile 04:51:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:51:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:51:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:51:39 INFO - Running setup.py install for mozrunner 04:51:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:51:39 INFO - Running setup.py install for mozscreenshot 04:51:39 INFO - Running setup.py install for moztest 04:51:39 INFO - Running setup.py install for mozversion 04:51:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:51:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:51:39 INFO - Cleaning up... 04:51:39 INFO - Return code: 0 04:51:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51: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:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51: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:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:39 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 0x21541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2321a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1eb0>, '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 0x24c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c3240>, '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': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', '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:51:39 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:51:39 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:51:39 INFO - Using env: {'DISPLAY': ':0', 04:51:39 INFO - 'HOME': '/home/cltbld', 04:51:39 INFO - 'LANG': 'en_US.UTF-8', 04:51:39 INFO - 'LANGUAGE': 'en_US:en', 04:51:39 INFO - 'LOGNAME': 'cltbld', 04:51:39 INFO - 'MAIL': '/var/mail/cltbld', 04:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:39 INFO - 'MOZ_NO_REMOTE': '1', 04:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:39 INFO - 'NO_EM_RESTART': '1', 04:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:39 INFO - 'PWD': '/builds/slave/test', 04:51:39 INFO - 'SHELL': '/bin/bash', 04:51:39 INFO - 'SHLVL': '1', 04:51:39 INFO - 'TERM': 'linux', 04:51:39 INFO - 'TMOUT': '86400', 04:51:39 INFO - 'USER': 'cltbld', 04:51:39 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', 04:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:39 INFO - '_': '/tools/buildbot/bin/python'} 04:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:51:40 INFO - Running setup.py (path:/tmp/pip-w4NatW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:51:40 INFO - Running setup.py (path:/tmp/pip-O240_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:51:40 INFO - Running setup.py (path:/tmp/pip-VZw_TT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:51:40 INFO - Running setup.py (path:/tmp/pip-5Ijapf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:51:40 INFO - Running setup.py (path:/tmp/pip-VFCVBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:51:40 INFO - Running setup.py (path:/tmp/pip-8vgBQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:51:40 INFO - Running setup.py (path:/tmp/pip-0rcsbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:51:40 INFO - Running setup.py (path:/tmp/pip-ewik_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:51:40 INFO - Running setup.py (path:/tmp/pip-am4Ahg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:51:40 INFO - Running setup.py (path:/tmp/pip-8XQUma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:51:40 INFO - Running setup.py (path:/tmp/pip-ldM_7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:51:40 INFO - Running setup.py (path:/tmp/pip-rBIRaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:51:41 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:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:51:41 INFO - Running setup.py (path:/tmp/pip-7C9K2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:51:41 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:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:51:41 INFO - Running setup.py (path:/tmp/pip-ygz5Q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:51:41 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:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:41 INFO - Running setup.py (path:/tmp/pip-xKzGYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:41 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:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:51:41 INFO - Running setup.py (path:/tmp/pip-iSeIMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:51:41 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:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:51:41 INFO - Running setup.py (path:/tmp/pip-QCL39g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:51:41 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:51:41 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:51:41 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:51:41 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:51:41 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:51:41 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:51:41 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:51:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:51:41 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:51:41 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:51:41 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:51:41 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:51:42 INFO - Downloading blessings-1.6.tar.gz 04:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:51:42 INFO - Installing collected packages: blessings 04:51:42 INFO - Running setup.py install for blessings 04:51:42 INFO - Successfully installed blessings 04:51:42 INFO - Cleaning up... 04:51:42 INFO - Return code: 0 04:51:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:51:42 INFO - Reading from file tmpfile_stdout 04:51:42 INFO - Current package versions: 04:51:42 INFO - argparse == 1.2.1 04:51:42 INFO - blessings == 1.6 04:51:42 INFO - blobuploader == 1.2.4 04:51:42 INFO - docopt == 0.6.1 04:51:42 INFO - functools32 == 3.2.3-2 04:51:42 INFO - jsonschema == 2.5.1 04:51:42 INFO - manifestparser == 1.1 04:51:42 INFO - mozInstall == 1.13 04:51:42 INFO - mozcrash == 1.0 04:51:42 INFO - mozdebug == 0.1 04:51:42 INFO - mozdevice == 0.51 04:51:42 INFO - mozfile == 1.2 04:51:42 INFO - mozhttpd == 0.7 04:51:42 INFO - mozinfo == 0.10 04:51:42 INFO - mozleak == 0.1 04:51:42 INFO - mozlog == 3.5 04:51:42 INFO - moznetwork == 0.27 04:51:42 INFO - mozprocess == 0.25 04:51:42 INFO - mozprofile == 0.28 04:51:42 INFO - mozrunner == 6.13 04:51:42 INFO - mozscreenshot == 0.1 04:51:42 INFO - mozsystemmonitor == 0.3 04:51:42 INFO - moztest == 0.8 04:51:42 INFO - mozversion == 1.4 04:51:42 INFO - psutil == 3.1.1 04:51:42 INFO - requests == 1.2.3 04:51:42 INFO - wsgiref == 0.1.2 04:51:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:42 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 0x21541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2321a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1eb0>, '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 0x24c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c3240>, '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': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', '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:51:42 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:51:42 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:51:42 INFO - Using env: {'DISPLAY': ':0', 04:51:42 INFO - 'HOME': '/home/cltbld', 04:51:42 INFO - 'LANG': 'en_US.UTF-8', 04:51:42 INFO - 'LANGUAGE': 'en_US:en', 04:51:42 INFO - 'LOGNAME': 'cltbld', 04:51:42 INFO - 'MAIL': '/var/mail/cltbld', 04:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:42 INFO - 'MOZ_NO_REMOTE': '1', 04:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:42 INFO - 'NO_EM_RESTART': '1', 04:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:42 INFO - 'PWD': '/builds/slave/test', 04:51:42 INFO - 'SHELL': '/bin/bash', 04:51:42 INFO - 'SHLVL': '1', 04:51:42 INFO - 'TERM': 'linux', 04:51:42 INFO - 'TMOUT': '86400', 04:51:42 INFO - 'USER': 'cltbld', 04:51:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', 04:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:42 INFO - '_': '/tools/buildbot/bin/python'} 04:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:43 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:51:43 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:51:43 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:51:43 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:51:43 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:51:43 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:51:43 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:51:43 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:51:43 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:51:43 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:44 INFO - Downloading marionette_driver-1.4.0.tar.gz 04:51:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 04:51:44 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 04:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:51:44 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:51:44 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:51:44 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:51:44 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:51:44 INFO - Installing collected packages: marionette-driver, simplejson 04:51:44 INFO - Running setup.py install for marionette-driver 04:51:44 INFO - Running setup.py install for simplejson 04:51:44 INFO - building 'simplejson._speedups' extension 04:51:44 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:51:45 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:51:45 INFO - Successfully installed marionette-driver simplejson 04:51:45 INFO - Cleaning up... 04:51:45 INFO - Return code: 0 04:51:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:45 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 0x21541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2321a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1eb0>, '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 0x24c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c3240>, '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': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', '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:51:45 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:51:45 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:51:45 INFO - Using env: {'DISPLAY': ':0', 04:51:45 INFO - 'HOME': '/home/cltbld', 04:51:45 INFO - 'LANG': 'en_US.UTF-8', 04:51:45 INFO - 'LANGUAGE': 'en_US:en', 04:51:45 INFO - 'LOGNAME': 'cltbld', 04:51:45 INFO - 'MAIL': '/var/mail/cltbld', 04:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:45 INFO - 'MOZ_NO_REMOTE': '1', 04:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:45 INFO - 'NO_EM_RESTART': '1', 04:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:45 INFO - 'PWD': '/builds/slave/test', 04:51:45 INFO - 'SHELL': '/bin/bash', 04:51:45 INFO - 'SHLVL': '1', 04:51:45 INFO - 'TERM': 'linux', 04:51:45 INFO - 'TMOUT': '86400', 04:51:45 INFO - 'USER': 'cltbld', 04:51:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', 04:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:45 INFO - '_': '/tools/buildbot/bin/python'} 04:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:51:45 INFO - Cleaning up... 04:51:45 INFO - Return code: 0 04:51:45 INFO - Running post-action listener: _resource_record_post_action 04:51:45 INFO - Running post-action listener: _start_resource_monitoring 04:51:45 INFO - Starting resource monitoring. 04:51:45 INFO - [mozharness: 2017-07-24 11:51:45.995741Z] Finished create-virtualenv step (success) 04:51:45 INFO - [mozharness: 2017-07-24 11:51:45.996252Z] Running install step. 04:51:45 INFO - Running pre-action listener: _resource_record_pre_action 04:51:45 INFO - Running main action method: install 04:51:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:51:46 INFO - Reading from file tmpfile_stdout 04:51:46 INFO - Detecting whether we're running mozinstall >=1.0... 04:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:51:46 INFO - Reading from file tmpfile_stdout 04:51:46 INFO - Output received: 04:51:46 INFO - Usage: mozinstall [options] installer 04:51:46 INFO - Options: 04:51:46 INFO - -h, --help show this help message and exit 04:51:46 INFO - -d DEST, --destination=DEST 04:51:46 INFO - Directory to install application into. [default: 04:51:46 INFO - "/builds/slave/test"] 04:51:46 INFO - --app=APP Application being installed. [default: firefox] 04:51:46 INFO - mkdir: /builds/slave/test/build/application 04:51:46 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:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:52:04 INFO - Reading from file tmpfile_stdout 04:52:04 INFO - Output received: 04:52:04 INFO - /builds/slave/test/build/application/firefox/firefox 04:52:04 INFO - Running post-action listener: _resource_record_post_action 04:52:04 INFO - [mozharness: 2017-07-24 11:52:04.275589Z] Finished install step (success) 04:52:04 INFO - [mozharness: 2017-07-24 11:52:04.275845Z] Running setup-mitmproxy step. 04:52:04 INFO - Running pre-action listener: _resource_record_pre_action 04:52:04 INFO - Running main action method: setup_mitmproxy 04:52:04 INFO - Skipping: mitmproxy is not required 04:52:04 INFO - Running post-action listener: _resource_record_post_action 04:52:04 INFO - [mozharness: 2017-07-24 11:52:04.276990Z] Finished setup-mitmproxy step (success) 04:52:04 INFO - [mozharness: 2017-07-24 11:52:04.277214Z] Running run-tests step. 04:52:04 INFO - Running pre-action listener: _resource_record_pre_action 04:52:04 INFO - Running pre-action listener: _set_gcov_prefix 04:52:04 INFO - Running main action method: run_tests 04:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:52:04 INFO - Python 2.7.3 04:52:04 INFO - Return code: 0 04:52:04 INFO - grabbing minidump binary from tooltool 04:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:04 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 0x24c1eb0>, '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 0x24c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c3240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:52:04 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:52:04 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:52:04 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:52:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:52:04 INFO - Return code: 0 04:52:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:52:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:52:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:52:04 INFO - ENV: RUST_BACKTRACE is now 1 04:52:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:52:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --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:52:04 INFO - Using env: {'DISPLAY': ':0', 04:52:04 INFO - 'HOME': '/home/cltbld', 04:52:04 INFO - 'LANG': 'en_US.UTF-8', 04:52:04 INFO - 'LANGUAGE': 'en_US:en', 04:52:04 INFO - 'LOGNAME': 'cltbld', 04:52:04 INFO - 'MAIL': '/var/mail/cltbld', 04:52:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:52:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:04 INFO - 'MOZ_NO_REMOTE': '1', 04:52:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:04 INFO - 'NO_EM_RESTART': '1', 04:52:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:04 INFO - 'PWD': '/builds/slave/test', 04:52:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:52:04 INFO - 'RUST_BACKTRACE': '1', 04:52:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:52:04 INFO - 'SHELL': '/bin/bash', 04:52:04 INFO - 'SHLVL': '1', 04:52:04 INFO - 'TERM': 'linux', 04:52:04 INFO - 'TMOUT': '86400', 04:52:04 INFO - 'USER': 'cltbld', 04:52:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231', 04:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:04 INFO - '_': '/tools/buildbot/bin/python'} 04:52:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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:52:04 INFO - mozversion application_buildid: 20170724110158 04:52:04 INFO - mozversion application_changeset: 60a5308fa987676fa5ed9fd5b3ad6c9938af0539 04:52:04 INFO - mozversion application_display_name: Nightly 04:52:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:52:04 INFO - mozversion application_name: Firefox 04:52:04 INFO - mozversion application_remotingname: firefox 04:52:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:52:04 INFO - mozversion application_vendor: Mozilla 04:52:04 INFO - mozversion application_version: 56.0a1 04:52:04 INFO - mozversion platform_buildid: 20170724110158 04:52:04 INFO - mozversion platform_changeset: 60a5308fa987676fa5ed9fd5b3ad6c9938af0539 04:52:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:52:04 INFO - mozversion platform_version: 56.0a1 04:52:04 INFO - using testdate: 1500897124 04:52:04 INFO - actual date: 1500897124 04:52:04 INFO - starting webserver on 'localhost:34463' 04:52:04 INFO - SUITE-START | Running 2 tests 04:52:04 INFO - TEST-START | dromaeo_css 04:52:04 INFO - Initialising browser for dromaeo_css test... 04:52:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34463/getInfo.html -profile /tmp/tmpcIJcWH/profile 04:52:04 INFO - TEST-INFO | started process 8469 (/builds/slave/test/build/application/firefox/firefox http://localhost:34463/getInfo.html) 04:52:10 INFO - TEST-INFO | 8469: exit 0 04:52:10 INFO - Browser initialized. 04:52:10 INFO - Running cycle 1/1 for dromaeo_css test... 04:52:10 INFO - TEST-INFO | started process 8676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcIJcWH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:21 INFO - PID 8676 | RSS: Main: 174706688 04:52:21 INFO - PID 8676 | 04:55:21 INFO - PID 8676 | Cycle 1(1): loaded http://localhost:34463/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34463/tests/dromaeo/cssquery-ext.html) 04:55:22 INFO - PID 8676 | RSS: Main: 179175424 04:55:22 INFO - PID 8676 | 04:58:24 INFO - PID 8676 | Cycle 1(1): loaded http://localhost:34463/tests/dromaeo/cssquery-ext.html (next: http://localhost:34463/tests/dromaeo/cssquery-jquery.html) 04:58:24 INFO - PID 8676 | RSS: Main: 177852416 04:58:24 INFO - PID 8676 | 05:01:26 INFO - PID 8676 | Cycle 1(1): loaded http://localhost:34463/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34463/tests/dromaeo/cssquery-mootools.html) 05:01:27 INFO - PID 8676 | RSS: Main: 179613696 05:01:27 INFO - PID 8676 | 05:04:28 INFO - PID 8676 | Cycle 1(1): loaded http://localhost:34463/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34463/tests/dromaeo/cssquery-prototype.html) 05:04:29 INFO - PID 8676 | RSS: Main: 177434624 05:04:29 INFO - PID 8676 | 05:07:33 INFO - PID 8676 | Cycle 1(1): loaded http://localhost:34463/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34463/tests/dromaeo/cssquery-yui.html) 05:07:34 INFO - PID 8676 | RSS: Main: 179175424 05:07:34 INFO - PID 8676 | 05:10:35 INFO - PID 8676 | Cycle 1(1): loaded http://localhost:34463/tests/dromaeo/cssquery-yui.html (next: http://localhost:34463/tests/dromaeo/cssquery-dojo.html) 05:10:36 INFO - PID 8676 | RSS: Main: 181592064 05:10:36 INFO - PID 8676 | 05:10:36 INFO - PID 8676 | __start_tp_report 05:10:36 INFO - PID 8676 | _x_x_mozilla_page_load 05:10:36 INFO - PID 8676 | _x_x_mozilla_page_load_details 05:10:36 INFO - PID 8676 | |i|pagename|runs| 05:10:36 INFO - PID 8676 | |0;dojo.html;3110.5645209670643;3129.2176955761074;3132.7493800495954;3163.49384098544;3177.3645270945804;6035.577509574332;6078.118672792442;6148.692565371736;6166.599171053884;6176.876462470748;5969.044952807551;6047.546434017444;6049;6054.212952316204;6065.181200537926;5562.471565201309;5588.776448942038;5592.748326325304;5598.24423702799;5610.943890561103;5587.3015873015875;5606.607537472379;5629.380768115504;5650.378458369576;5658.8019419320335;5560.527355174815;5643.984082865082;5646.265985421889;5661.952538780298;5678.659280443166;5451.209574611698;5554.055810512182;5589.301337332833;5610.074337734269;5619.859503512404;5534.418886016991;5548.361938377098;5592.5805564582415;5608;5630.634008789457;5956.761729530814;5974.701264936779;6006.219191505076;6019.217501724792;6072.969635151796;6413.070104834819;6519.152510173694;6568.507361947825;6572.145621069279;6583;6587.2095348558005;6623.271440141581;6661.433778128817;6680.532362734611;6684.766033188815;6101.84745381369;6128.417800309053;6186.814395568095;6197.287311959138;6212.565120441616;6611.702473388613;6686.7993960181275;6719.294474080249;6726.058351830748;6820.35206655367;6482.092507049017;6487.610743355413;6490.993895946136;6492.123563318986;6494.805155845333;6392.840178995562;6467.159269294962;6493;6561.5734977227285;6575.901361479581;6189.907151392733;6293.118963345135;6430.421262086435;6525.608463492111;6553.672316384257;6548.1814773153355;6557.180352455943;6574;6611.041398997215;6614;5319.335083114611;5327.760250788724;5405.5135037846785;5407.972960135174;5409.621326507186;4520.932186017212;4547.749873756975;4551.158035763395;4576.8626941191815;4598.724076555417;5689.345725241567;5771.5671324649975;5788.363280039192;5794.739236734273;5815.156802263733;6570.113034740344;6587.604743715392;6641.203055633355;6676.86646267072;6701.497387695845;5631.408702086222;5710.942890571124;5712.6001179917;5713.628614140068;5809.622374545641;5734.741936612862;5804.100364443518;5830.2420685310635;5845.590808643354;5851.853703657357;6359.427651511293;6364.7135878885565;6431.389018043372;6448.097266382711;6462.450691691259;6345.968270158804;6506.512011599054;6513.804585862432;6623.834404139935;6632.303608121078;6242.781502647567;6246.750129994931;6372.745090196526;6376.74493020274;6388.712507937247;6454.774082907264;6459.935400645933;6462.063000864942;6542.411182993554;6553.377429144223;6489.221293444817;6599.4390476808085;6619.933800661932;6699.899501507384;6707.832304192434;6255.0617407387435;6350.745970161327;6388.87222255543;6403.359664033559;6407.807765767035;6280.654563999024;6384.45732112757;6445.291017987924;6452.451541618827;6472.417482426604;6201.937980620317;6291.150694656163;6295.18162638854;6329.778457753957;6411.679416029273;6242.875142497215;6385;6452.709628066655;6461.483081353575;6480.643564603992;6227.750889964532;6261.436470717657;6277.96861015692;6308.337624549356;6330.208723909512 05:10:36 INFO - PID 8676 | |1;ext.html;815.4373482297215;854.6624083487022;876.0319846569537;883.7392969074123;1158.6176561734628;30101.849490752542;30649.846750766243;30983.225419364528;40789;41541.584584154225;41422.585774142324;41774.37338439926;41780.37329440053;41842;41917;7263.963680181591;7415.703371865119;7570.394368450538;7574.20470850561;7578.052743407075;7300;7441.367483763886;7446.888296675555;7450.962745186266;7451.366633836131;7398.186199518049;7457.366123879477;7464.776056718307;7476.140243871942;7485.9251407486045;7384.076990376203;7423.480356375029;7440.404767618577;7442.665080071356;7448.478606497547;7351.77944661661;7390.002349682778;7407;7414.666340014658;7415.666295016683;37449.625503745156;37505.24989500222;37658.8117059413;37672.24655506902;37774.24451510982;3555.6444355564495;3569.785812851237;3583.8924832254816;3594.442861356468;3596.460530920383;30303.696963030307;30642.38715225705;30706.84646576775;30742.538861917088;30745.385092298027;4859.41686997559;4893.241547560134;4896.951030489685;4911.165101932645;4966.826161084345;185128;186383;186629;186964.0651796746;187766;49369.753151234734;49395.259071113964;49463;49471.75264123656;49537.25694114591;51630;51649.48350516447;51652.22521662178;51653;51654.48345516572;16388.590285242724;16933.322667093424;16942;16958.745618815727;16989.320427182774;10902.182336324808;11010.39442830636;12299.754004919852;12487.250764954131;13924;14223.573292801233;14236.501722439665;14264.50074247417;14320.856791431952;14406.711865762625;5529.751161197675;5579.13523403873;5719.885602287931;5741.081426971665;5750.1949727038245;965.1362030982372;982.2093214962024;992.3599278465349;1010.2473657125488;1016.7407311135761;21893.233736819137;21995.164804552544;22408.327750167522;22956.311310660705;23151.884240579027;1045.9372437653765;1066.6373433032807;1080.8054550181043;1083.7182332593425;1087.342157994418;11874.465649045813;11970.82043769344;12099.395030248628;12136.696582585506;12185.268883866996;229863;232674;234253;234327;234388;51735;51949.480505194464;52032;52223.73888130535;52328;1453.847346028673;1460.5399299220712;1480.407836865241;1488.0402140619456;1496.102338596833;21730.782692172877;21779.455513612287;21885.452863678536;21946.670799937696;22144.55710885741;37524.812375937945;37705.62294377131;37811;37815.62184378121;37816.24367512689;197776;199646;201158;201327;201528;34670.65329346775;36140.27719445649;37661.623383765815;37707.62292377041;37905.62094379021;46034.76982615065;46530.30204547002;46660.300095497914;46864.297035545176;47039.529604703515;32972;33427.1643208912;33567.16082097967;33742;34405.483917740756;33407.49888751622;33784.32431351408;33946.83026584851;33980;34443.311133777686;36953.44569831508;37016;37100.25799484049;37379.06552336214;37500.43749343816;31316.37367252688;33554.664453356134;34042.31915361728;34534.30931381308;34651.48022779711;23632.054717811094;23722.406939826644;24008.87995560011;24744.25767226986;25801.870990644926 05:10:36 INFO - PID 8676 | |2;jquery.html;573.6930742053003;575.8416435480242;579.4755746049826;592.1946153231603;602.978895738649;21758.129674813008;22665.206717764882;22693.659595106088;22723.431914202134;22728.8863555682;25946.35134121648;26529;26534.469310613775;26554.468910621777;26562;6392.680365981706;6539.869202615945;6548.05053267276;6554.737810487599;6556.08214849919;5892.616979896315;6448.935510644904;6453.903191452132;6456.35436456353;6458.451031662291;6426.646534440627;6439.80680579581;6444.774432894849;6453.548251622388;6462.612243265396;6364.077208804743;6414.358564143572;6417;6433;6436.066770318301;5946.167536544887;5952.642841429528;5978.790742323998;5983.940160598426;5995.310539287994;26920.59619105715;30423.391532169455;31035.379292414025;31079.533806992913;31339.2763398013;1919.3570153998428;1947.2795065825735;1954.7263383126374;1956.814102660245;1962.1170473287077;19266.80733192664;19572.412827615193;19666.90166549158;19687.114079866442;19740.11169497376;2334.0780391745334;2384.9523009539885;2426.187227278846;2433.1605596069503;2446.397609565737;128878;134614;135124;135194.32402837923;135350.5254632176;14917.627059323604;14920.47778327775;14932.552023439313;15345;15413.229338533029;23751.524969500515;23785.643215351785;23809.166679166494;23849.165279215144;23886.283411497683;9797.853032204523;9879.184432436721;9912.702618921443;9920.652777152765;10027.849582256273;8592.140785921358;8852.114788521225;8964;9024.323175761843;9028.503432311287;7691.538507689556;9162.496062716615;9297.209737172281;9319.254459643213;9586.760330991781;2685.8657067146564;2740.0544414754218;2794.147784925617;2837.943241135166;2913.126062181337;947.6162154327509;951.8319809633653;959.3045042344245;963.4443381620532;995.4823491784232;19407.320743774184;19634.214631414583;19671.21315147407;19763.40709778709;20076.799232007786;974.4932635029745;1012.104287705386;1024.5850430575629;1030.8762948446085;1050.847627094067;10558.260921735406;10617.407388891574;10754;11138;11190.96355839773;474831;486421;488277;489736;499928;111819;121786;122989;123600.38199808943;124215.3789231048;1229.569650622275;1265.4685032286461;1295.2681734819985;1295.5659853949032;1298.8311519502404;16640.480430152616;17575.945443273446;17627.20677569538;18068.457946261635;18224.72662910031;52275.47724522858;52698.20952685789;53829.19256211238;53899.46100538944;54469.72765136149;75064.24935750791;75132.24867751253;75365;75701;75908.24091759011;12453.813192801934;12989.415476303779;14546.345414456164;14747.483838065617;14965.32656030503;23237;23589.52820943606;23708.288751337488;25025.374365640277;25033.249002529952;19165.32921347746;19348.613027739084;19366.70949935724;19420.514487137934;19554.022298884713;15440.922795385952;15875;16194.757078644065;16388.75416868772;16801.159942003094;19183;19812.603747925248;19844.60310793805;20195.192192312144;20220.494487637927;14947.925260373628;15059.698806024036;15088.396464141311;15121;15148.924255378653;18315.450536483928;18632.720509192102;18648.254069837054;18704.625907481503;18739 05:10:36 INFO - PID 8676 | |3;mootools.html;1358.3276278242272;1443.8989270751038;1447.2257342321857;1448.8478709735477;1452.2883786944394;13526.323683815806;13790.448382064731;14092;14138.363773630173;14166.504172353969;14250.358733856976;14487.420503179861;14505.202213878232;14505.927470362634;14512.201828899406;2647.5631520799043;2690.0719251858177;2709.9051533196343;2715.633389492413;2717;2681.852498112603;2762.185155379158;2771.750542451179;2792.986035069832;2795.329121010953;2678.4375281190974;2713.91858244253;2743.43759529297;2746.8214566053143;2757.9448411031767;2658.7607115359615;2669.8398096114297;2676.839389636628;2691.4886171627522;2708.7155848635907;2609.9217023489327;2621.488809682113;2642.4582960493053;2644.9074282400215;2646.364872430622;13490.325483725872;13696.589102326847;13810.240436775974;13819.654508637264;13825.308734563332;7499.325060744559;7768.378529717609;7772.844543109106;7779.338756205672;7784.766457006299;4977.203647416432;5054.82308119214;5160.974195129001;5241.8165364212455;5251.894962100737;1889.7070954002015;1906.1041310584003;1907.8569107316869;1939.7575303087115;1940.262700173939;21723.565528689338;21831.345059648236;21924.780752192593;21951.560968780534;22111.44721381978;6046.3349031606485;6257.687115644199;6290.182276304051;6400.039994000844;6453.548251622341;15726.21368931549;15748.76376854348;15751.842481575266;15752.369905203663;15795.36818527246;7259.709611615582;7495.025646665898;7497.362724168398;7504.512206706547;7504.887426688604;5895.4399332063385;5999;6172.321044685081;6906.792796216121;6914.204866440323;4920.778564964585;4977.65156439053;5131.56381707559;5135.820246291437;5146.150885103916;1445.7614493608646;1463.8536146385488;1465.992670036643;1494.5815171751926;1497.2332647476082;866.6403442571262;892.3307519360479;902.4179404284331;919.5815903763771;921.3228277216241;7156.105486814148;8384.706535271236;8457.534835584102;8520.786980325418;8756.912430875736;944.1313991128178;953.8950715421298;993.6522217224058;1006.1699098243978;1027.275770581753;4887.73117478535;4987.226979818134;5044.4198917125;5046.9747651261505;5281;18209.63580728378;18650.440486785417;18879.52801179954;19064.52338691516;19113.52216194606;18291;19600.509987250432;19697.113629886404;19719.901400493192;19922.402327930184;10669.83995240072;10957.397343146204;10979.451027448597;10989.890101099047;11019.449027548591;7363.630459652469;8132.878006829784;8240.83518329618;8319.334453243606;8500.36247281444;16004.67990640204;16202.351905923631;16396.508104756875;16594.834051659327;16626.418075367303;15829.604259893595;16065.678686425972;16503.09232992197;16597.41909033178;16914.746278805582;11184.496697648463;11402.94298528502;11405.657830265105;11406.372649504357;11418.429078546205;12732.299723515296;12769.553065642658;12813.359332033548;12859.678508037374;12898.67753306175;10448.32085914413;10563.313384629975;10760.89239107599;10844.295120817122;10864.674059778219;9809.313348065567;10297.227707922086;10450.16398688088;10547.261691681508;10597.15222782191;9282.675106371245;9313.627454901729;9414.57634406467;9424.528773561158;9450.858237126586;6907.758228461979;7101.431885449255;7262.963685181751;7328.926710732824;7369.484136110421;6450.258220304725;6769.864602708017;6986.126734158231;7011.754588589375;7069.081019467436 05:10:36 INFO - PID 8676 | |4;prototype.html;467.233736671858;503.69023050823756;505.724380212784;509.94900509948997;528.735632183908;6137.294211165718;6264.123022776809;6333.746650133995;6333.936660633392;6337;6125.969370153143;6126.172966649512;6135.110408990694;6136.545381847252;6155.815325540229;4881.877168251313;4902.926456103143;4910.1898186799135;4927.852164435073;4933.260010998343;4791.47293797682;4851.417829860422;4910.435299940516;4939.333190019337;5006.874828129289;4920.950790492085;4935.5804756595735;4935.8272460463895;4954.727489988068;4976.203807390818;4926.655134140611;4933;4935.235038569028;4943.431505376891;4955.776990035439;4410.184115938561;4429.623482004034;4440.844570440019;4448.777561121931;4452.018851611035;6078.635281883101;6114.602550834182;6121.234845644294;6131.785387511416;6132.264128304588;5625.240592519998;5645.040343141676;5657.377688454267;5674;5702.201691763156;6535.21577410709;6535.738570457176;6542.738290468375;6568.3103274156;6568.967155164241;4817.951820481785;4851.393575803025;4858.805647774085;4869.2939523768855;4871.318015477836;6873.250699720152;6926.688299026556;6951.965240173767;6956.65216739166;6998.160220773489;5022.196448568285;5057.291979122926;5069.163588008011;5072.485487915758;5080.74596270185;5039.420466646309;5068.4424713281505;5074.2895994560795;5155.896882062413;5168.2866495090375;5614.410486898899;5640.746166422521;5673.574481913873;5711.286089238845;5786.392428795;6306.211723534559;6527.934720652733;6576;6630.86738265232;6647.302033286532;1704.718721410978;1710.187660861106;1777.5467255849935;1780.376868096156;1786.8659850511265;1221.688469440287;1221.908356873238;1247.2890452442202;1249.4377530111485;1256.1834807375278;5659.547675917687;5778.479936805707;5794.88410231793;5806.44838740319;5810.593258471867;6763.985402189711;6773.017912402674;6776.543043245726;6805.557638753465;6811.318868113149;5807.82576522705;5812.3025236971835;5824.94175058244;5841;5852.941470585325;3578.910527236788;3591.60492345847;3596.047047532406;3627.1113577173232;3641.289948460078;6553.148090748267;6556.377144171296;6559.24568674599;6562.8359291018105;6596.86806263872;6926.610319439786;6948.583085014915;6952.304769523007;6952.826179345456;6956.678231136068;6463.515236357198;6494.253160886369;6531;6540.117084193668;6544.411003009657;6690.632015239208;6722.731090756315;6732.562383445061;6742.190937087581;6813.182418109858;6537.836554086186;6540.2151741789385;6609.966950165219;6642;6721.495887808336;6462.612243265419;6494.740210391531;6499.1876015498065;6500.869982600227;6511.744127936032;5005.124103281838;5051.797928082982;5076.898462030665;5082.391502033597;5085.618578606545;6483.157189565326;6657.538080198173;6731.899021514583;6754.2570317266045;6803.42170915458;6364.586301890362;6368.579939622914;6457.321981191907;6503.6097834130105;6523.9347606525225;6351.396617321347;6386.552941294065;6446.871062578816;6499.935000650122;6513.837154071186;6306.337834527492;6338.936610633835;6363;6379.170707807955;6483.481321494363;6450.483961282992;6459.160309159967;6494.383033611799;6548.901766473411;6575.868482630416;6310.49516038725;6311.400416960381;6313.55805093639;6365.7135428904885;6376.39424254695 05:10:36 INFO - PID 8676 | |5;yui.html;906.1210625693079;921.2445794448552;931.3992474853716;940.1491650056697;944.0465130218481;15321.846781532182;16171.35314587415;21213.787862121375;21990.89004554975;22010.119595216172;17141.571460713458;18484.44546663599;18504.907475462638;18555;18572.257109715596;1030.3663247103034;1062.5537274344795;1063.2132222155587;1063.2557209953025;1063.478895341281;1039.7088815131776;1045.7176562328204;1047.0681093826502;1047.5809676129534;1047.6123834181365;1109.0960866893456;1112.9833052504177;1115.0577761791274;1115.2304909612383;1115.9888401116007;1083.4528563075676;1108.1024370260075;1110.3116068037868;1110.439228189763;1111.4053981120103;785.6071964017991;792.8929594504783;797.7207977207988;803.6263137641025;806.1897792718339;17756.644867102714;17963.73054404185;17968;18043.188056537358;18319.450416487394;19473;20756.377308680763;20794.16823327065;20904.79095209059;20961.790382096136;15687.607809804733;16585;16633.50099497017;16654.58363540909;16726.58183545409;3290.276139249361;3367.7474189435648;3368.4610462326154;3373.4939759036097;3407.522946787427;115810.42094789472;119751.40124299409;120460;121660.39169804183;123756;15739.921300393426;16486.422975195812;16628.168591570375;17163.313467461412;17175.570610734583;29815.85092074526;30869.845650771604;31047.379052418826;31233.219169520944;31409.685903141133;8529.914700853036;8673.479591224546;8710.47737135774;8739.519326437106;8804.735857924272;3873.3996230584303;3959.1092004298803;3968.7420317679257;3970.781607011642;3978.1844721831953;5029.06962211992;5044.571211447068;5152.252923326097;5161.225816127536;5181.4300426953005;1031.8400647899587;1034.9586016559253;1040.5889673579045;1042.1714736784274;1042.8852826189113;654.7348323928817;703.5813690853934;717.1716667249335;726.1322719350431;727.7598392530452;11704.712481627013;12286.692832679255;12449.751004980031;12699.11106222574;12828.29444380568;682.126877596677;703.2615753458848;706.3254591864757;717.9138503379523;724.0731863215093;5376.489233522809;5385;5436.0486914790545;5467.309566042905;6056.182415373956;98259;100139.49930250448;101836;101837.49081254695;105148;85921.57039214764;88003.55998219967;93154.53422732979;94292;94365;79703;80360.59819700864;80962;82988;84471.5776421114;11874.703132421759;12331.938340308241;12407.813882791585;12447.564335248222;12617.747645046864;36307.27385452329;36636;37873.81063094667;38113.2377352457;40092;46963.530364695915;66398.66800665966;66986;67229.55197506245;73337.6333118331;18445.262189512807;18737.531561710523;18742;18894.3386981455;19301.32445364462;19823;19924.60150796947;20351.185952561733;20554.486137846674;20694;18635.534111646775;18840.246390144242;18946.052697365354;19077.332293369665;19162;17487;17821.376251831123;18011.459656210336;18999;19657.213711451383;17955.281788728305;18406.447806565826;18459.446216613524;18570.53573660615;18871;13052.34738263102;13536.729265414833;14178.86569074451;14203.857961420254;14697.92651036738;13105.14816536922;13846;13878.791818122534;14101.506447274296;14496.565103046925 05:10:36 INFO - PID 8676 | __end_tp_report 05:10:36 INFO - PID 8676 | __start_cc_report 05:10:36 INFO - PID 8676 | _x_x_mozilla_cycle_collect,379 05:10:36 INFO - PID 8676 | __end_cc_report 05:10:36 INFO - PID 8676 | __startTimestamp1500898236041__endTimestamp 05:10:36 INFO - PID 8676 | 05:10:36 INFO - PID 8676 | ------- Summary: start ------- 05:10:36 INFO - PID 8676 | Number of tests: 6 05:10:36 INFO - PID 8676 | 05:10:36 INFO - PID 8676 | [#0] dojo.html Cycles:165 Average:6040.73 Median:6261.44 stddev:700.90 (11.2%) stddev-sans-first:664.29 05:10:36 INFO - PID 8676 | Values: 3110.6 3129.2 3132.7 3163.5 3177.4 6035.6 6078.1 6148.7 6166.6 6176.9 5969.0 6047.5 6049.0 6054.2 6065.2 5562.5 5588.8 5592.7 5598.2 5610.9 5587.3 5606.6 5629.4 5650.4 5658.8 5560.5 5644.0 5646.3 5662.0 5678.7 5451.2 5554.1 5589.3 5610.1 5619.9 5534.4 5548.4 5592.6 5608.0 5630.6 5956.8 5974.7 6006.2 6019.2 6073.0 6413.1 6519.2 6568.5 6572.1 6583.0 6587.2 6623.3 6661.4 6680.5 6684.8 6101.8 6128.4 6186.8 6197.3 6212.6 6611.7 6686.8 6719.3 6726.1 6820.4 6482.1 6487.6 6491.0 6492.1 6494.8 6392.8 6467.2 6493.0 6561.6 6575.9 6189.9 6293.1 6430.4 6525.6 6553.7 6548.2 6557.2 6574.0 6611.0 6614.0 5319.3 5327.8 5405.5 5408.0 5409.6 4520.9 4547.7 4551.2 4576.9 4598.7 5689.3 5771.6 5788.4 5794.7 5815.2 6570.1 6587.6 6641.2 6676.9 6701.5 5631.4 5710.9 5712.6 5713.6 5809.6 5734.7 5804.1 5830.2 5845.6 5851.9 6359.4 6364.7 6431.4 6448.1 6462.5 6346.0 6506.5 6513.8 6623.8 6632.3 6242.8 6246.8 6372.7 6376.7 6388.7 6454.8 6459.9 6462.1 6542.4 6553.4 6489.2 6599.4 6619.9 6699.9 6707.8 6255.1 6350.7 6388.9 6403.4 6407.8 6280.7 6384.5 6445.3 6452.5 6472.4 6201.9 6291.2 6295.2 6329.8 6411.7 6242.9 6385.0 6452.7 6461.5 6480.6 6227.8 6261.4 6278.0 6308.3 6330.2 05:10:36 INFO - PID 8676 | 05:10:36 INFO - PID 8676 | [#1] ext.html Cycles:180 Average:37702.59 Median:3595.45 stddev:53823.94 (1497.0%) stddev-sans-first:53903.66 05:10:36 INFO - PID 8676 | Values: 815.4 854.7 876.0 883.7 1158.6 30101.8 30649.8 30983.2 40789.0 41541.6 41422.6 41774.4 41780.4 41842.0 41917.0 7264.0 7415.7 7570.4 7574.2 7578.1 7300.0 7441.4 7446.9 7451.0 7451.4 7398.2 7457.4 7464.8 7476.1 7485.9 7384.1 7423.5 7440.4 7442.7 7448.5 7351.8 7390.0 7407.0 7414.7 7415.7 37449.6 37505.2 37658.8 37672.2 37774.2 3555.6 3569.8 3583.9 3594.4 3596.5 30303.7 30642.4 30706.8 30742.5 30745.4 4859.4 4893.2 4897.0 4911.2 4966.8 185128.0 186383.0 186629.0 186964.1 187766.0 49369.8 49395.3 49463.0 49471.8 49537.3 51630.0 51649.5 51652.2 51653.0 51654.5 16388.6 16933.3 16942.0 16958.7 16989.3 10902.2 11010.4 12299.8 12487.3 13924.0 14223.6 14236.5 14264.5 14320.9 14406.7 5529.8 5579.1 5719.9 5741.1 5750.2 965.1 982.2 992.4 1010.2 1016.7 21893.2 21995.2 22408.3 22956.3 23151.9 1045.9 1066.6 1080.8 1083.7 1087.3 11874.5 11970.8 12099.4 12136.7 12185.3 229863.0 232674.0 234253.0 234327.0 234388.0 51735.0 51949.5 52032.0 52223.7 52328.0 1453.8 1460.5 1480.4 1488.0 1496.1 21730.8 21779.5 21885.5 21946.7 22144.6 37524.8 37705.6 37811.0 37815.6 37816.2 197776.0 199646.0 201158.0 201327.0 201528.0 34670.7 36140.3 37661.6 37707.6 37905.6 46034.8 46530.3 46660.3 46864.3 47039.5 32972.0 33427.2 33567.2 33742.0 34405.5 33407.5 33784.3 33946.8 33980.0 34443.3 36953.4 37016.0 37100.3 37379.1 37500.4 31316.4 33554.7 34042.3 34534.3 34651.5 23632.1 23722.4 24008.9 24744.3 25801.9 05:10:36 INFO - PID 8676 | 05:10:36 INFO - PID 8676 | [#2] jquery.html Cycles:180 Average:34855.94 Median:23797.40 stddev:82283.59 (345.8%) stddev-sans-first:82474.16 05:10:36 INFO - PID 8676 | Values: 573.7 575.8 579.5 592.2 603.0 21758.1 22665.2 22693.7 22723.4 22728.9 25946.4 26529.0 26534.5 26554.5 26562.0 6392.7 6539.9 6548.1 6554.7 6556.1 5892.6 6448.9 6453.9 6456.4 6458.5 6426.6 6439.8 6444.8 6453.5 6462.6 6364.1 6414.4 6417.0 6433.0 6436.1 5946.2 5952.6 5978.8 5983.9 5995.3 26920.6 30423.4 31035.4 31079.5 31339.3 1919.4 1947.3 1954.7 1956.8 1962.1 19266.8 19572.4 19666.9 19687.1 19740.1 2334.1 2385.0 2426.2 2433.2 2446.4 128878.0 134614.0 135124.0 135194.3 135350.5 14917.6 14920.5 14932.6 15345.0 15413.2 23751.5 23785.6 23809.2 23849.2 23886.3 9797.9 9879.2 9912.7 9920.7 10027.8 8592.1 8852.1 8964.0 9024.3 9028.5 7691.5 9162.5 9297.2 9319.3 9586.8 2685.9 2740.1 2794.1 2837.9 2913.1 947.6 951.8 959.3 963.4 995.5 19407.3 19634.2 19671.2 19763.4 20076.8 974.5 1012.1 1024.6 1030.9 1050.8 10558.3 10617.4 10754.0 11138.0 11191.0 474831.0 486421.0 488277.0 489736.0 499928.0 111819.0 121786.0 122989.0 123600.4 124215.4 1229.6 1265.5 1295.3 1295.6 1298.8 16640.5 17575.9 17627.2 18068.5 18224.7 52275.5 52698.2 53829.2 53899.5 54469.7 75064.2 75132.2 75365.0 75701.0 75908.2 12453.8 12989.4 14546.3 14747.5 14965.3 23237.0 23589.5 23708.3 25025.4 25033.2 19165.3 19348.6 19366.7 19420.5 19554.0 15440.9 15875.0 16194.8 16388.8 16801.2 19183.0 19812.6 19844.6 20195.2 20220.5 14947.9 15059.7 15088.4 15121.0 15148.9 18315.5 18632.7 18648.3 18704.6 18739.0 05:10:36 INFO - PID 8676 | 05:10:36 INFO - PID 8676 | [#3] mootools.html Cycles:180 Average:8610.88 Median:2646.96 stddev:5773.22 (218.1%) stddev-sans-first:5763.69 05:10:36 INFO - PID 8676 | Values: 1358.3 1443.9 1447.2 1448.8 1452.3 13526.3 13790.4 14092.0 14138.4 14166.5 14250.4 14487.4 14505.2 14505.9 14512.2 2647.6 2690.1 2709.9 2715.6 2717.0 2681.9 2762.2 2771.8 2793.0 2795.3 2678.4 2713.9 2743.4 2746.8 2757.9 2658.8 2669.8 2676.8 2691.5 2708.7 2609.9 2621.5 2642.5 2644.9 2646.4 13490.3 13696.6 13810.2 13819.7 13825.3 7499.3 7768.4 7772.8 7779.3 7784.8 4977.2 5054.8 5161.0 5241.8 5251.9 1889.7 1906.1 1907.9 1939.8 1940.3 21723.6 21831.3 21924.8 21951.6 22111.4 6046.3 6257.7 6290.2 6400.0 6453.5 15726.2 15748.8 15751.8 15752.4 15795.4 7259.7 7495.0 7497.4 7504.5 7504.9 5895.4 5999.0 6172.3 6906.8 6914.2 4920.8 4977.7 5131.6 5135.8 5146.2 1445.8 1463.9 1466.0 1494.6 1497.2 866.6 892.3 902.4 919.6 921.3 7156.1 8384.7 8457.5 8520.8 8756.9 944.1 953.9 993.7 1006.2 1027.3 4887.7 4987.2 5044.4 5047.0 5281.0 18209.6 18650.4 18879.5 19064.5 19113.5 18291.0 19600.5 19697.1 19719.9 19922.4 10669.8 10957.4 10979.5 10989.9 11019.4 7363.6 8132.9 8240.8 8319.3 8500.4 16004.7 16202.4 16396.5 16594.8 16626.4 15829.6 16065.7 16503.1 16597.4 16914.7 11184.5 11402.9 11405.7 11406.4 11418.4 12732.3 12769.6 12813.4 12859.7 12898.7 10448.3 10563.3 10760.9 10844.3 10864.7 9809.3 10297.2 10450.2 10547.3 10597.2 9282.7 9313.6 9414.6 9424.5 9450.9 6907.8 7101.4 7263.0 7328.9 7369.5 6450.3 6769.9 6986.1 7011.8 7069.1 05:10:36 INFO - PID 8676 | 05:10:36 INFO - PID 8676 | [#4] prototype.html Cycles:180 Average:5507.14 Median:6132.02 stddev:1545.19 (25.2%) stddev-sans-first:1502.51 05:10:36 INFO - PID 8676 | Values: 467.2 503.7 505.7 509.9 528.7 6137.3 6264.1 6333.7 6333.9 6337.0 6126.0 6126.2 6135.1 6136.5 6155.8 4881.9 4902.9 4910.2 4927.9 4933.3 4791.5 4851.4 4910.4 4939.3 5006.9 4921.0 4935.6 4935.8 4954.7 4976.2 4926.7 4933.0 4935.2 4943.4 4955.8 4410.2 4429.6 4440.8 4448.8 4452.0 6078.6 6114.6 6121.2 6131.8 6132.3 5625.2 5645.0 5657.4 5674.0 5702.2 6535.2 6535.7 6542.7 6568.3 6569.0 4818.0 4851.4 4858.8 4869.3 4871.3 6873.3 6926.7 6952.0 6956.7 6998.2 5022.2 5057.3 5069.2 5072.5 5080.7 5039.4 5068.4 5074.3 5155.9 5168.3 5614.4 5640.7 5673.6 5711.3 5786.4 6306.2 6527.9 6576.0 6630.9 6647.3 1704.7 1710.2 1777.5 1780.4 1786.9 1221.7 1221.9 1247.3 1249.4 1256.2 5659.5 5778.5 5794.9 5806.4 5810.6 6764.0 6773.0 6776.5 6805.6 6811.3 5807.8 5812.3 5824.9 5841.0 5852.9 3578.9 3591.6 3596.0 3627.1 3641.3 6553.1 6556.4 6559.2 6562.8 6596.9 6926.6 6948.6 6952.3 6952.8 6956.7 6463.5 6494.3 6531.0 6540.1 6544.4 6690.6 6722.7 6732.6 6742.2 6813.2 6537.8 6540.2 6610.0 6642.0 6721.5 6462.6 6494.7 6499.2 6500.9 6511.7 5005.1 5051.8 5076.9 5082.4 5085.6 6483.2 6657.5 6731.9 6754.3 6803.4 6364.6 6368.6 6457.3 6503.6 6523.9 6351.4 6386.6 6446.9 6499.9 6513.8 6306.3 6338.9 6363.0 6379.2 6483.5 6450.5 6459.2 6494.4 6548.9 6575.9 6310.5 6311.4 6313.6 6365.7 6376.4 05:10:36 INFO - PID 8676 | 05:10:36 INFO - PID 8676 | [#5] yui.html Cycles:180 Average:22758.27 Median:18972.53 stddev:30077.01 (158.5%) stddev-sans-first:30116.62 05:10:36 INFO - PID 8676 | Values: 906.1 921.2 931.4 940.1 944.0 15321.8 16171.4 21213.8 21990.9 22010.1 17141.6 18484.4 18504.9 18555.0 18572.3 1030.4 1062.6 1063.2 1063.3 1063.5 1039.7 1045.7 1047.1 1047.6 1047.6 1109.1 1113.0 1115.1 1115.2 1116.0 1083.5 1108.1 1110.3 1110.4 1111.4 785.6 792.9 797.7 803.6 806.2 17756.6 17963.7 17968.0 18043.2 18319.5 19473.0 20756.4 20794.2 20904.8 20961.8 15687.6 16585.0 16633.5 16654.6 16726.6 3290.3 3367.7 3368.5 3373.5 3407.5 115810.4 119751.4 120460.0 121660.4 123756.0 15739.9 16486.4 16628.2 17163.3 17175.6 29815.9 30869.8 31047.4 31233.2 31409.7 8529.9 8673.5 8710.5 8739.5 8804.7 3873.4 3959.1 3968.7 3970.8 3978.2 5029.1 5044.6 5152.3 5161.2 5181.4 1031.8 1035.0 1040.6 1042.2 1042.9 654.7 703.6 717.2 726.1 727.8 11704.7 12286.7 12449.8 12699.1 12828.3 682.1 703.3 706.3 717.9 724.1 5376.5 5385.0 5436.0 5467.3 6056.2 98259.0 100139.5 101836.0 101837.5 105148.0 85921.6 88003.6 93154.5 94292.0 94365.0 79703.0 80360.6 80962.0 82988.0 84471.6 11874.7 12331.9 12407.8 12447.6 12617.7 36307.3 36636.0 37873.8 38113.2 40092.0 46963.5 66398.7 66986.0 67229.6 73337.6 18445.3 18737.5 18742.0 18894.3 19301.3 19823.0 19924.6 20351.2 20554.5 20694.0 18635.5 18840.2 18946.1 19077.3 19162.0 17487.0 17821.4 18011.5 18999.0 19657.2 17955.3 18406.4 18459.4 18570.5 18871.0 13052.3 13536.7 14178.9 14203.9 14697.9 13105.1 13846.0 13878.8 14101.5 14496.6 05:10:36 INFO - PID 8676 | -------- Summary: end -------- 05:10:36 INFO - PID 8676 | 05:10:36 INFO - TEST-INFO | 8676: exit 0 05:10:36 INFO - TEST-OK | dromaeo_css | took 1112095ms 05:10:36 INFO - TEST-START | kraken 05:10:36 INFO - Initialising browser for kraken test... 05:10:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34463/getInfo.html -profile /tmp/tmpqo8Suw/profile 05:10:36 INFO - TEST-INFO | started process 9041 (/builds/slave/test/build/application/firefox/firefox http://localhost:34463/getInfo.html) 05:10:42 INFO - TEST-INFO | 9041: exit 0 05:10:42 INFO - Browser initialized. 05:10:42 INFO - Running cycle 1/1 for kraken test... 05:10:42 INFO - TEST-INFO | started process 9248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqo8Suw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:53 INFO - PID 9248 | RSS: Main: 176480256 05:10:53 INFO - PID 9248 | 05:10:56 INFO - PID 9248 | Cycle 1(1): loaded http://localhost:34463/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34463/tests/kraken/driver.html?testName=audio-beat-detection) 05:10:57 INFO - PID 9248 | RSS: Main: 182067200 05:10:57 INFO - PID 9248 | 05:11:00 INFO - PID 9248 | Cycle 1(1): loaded http://localhost:34463/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34463/tests/kraken/driver.html?testName=audio-dft) 05:11:00 INFO - PID 9248 | RSS: Main: 182083584 05:11:00 INFO - PID 9248 | 05:11:03 INFO - PID 9248 | Cycle 1(1): loaded http://localhost:34463/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34463/tests/kraken/driver.html?testName=audio-fft) 05:11:04 INFO - PID 9248 | RSS: Main: 175894528 05:11:04 INFO - PID 9248 | 05:11:06 INFO - PID 9248 | Cycle 1(1): loaded http://localhost:34463/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34463/tests/kraken/driver.html?testName=audio-oscillator) 05:11:07 INFO - PID 9248 | RSS: Main: 176525312 05:11:07 INFO - PID 9248 | 05:11:09 INFO - PID 9248 | Cycle 1(1): loaded http://localhost:34463/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34463/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:11:09 INFO - PID 9248 | RSS: Main: 176570368 05:11:09 INFO - PID 9248 | 05:11:13 INFO - PID 9248 | Cycle 1(1): loaded http://localhost:34463/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34463/tests/kraken/driver.html?testName=imaging-darkroom) 05:11:13 INFO - PID 9248 | RSS: Main: 179150848 05:11:13 INFO - PID 9248 | 05:11:17 INFO - PID 9248 | Cycle 1(1): loaded http://localhost:34463/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34463/tests/kraken/driver.html?testName=imaging-desaturate) 05:11:17 INFO - PID 9248 | RSS: Main: 178753536 05:11:17 INFO - PID 9248 | 05:11:20 INFO - PID 9248 | Cycle 1(1): loaded http://localhost:34463/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34463/tests/kraken/driver.html?testName=json-parse-financial) 05:11:21 INFO - PID 9248 | RSS: Main: 179965952 05:11:21 INFO - PID 9248 | 05:11:22 INFO - PID 9248 | Cycle 1(1): loaded http://localhost:34463/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34463/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:11:23 INFO - PID 9248 | RSS: Main: 179666944 05:11:23 INFO - PID 9248 | 05:11:25 INFO - PID 9248 | Cycle 1(1): loaded http://localhost:34463/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34463/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:11:26 INFO - PID 9248 | RSS: Main: 177102848 05:11:26 INFO - PID 9248 | 05:11:28 INFO - PID 9248 | Cycle 1(1): loaded http://localhost:34463/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34463/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:11:28 INFO - PID 9248 | RSS: Main: 177123328 05:11:28 INFO - PID 9248 | 05:11:31 INFO - PID 9248 | Cycle 1(1): loaded http://localhost:34463/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34463/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:11:32 INFO - PID 9248 | RSS: Main: 177291264 05:11:32 INFO - PID 9248 | 05:11:35 INFO - PID 9248 | Cycle 1(1): loaded http://localhost:34463/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34463/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:11:35 INFO - PID 9248 | RSS: Main: 177549312 05:11:35 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | Cycle 1(1): loaded http://localhost:34463/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34463/tests/kraken/driver.html?testName=ai-astar) 05:11:37 INFO - PID 9248 | RSS: Main: 179175424 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | __start_tp_report 05:11:37 INFO - PID 9248 | _x_x_mozilla_page_load 05:11:37 INFO - PID 9248 | _x_x_mozilla_page_load_details 05:11:37 INFO - PID 9248 | |i|pagename|runs| 05:11:37 INFO - PID 9248 | |0;ai-astar;106;111;98;109;111;111;111;109;110;113 05:11:37 INFO - PID 9248 | |1;audio-beat-detection;141;118;145;189;120;148;149;123;168;119 05:11:37 INFO - PID 9248 | |2;audio-dft;164;164;163;163;165;161;166;166;167;161 05:11:37 INFO - PID 9248 | |3;audio-fft;76;77;75;182;76;75;75;74;161;78 05:11:37 INFO - PID 9248 | |4;audio-oscillator;82;80;139;81;81;81;127;82;80;137 05:11:37 INFO - PID 9248 | |5;imaging-gaussian-blur;115;114;114;115;115;114;115;115;114;114 05:11:37 INFO - PID 9248 | |6;imaging-darkroom;151;151;152;151;149;153;150;150;150;151 05:11:37 INFO - PID 9248 | |7;imaging-desaturate;94;94;94;94;94;95;94;94;94;94 05:11:37 INFO - PID 9248 | |8;json-parse-financial;55;56;58;55;56;56;56;56;55;55 05:11:37 INFO - PID 9248 | |9;json-stringify-tinderbox;56;54;56;56;55;54;55;56;55;55 05:11:37 INFO - PID 9248 | |10;stanford-crypto-aes;85;88;77;77;83;88;77;77;87;78 05:11:37 INFO - PID 9248 | |11;stanford-crypto-ccm;135;128;128;138;126;124;131;125;130;176 05:11:37 INFO - PID 9248 | |12;stanford-crypto-pbkdf2;177;180;197;174;178;174;185;176;185;176 05:11:37 INFO - PID 9248 | |13;stanford-crypto-sha256-iterative;71;67;69;69;68;68;68;67;70;71 05:11:37 INFO - PID 9248 | __end_tp_report 05:11:37 INFO - PID 9248 | __start_cc_report 05:11:37 INFO - PID 9248 | _x_x_mozilla_cycle_collect,1012 05:11:37 INFO - PID 9248 | __end_cc_report 05:11:37 INFO - PID 9248 | __startTimestamp1500898297938__endTimestamp 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | ------- Summary: start ------- 05:11:37 INFO - PID 9248 | Number of tests: 14 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:4.25 (3.8%) stddev-sans-first:4.38 05:11:37 INFO - PID 9248 | Values: 106.0 111.0 98.0 109.0 111.0 111.0 111.0 109.0 110.0 113.0 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:146.50 stddev:23.40 (16.0%) stddev-sans-first:24.82 05:11:37 INFO - PID 9248 | Values: 141.0 118.0 145.0 189.0 120.0 148.0 149.0 123.0 168.0 119.0 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.50 stddev:2.05 (1.2%) stddev-sans-first:2.18 05:11:37 INFO - PID 9248 | Values: 164.0 164.0 163.0 163.0 165.0 161.0 166.0 166.0 167.0 161.0 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | [#3] audio-fft Cycles:10 Average:94.90 Median:75.50 stddev:40.69 (53.9%) stddev-sans-first:42.58 05:11:37 INFO - PID 9248 | Values: 76.0 77.0 75.0 182.0 76.0 75.0 75.0 74.0 161.0 78.0 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:81.00 stddev:25.95 (32.0%) stddev-sans-first:26.95 05:11:37 INFO - PID 9248 | Values: 82.0 80.0 139.0 81.0 81.0 81.0 127.0 82.0 80.0 137.0 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:115.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:11:37 INFO - PID 9248 | Values: 115.0 114.0 114.0 115.0 115.0 114.0 115.0 115.0 114.0 114.0 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 05:11:37 INFO - PID 9248 | Values: 151.0 151.0 152.0 151.0 149.0 153.0 150.0 150.0 150.0 151.0 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:11:37 INFO - PID 9248 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:0.92 (1.6%) stddev-sans-first:0.93 05:11:37 INFO - PID 9248 | Values: 55.0 56.0 58.0 55.0 56.0 56.0 56.0 56.0 55.0 55.0 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | [#9] json-stringify-tinderbox Cycles:10 Average:55.20 Median:55.50 stddev:0.79 (1.4%) stddev-sans-first:0.78 05:11:37 INFO - PID 9248 | Values: 56.0 54.0 56.0 56.0 55.0 54.0 55.0 56.0 55.0 55.0 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:84.00 stddev:4.97 (5.9%) stddev-sans-first:5.12 05:11:37 INFO - PID 9248 | Values: 85.0 88.0 77.0 77.0 83.0 88.0 77.0 77.0 87.0 78.0 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:130.50 stddev:15.36 (11.8%) stddev-sans-first:16.29 05:11:37 INFO - PID 9248 | Values: 135.0 128.0 128.0 138.0 126.0 124.0 131.0 125.0 130.0 176.0 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.20 Median:179.00 stddev:7.11 (4.0%) stddev-sans-first:7.45 05:11:37 INFO - PID 9248 | Values: 177.0 180.0 197.0 174.0 178.0 174.0 185.0 176.0 185.0 176.0 05:11:37 INFO - PID 9248 | 05:11:37 INFO - PID 9248 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.48 (2.1%) stddev-sans-first:1.33 05:11:37 INFO - PID 9248 | Values: 71.0 67.0 69.0 69.0 68.0 68.0 68.0 67.0 70.0 71.0 05:11:37 INFO - PID 9248 | -------- Summary: end -------- 05:11:37 INFO - PID 9248 | 05:11:38 INFO - PID 9248 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:11:38 INFO - TEST-INFO | 9248: exit 0 05:11:38 INFO - TEST-OK | kraken | took 62019ms 05:11:38 INFO - SUITE-END | took 1174s 05:11:39 INFO - Completed test suite (00:19:34) 05:11:39 INFO - javascript benchmark 05:11:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8425.415778966399, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3110.5645209670643, 3129.2176955761074, 3132.7493800495954, 3163.49384098544, 3177.3645270945804, 6035.577509574332, 6078.118672792442, 6148.692565371736, 6166.599171053884, 6176.876462470748, 5969.044952807551, 6047.546434017444, 6049.0, 6054.212952316204, 6065.181200537926, 5562.471565201309, 5588.776448942038, 5592.748326325304, 5598.24423702799, 5610.943890561103, 5587.3015873015875, 5606.607537472379, 5629.380768115504, 5650.378458369576, 5658.8019419320335, 5560.527355174815, 5643.984082865082, 5646.265985421889, 5661.952538780298, 5678.659280443166, 5451.209574611698, 5554.055810512182, 5589.301337332833, 5610.074337734269, 5619.859503512404, 5534.418886016991, 5548.361938377098, 5592.5805564582415, 5608.0, 5630.634008789457, 5956.761729530814, 5974.701264936779, 6006.219191505076, 6019.217501724792, 6072.969635151796, 6413.070104834819, 6519.152510173694, 6568.507361947825, 6572.145621069279, 6583.0, 6587.2095348558005, 6623.271440141581, 6661.433778128817, 6680.532362734611, 6684.766033188815, 6101.84745381369, 6128.417800309053, 6186.814395568095, 6197.287311959138, 6212.565120441616, 6611.702473388613, 6686.7993960181275, 6719.294474080249, 6726.058351830748, 6820.35206655367, 6482.092507049017, 6487.610743355413, 6490.993895946136, 6492.123563318986, 6494.805155845333, 6392.840178995562, 6467.159269294962, 6493.0, 6561.5734977227285, 6575.901361479581, 6189.907151392733, 6293.118963345135, 6430.421262086435, 6525.608463492111, 6553.672316384257, 6548.1814773153355, 6557.180352455943, 6574.0, 6611.041398997215, 6614.0, 5319.335083114611, 5327.760250788724, 5405.5135037846785, 5407.972960135174, 5409.621326507186, 4520.932186017212, 4547.749873756975, 4551.158035763395, 4576.8626941191815, 4598.724076555417, 5689.345725241567, 5771.5671324649975, 5788.363280039192, 5794.739236734273, 5815.156802263733, 6570.113034740344, 6587.604743715392, 6641.203055633355, 6676.86646267072, 6701.497387695845, 5631.408702086222, 5710.942890571124, 5712.6001179917, 5713.628614140068, 5809.622374545641, 5734.741936612862, 5804.100364443518, 5830.2420685310635, 5845.590808643354, 5851.853703657357, 6359.427651511293, 6364.7135878885565, 6431.389018043372, 6448.097266382711, 6462.450691691259, 6345.968270158804, 6506.512011599054, 6513.804585862432, 6623.834404139935, 6632.303608121078, 6242.781502647567, 6246.750129994931, 6372.745090196526, 6376.74493020274, 6388.712507937247, 6454.774082907264, 6459.935400645933, 6462.063000864942, 6542.411182993554, 6553.377429144223, 6489.221293444817, 6599.4390476808085, 6619.933800661932, 6699.899501507384, 6707.832304192434, 6255.0617407387435, 6350.745970161327, 6388.87222255543, 6403.359664033559, 6407.807765767035, 6280.654563999024, 6384.45732112757, 6445.291017987924, 6452.451541618827, 6472.417482426604, 6201.937980620317, 6291.150694656163, 6295.18162638854, 6329.778457753957, 6411.679416029273, 6242.875142497215, 6385.0, 6452.709628066655, 6461.483081353575, 6480.643564603992, 6227.750889964532, 6261.436470717657, 6277.96861015692, 6308.337624549356, 6330.208723909512], "value": 5989.237541405883, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.4373482297215, 854.6624083487022, 876.0319846569537, 883.7392969074123, 1158.6176561734628, 30101.849490752542, 30649.846750766243, 30983.225419364528, 40789.0, 41541.584584154225, 41422.585774142324, 41774.37338439926, 41780.37329440053, 41842.0, 41917.0, 7263.963680181591, 7415.703371865119, 7570.394368450538, 7574.20470850561, 7578.052743407075, 7300.0, 7441.367483763886, 7446.888296675555, 7450.962745186266, 7451.366633836131, 7398.186199518049, 7457.366123879477, 7464.776056718307, 7476.140243871942, 7485.9251407486045, 7384.076990376203, 7423.480356375029, 7440.404767618577, 7442.665080071356, 7448.478606497547, 7351.77944661661, 7390.002349682778, 7407.0, 7414.666340014658, 7415.666295016683, 37449.625503745156, 37505.24989500222, 37658.8117059413, 37672.24655506902, 37774.24451510982, 3555.6444355564495, 3569.785812851237, 3583.8924832254816, 3594.442861356468, 3596.460530920383, 30303.696963030307, 30642.38715225705, 30706.84646576775, 30742.538861917088, 30745.385092298027, 4859.41686997559, 4893.241547560134, 4896.951030489685, 4911.165101932645, 4966.826161084345, 185128.0, 186383.0, 186629.0, 186964.0651796746, 187766.0, 49369.753151234734, 49395.259071113964, 49463.0, 49471.75264123656, 49537.25694114591, 51630.0, 51649.48350516447, 51652.22521662178, 51653.0, 51654.48345516572, 16388.590285242724, 16933.322667093424, 16942.0, 16958.745618815727, 16989.320427182774, 10902.182336324808, 11010.39442830636, 12299.754004919852, 12487.250764954131, 13924.0, 14223.573292801233, 14236.501722439665, 14264.50074247417, 14320.856791431952, 14406.711865762625, 5529.751161197675, 5579.13523403873, 5719.885602287931, 5741.081426971665, 5750.1949727038245, 965.1362030982372, 982.2093214962024, 992.3599278465349, 1010.2473657125488, 1016.7407311135761, 21893.233736819137, 21995.164804552544, 22408.327750167522, 22956.311310660705, 23151.884240579027, 1045.9372437653765, 1066.6373433032807, 1080.8054550181043, 1083.7182332593425, 1087.342157994418, 11874.465649045813, 11970.82043769344, 12099.395030248628, 12136.696582585506, 12185.268883866996, 229863.0, 232674.0, 234253.0, 234327.0, 234388.0, 51735.0, 51949.480505194464, 52032.0, 52223.73888130535, 52328.0, 1453.847346028673, 1460.5399299220712, 1480.407836865241, 1488.0402140619456, 1496.102338596833, 21730.782692172877, 21779.455513612287, 21885.452863678536, 21946.670799937696, 22144.55710885741, 37524.812375937945, 37705.62294377131, 37811.0, 37815.62184378121, 37816.24367512689, 197776.0, 199646.0, 201158.0, 201327.0, 201528.0, 34670.65329346775, 36140.27719445649, 37661.623383765815, 37707.62292377041, 37905.62094379021, 46034.76982615065, 46530.30204547002, 46660.300095497914, 46864.297035545176, 47039.529604703515, 32972.0, 33427.1643208912, 33567.16082097967, 33742.0, 34405.483917740756, 33407.49888751622, 33784.32431351408, 33946.83026584851, 33980.0, 34443.311133777686, 36953.44569831508, 37016.0, 37100.25799484049, 37379.06552336214, 37500.43749343816, 31316.37367252688, 33554.664453356134, 34042.31915361728, 34534.30931381308, 34651.48022779711, 23632.054717811094, 23722.406939826644, 24008.87995560011, 24744.25767226986, 25801.870990644926], "value": 17106.436499021584, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.6930742053003, 575.8416435480242, 579.4755746049826, 592.1946153231603, 602.978895738649, 21758.129674813008, 22665.206717764882, 22693.659595106088, 22723.431914202134, 22728.8863555682, 25946.35134121648, 26529.0, 26534.469310613775, 26554.468910621777, 26562.0, 6392.680365981706, 6539.869202615945, 6548.05053267276, 6554.737810487599, 6556.08214849919, 5892.616979896315, 6448.935510644904, 6453.903191452132, 6456.35436456353, 6458.451031662291, 6426.646534440627, 6439.80680579581, 6444.774432894849, 6453.548251622388, 6462.612243265396, 6364.077208804743, 6414.358564143572, 6417.0, 6433.0, 6436.066770318301, 5946.167536544887, 5952.642841429528, 5978.790742323998, 5983.940160598426, 5995.310539287994, 26920.59619105715, 30423.391532169455, 31035.379292414025, 31079.533806992913, 31339.2763398013, 1919.3570153998428, 1947.2795065825735, 1954.7263383126374, 1956.814102660245, 1962.1170473287077, 19266.80733192664, 19572.412827615193, 19666.90166549158, 19687.114079866442, 19740.11169497376, 2334.0780391745334, 2384.9523009539885, 2426.187227278846, 2433.1605596069503, 2446.397609565737, 128878.0, 134614.0, 135124.0, 135194.32402837923, 135350.5254632176, 14917.627059323604, 14920.47778327775, 14932.552023439313, 15345.0, 15413.229338533029, 23751.524969500515, 23785.643215351785, 23809.166679166494, 23849.165279215144, 23886.283411497683, 9797.853032204523, 9879.184432436721, 9912.702618921443, 9920.652777152765, 10027.849582256273, 8592.140785921358, 8852.114788521225, 8964.0, 9024.323175761843, 9028.503432311287, 7691.538507689556, 9162.496062716615, 9297.209737172281, 9319.254459643213, 9586.760330991781, 2685.8657067146564, 2740.0544414754218, 2794.147784925617, 2837.943241135166, 2913.126062181337, 947.6162154327509, 951.8319809633653, 959.3045042344245, 963.4443381620532, 995.4823491784232, 19407.320743774184, 19634.214631414583, 19671.21315147407, 19763.40709778709, 20076.799232007786, 974.4932635029745, 1012.104287705386, 1024.5850430575629, 1030.8762948446085, 1050.847627094067, 10558.260921735406, 10617.407388891574, 10754.0, 11138.0, 11190.96355839773, 474831.0, 486421.0, 488277.0, 489736.0, 499928.0, 111819.0, 121786.0, 122989.0, 123600.38199808943, 124215.3789231048, 1229.569650622275, 1265.4685032286461, 1295.2681734819985, 1295.5659853949032, 1298.8311519502404, 16640.480430152616, 17575.945443273446, 17627.20677569538, 18068.457946261635, 18224.72662910031, 52275.47724522858, 52698.20952685789, 53829.19256211238, 53899.46100538944, 54469.72765136149, 75064.24935750791, 75132.24867751253, 75365.0, 75701.0, 75908.24091759011, 12453.813192801934, 12989.415476303779, 14546.345414456164, 14747.483838065617, 14965.32656030503, 23237.0, 23589.52820943606, 23708.288751337488, 25025.374365640277, 25033.249002529952, 19165.32921347746, 19348.613027739084, 19366.70949935724, 19420.514487137934, 19554.022298884713, 15440.922795385952, 15875.0, 16194.757078644065, 16388.75416868772, 16801.159942003094, 19183.0, 19812.603747925248, 19844.60310793805, 20195.192192312144, 20220.494487637927, 14947.925260373628, 15059.698806024036, 15088.396464141311, 15121.0, 15148.924255378653, 18315.450536483928, 18632.720509192102, 18648.254069837054, 18704.625907481503, 18739.0], "value": 11992.606615362627, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.3276278242272, 1443.8989270751038, 1447.2257342321857, 1448.8478709735477, 1452.2883786944394, 13526.323683815806, 13790.448382064731, 14092.0, 14138.363773630173, 14166.504172353969, 14250.358733856976, 14487.420503179861, 14505.202213878232, 14505.927470362634, 14512.201828899406, 2647.5631520799043, 2690.0719251858177, 2709.9051533196343, 2715.633389492413, 2717.0, 2681.852498112603, 2762.185155379158, 2771.750542451179, 2792.986035069832, 2795.329121010953, 2678.4375281190974, 2713.91858244253, 2743.43759529297, 2746.8214566053143, 2757.9448411031767, 2658.7607115359615, 2669.8398096114297, 2676.839389636628, 2691.4886171627522, 2708.7155848635907, 2609.9217023489327, 2621.488809682113, 2642.4582960493053, 2644.9074282400215, 2646.364872430622, 13490.325483725872, 13696.589102326847, 13810.240436775974, 13819.654508637264, 13825.308734563332, 7499.325060744559, 7768.378529717609, 7772.844543109106, 7779.338756205672, 7784.766457006299, 4977.203647416432, 5054.82308119214, 5160.974195129001, 5241.8165364212455, 5251.894962100737, 1889.7070954002015, 1906.1041310584003, 1907.8569107316869, 1939.7575303087115, 1940.262700173939, 21723.565528689338, 21831.345059648236, 21924.780752192593, 21951.560968780534, 22111.44721381978, 6046.3349031606485, 6257.687115644199, 6290.182276304051, 6400.039994000844, 6453.548251622341, 15726.21368931549, 15748.76376854348, 15751.842481575266, 15752.369905203663, 15795.36818527246, 7259.709611615582, 7495.025646665898, 7497.362724168398, 7504.512206706547, 7504.887426688604, 5895.4399332063385, 5999.0, 6172.321044685081, 6906.792796216121, 6914.204866440323, 4920.778564964585, 4977.65156439053, 5131.56381707559, 5135.820246291437, 5146.150885103916, 1445.7614493608646, 1463.8536146385488, 1465.992670036643, 1494.5815171751926, 1497.2332647476082, 866.6403442571262, 892.3307519360479, 902.4179404284331, 919.5815903763771, 921.3228277216241, 7156.105486814148, 8384.706535271236, 8457.534835584102, 8520.786980325418, 8756.912430875736, 944.1313991128178, 953.8950715421298, 993.6522217224058, 1006.1699098243978, 1027.275770581753, 4887.73117478535, 4987.226979818134, 5044.4198917125, 5046.9747651261505, 5281.0, 18209.63580728378, 18650.440486785417, 18879.52801179954, 19064.52338691516, 19113.52216194606, 18291.0, 19600.509987250432, 19697.113629886404, 19719.901400493192, 19922.402327930184, 10669.83995240072, 10957.397343146204, 10979.451027448597, 10989.890101099047, 11019.449027548591, 7363.630459652469, 8132.878006829784, 8240.83518329618, 8319.334453243606, 8500.36247281444, 16004.67990640204, 16202.351905923631, 16396.508104756875, 16594.834051659327, 16626.418075367303, 15829.604259893595, 16065.678686425972, 16503.09232992197, 16597.41909033178, 16914.746278805582, 11184.496697648463, 11402.94298528502, 11405.657830265105, 11406.372649504357, 11418.429078546205, 12732.299723515296, 12769.553065642658, 12813.359332033548, 12859.678508037374, 12898.67753306175, 10448.32085914413, 10563.313384629975, 10760.89239107599, 10844.295120817122, 10864.674059778219, 9809.313348065567, 10297.227707922086, 10450.16398688088, 10547.261691681508, 10597.15222782191, 9282.675106371245, 9313.627454901729, 9414.57634406467, 9424.528773561158, 9450.858237126586, 6907.758228461979, 7101.431885449255, 7262.963685181751, 7328.926710732824, 7369.484136110421, 6450.258220304725, 6769.864602708017, 6986.126734158231, 7011.754588589375, 7069.081019467436], "value": 6350.333794258487, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.233736671858, 503.69023050823756, 505.724380212784, 509.94900509948997, 528.735632183908, 6137.294211165718, 6264.123022776809, 6333.746650133995, 6333.936660633392, 6337.0, 6125.969370153143, 6126.172966649512, 6135.110408990694, 6136.545381847252, 6155.815325540229, 4881.877168251313, 4902.926456103143, 4910.1898186799135, 4927.852164435073, 4933.260010998343, 4791.47293797682, 4851.417829860422, 4910.435299940516, 4939.333190019337, 5006.874828129289, 4920.950790492085, 4935.5804756595735, 4935.8272460463895, 4954.727489988068, 4976.203807390818, 4926.655134140611, 4933.0, 4935.235038569028, 4943.431505376891, 4955.776990035439, 4410.184115938561, 4429.623482004034, 4440.844570440019, 4448.777561121931, 4452.018851611035, 6078.635281883101, 6114.602550834182, 6121.234845644294, 6131.785387511416, 6132.264128304588, 5625.240592519998, 5645.040343141676, 5657.377688454267, 5674.0, 5702.201691763156, 6535.21577410709, 6535.738570457176, 6542.738290468375, 6568.3103274156, 6568.967155164241, 4817.951820481785, 4851.393575803025, 4858.805647774085, 4869.2939523768855, 4871.318015477836, 6873.250699720152, 6926.688299026556, 6951.965240173767, 6956.65216739166, 6998.160220773489, 5022.196448568285, 5057.291979122926, 5069.163588008011, 5072.485487915758, 5080.74596270185, 5039.420466646309, 5068.4424713281505, 5074.2895994560795, 5155.896882062413, 5168.2866495090375, 5614.410486898899, 5640.746166422521, 5673.574481913873, 5711.286089238845, 5786.392428795, 6306.211723534559, 6527.934720652733, 6576.0, 6630.86738265232, 6647.302033286532, 1704.718721410978, 1710.187660861106, 1777.5467255849935, 1780.376868096156, 1786.8659850511265, 1221.688469440287, 1221.908356873238, 1247.2890452442202, 1249.4377530111485, 1256.1834807375278, 5659.547675917687, 5778.479936805707, 5794.88410231793, 5806.44838740319, 5810.593258471867, 6763.985402189711, 6773.017912402674, 6776.543043245726, 6805.557638753465, 6811.318868113149, 5807.82576522705, 5812.3025236971835, 5824.94175058244, 5841.0, 5852.941470585325, 3578.910527236788, 3591.60492345847, 3596.047047532406, 3627.1113577173232, 3641.289948460078, 6553.148090748267, 6556.377144171296, 6559.24568674599, 6562.8359291018105, 6596.86806263872, 6926.610319439786, 6948.583085014915, 6952.304769523007, 6952.826179345456, 6956.678231136068, 6463.515236357198, 6494.253160886369, 6531.0, 6540.117084193668, 6544.411003009657, 6690.632015239208, 6722.731090756315, 6732.562383445061, 6742.190937087581, 6813.182418109858, 6537.836554086186, 6540.2151741789385, 6609.966950165219, 6642.0, 6721.495887808336, 6462.612243265419, 6494.740210391531, 6499.1876015498065, 6500.869982600227, 6511.744127936032, 5005.124103281838, 5051.797928082982, 5076.898462030665, 5082.391502033597, 5085.618578606545, 6483.157189565326, 6657.538080198173, 6731.899021514583, 6754.2570317266045, 6803.42170915458, 6364.586301890362, 6368.579939622914, 6457.321981191907, 6503.6097834130105, 6523.9347606525225, 6351.396617321347, 6386.552941294065, 6446.871062578816, 6499.935000650122, 6513.837154071186, 6306.337834527492, 6338.936610633835, 6363.0, 6379.170707807955, 6483.481321494363, 6450.483961282992, 6459.160309159967, 6494.383033611799, 6548.901766473411, 6575.868482630416, 6310.49516038725, 6311.400416960381, 6313.55805093639, 6365.7135428904885, 6376.39424254695], "value": 5051.481938746514, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.1210625693079, 921.2445794448552, 931.3992474853716, 940.1491650056697, 944.0465130218481, 15321.846781532182, 16171.35314587415, 21213.787862121375, 21990.89004554975, 22010.119595216172, 17141.571460713458, 18484.44546663599, 18504.907475462638, 18555.0, 18572.257109715596, 1030.3663247103034, 1062.5537274344795, 1063.2132222155587, 1063.2557209953025, 1063.478895341281, 1039.7088815131776, 1045.7176562328204, 1047.0681093826502, 1047.5809676129534, 1047.6123834181365, 1109.0960866893456, 1112.9833052504177, 1115.0577761791274, 1115.2304909612383, 1115.9888401116007, 1083.4528563075676, 1108.1024370260075, 1110.3116068037868, 1110.439228189763, 1111.4053981120103, 785.6071964017991, 792.8929594504783, 797.7207977207988, 803.6263137641025, 806.1897792718339, 17756.644867102714, 17963.73054404185, 17968.0, 18043.188056537358, 18319.450416487394, 19473.0, 20756.377308680763, 20794.16823327065, 20904.79095209059, 20961.790382096136, 15687.607809804733, 16585.0, 16633.50099497017, 16654.58363540909, 16726.58183545409, 3290.276139249361, 3367.7474189435648, 3368.4610462326154, 3373.4939759036097, 3407.522946787427, 115810.42094789472, 119751.40124299409, 120460.0, 121660.39169804183, 123756.0, 15739.921300393426, 16486.422975195812, 16628.168591570375, 17163.313467461412, 17175.570610734583, 29815.85092074526, 30869.845650771604, 31047.379052418826, 31233.219169520944, 31409.685903141133, 8529.914700853036, 8673.479591224546, 8710.47737135774, 8739.519326437106, 8804.735857924272, 3873.3996230584303, 3959.1092004298803, 3968.7420317679257, 3970.781607011642, 3978.1844721831953, 5029.06962211992, 5044.571211447068, 5152.252923326097, 5161.225816127536, 5181.4300426953005, 1031.8400647899587, 1034.9586016559253, 1040.5889673579045, 1042.1714736784274, 1042.8852826189113, 654.7348323928817, 703.5813690853934, 717.1716667249335, 726.1322719350431, 727.7598392530452, 11704.712481627013, 12286.692832679255, 12449.751004980031, 12699.11106222574, 12828.29444380568, 682.126877596677, 703.2615753458848, 706.3254591864757, 717.9138503379523, 724.0731863215093, 5376.489233522809, 5385.0, 5436.0486914790545, 5467.309566042905, 6056.182415373956, 98259.0, 100139.49930250448, 101836.0, 101837.49081254695, 105148.0, 85921.57039214764, 88003.55998219967, 93154.53422732979, 94292.0, 94365.0, 79703.0, 80360.59819700864, 80962.0, 82988.0, 84471.5776421114, 11874.703132421759, 12331.938340308241, 12407.813882791585, 12447.564335248222, 12617.747645046864, 36307.27385452329, 36636.0, 37873.81063094667, 38113.2377352457, 40092.0, 46963.530364695915, 66398.66800665966, 66986.0, 67229.55197506245, 73337.6333118331, 18445.262189512807, 18737.531561710523, 18742.0, 18894.3386981455, 19301.32445364462, 19823.0, 19924.60150796947, 20351.185952561733, 20554.486137846674, 20694.0, 18635.534111646775, 18840.246390144242, 18946.052697365354, 19077.332293369665, 19162.0, 17487.0, 17821.376251831123, 18011.459656210336, 18999.0, 19657.213711451383, 17955.281788728305, 18406.447806565826, 18459.446216613524, 18570.53573660615, 18871.0, 13052.34738263102, 13536.729265414833, 14178.86569074451, 14203.857961420254, 14697.92651036738, 13105.14816536922, 13846.0, 13878.791818122534, 14101.506447274296, 14496.565103046925], "value": 9075.299490684138, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 111.0, 98.0, 109.0, 111.0, 111.0, 111.0, 109.0, 110.0, 113.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 145.0, 189.0, 120.0, 148.0, 149.0, 123.0, 168.0, 119.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 163.0, 165.0, 161.0, 166.0, 166.0, 167.0, 161.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 182.0, 76.0, 75.0, 75.0, 74.0, 161.0, 78.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 139.0, 81.0, 81.0, 81.0, 127.0, 82.0, 80.0, 137.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 152.0, 151.0, 149.0, 153.0, 150.0, 150.0, 150.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 58.0, 55.0, 56.0, 56.0, 56.0, 56.0, 55.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 56.0, 56.0, 55.0, 54.0, 55.0, 56.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 77.0, 77.0, 83.0, 88.0, 77.0, 77.0, 87.0, 78.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 128.0, 128.0, 138.0, 126.0, 124.0, 131.0, 125.0, 130.0, 176.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 180.0, 197.0, 174.0, 178.0, 174.0, 185.0, 176.0, 185.0, 176.0], "value": 180.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0, 70.0, 71.0], "value": 68.8, "unit": "score"}]}]} 05:11:39 INFO - Return code: 0 05:11:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:11:39 INFO - # TBPL SUCCESS # 05:11:39 INFO - Running post-action listener: _package_coverage_data 05:11:39 INFO - Running post-action listener: _resource_record_post_action 05:11:39 INFO - [mozharness: 2017-07-24 12:11:39.207979Z] Finished run-tests step (success) 05:11:39 INFO - Running post-run listener: _resource_record_post_run 05:11:39 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 439898112; Read time: 12; Write time: 276816 05:11:39 INFO - TinderboxPrint: CPU usage
13.1% 05:11:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:11:39 INFO - TinderboxPrint: I/O write bytes / time
439,898,112 / 276,816 05:11:39 INFO - TinderboxPrint: CPU idle
8,262.2 (86.9%) 05:11:39 INFO - TinderboxPrint: CPU user
1,202.6 (12.6%) 05:11:39 INFO - TinderboxPrint: Swap in / out
0 / 0 05:11:39 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106901504; Read time: 0; Write time: 96056 05:11:39 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:11:39 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 330158080; Read time: 0; Write time: 180464 05:11:39 INFO - Running post-run listener: _upload_blobber_files 05:11:39 INFO - Blob upload gear active. 05:11:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:11:39 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:11:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:11:40 INFO - (blobuploader) - INFO - Open directory for files ... 05:11:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:11:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:11:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:41 INFO - (blobuploader) - INFO - Done attempting. 05:11:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:11:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:11:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:42 INFO - (blobuploader) - INFO - Done attempting. 05:11:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:11:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:11:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:43 INFO - (blobuploader) - INFO - Done attempting. 05:11:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:11:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:11:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:48 INFO - (blobuploader) - INFO - Done attempting. 05:11:48 INFO - (blobuploader) - INFO - Iteration through files over. 05:11:48 INFO - Return code: 0 05:11:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:11:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:11:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f13fc0bdfe18320e7d1932e055a3d8d207da48c4f4b6d7c9132e4efa57a973035736cd608eba7ae01bd9f6b5b1471fdd4e5c0da872b475783070a5da83da83c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33ea9cbc48ec88590385818b36a5f5973d29038b830a8997133acaaef31cb001c67e326a9fe4f217028e34c6ada7262bb5cae154eb2c6bedcc1a3eecbc86ecb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4f416522c4b04eaa01702c4c4918a7949a3d606ee4544470fad2a5df42809d9a1d760c084e05cda03c2b7c3d40a727b8bd9b0375f3a13a12ce67af4a5d00f46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a41904b3273d8eac0c6de9101859ff4a15a52c6435dba0cbece69cd5bd88e157759c240aac1fde6d5abd23fdc32c61d40b9750d18ab4221ee7c0c1fa086f323a"} 05:11:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:11:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:11:48 INFO - Contents: 05:11:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f13fc0bdfe18320e7d1932e055a3d8d207da48c4f4b6d7c9132e4efa57a973035736cd608eba7ae01bd9f6b5b1471fdd4e5c0da872b475783070a5da83da83c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33ea9cbc48ec88590385818b36a5f5973d29038b830a8997133acaaef31cb001c67e326a9fe4f217028e34c6ada7262bb5cae154eb2c6bedcc1a3eecbc86ecb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4f416522c4b04eaa01702c4c4918a7949a3d606ee4544470fad2a5df42809d9a1d760c084e05cda03c2b7c3d40a727b8bd9b0375f3a13a12ce67af4a5d00f46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a41904b3273d8eac0c6de9101859ff4a15a52c6435dba0cbece69cd5bd88e157759c240aac1fde6d5abd23fdc32c61d40b9750d18ab4221ee7c0c1fa086f323a"} 05:11:48 INFO - Running post-run listener: copy_logs_to_upload_dir 05:11:48 INFO - Copying logs to upload dir... 05:11:48 INFO - mkdir: /builds/slave/test/build/upload/logs 05:11:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.333457 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-24 05:11:48.402672) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 05:11:48.409096) ========= 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=0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231 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-Non-PGO/sha512/f13fc0bdfe18320e7d1932e055a3d8d207da48c4f4b6d7c9132e4efa57a973035736cd608eba7ae01bd9f6b5b1471fdd4e5c0da872b475783070a5da83da83c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33ea9cbc48ec88590385818b36a5f5973d29038b830a8997133acaaef31cb001c67e326a9fe4f217028e34c6ada7262bb5cae154eb2c6bedcc1a3eecbc86ecb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4f416522c4b04eaa01702c4c4918a7949a3d606ee4544470fad2a5df42809d9a1d760c084e05cda03c2b7c3d40a727b8bd9b0375f3a13a12ce67af4a5d00f46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a41904b3273d8eac0c6de9101859ff4a15a52c6435dba0cbece69cd5bd88e157759c240aac1fde6d5abd23fdc32c61d40b9750d18ab4221ee7c0c1fa086f323a"} build_url:https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011408 build_url: 'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f13fc0bdfe18320e7d1932e055a3d8d207da48c4f4b6d7c9132e4efa57a973035736cd608eba7ae01bd9f6b5b1471fdd4e5c0da872b475783070a5da83da83c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33ea9cbc48ec88590385818b36a5f5973d29038b830a8997133acaaef31cb001c67e326a9fe4f217028e34c6ada7262bb5cae154eb2c6bedcc1a3eecbc86ecb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4f416522c4b04eaa01702c4c4918a7949a3d606ee4544470fad2a5df42809d9a1d760c084e05cda03c2b7c3d40a727b8bd9b0375f3a13a12ce67af4a5d00f46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a41904b3273d8eac0c6de9101859ff4a15a52c6435dba0cbece69cd5bd88e157759c240aac1fde6d5abd23fdc32c61d40b9750d18ab4221ee7c0c1fa086f323a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 05:11:48.436215) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 05:11:48.436536) ========= 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=0333a256a5e4f052382dd180000001b1-1500897052.496003-1222391231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 05:11:48.521839) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 05:11:48.522151) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 05:11:48.522485) ========= ========= Total master_lag: 0.20 =========