builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1500218040.91 results: success (0) revision: bc3f73d54feeaf0e97b30496574357f05b2d5307 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:00.908605) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:00.909205) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:00.909486) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:00.962393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:00.962770) ========= 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=db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-16 08:14:01-- 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% 30.0M=0s 2017-07-16 08:14:01 (30.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.174519 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:01.156254) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:01.156641) ========= 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=db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019939 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:01.206841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:01.210179) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bc3f73d54feeaf0e97b30496574357f05b2d5307 --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 bc3f73d54feeaf0e97b30496574357f05b2d5307 --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=db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-16 08:14:01,609 truncating revision to first 12 chars 2017-07-16 08:14:01,609 Setting DEBUG logging. 2017-07-16 08:14:01,609 attempt 1/10 2017-07-16 08:14:01,609 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bc3f73d54fee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-16 08:14:02,089 unpacking tar archive at: mozilla-central-bc3f73d54fee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.895093 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:02.120203) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:02.120506) ========= script_repo_revision: bc3f73d54feeaf0e97b30496574357f05b2d5307 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:02.120904) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:02.121179) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:02.132974) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-07-16 08:14:02.136320) ========= /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=db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:02 INFO - MultiFileLogger online at 20170716 08:14:02 in /builds/slave/test 08:14:02 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 08:14:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:02 INFO - {'append_to_log': False, 08:14:02 INFO - 'base_work_dir': '/builds/slave/test', 08:14:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:14:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:02 INFO - 'branch': 'Firefox-Non-PGO', 08:14:02 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:02 INFO - 'code_coverage': False, 08:14:02 INFO - 'config_files': ('talos/linux_config.py',), 08:14:02 INFO - 'default_actions': ('clobber', 08:14:02 INFO - 'read-buildbot-config', 08:14:02 INFO - 'download-and-extract', 08:14:02 INFO - 'populate-webroot', 08:14:02 INFO - 'create-virtualenv', 08:14:02 INFO - 'install', 08:14:02 INFO - 'setup-mitmproxy', 08:14:02 INFO - 'run-tests'), 08:14:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:02 INFO - 'disable_ccov_upload': False, 08:14:02 INFO - 'download_minidump_stackwalk': True, 08:14:02 INFO - 'download_symbols': 'ondemand', 08:14:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:02 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:02 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:02 INFO - 'gecko_profile': False, 08:14:02 INFO - 'gecko_profile_interval': 0, 08:14:02 INFO - 'installer_path': 'installer.exe', 08:14:02 INFO - 'log_level': 'info', 08:14:02 INFO - 'log_name': 'talos', 08:14:02 INFO - 'log_to_console': True, 08:14:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:02 INFO - 'opt_config_files': (), 08:14:02 INFO - 'pip_index': False, 08:14:02 INFO - 'suite': 'dromaeojs-e10s', 08:14:02 INFO - 'system_bits': '32', 08:14:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:02 INFO - 'title': 'talos-linux64-ix-031', 08:14:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:02 INFO - 'use_talos_json': True, 08:14:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:02 INFO - 'work_dir': 'build'} 08:14:02 INFO - [mozharness: 2017-07-16 15:14:02.768853Z] Running clobber step. 08:14:02 INFO - Running pre-action listener: _resource_record_pre_action 08:14:02 INFO - Running main action method: clobber 08:14:02 INFO - rmtree: /builds/slave/test/build 08:14:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:03 INFO - Running post-action listener: _resource_record_post_action 08:14:03 INFO - [mozharness: 2017-07-16 15:14:03.759400Z] Finished clobber step (success) 08:14:03 INFO - [mozharness: 2017-07-16 15:14:03.759503Z] Running read-buildbot-config step. 08:14:03 INFO - Running pre-action listener: _resource_record_pre_action 08:14:03 INFO - Running main action method: read_buildbot_config 08:14:03 INFO - Using buildbot properties: 08:14:03 INFO - { 08:14:03 INFO - "project": "", 08:14:03 INFO - "product": "firefox", 08:14:03 INFO - "who": "archaeopteryx@coole-files.de", 08:14:03 INFO - "installer_path": "public/build/target.tar.bz2", 08:14:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:14:03 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:14:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:14:03 INFO - "stage_platform": "linux64", 08:14:03 INFO - "basedir": "/builds/slave/test", 08:14:03 INFO - "buildnumber": 721, 08:14:03 INFO - "platform": "ubuntu64_hw", 08:14:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:14:03 INFO - "slavebuilddir": "test", 08:14:03 INFO - "taskId": "DlWHMg7IRcKEzZ-9J3UubQ", 08:14:03 INFO - "branch": "mozilla-central", 08:14:03 INFO - "script_repo_revision": "production", 08:14:03 INFO - "revision": "bc3f73d54feeaf0e97b30496574357f05b2d5307", 08:14:03 INFO - "slavename": "talos-linux64-ix-031", 08:14:03 INFO - "repo_path": "mozilla-central" 08:14:03 INFO - } 08:14:03 INFO - Finding installer, test and symbols from parent task. 08:14:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DlWHMg7IRcKEzZ-9J3UubQ'}, attempt #1 08:14:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DlWHMg7IRcKEzZ-9J3UubQ'}, attempt #1 08:14:04 INFO - Task dependencies: OXnQqhCqRxGEYVX412N4ZQ 08:14:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ'}, attempt #1 08:14:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.tar.bz2 08:14:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/test_packages.json 08:14:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.crashreporter-symbols.zip 08:14:05 INFO - Running post-action listener: _resource_record_post_action 08:14:05 INFO - [mozharness: 2017-07-16 15:14:05.124795Z] Finished read-buildbot-config step (success) 08:14:05 INFO - [mozharness: 2017-07-16 15:14:05.125018Z] Running download-and-extract step. 08:14:05 INFO - Running pre-action listener: _resource_record_pre_action 08:14:05 INFO - Running main action method: download_and_extract 08:14:05 INFO - mkdir: /builds/slave/test/build/tests 08:14:05 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')]} 08:14:05 INFO - trying https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.test_packages.json 08:14:05 INFO - Downloading https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:14:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:14:05 INFO - Downloaded 989 bytes. 08:14:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:14:05 INFO - Using the following test package requirements: 08:14:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:14:05 INFO - u'common': [u'target.common.tests.zip'], 08:14:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:14:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:14:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:14:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:14:05 INFO - u'mozbase': [u'target.common.tests.zip'], 08:14:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:14:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:14:05 INFO - u'web-platform': [u'target.common.tests.zip', 08:14:05 INFO - u'target.web-platform.tests.tar.gz'], 08:14:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:14:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:14:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.common.tests.zip 08:14:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:14:05 INFO - Fetch https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.common.tests.zip into memory 08:14:07 INFO - Content-Length response header: 72753081 08:14:07 INFO - Bytes received: 72753081 08:14:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:14:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.common.tests.zip 08:14:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:14:19 INFO - Fetch https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.common.tests.zip into memory 08:14:20 INFO - Content-Length response header: 72753081 08:14:20 INFO - Bytes received: 72753081 08:14:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.talos.tests.zip 08:14:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:14:33 INFO - Fetch https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.talos.tests.zip into memory 08:14:34 INFO - Content-Length response header: 14495033 08:14:34 INFO - Bytes received: 14495033 08:14: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')]} 08:14:34 INFO - trying https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.tar.bz2 08:14:34 INFO - Downloading https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:14:35 INFO - Downloaded 61903484 bytes. 08:14:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.tar.bz2 08:14:35 INFO - mkdir: /builds/slave/test/properties 08:14:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:35 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:35 INFO - Contents: 08:14:35 INFO - build_url:https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.tar.bz2 08:14:35 INFO - Running post-action listener: _resource_record_post_action 08:14:35 INFO - Running post-action listener: set_extra_try_arguments 08:14:35 INFO - [mozharness: 2017-07-16 15:14:35.905071Z] Finished download-and-extract step (success) 08:14:35 INFO - [mozharness: 2017-07-16 15:14:35.905168Z] Running populate-webroot step. 08:14:35 INFO - Running pre-action listener: _resource_record_pre_action 08:14:35 INFO - Running main action method: populate_webroot 08:14:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:35 INFO - '--tppagecycles', 08:14:35 INFO - '7'], 08:14:35 INFO - 'tests': ['tsvgm']}}, 08:14:35 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:14:35 INFO - 'talos_options': ['--disable-e10s'], 08:14:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:14:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:14:35 INFO - 'talos_options': ['--disable-e10s'], 08:14:35 INFO - 'tests': ['damp', 'tps']}, 08:14:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:14:35 INFO - 'tests': ['damp', 'tps']}, 08:14:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:35 INFO - 'tests': ['dromaeo_dom']}, 08:14:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:14:35 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:14:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:14:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:14:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:14:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:35 INFO - 'tests': ['a11yr', 08:14:35 INFO - 'ts_paint', 08:14:35 INFO - 'tpaint', 08:14:35 INFO - 'sessionrestore', 08:14:35 INFO - 'sessionrestore_no_auto_restore', 08:14:35 INFO - 'tabpaint']}, 08:14:35 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:35 INFO - 'ts_paint', 08:14:35 INFO - 'tpaint', 08:14:35 INFO - 'sessionrestore', 08:14:35 INFO - 'sessionrestore_many_windows', 08:14:35 INFO - 'sessionrestore_no_auto_restore', 08:14:35 INFO - 'tabpaint']}, 08:14:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:35 INFO - 'ts_paint', 08:14:35 INFO - 'tpaint', 08:14:35 INFO - 'sessionrestore', 08:14:35 INFO - 'sessionrestore_many_windows', 08:14:35 INFO - 'sessionrestore_no_auto_restore', 08:14:35 INFO - 'tabpaint']}, 08:14:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:35 INFO - 'ts_paint', 08:14:35 INFO - 'tpaint', 08:14:35 INFO - 'sessionrestore', 08:14:35 INFO - 'sessionrestore_many_windows', 08:14:35 INFO - 'sessionrestore_no_auto_restore', 08:14:35 INFO - 'tabpaint']}, 08:14:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:35 INFO - 'tests': ['a11yr', 08:14:35 INFO - 'ts_paint', 08:14:35 INFO - 'tpaint', 08:14:35 INFO - 'sessionrestore', 08:14:35 INFO - 'sessionrestore_no_auto_restore', 08:14:35 INFO - 'tabpaint']}, 08:14:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:35 INFO - 'tests': ['a11yr', 08:14:35 INFO - 'ts_paint', 08:14:35 INFO - 'tpaint', 08:14:35 INFO - 'sessionrestore', 08:14:35 INFO - 'sessionrestore_no_auto_restore', 08:14:35 INFO - 'tabpaint']}, 08:14:35 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 08:14:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:14:35 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:14:35 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:14:35 INFO - 'talos_options': ['--mitmproxy', 08:14:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:14:35 INFO - '--firstNonBlankPaint'], 08:14:35 INFO - 'tests': ['quantum_pageload_google', 08:14:35 INFO - 'quantum_pageload_youtube', 08:14:35 INFO - 'quantum_pageload_amazon', 08:14:35 INFO - 'quantum_pageload_facebook']}, 08:14:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:35 INFO - 'tests': ['tsvgx', 08:14:35 INFO - 'tsvgr_opacity', 08:14:35 INFO - 'tart', 08:14:35 INFO - 'tscrollx', 08:14:35 INFO - 'cart', 08:14:35 INFO - 'tsvg_static']}, 08:14:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:35 INFO - 'tsvgr_opacity', 08:14:35 INFO - 'tart', 08:14:35 INFO - 'tscrollx', 08:14:35 INFO - 'cart', 08:14:35 INFO - 'tsvg_static']}, 08:14:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:14:35 INFO - 'talos_options': ['--disable-e10s'], 08:14:35 INFO - 'tests': ['tp5o']}, 08:14:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:14:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:14:35 INFO - 'talos_options': ['--disable-e10s', 08:14:35 INFO - '--xperf_path', 08:14:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:35 INFO - 'tests': ['tp5n']}, 08:14:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:14:35 INFO - 'talos_options': ['--xperf_path', 08:14:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:35 INFO - 'tests': ['tp5n']}}, 08:14:35 INFO - 'talos.zip': {'path': '', 08:14:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:35 INFO - Running post-action listener: _resource_record_post_action 08:14:35 INFO - [mozharness: 2017-07-16 15:14:35.920616Z] Finished populate-webroot step (success) 08:14:35 INFO - [mozharness: 2017-07-16 15:14:35.920707Z] Running create-virtualenv step. 08:14:35 INFO - Running pre-action listener: _resource_record_pre_action 08:14:35 INFO - Running main action method: create_virtualenv 08:14:35 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:35 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 08:14:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:35 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:14:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:36 INFO - Using real prefix '/usr' 08:14:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:36 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:38 INFO - Installing pip.................done. 08:14:38 INFO - Return code: 0 08:14:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:14:38 INFO - Reading from file tmpfile_stdout 08:14:38 INFO - Output received: 08:14:38 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) 08:14:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:38 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')]} 08:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:38 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')]} 08:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:38 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 0x27861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af7b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af4d10>, '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 0x2af5c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af60c0>, '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': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', '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 08:14:38 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 08:14:38 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 08:14:38 INFO - Using env: {'DISPLAY': ':0', 08:14:38 INFO - 'HOME': '/home/cltbld', 08:14:38 INFO - 'LANG': 'en_US.UTF-8', 08:14:38 INFO - 'LANGUAGE': 'en_US:en', 08:14:38 INFO - 'LOGNAME': 'cltbld', 08:14:38 INFO - 'MAIL': '/var/mail/cltbld', 08:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:38 INFO - 'MOZ_NO_REMOTE': '1', 08:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:38 INFO - 'NO_EM_RESTART': '1', 08:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:38 INFO - 'PWD': '/builds/slave/test', 08:14:38 INFO - 'SHELL': '/bin/bash', 08:14:38 INFO - 'SHLVL': '1', 08:14:38 INFO - 'TERM': 'linux', 08:14:38 INFO - 'TMOUT': '86400', 08:14:38 INFO - 'USER': 'cltbld', 08:14:38 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', 08:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:38 INFO - '_': '/tools/buildbot/bin/python'} 08:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:39 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 08:14:39 INFO - Cleaning up... 08:14:39 INFO - Return code: 0 08:14:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14: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')]} 08:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:39 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 0x27861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af7b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af4d10>, '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 0x2af5c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af60c0>, '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': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', '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 08:14:39 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 08:14:39 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 08:14:39 INFO - Using env: {'DISPLAY': ':0', 08:14:39 INFO - 'HOME': '/home/cltbld', 08:14:39 INFO - 'LANG': 'en_US.UTF-8', 08:14:39 INFO - 'LANGUAGE': 'en_US:en', 08:14:39 INFO - 'LOGNAME': 'cltbld', 08:14:39 INFO - 'MAIL': '/var/mail/cltbld', 08:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:39 INFO - 'MOZ_NO_REMOTE': '1', 08:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:39 INFO - 'NO_EM_RESTART': '1', 08:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:39 INFO - 'PWD': '/builds/slave/test', 08:14:39 INFO - 'SHELL': '/bin/bash', 08:14:39 INFO - 'SHLVL': '1', 08:14:39 INFO - 'TERM': 'linux', 08:14:39 INFO - 'TMOUT': '86400', 08:14:39 INFO - 'USER': 'cltbld', 08:14:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', 08:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:39 INFO - '_': '/tools/buildbot/bin/python'} 08:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:39 INFO - Downloading/unpacking psutil>=3.1.1 08:14:39 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 08:14:39 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 08:14:39 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 08:14:39 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 08:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:40 INFO - Installing collected packages: psutil 08:14:40 INFO - Running setup.py install for psutil 08:14:40 INFO - building 'psutil._psutil_linux' extension 08:14:40 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 08:14:41 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 08:14:41 INFO - building 'psutil._psutil_posix' extension 08:14:41 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 08:14:41 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 08:14:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:42 INFO - Successfully installed psutil 08:14:42 INFO - Cleaning up... 08:14:42 INFO - Return code: 0 08:14:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14: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')]} 08:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:42 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 0x27861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af7b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af4d10>, '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 0x2af5c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af60c0>, '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': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', '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 08:14:42 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 08:14:42 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 08:14:42 INFO - Using env: {'DISPLAY': ':0', 08:14:42 INFO - 'HOME': '/home/cltbld', 08:14:42 INFO - 'LANG': 'en_US.UTF-8', 08:14:42 INFO - 'LANGUAGE': 'en_US:en', 08:14:42 INFO - 'LOGNAME': 'cltbld', 08:14:42 INFO - 'MAIL': '/var/mail/cltbld', 08:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:42 INFO - 'MOZ_NO_REMOTE': '1', 08:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:42 INFO - 'NO_EM_RESTART': '1', 08:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:42 INFO - 'PWD': '/builds/slave/test', 08:14:42 INFO - 'SHELL': '/bin/bash', 08:14:42 INFO - 'SHLVL': '1', 08:14:42 INFO - 'TERM': 'linux', 08:14:42 INFO - 'TMOUT': '86400', 08:14:42 INFO - 'USER': 'cltbld', 08:14:42 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', 08:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:42 INFO - '_': '/tools/buildbot/bin/python'} 08:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:14:42 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 08:14:42 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 08:14:42 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 08:14:42 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 08:14:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:14:43 INFO - Installing collected packages: mozsystemmonitor 08:14:43 INFO - Running setup.py install for mozsystemmonitor 08:14:43 INFO - Successfully installed mozsystemmonitor 08:14:43 INFO - Cleaning up... 08:14:43 INFO - Return code: 0 08:14:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:14:43 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')]} 08:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:43 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')]} 08:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:43 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 0x27861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af7b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af4d10>, '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 0x2af5c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af60c0>, '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': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', '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 08:14:43 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 08:14:43 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 08:14:43 INFO - Using env: {'DISPLAY': ':0', 08:14:43 INFO - 'HOME': '/home/cltbld', 08:14:43 INFO - 'LANG': 'en_US.UTF-8', 08:14:43 INFO - 'LANGUAGE': 'en_US:en', 08:14:43 INFO - 'LOGNAME': 'cltbld', 08:14:43 INFO - 'MAIL': '/var/mail/cltbld', 08:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:43 INFO - 'MOZ_NO_REMOTE': '1', 08:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:43 INFO - 'NO_EM_RESTART': '1', 08:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:43 INFO - 'PWD': '/builds/slave/test', 08:14:43 INFO - 'SHELL': '/bin/bash', 08:14:43 INFO - 'SHLVL': '1', 08:14:43 INFO - 'TERM': 'linux', 08:14:43 INFO - 'TMOUT': '86400', 08:14:43 INFO - 'USER': 'cltbld', 08:14:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', 08:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:43 INFO - '_': '/tools/buildbot/bin/python'} 08:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:43 INFO - Downloading/unpacking jsonschema==2.5.1 08:14: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 08:14: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 08:14: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 08:14: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 08:14:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:14: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 08:14: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 08:14: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 08:14: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 08:14:44 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:45 INFO - warning: no files found matching '*.txt' 08:14:45 INFO - no previously-included directories found matching 'build' 08:14:45 INFO - no previously-included directories found matching 'dist' 08:14:45 INFO - no previously-included directories found matching '.git*' 08:14:45 INFO - Installing collected packages: jsonschema, functools32 08:14:45 INFO - Running setup.py install for functools32 08:14:45 INFO - warning: no files found matching '*.txt' 08:14:45 INFO - no previously-included directories found matching 'build' 08:14:45 INFO - no previously-included directories found matching 'dist' 08:14:45 INFO - no previously-included directories found matching '.git*' 08:14:45 INFO - Successfully installed jsonschema functools32 08:14:45 INFO - Cleaning up... 08:14:45 INFO - Return code: 0 08:14:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14: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')]} 08:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14: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', '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 0x27861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af7b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af4d10>, '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 0x2af5c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af60c0>, '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': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', '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 08:14: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:14: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 functools32==3.2.3-2 08:14:45 INFO - Using env: {'DISPLAY': ':0', 08:14:45 INFO - 'HOME': '/home/cltbld', 08:14:45 INFO - 'LANG': 'en_US.UTF-8', 08:14:45 INFO - 'LANGUAGE': 'en_US:en', 08:14:45 INFO - 'LOGNAME': 'cltbld', 08:14:45 INFO - 'MAIL': '/var/mail/cltbld', 08:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:45 INFO - 'MOZ_NO_REMOTE': '1', 08:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:45 INFO - 'NO_EM_RESTART': '1', 08:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:45 INFO - 'PWD': '/builds/slave/test', 08:14:45 INFO - 'SHELL': '/bin/bash', 08:14:45 INFO - 'SHLVL': '1', 08:14:45 INFO - 'TERM': 'linux', 08:14:45 INFO - 'TMOUT': '86400', 08:14:45 INFO - 'USER': 'cltbld', 08:14:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', 08:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:45 INFO - '_': '/tools/buildbot/bin/python'} 08:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:14:45 INFO - Cleaning up... 08:14:45 INFO - Return code: 0 08:14:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14: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')]} 08:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14: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', '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 0x27861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af7b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af4d10>, '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 0x2af5c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af60c0>, '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': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', '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 08:14: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:14: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 blobuploader==1.2.4 08:14:45 INFO - Using env: {'DISPLAY': ':0', 08:14:45 INFO - 'HOME': '/home/cltbld', 08:14:45 INFO - 'LANG': 'en_US.UTF-8', 08:14:45 INFO - 'LANGUAGE': 'en_US:en', 08:14:45 INFO - 'LOGNAME': 'cltbld', 08:14:45 INFO - 'MAIL': '/var/mail/cltbld', 08:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:45 INFO - 'MOZ_NO_REMOTE': '1', 08:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:45 INFO - 'NO_EM_RESTART': '1', 08:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:45 INFO - 'PWD': '/builds/slave/test', 08:14:45 INFO - 'SHELL': '/bin/bash', 08:14:45 INFO - 'SHLVL': '1', 08:14:45 INFO - 'TERM': 'linux', 08:14:45 INFO - 'TMOUT': '86400', 08:14:45 INFO - 'USER': 'cltbld', 08:14:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', 08:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:45 INFO - '_': '/tools/buildbot/bin/python'} 08:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:45 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:46 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14:47 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 08:14:47 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 08:14:47 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 08:14:47 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 08:14:47 INFO - Downloading docopt-0.6.1.tar.gz 08:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:47 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:47 INFO - Running setup.py install for blobuploader 08:14:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:47 INFO - Running setup.py install for requests 08:14:47 INFO - Running setup.py install for docopt 08:14:47 INFO - Successfully installed blobuploader requests docopt 08:14:47 INFO - Cleaning up... 08:14:47 INFO - Return code: 0 08:14:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:47 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 0x27861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af7b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af4d10>, '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 0x2af5c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af60c0>, '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': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', '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 08:14:47 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 08:14:47 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 08:14:47 INFO - Using env: {'DISPLAY': ':0', 08:14:47 INFO - 'HOME': '/home/cltbld', 08:14:47 INFO - 'LANG': 'en_US.UTF-8', 08:14:47 INFO - 'LANGUAGE': 'en_US:en', 08:14:47 INFO - 'LOGNAME': 'cltbld', 08:14:47 INFO - 'MAIL': '/var/mail/cltbld', 08:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:47 INFO - 'MOZ_NO_REMOTE': '1', 08:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:47 INFO - 'NO_EM_RESTART': '1', 08:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:47 INFO - 'PWD': '/builds/slave/test', 08:14:47 INFO - 'SHELL': '/bin/bash', 08:14:47 INFO - 'SHLVL': '1', 08:14:47 INFO - 'TERM': 'linux', 08:14:47 INFO - 'TMOUT': '86400', 08:14:47 INFO - 'USER': 'cltbld', 08:14:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', 08:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:47 INFO - '_': '/tools/buildbot/bin/python'} 08:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:48 INFO - Running setup.py (path:/tmp/pip-yam8ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:48 INFO - Running setup.py (path:/tmp/pip-oAAB4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:48 INFO - Running setup.py (path:/tmp/pip-qbS8EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:48 INFO - Running setup.py (path:/tmp/pip-Ybhvqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:48 INFO - Running setup.py (path:/tmp/pip-2rely9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:48 INFO - Running setup.py (path:/tmp/pip-PLhBXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:48 INFO - Running setup.py (path:/tmp/pip-fFPhHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:48 INFO - Running setup.py (path:/tmp/pip-siPuRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:48 INFO - Running setup.py (path:/tmp/pip-WVooPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:48 INFO - Running setup.py (path:/tmp/pip-tkAo82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:48 INFO - Running setup.py (path:/tmp/pip-vKkM2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:48 INFO - Running setup.py (path:/tmp/pip-O7HtUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:49 INFO - Running setup.py (path:/tmp/pip-pHgzSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:49 INFO - Running setup.py (path:/tmp/pip-EEVsgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:49 INFO - Running setup.py (path:/tmp/pip-5FbBsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:49 INFO - Running setup.py (path:/tmp/pip-n2Om0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:49 INFO - Running setup.py (path:/tmp/pip-2JkeXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:49 INFO - Running setup.py install for manifestparser 08:14:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:49 INFO - Running setup.py install for mozcrash 08:14:49 INFO - Running setup.py install for mozdebug 08:14:49 INFO - Running setup.py install for mozdevice 08:14:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:49 INFO - Running setup.py install for mozfile 08:14:49 INFO - Running setup.py install for mozhttpd 08:14:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:49 INFO - Running setup.py install for mozinfo 08:14:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:50 INFO - Running setup.py install for mozInstall 08:14:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:50 INFO - Running setup.py install for mozleak 08:14:50 INFO - Running setup.py install for mozlog 08:14:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:50 INFO - Running setup.py install for moznetwork 08:14:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:50 INFO - Running setup.py install for mozprocess 08:14:50 INFO - Running setup.py install for mozprofile 08:14:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:50 INFO - Running setup.py install for mozrunner 08:14:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:50 INFO - Running setup.py install for mozscreenshot 08:14:50 INFO - Running setup.py install for moztest 08:14:51 INFO - Running setup.py install for mozversion 08:14:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:51 INFO - Cleaning up... 08:14:51 INFO - Return code: 0 08:14:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:51 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')]} 08:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:51 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')]} 08:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:51 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 0x27861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af7b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af4d10>, '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 0x2af5c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af60c0>, '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': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', '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 08:14:51 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 08:14:51 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 08:14:51 INFO - Using env: {'DISPLAY': ':0', 08:14:51 INFO - 'HOME': '/home/cltbld', 08:14:51 INFO - 'LANG': 'en_US.UTF-8', 08:14:51 INFO - 'LANGUAGE': 'en_US:en', 08:14:51 INFO - 'LOGNAME': 'cltbld', 08:14:51 INFO - 'MAIL': '/var/mail/cltbld', 08:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:51 INFO - 'MOZ_NO_REMOTE': '1', 08:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:51 INFO - 'NO_EM_RESTART': '1', 08:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:51 INFO - 'PWD': '/builds/slave/test', 08:14:51 INFO - 'SHELL': '/bin/bash', 08:14:51 INFO - 'SHLVL': '1', 08:14:51 INFO - 'TERM': 'linux', 08:14:51 INFO - 'TMOUT': '86400', 08:14:51 INFO - 'USER': 'cltbld', 08:14:51 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', 08:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:51 INFO - '_': '/tools/buildbot/bin/python'} 08:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:51 INFO - Running setup.py (path:/tmp/pip-T07eXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:51 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)) 08:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:51 INFO - Running setup.py (path:/tmp/pip-Z6SK4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:51 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)) 08:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:51 INFO - Running setup.py (path:/tmp/pip-B5Rm_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:51 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)) 08:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:51 INFO - Running setup.py (path:/tmp/pip-R8Fgsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:51 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)) 08:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:51 INFO - Running setup.py (path:/tmp/pip-y78hV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:51 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)) 08:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:51 INFO - Running setup.py (path:/tmp/pip-yaDiOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:51 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)) 08:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:51 INFO - Running setup.py (path:/tmp/pip-4dcPVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:51 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)) 08:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:51 INFO - Running setup.py (path:/tmp/pip-rYm0mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:51 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)) 08:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:51 INFO - Running setup.py (path:/tmp/pip-bOGqlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:51 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)) 08:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:52 INFO - Running setup.py (path:/tmp/pip-EiUaoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:52 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)) 08:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:52 INFO - Running setup.py (path:/tmp/pip-G_23Vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:52 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)) 08:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:52 INFO - Running setup.py (path:/tmp/pip-SrUxIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:52 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)) 08:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:52 INFO - Running setup.py (path:/tmp/pip-H4Q6rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:52 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)) 08:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:52 INFO - Running setup.py (path:/tmp/pip-_wbJaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:52 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)) 08:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:52 INFO - Running setup.py (path:/tmp/pip-pKRRAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:52 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)) 08:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:52 INFO - Running setup.py (path:/tmp/pip-liVard-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:52 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)) 08:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:52 INFO - Running setup.py (path:/tmp/pip-PhkBay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:52 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)) 08:14:52 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)) 08:14:52 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)) 08:14:52 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)) 08:14:52 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)) 08:14:52 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)) 08:14:52 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)) 08:14:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:52 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 08:14:52 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 08:14:52 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 08:14:52 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 08:14:53 INFO - Downloading blessings-1.6.tar.gz 08:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:53 INFO - Installing collected packages: blessings 08:14:53 INFO - Running setup.py install for blessings 08:14:53 INFO - Successfully installed blessings 08:14:53 INFO - Cleaning up... 08:14:53 INFO - Return code: 0 08:14:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:54 INFO - Reading from file tmpfile_stdout 08:14:54 INFO - Current package versions: 08:14:54 INFO - argparse == 1.2.1 08:14:54 INFO - blessings == 1.6 08:14:54 INFO - blobuploader == 1.2.4 08:14:54 INFO - docopt == 0.6.1 08:14:54 INFO - functools32 == 3.2.3-2 08:14:54 INFO - jsonschema == 2.5.1 08:14:54 INFO - manifestparser == 1.1 08:14:54 INFO - mozInstall == 1.13 08:14:54 INFO - mozcrash == 1.0 08:14:54 INFO - mozdebug == 0.1 08:14:54 INFO - mozdevice == 0.51 08:14:54 INFO - mozfile == 1.2 08:14:54 INFO - mozhttpd == 0.7 08:14:54 INFO - mozinfo == 0.10 08:14:54 INFO - mozleak == 0.1 08:14:54 INFO - mozlog == 3.5 08:14:54 INFO - moznetwork == 0.27 08:14:54 INFO - mozprocess == 0.25 08:14:54 INFO - mozprofile == 0.28 08:14:54 INFO - mozrunner == 6.13 08:14:54 INFO - mozscreenshot == 0.1 08:14:54 INFO - mozsystemmonitor == 0.3 08:14:54 INFO - moztest == 0.8 08:14:54 INFO - mozversion == 1.4 08:14:54 INFO - psutil == 3.1.1 08:14:54 INFO - requests == 1.2.3 08:14:54 INFO - wsgiref == 0.1.2 08:14:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:54 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 0x27861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af7b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af4d10>, '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 0x2af5c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af60c0>, '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': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', '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 08:14:54 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 08:14:54 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 08:14:54 INFO - Using env: {'DISPLAY': ':0', 08:14:54 INFO - 'HOME': '/home/cltbld', 08:14:54 INFO - 'LANG': 'en_US.UTF-8', 08:14:54 INFO - 'LANGUAGE': 'en_US:en', 08:14:54 INFO - 'LOGNAME': 'cltbld', 08:14:54 INFO - 'MAIL': '/var/mail/cltbld', 08:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:54 INFO - 'MOZ_NO_REMOTE': '1', 08:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:54 INFO - 'NO_EM_RESTART': '1', 08:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:54 INFO - 'PWD': '/builds/slave/test', 08:14:54 INFO - 'SHELL': '/bin/bash', 08:14:54 INFO - 'SHLVL': '1', 08:14:54 INFO - 'TERM': 'linux', 08:14:54 INFO - 'TMOUT': '86400', 08:14:54 INFO - 'USER': 'cltbld', 08:14:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', 08:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:54 INFO - '_': '/tools/buildbot/bin/python'} 08:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:54 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)) 08:14:54 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)) 08:14:54 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)) 08:14:54 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)) 08:14:54 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)) 08:14:54 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)) 08:14:54 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)) 08:14:54 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)) 08:14:54 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)) 08:14:54 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:14:54 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 08:14:54 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 08:14:54 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 08:14:54 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 08:14:55 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:14:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 08:14:55 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 08:14:55 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 08:14:55 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 08:14:55 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 08:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:14:55 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)) 08:14:55 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)) 08:14:55 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)) 08:14:55 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)) 08:14:55 INFO - Installing collected packages: marionette-driver, simplejson 08:14:55 INFO - Running setup.py install for marionette-driver 08:14:55 INFO - Running setup.py install for simplejson 08:14:55 INFO - building 'simplejson._speedups' extension 08:14:55 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 08:14:56 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 08:14:56 INFO - Successfully installed marionette-driver simplejson 08:14:56 INFO - Cleaning up... 08:14:56 INFO - Return code: 0 08:14:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14: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')]} 08:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:56 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 0x27861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af7b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af4d10>, '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 0x2af5c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af60c0>, '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': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', '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 08:14:56 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 08:14:56 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 08:14:56 INFO - Using env: {'DISPLAY': ':0', 08:14:56 INFO - 'HOME': '/home/cltbld', 08:14:56 INFO - 'LANG': 'en_US.UTF-8', 08:14:56 INFO - 'LANGUAGE': 'en_US:en', 08:14:56 INFO - 'LOGNAME': 'cltbld', 08:14:56 INFO - 'MAIL': '/var/mail/cltbld', 08:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:56 INFO - 'MOZ_NO_REMOTE': '1', 08:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:56 INFO - 'NO_EM_RESTART': '1', 08:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:56 INFO - 'PWD': '/builds/slave/test', 08:14:56 INFO - 'SHELL': '/bin/bash', 08:14:56 INFO - 'SHLVL': '1', 08:14:56 INFO - 'TERM': 'linux', 08:14:56 INFO - 'TMOUT': '86400', 08:14:56 INFO - 'USER': 'cltbld', 08:14:56 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', 08:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:56 INFO - '_': '/tools/buildbot/bin/python'} 08:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:14:57 INFO - Cleaning up... 08:14:57 INFO - Return code: 0 08:14:57 INFO - Running post-action listener: _resource_record_post_action 08:14:57 INFO - Running post-action listener: _start_resource_monitoring 08:14:57 INFO - Starting resource monitoring. 08:14:57 INFO - [mozharness: 2017-07-16 15:14:57.222697Z] Finished create-virtualenv step (success) 08:14:57 INFO - [mozharness: 2017-07-16 15:14:57.223652Z] Running install step. 08:14:57 INFO - Running pre-action listener: _resource_record_pre_action 08:14:57 INFO - Running main action method: install 08:14:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:57 INFO - Reading from file tmpfile_stdout 08:14:57 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:57 INFO - Reading from file tmpfile_stdout 08:14:57 INFO - Output received: 08:14:57 INFO - Usage: mozinstall [options] installer 08:14:57 INFO - Options: 08:14:57 INFO - -h, --help show this help message and exit 08:14:57 INFO - -d DEST, --destination=DEST 08:14:57 INFO - Directory to install application into. [default: 08:14:57 INFO - "/builds/slave/test"] 08:14:57 INFO - --app=APP Application being installed. [default: firefox] 08:14:57 INFO - mkdir: /builds/slave/test/build/application 08:14:57 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'] 08:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:15:15 INFO - Reading from file tmpfile_stdout 08:15:15 INFO - Output received: 08:15:15 INFO - /builds/slave/test/build/application/firefox/firefox 08:15:15 INFO - Running post-action listener: _resource_record_post_action 08:15:15 INFO - [mozharness: 2017-07-16 15:15:15.470833Z] Finished install step (success) 08:15:15 INFO - [mozharness: 2017-07-16 15:15:15.471088Z] Running setup-mitmproxy step. 08:15:15 INFO - Running pre-action listener: _resource_record_pre_action 08:15:15 INFO - Running main action method: setup_mitmproxy 08:15:15 INFO - Skipping: mitmproxy is not required 08:15:15 INFO - Running post-action listener: _resource_record_post_action 08:15:15 INFO - [mozharness: 2017-07-16 15:15:15.472240Z] Finished setup-mitmproxy step (success) 08:15:15 INFO - [mozharness: 2017-07-16 15:15:15.472461Z] Running run-tests step. 08:15:15 INFO - Running pre-action listener: _resource_record_pre_action 08:15:15 INFO - Running pre-action listener: _set_gcov_prefix 08:15:15 INFO - Running main action method: run_tests 08:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:15 INFO - Python 2.7.3 08:15:15 INFO - Return code: 0 08:15:15 INFO - grabbing minidump binary from tooltool 08:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:15 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 0x2af4d10>, '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 0x2af5c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af60c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:15 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 08:15:15 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 08:15:15 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 08:15:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:15 INFO - Return code: 0 08:15:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:15:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:15 INFO - ENV: RUST_BACKTRACE is now 1 08:15:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:15:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:15 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/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 08:15:15 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/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 08:15:15 INFO - Using env: {'DISPLAY': ':0', 08:15:15 INFO - 'HOME': '/home/cltbld', 08:15:15 INFO - 'LANG': 'en_US.UTF-8', 08:15:15 INFO - 'LANGUAGE': 'en_US:en', 08:15:15 INFO - 'LOGNAME': 'cltbld', 08:15:15 INFO - 'MAIL': '/var/mail/cltbld', 08:15:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:15 INFO - 'MOZ_NO_REMOTE': '1', 08:15:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:15 INFO - 'NO_EM_RESTART': '1', 08:15:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:15 INFO - 'PWD': '/builds/slave/test', 08:15:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:15 INFO - 'RUST_BACKTRACE': '1', 08:15:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:15:15 INFO - 'SHELL': '/bin/bash', 08:15:15 INFO - 'SHLVL': '1', 08:15:15 INFO - 'TERM': 'linux', 08:15:15 INFO - 'TMOUT': '86400', 08:15:15 INFO - 'USER': 'cltbld', 08:15:15 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313', 08:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:15 INFO - '_': '/tools/buildbot/bin/python'} 08:15:15 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/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 08:15:15 INFO - mozversion application_buildid: 20170716143035 08:15:15 INFO - mozversion application_changeset: bc3f73d54feeaf0e97b30496574357f05b2d5307 08:15:15 INFO - mozversion application_display_name: Nightly 08:15:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:15 INFO - mozversion application_name: Firefox 08:15:15 INFO - mozversion application_remotingname: firefox 08:15:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:15:15 INFO - mozversion application_vendor: Mozilla 08:15:15 INFO - mozversion application_version: 56.0a1 08:15:15 INFO - mozversion platform_buildid: 20170716143035 08:15:15 INFO - mozversion platform_changeset: bc3f73d54feeaf0e97b30496574357f05b2d5307 08:15:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:15:15 INFO - mozversion platform_version: 56.0a1 08:15:15 INFO - using testdate: 1500218115 08:15:15 INFO - actual date: 1500218115 08:15:15 INFO - starting webserver on 'localhost:46529' 08:15:15 INFO - SUITE-START | Running 2 tests 08:15:15 INFO - TEST-START | dromaeo_css 08:15:15 INFO - Initialising browser for dromaeo_css test... 08:15:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46529/getInfo.html -profile /tmp/tmphzMXdR/profile 08:15:16 INFO - TEST-INFO | started process 3476 (/builds/slave/test/build/application/firefox/firefox http://localhost:46529/getInfo.html) 08:15:22 INFO - TEST-INFO | 3476: exit 0 08:15:23 INFO - Browser initialized. 08:15:23 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:23 INFO - TEST-INFO | started process 3683 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphzMXdR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:34 INFO - PID 3683 | RSS: Main: 167395328 08:15:34 INFO - PID 3683 | 08:18:32 INFO - PID 3683 | Cycle 1(1): loaded http://localhost:46529/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46529/tests/dromaeo/cssquery-ext.html) 08:18:34 INFO - PID 3683 | RSS: Main: 176136192 08:18:34 INFO - PID 3683 | 08:21:35 INFO - PID 3683 | Cycle 1(1): loaded http://localhost:46529/tests/dromaeo/cssquery-ext.html (next: http://localhost:46529/tests/dromaeo/cssquery-jquery.html) 08:21:36 INFO - PID 3683 | RSS: Main: 173707264 08:21:36 INFO - PID 3683 | 08:24:38 INFO - PID 3683 | Cycle 1(1): loaded http://localhost:46529/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46529/tests/dromaeo/cssquery-mootools.html) 08:24:38 INFO - PID 3683 | RSS: Main: 176459776 08:24:38 INFO - PID 3683 | 08:27:40 INFO - PID 3683 | Cycle 1(1): loaded http://localhost:46529/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46529/tests/dromaeo/cssquery-prototype.html) 08:27:40 INFO - PID 3683 | RSS: Main: 175501312 08:27:40 INFO - PID 3683 | 08:30:44 INFO - PID 3683 | Cycle 1(1): loaded http://localhost:46529/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46529/tests/dromaeo/cssquery-yui.html) 08:30:44 INFO - PID 3683 | RSS: Main: 174194688 08:30:44 INFO - PID 3683 | 08:33:46 INFO - PID 3683 | Cycle 1(1): loaded http://localhost:46529/tests/dromaeo/cssquery-yui.html (next: http://localhost:46529/tests/dromaeo/cssquery-dojo.html) 08:33:46 INFO - PID 3683 | RSS: Main: 176058368 08:33:46 INFO - PID 3683 | 08:33:46 INFO - PID 3683 | __start_tp_report 08:33:46 INFO - PID 3683 | _x_x_mozilla_page_load 08:33:46 INFO - PID 3683 | _x_x_mozilla_page_load_details 08:33:46 INFO - PID 3683 | |i|pagename|runs| 08:33:46 INFO - PID 3683 | |0;dojo.html;3090.35102628448;3158.9210269743253;3161.6838316168387;3171.3974344874478;3203.695648913352;5994.880102397955;6007.819765407039;6042.939570604292;6064.9090263646085;6095.451409373156;6062.939370606293;6075.45320921117;6147.354527774586;6156;6165.475934545569;5587.7485513151805;5596.356419011825;5649.322081350244;5657.603967722272;5693.975084484791;5558.833235002957;5573.8606534836545;5621.522170615503;5656.490915817576;5720.8855822883515;5429.212764149196;5489.066858634042;5496.395396506381;5591.74837132326;5637.182608521762;5582.804601838957;5605.5515558755205;5627.521660658849;5629.3526244482;5646.350669672999;5437.8368648940195;5493.395726470085;5568.693721845297;5569.220309156681;5588.804391846306;5997.580169388145;5998.190244317005;6014.75940962361;6030.457258846681;6042;6318.684065796738;6400.39196276353;6444.645544495051;6448.097266382711;6465.67671616422;6463.1274777904855;6469.74121035158;6476.481881449473;6479.6760161991715;6486.772962946275;5923.911141332884;6004.789832355847;6009.609375390585;6023.247094113236;6027.698615069229;6615.17310336208;6616.569922954993;6617.073609694647;6633.071370008106;6645;6276.278228003746;6304.873902521924;6312.842178945563;6351.2696039956;6356.555041147168;6447.25856526496;6450.290468048511;6506.41442270198;6575.638339891352;6579.934200658028;6454.9677251614385;6467.385598368148;6520.217573891164;6549.279579246279;6570.671466426659;6332.651704156316;6463.289038205794;6480;6576.605403675795;6589.242237142694;4843.176659967814;5296.232046353257;5300.416954135042;5316.3354580677415;5323.813666521731;4554.7039442436135;4556.863294101182;4559.042601053816;4577.06170235101;4594.632429405639;5534.0315444797;5536.806211782568;5611.859703507445;5612.242347283064;5626.409227031103;6512;6522.282548919615;6529.15121034272;6605.801825945229;6634.900476492857;5499.202615620713;5560.972195138998;5565.053940830068;5565.833025009256;5573.052581061148;5780.884382312414;5801.245838041028;5801.767929282866;5802.709864506758;5808.099744539603;5872.2366092408565;6291.905621415683;6346.11154438379;6349.238091428966;6378.553501254868;6494.025896115431;6501.934980650133;6586.110875031809;6596;6603.834904127435;6251.9687401562705;6281.089242059968;6341.556091073765;6342.429181373698;6379.7129129190225;6370.044493326038;6375.043743438521;6380.361963803768;6397.1363865879375;6399.360063993563;6504.869902601827;6516.543841931019;6520.119783829123;6532.248791388861;6538.607683539003;6285.748570057147;6289.7169627365965;6295.905561416491;6300.432961033529;6309.968450157719;5366.168243922199;6251.4061164189325;6280.27776805655;6285.308616052322;6300.054991751091;6229.875402492015;6247.937520624918;6257.4994000480765;6302.306746257999;6309.211348581427;6377.107204991212;6381.106645069601;6410;6436.549441539048;6462.870742585028;6044.848878778066;6188.81433556994;6189;6266.624002559861;6268.749250029948 08:33:46 INFO - PID 3683 | |1;ext.html;735.9779206623804;787.5432249295409;818.4925346285304;838.2120806441947;842.5829214538804;39876;40218;40273.99999999996;40438.191236175335;40445.393319100236;36577.81711091441;36642.08394790125;36739.81630091852;36918.815405923;37016.62983370172;6683.2314283857495;6699.464042876582;6799.1840979082335;6800.1159849219775;6811.863762724743;6661.93338066618;6731.293214212511;6782.932170678279;6784.626845523494;6806.319368063204;6753.45972322213;6755.729770809162;6768.3908448239645;6785.932140678604;6789.253182149984;6737.225219099817;6771.322867713238;6772.492063095238;6775.695093720795;6777.864442711168;6062;6073.0283154695035;6118.571699981003;6121.540884433685;6127.203463549755;33012.339753205044;33049.50425743616;33277.6672233277;33325.16687082818;33413.83293083544;2831.6602007758993;2922.1379692990618;3344.4816053511745;3392.5589673342306;3400.0309911675054;30288;30378.088657340315;30637.846810766026;30668.38663226745;30676.693233067606;4897.902041959141;4913.950860491385;4935.136351138536;4950.356453661037;5047.671901326439;179035;179742;180638;187824;187905;46392.304115438295;46889.5311046892;46915.76542117268;47187.29219061717;47189.764051179525;49702.50297497051;50168.749156254715;50205;50213;50253.49746502561;15876.364945402054;15926.920365398099;15932.442364517186;16013.359465621244;16067.758983615255;12959.222446653042;13003;13055.543055992996;13106.934465327802;13154;14234.572962811133;14308.642283942985;14333.928330358282;14423.134611923319;14648.633784155481;5638.323401191883;5646.6583388493045;5719.170720245625;5755.568332375088;5795.1017592273265;1012.4937531234383;1015.674984005126;1022.3508072373947;1044.3159730376615;1047.015805143178;22163.445913852283;22253.888730556566;22268.888655556617;22884.42788930257;23286.184983525494;1071.3304184884448;1085.1806885801327;1121.428071683431;1133.4729350851894;1135.0862555642786;11617.186796924303;11834.408279585987;11943.044556435465;11986.820197697041;12014.399280036137;231832;232776;232810;233393;233523;49447.25829112566;49865.50134498681;49875.50124498781;49959.500404996215;49999;1474.2702362330715;1477.5936617430077;1497.610621238486;1500.6398464368474;1507.6984603079427;21566.8921655397;21990.45023874352;22042.44893877666;22213.445453773023;26885.262289756298;49261.753691231315;49553.75223123861;49706.254406183216;49781;49899.251511226634;205359;208272;208348;208473;209933;31124.533132002583;31582;31609.84195079102;31707.365852682356;34999.475007875415;37263.44104838376;37692;37710.81144594259;41542.58457415387;42180.57819421889;31010.844945775127;31453.370932581678;31760.205994849388;32425.675743242267;33425.66574334323;32557.674423256412;33731.15672108217;33948;34127.488087678204;34578;35543.82228088843;36425.08937276589;36878.078048049014;37018.44472332971;37148.44277335896;31768;32622;32761.836190818893;33055.173620658716;33103.50344744782;23379.298621041395;23902;23979.880100599385;24192.758072419052;24473.632895506937 08:33:46 INFO - PID 3683 | |2;jquery.html;560.4787547580748;572.9570282228834;574.8103125968428;591.62136232811;597.2564157623759;21841.672374914368;22545.210917617886;22549.210777622786;22574.887125564368;22651.99999999996;26065.60901586478;26735.598966015525;26785.33036674084;26873;26932.865335673294;6479.481641468683;6627.768028119017;6632.701528431232;6637.601743895381;6645;3863.1887303666263;6483.481321494269;6560.770373036945;6569.080328753978;6574.901376479356;5277.815276465324;6568.934310656904;6592.439642630358;6616.305287944769;6630.436412904909;6558.2130144382745;6582.835429114262;6584.5061620378665;6607.405333519982;6616.172978377703;6123.693815309217;6141.754329826802;6158.753649854;6166.7533298667995;6172.043333283348;28091.85954070237;29939.700602993908;29955.400891982037;30031.699683003328;30806.229844254074;1916.626257879714;1957.4812674641232;1958.8530860185542;1961.0292905011968;1980.1386396917387;18455.446336609923;18861.90569047146;19085.713714294296;19116.426507204807;19141.425757227167;2194.473326401668;2260.2654137405407;2263.0834512022657;2277.202978957368;2389.3190440724484;136008;138494.3075284617;140026;140572.29713851467;140841;14693.55919322422;15160.696786064216;15223;15642.279349271572;16051.598710032342;23691.28926132219;23846.880765596063;23888.880555597458;24012.27963161108;24169;10140.543675534618;10192.286539942133;10328.277020608486;10364.378137311785;10470.581176752845;9506.191973682176;9550.331476796697;9571.569279382444;9708.660196893075;9723.805523889483;8695.695650652196;9221.861672074925;9272;9481.478518681539;9651.613935442643;2843.5876797864194;2916.5770963210216;2926.195296293536;2957.6155099836883;2974.2897833745683;950.6625148072472;958.1137447860701;960.9087136722001;986.0780170540424;1003.3277703938379;19581.90209048974;20388.184472621226;20402.18391264333;20490.59018819615;20606.896965515076;987.8863930648067;1009.3237530854345;1046.7958748044211;1048.9475526223657;1051.2588625019343;10916.181286403551;11038.448077596087;11158.60944866942;11168.776624467466;11175.161862860155;457116;461766;478178;479906;483713;107307;110589;113697.43151284191;114147;114661.42669286767;1197.1201167142144;1222.9082818788627;1300.8764167403892;1305.5887395470397;1306.1575283941995;20365.49086272855;21378.89310553437;21661.133554657637;21773.12907483683;21936.451588709773;56411.15383269172;57805.13292300703;58550.7072464635;58892.70553647204;60599;73811;75009;75865.6206718963;76038.6198069006;76466.23533764813;14387.496437624633;14726.558203253919;15002.699946001238;15195.62010949691;15221.238938052831;18060.458186254433;18256.72614910804;23805.404864878517;24317.635235471127;24338.87830560836;18542;18663.44009679712;18725.625487490448;18860.434186974413;19288.22847086101;16228.51314460568;16272.837271627606;16997.40509082176;17094.316227350766;17527.649447011245;18826.717599236297;19417.902910485358;19521;19670;19698;14533.200673963034;14680.41278348854;14698.63253418673;14756.557303280919;14838.629034274229;17718.025508596635;18603;18639.440816774975;18683.626327473103;18845 08:33:46 INFO - PID 3683 | |3;mootools.html;1314.3625341709271;1341.4835288413965;1382.3917476310423;1383.9723205535884;1386.6048176269765;13444.126131801439;14053.859461405384;14119;14135.222562759043;14176.078554893938;13635.318234088305;13913.095648782823;14067.437302507913;14068.929655351734;14096.788548171786;2685.3957859481607;2760.7239276072332;2762.557990721485;2767.1698490452886;2772.37621535155;2610.2038878142157;2669.7730692891128;2696.5281075811754;2696.5820297853866;2702.6216329713857;2251.977480225193;2328.941776455585;2351.623740201568;2616.071294690386;2683.597460380939;2299.977000229993;2615.6338112664243;2730.2082396105307;2733.8633068346503;2738.096428178706;2655.030913716499;2672.906448274301;2677.1700772760505;2677.8794954227105;2683.651125353711;13537.932310338483;13559.38982745769;13657.726845463134;13685.178889266675;13709.17744935307;7433.256674332523;7786.1824508426935;7832.177621349791;7836.412269079842;7845.1762564931005;5202.635815492917;5426.593005524562;5543.334799824007;5559.916601250984;5585.664860108406;1847.7690288713911;1903.6954087345957;1909.4844392014218;1954.0913475233942;1960.7941166177632;22454.55090898189;22721.431964200863;22738.77261227383;22742.772572274233;22757.43106422353;6433.5496515243485;6496.772612958618;6522.836929076716;6600.108985287021;6644.269130395653;15573.377064917502;15633.218339083;15648.687026259411;15652.452164174427;15664.060156390653;7400.407967362598;7575.810604734926;7576.393888489018;7579.810504737426;7587;6871.931280687229;6999.510034297652;7088.964555177191;7141.500094993301;7178.8205294867;4996.150654388763;5093.312402825645;5119.897602047939;5162.406323272797;5220.556252718486;1457.9562613121623;1483.7922690823293;1489.2404873514586;1508.3740247797261;1514.4169494744383;880.55972013993;889.3374436045187;909.3952521573079;911.8768966189613;912.1380295620575;7034.648267586703;7090;7098.432125429953;7105.111861017373;7144.3570078693165;714.9034880291094;725.050184258623;735.9337659610661;739.8002539314355;742.7957311739315;5386.272853164773;5484.2596249505805;5600.60795744294;5613.831585052455;5635.154726790932;18736.531586710167;18781.7182742259;19006.52483687891;19007.90496047511;19109.808901910805;18201.180946857425;18826.71759923602;18848.246070157315;18866.151023203714;19126.808731912504;10673.519691613896;10680.038796508352;10684.626038088629;10731.248812583044;10906.454677266105;8202.712905048533;8231.588420578828;8373.246407823324;8495.405321627426;8590.012148602991;15107.697846043238;15810.209489525707;16072.437464688679;16179;16326.673466530841;15636.4527241546;16942.152892355087;17061.061641609333;17171.65656686884;17209.397671081453;10190.949045255024;10362.948185259327;10382;10389.9480502597;10406;12250.203736757083;12343.444544995677;12350.320732359807;12381.195222310522;12566.497340106293;10347.482625868526;10452.425116618355;10611;10658.573657053632;10898.182636302468;9955.701328960144;10160.847587286344;10212.591496340361;10524.158067354747;10590.576376944837;9169;9212.723618291462;9231;9258;9263.953680231556;6938.098047253825;6943.861122777415;6982.266861979419;7053.153621565445;7140.964295178491;6955.965220174069;7074;7085.645717713991;7101.502894797314;7127.964360178166 08:33:46 INFO - PID 3683 | |4;prototype.html;499.0139245801708;499.8578248701715;523.2648129378223;525.1387724132421;528.3000024966917;6050.576459647827;6052.5473886267255;6075.574709770318;6076.422739839719;6087.847803804907;5855.619384739989;5959.718660487994;5977.910331345033;5998.190244317016;6054.485368743651;4887.828925987591;4903.803847846091;4903.954237753849;4934.28452874333;4961.330220420251;4866.756662166895;4889.9511004889855;4907.533784290486;4910.288008238803;4913.926291105637;4780.187368147406;4807.639427042968;4828.155072862252;4845.273209018657;4912.287718280847;4626.722396656194;4823.855284341475;4826.372571565709;4838.201696720037;4868.63678170113;4371.562843715635;4372.3878656988045;4381.9561804381865;4424.867253982386;4432.534583868712;5919.2009078774245;5920.851978700523;5920.881582368328;5945.256842894638;5951.49412299955;5587.469190426903;5605.7197140143235;5612.466815652507;5619.775208991636;5647.576431767593;6403.551751377406;6413.16628838248;6415.679216039226;6437.967810160919;6473.5366578880075;4795.736234507101;4804.7837847296605;4805.5434733700595;4817.56641902227;4825.638077144193;6652.800415987528;6655.86688266232;6744.865102697968;6785.898211526831;6791.388775010273;4884.0476107159475;4922.237053256751;4935.7532123393685;4953.306537084811;5002.949970500321;4949.455559888409;4988.700677959334;4998.300237966688;5013.793930670493;5049.368828896388;5503.504684578407;5520.723963801794;5533.612647114744;5562.276904002454;5598.1322894951345;6337.65142917144;6342.809715708536;6374.617522948638;6483.967580162069;6495.642739649365;1716.7167417375992;1737.2008875916968;1739.1217435195144;1746.2752957522487;1747.1962897067237;1112.4159816096453;1204.7650708111835;1215.4469716279073;1219.3659297165425;1231.802911534168;5367.302250707383;5455.208994695747;5456.563474921997;5579.302587176603;5598.272224610774;6554.737810487527;6591.76928807499;6611.636360000246;6621.602703837785;6626.204855417381;5530.336359636789;5571.777128914879;5585.162225666182;5618.381977982419;5631.931925433555;3396.2698019925833;3450.7929524228125;3470.4383027637664;3471.8437670304897;3489.8778542750883;6319.399657032574;6335.968320158369;6383.329750376237;6385.361463853577;6406.8718625627225;6711.261761206263;6747.257801641816;6752.898706519406;6771.322867713189;6779;6376.202974628171;6376.458001069868;6453.19335083124;6459.386358295955;6468.870622587522;6447.871042579216;6481.222253329631;6543.5419520633095;6574.638394888136;6587.179435927246;6532.379423954717;6536.398582347355;6537.215534135934;6546.574472659262;6589.17635295588;6389.4888408926245;6393.168888044711;6399.8080057598345;6402.295747467868;6408.455281300955;4914.041761856403;4926.482719314564;4932.1122198004705;4954.281629163823;4956.677815941952;6592.967035164794;6626.271110177973;6645.305447110955;6669.199696036507;6679.165104361955;6356.872862542631;6357.777477788255;6392.584482008655;6393.968030159819;6435.774747883802;6361.872762544631;6377.649229292433;6387.489000879826;6391.32891046452;6414.7434102637235;6262.624242545279;6278.497720182283;6281.937180628135;6332.525060620564;6342.587731797418;6375.776847810304;6410.230772307353;6416;6464.935350646433;6469.7412103515335;5964.403559644001;6234.781782637586;6245.5628106032145;6304.6847657617855;6321.273053598895 08:33:46 INFO - PID 3683 | |5;yui.html;906.3564868943046;914.1681070226093;923.3167456082501;929.5863340813337;930.1767935377189;17971.730424043635;18335.449936501893;18378.448646540593;18494.16776245069;18939.337123200672;19599.510012249702;20502.384928452135;21198;21284.680729789066;21514.03186856591;1037.4034929915292;1063.2769716592713;1065.3661071662386;1065.9926369580749;1067.9626213082543;1061.039759018086;1061.824798908183;1063.2185343772321;1063.462951209638;1064.2497039587072;1023.7235946294496;1063.8404239364118;1115.8828323026087;1124.5558004588183;1128.949197286124;1109.9223054386196;1112.6105862947984;1113.7661091170864;1116.2967330581682;1117.8602674665667;791.3431851563246;793.8055176481741;794.6543253684608;795.2127393880075;795.2842441802367;17916.28334866604;18649.34727284552;18912.43262702121;19221.80778192214;19233.03834808268;19648.60702785936;19680.50798730029;20296.594068118702;20299.492512687153;20532.281370152123;15325.770113448307;15777.68444631101;15916.20418979058;15936.840631593652;15985.520434386986;3514.1566024154017;3516.6483351664883;3545.007397928584;3547.7516573839844;3551.893443196708;101738;102085.48957255167;104621.95378046198;105065.47467262691;107576;16208.67582648364;16292.674146517003;16663.50009499717;16736.326367363166;16883.662326753398;27433.45133097327;29451.558226626617;29621.111366659035;29681.85159074191;29697.703022969927;8538.487690738575;8759.737207883774;8774.956125219333;8786.25316848075;8800.47197168172;3903.4925459690057;3959.3269144245546;4030.697697672628;4034.515858097047;4160.396742472385;4762.809487620457;4848.418189817245;4858.271259311132;4873.610111191097;4889.706617602955;909.1045320359441;962.5716556132594;971.3491960386558;1056.8995945385177;1084.0947808579924;678.8336857469951;697.2156324135348;718.2745427118543;720.1106633307861;734.3280897978397;11469.31184128955;11956.880431195577;12051.819222711667;12460.937695311646;12529.686757831127;675.6385333846368;706.7702996526046;717.8959050937585;734.3794493652855;734.8860926556392;5238.92141617876;5371.75827087782;5388.515033646991;5443.836684899459;5581.2186293918885;97212.51393743127;97824;98022;99695.50152249192;101530.49234753779;82809.58595206986;82870;83627.16372836316;83790.58104709437;85646.57176714076;72145;72656.63671681714;72702;75764.24235757682;78369;11102.281203836048;11200;11448.313101213955;11488.310244909288;11755.412229388325;34754.652453475144;35024;35086.64913350834;36700;37490.2501949954;58475.70762146332;61674.69162654158;67191.66404167948;67221.66389168023;67366.66316668582;18575.53561160982;19309.13108910074;19321;19582;19605.8039419604;18491.44525664232;19919.402417927486;20449.591008179457;21045.89477052605;21832.126714931226;17115.914420427816;17746.5563360917;17833.821661783215;18005.189766460804;18600.162992665093;18702.251909923452;18930;19271.51821204481;19370.515737106685;19380.806191938464;14936.327865245872;16907.91546042262;16941.91529042347;17389.91305043467;17536.82463175403;12657.936710316759;13878.375473103533;14024.018318717592;14243.21662308583;14377.993540452067;13197.20816750998;13539.932300338829;13609;14646.194459304841;14692.485762998243 08:33:46 INFO - PID 3683 | __end_tp_report 08:33:46 INFO - PID 3683 | __start_cc_report 08:33:46 INFO - PID 3683 | _x_x_mozilla_cycle_collect,348 08:33:46 INFO - PID 3683 | __end_cc_report 08:33:46 INFO - PID 3683 | __startTimestamp1500219226531__endTimestamp 08:33:46 INFO - PID 3683 | 08:33:46 INFO - PID 3683 | ------- Summary: start ------- 08:33:46 INFO - PID 3683 | Number of tests: 6 08:33:46 INFO - PID 3683 | 08:33:46 INFO - PID 3683 | [#0] dojo.html Cycles:165 Average:5975.89 Median:6251.41 stddev:687.82 (11.0%) stddev-sans-first:651.61 08:33:46 INFO - PID 3683 | Values: 3090.4 3158.9 3161.7 3171.4 3203.7 5994.9 6007.8 6042.9 6064.9 6095.5 6062.9 6075.5 6147.4 6156.0 6165.5 5587.7 5596.4 5649.3 5657.6 5694.0 5558.8 5573.9 5621.5 5656.5 5720.9 5429.2 5489.1 5496.4 5591.7 5637.2 5582.8 5605.6 5627.5 5629.4 5646.4 5437.8 5493.4 5568.7 5569.2 5588.8 5997.6 5998.2 6014.8 6030.5 6042.0 6318.7 6400.4 6444.6 6448.1 6465.7 6463.1 6469.7 6476.5 6479.7 6486.8 5923.9 6004.8 6009.6 6023.2 6027.7 6615.2 6616.6 6617.1 6633.1 6645.0 6276.3 6304.9 6312.8 6351.3 6356.6 6447.3 6450.3 6506.4 6575.6 6579.9 6455.0 6467.4 6520.2 6549.3 6570.7 6332.7 6463.3 6480.0 6576.6 6589.2 4843.2 5296.2 5300.4 5316.3 5323.8 4554.7 4556.9 4559.0 4577.1 4594.6 5534.0 5536.8 5611.9 5612.2 5626.4 6512.0 6522.3 6529.2 6605.8 6634.9 5499.2 5561.0 5565.1 5565.8 5573.1 5780.9 5801.2 5801.8 5802.7 5808.1 5872.2 6291.9 6346.1 6349.2 6378.6 6494.0 6501.9 6586.1 6596.0 6603.8 6252.0 6281.1 6341.6 6342.4 6379.7 6370.0 6375.0 6380.4 6397.1 6399.4 6504.9 6516.5 6520.1 6532.2 6538.6 6285.7 6289.7 6295.9 6300.4 6310.0 5366.2 6251.4 6280.3 6285.3 6300.1 6229.9 6247.9 6257.5 6302.3 6309.2 6377.1 6381.1 6410.0 6436.5 6462.9 6044.8 6188.8 6189.0 6266.6 6268.7 08:33:46 INFO - PID 3683 | 08:33:46 INFO - PID 3683 | [#1] ext.html Cycles:180 Average:37333.29 Median:33419.75 stddev:54253.51 (162.3%) stddev-sans-first:54336.11 08:33:46 INFO - PID 3683 | Values: 736.0 787.5 818.5 838.2 842.6 39876.0 40218.0 40274.0 40438.2 40445.4 36577.8 36642.1 36739.8 36918.8 37016.6 6683.2 6699.5 6799.2 6800.1 6811.9 6661.9 6731.3 6782.9 6784.6 6806.3 6753.5 6755.7 6768.4 6785.9 6789.3 6737.2 6771.3 6772.5 6775.7 6777.9 6062.0 6073.0 6118.6 6121.5 6127.2 33012.3 33049.5 33277.7 33325.2 33413.8 2831.7 2922.1 3344.5 3392.6 3400.0 30288.0 30378.1 30637.8 30668.4 30676.7 4897.9 4914.0 4935.1 4950.4 5047.7 179035.0 179742.0 180638.0 187824.0 187905.0 46392.3 46889.5 46915.8 47187.3 47189.8 49702.5 50168.7 50205.0 50213.0 50253.5 15876.4 15926.9 15932.4 16013.4 16067.8 12959.2 13003.0 13055.5 13106.9 13154.0 14234.6 14308.6 14333.9 14423.1 14648.6 5638.3 5646.7 5719.2 5755.6 5795.1 1012.5 1015.7 1022.4 1044.3 1047.0 22163.4 22253.9 22268.9 22884.4 23286.2 1071.3 1085.2 1121.4 1133.5 1135.1 11617.2 11834.4 11943.0 11986.8 12014.4 231832.0 232776.0 232810.0 233393.0 233523.0 49447.3 49865.5 49875.5 49959.5 49999.0 1474.3 1477.6 1497.6 1500.6 1507.7 21566.9 21990.5 22042.4 22213.4 26885.3 49261.8 49553.8 49706.3 49781.0 49899.3 205359.0 208272.0 208348.0 208473.0 209933.0 31124.5 31582.0 31609.8 31707.4 34999.5 37263.4 37692.0 37710.8 41542.6 42180.6 31010.8 31453.4 31760.2 32425.7 33425.7 32557.7 33731.2 33948.0 34127.5 34578.0 35543.8 36425.1 36878.1 37018.4 37148.4 31768.0 32622.0 32761.8 33055.2 33103.5 23379.3 23902.0 23979.9 24192.8 24473.6 08:33:46 INFO - PID 3683 | 08:33:46 INFO - PID 3683 | [#2] jquery.html Cycles:180 Average:34555.22 Median:22562.05 stddev:79829.51 (353.8%) stddev-sans-first:80012.65 08:33:46 INFO - PID 3683 | Values: 560.5 573.0 574.8 591.6 597.3 21841.7 22545.2 22549.2 22574.9 22652.0 26065.6 26735.6 26785.3 26873.0 26932.9 6479.5 6627.8 6632.7 6637.6 6645.0 3863.2 6483.5 6560.8 6569.1 6574.9 5277.8 6568.9 6592.4 6616.3 6630.4 6558.2 6582.8 6584.5 6607.4 6616.2 6123.7 6141.8 6158.8 6166.8 6172.0 28091.9 29939.7 29955.4 30031.7 30806.2 1916.6 1957.5 1958.9 1961.0 1980.1 18455.4 18861.9 19085.7 19116.4 19141.4 2194.5 2260.3 2263.1 2277.2 2389.3 136008.0 138494.3 140026.0 140572.3 140841.0 14693.6 15160.7 15223.0 15642.3 16051.6 23691.3 23846.9 23888.9 24012.3 24169.0 10140.5 10192.3 10328.3 10364.4 10470.6 9506.2 9550.3 9571.6 9708.7 9723.8 8695.7 9221.9 9272.0 9481.5 9651.6 2843.6 2916.6 2926.2 2957.6 2974.3 950.7 958.1 960.9 986.1 1003.3 19581.9 20388.2 20402.2 20490.6 20606.9 987.9 1009.3 1046.8 1048.9 1051.3 10916.2 11038.4 11158.6 11168.8 11175.2 457116.0 461766.0 478178.0 479906.0 483713.0 107307.0 110589.0 113697.4 114147.0 114661.4 1197.1 1222.9 1300.9 1305.6 1306.2 20365.5 21378.9 21661.1 21773.1 21936.5 56411.2 57805.1 58550.7 58892.7 60599.0 73811.0 75009.0 75865.6 76038.6 76466.2 14387.5 14726.6 15002.7 15195.6 15221.2 18060.5 18256.7 23805.4 24317.6 24338.9 18542.0 18663.4 18725.6 18860.4 19288.2 16228.5 16272.8 16997.4 17094.3 17527.6 18826.7 19417.9 19521.0 19670.0 19698.0 14533.2 14680.4 14698.6 14756.6 14838.6 17718.0 18603.0 18639.4 18683.6 18845.0 08:33:46 INFO - PID 3683 | 08:33:46 INFO - PID 3683 | [#3] mootools.html Cycles:180 Average:8555.51 Median:2635.55 stddev:5754.48 (218.3%) stddev-sans-first:5744.90 08:33:46 INFO - PID 3683 | Values: 1314.4 1341.5 1382.4 1384.0 1386.6 13444.1 14053.9 14119.0 14135.2 14176.1 13635.3 13913.1 14067.4 14068.9 14096.8 2685.4 2760.7 2762.6 2767.2 2772.4 2610.2 2669.8 2696.5 2696.6 2702.6 2252.0 2328.9 2351.6 2616.1 2683.6 2300.0 2615.6 2730.2 2733.9 2738.1 2655.0 2672.9 2677.2 2677.9 2683.7 13537.9 13559.4 13657.7 13685.2 13709.2 7433.3 7786.2 7832.2 7836.4 7845.2 5202.6 5426.6 5543.3 5559.9 5585.7 1847.8 1903.7 1909.5 1954.1 1960.8 22454.6 22721.4 22738.8 22742.8 22757.4 6433.5 6496.8 6522.8 6600.1 6644.3 15573.4 15633.2 15648.7 15652.5 15664.1 7400.4 7575.8 7576.4 7579.8 7587.0 6871.9 6999.5 7089.0 7141.5 7178.8 4996.2 5093.3 5119.9 5162.4 5220.6 1458.0 1483.8 1489.2 1508.4 1514.4 880.6 889.3 909.4 911.9 912.1 7034.6 7090.0 7098.4 7105.1 7144.4 714.9 725.1 735.9 739.8 742.8 5386.3 5484.3 5600.6 5613.8 5635.2 18736.5 18781.7 19006.5 19007.9 19109.8 18201.2 18826.7 18848.2 18866.2 19126.8 10673.5 10680.0 10684.6 10731.2 10906.5 8202.7 8231.6 8373.2 8495.4 8590.0 15107.7 15810.2 16072.4 16179.0 16326.7 15636.5 16942.2 17061.1 17171.7 17209.4 10190.9 10362.9 10382.0 10389.9 10406.0 12250.2 12343.4 12350.3 12381.2 12566.5 10347.5 10452.4 10611.0 10658.6 10898.2 9955.7 10160.8 10212.6 10524.2 10590.6 9169.0 9212.7 9231.0 9258.0 9264.0 6938.1 6943.9 6982.3 7053.2 7141.0 6956.0 7074.0 7085.6 7101.5 7128.0 08:33:46 INFO - PID 3683 | 08:33:46 INFO - PID 3683 | [#4] prototype.html Cycles:180 Average:5393.94 Median:5955.61 stddev:1511.25 (25.4%) stddev-sans-first:1470.15 08:33:46 INFO - PID 3683 | Values: 499.0 499.9 523.3 525.1 528.3 6050.6 6052.5 6075.6 6076.4 6087.8 5855.6 5959.7 5977.9 5998.2 6054.5 4887.8 4903.8 4904.0 4934.3 4961.3 4866.8 4890.0 4907.5 4910.3 4913.9 4780.2 4807.6 4828.2 4845.3 4912.3 4626.7 4823.9 4826.4 4838.2 4868.6 4371.6 4372.4 4382.0 4424.9 4432.5 5919.2 5920.9 5920.9 5945.3 5951.5 5587.5 5605.7 5612.5 5619.8 5647.6 6403.6 6413.2 6415.7 6438.0 6473.5 4795.7 4804.8 4805.5 4817.6 4825.6 6652.8 6655.9 6744.9 6785.9 6791.4 4884.0 4922.2 4935.8 4953.3 5002.9 4949.5 4988.7 4998.3 5013.8 5049.4 5503.5 5520.7 5533.6 5562.3 5598.1 6337.7 6342.8 6374.6 6484.0 6495.6 1716.7 1737.2 1739.1 1746.3 1747.2 1112.4 1204.8 1215.4 1219.4 1231.8 5367.3 5455.2 5456.6 5579.3 5598.3 6554.7 6591.8 6611.6 6621.6 6626.2 5530.3 5571.8 5585.2 5618.4 5631.9 3396.3 3450.8 3470.4 3471.8 3489.9 6319.4 6336.0 6383.3 6385.4 6406.9 6711.3 6747.3 6752.9 6771.3 6779.0 6376.2 6376.5 6453.2 6459.4 6468.9 6447.9 6481.2 6543.5 6574.6 6587.2 6532.4 6536.4 6537.2 6546.6 6589.2 6389.5 6393.2 6399.8 6402.3 6408.5 4914.0 4926.5 4932.1 4954.3 4956.7 6593.0 6626.3 6645.3 6669.2 6679.2 6356.9 6357.8 6392.6 6394.0 6435.8 6361.9 6377.6 6387.5 6391.3 6414.7 6262.6 6278.5 6281.9 6332.5 6342.6 6375.8 6410.2 6416.0 6464.9 6469.7 5964.4 6234.8 6245.6 6304.7 6321.3 08:33:46 INFO - PID 3683 | 08:33:46 INFO - PID 3683 | [#5] yui.html Cycles:180 Average:21683.82 Median:19664.56 stddev:27559.11 (140.1%) stddev-sans-first:27592.25 08:33:46 INFO - PID 3683 | Values: 906.4 914.2 923.3 929.6 930.2 17971.7 18335.4 18378.4 18494.2 18939.3 19599.5 20502.4 21198.0 21284.7 21514.0 1037.4 1063.3 1065.4 1066.0 1068.0 1061.0 1061.8 1063.2 1063.5 1064.2 1023.7 1063.8 1115.9 1124.6 1128.9 1109.9 1112.6 1113.8 1116.3 1117.9 791.3 793.8 794.7 795.2 795.3 17916.3 18649.3 18912.4 19221.8 19233.0 19648.6 19680.5 20296.6 20299.5 20532.3 15325.8 15777.7 15916.2 15936.8 15985.5 3514.2 3516.6 3545.0 3547.8 3551.9 101738.0 102085.5 104622.0 105065.5 107576.0 16208.7 16292.7 16663.5 16736.3 16883.7 27433.5 29451.6 29621.1 29681.9 29697.7 8538.5 8759.7 8775.0 8786.3 8800.5 3903.5 3959.3 4030.7 4034.5 4160.4 4762.8 4848.4 4858.3 4873.6 4889.7 909.1 962.6 971.3 1056.9 1084.1 678.8 697.2 718.3 720.1 734.3 11469.3 11956.9 12051.8 12460.9 12529.7 675.6 706.8 717.9 734.4 734.9 5238.9 5371.8 5388.5 5443.8 5581.2 97212.5 97824.0 98022.0 99695.5 101530.5 82809.6 82870.0 83627.2 83790.6 85646.6 72145.0 72656.6 72702.0 75764.2 78369.0 11102.3 11200.0 11448.3 11488.3 11755.4 34754.7 35024.0 35086.6 36700.0 37490.3 58475.7 61674.7 67191.7 67221.7 67366.7 18575.5 19309.1 19321.0 19582.0 19605.8 18491.4 19919.4 20449.6 21045.9 21832.1 17115.9 17746.6 17833.8 18005.2 18600.2 18702.3 18930.0 19271.5 19370.5 19380.8 14936.3 16907.9 16941.9 17389.9 17536.8 12657.9 13878.4 14024.0 14243.2 14378.0 13197.2 13539.9 13609.0 14646.2 14692.5 08:33:46 INFO - PID 3683 | -------- Summary: end -------- 08:33:46 INFO - PID 3683 | 08:33:47 INFO - TEST-INFO | 3683: exit 0 08:33:47 INFO - TEST-OK | dromaeo_css | took 1111137ms 08:33:47 INFO - TEST-START | kraken 08:33:47 INFO - Initialising browser for kraken test... 08:33:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46529/getInfo.html -profile /tmp/tmpxmxark/profile 08:33:47 INFO - TEST-INFO | started process 4091 (/builds/slave/test/build/application/firefox/firefox http://localhost:46529/getInfo.html) 08:33:53 INFO - TEST-INFO | 4091: exit 0 08:33:53 INFO - Browser initialized. 08:33:53 INFO - Running cycle 1/1 for kraken test... 08:33:53 INFO - TEST-INFO | started process 4298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxmxark/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:04 INFO - PID 4298 | RSS: Main: 167239680 08:34:04 INFO - PID 4298 | 08:34:07 INFO - PID 4298 | Cycle 1(1): loaded http://localhost:46529/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46529/tests/kraken/driver.html?testName=audio-beat-detection) 08:34:08 INFO - PID 4298 | RSS: Main: 173957120 08:34:08 INFO - PID 4298 | 08:34:11 INFO - PID 4298 | Cycle 1(1): loaded http://localhost:46529/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46529/tests/kraken/driver.html?testName=audio-dft) 08:34:11 INFO - PID 4298 | RSS: Main: 173731840 08:34:11 INFO - PID 4298 | 08:34:14 INFO - PID 4298 | Cycle 1(1): loaded http://localhost:46529/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46529/tests/kraken/driver.html?testName=audio-fft) 08:34:15 INFO - PID 4298 | RSS: Main: 167682048 08:34:15 INFO - PID 4298 | 08:34:17 INFO - PID 4298 | Cycle 1(1): loaded http://localhost:46529/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46529/tests/kraken/driver.html?testName=audio-oscillator) 08:34:17 INFO - PID 4298 | RSS: Main: 168615936 08:34:17 INFO - PID 4298 | 08:34:20 INFO - PID 4298 | Cycle 1(1): loaded http://localhost:46529/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46529/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:20 INFO - PID 4298 | RSS: Main: 168374272 08:34:20 INFO - PID 4298 | 08:34:23 INFO - PID 4298 | Cycle 1(1): loaded http://localhost:46529/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46529/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:24 INFO - PID 4298 | RSS: Main: 171413504 08:34:24 INFO - PID 4298 | 08:34:27 INFO - PID 4298 | Cycle 1(1): loaded http://localhost:46529/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46529/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:28 INFO - PID 4298 | RSS: Main: 174256128 08:34:28 INFO - PID 4298 | 08:34:31 INFO - PID 4298 | Cycle 1(1): loaded http://localhost:46529/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46529/tests/kraken/driver.html?testName=json-parse-financial) 08:34:31 INFO - PID 4298 | RSS: Main: 172765184 08:34:31 INFO - PID 4298 | 08:34:33 INFO - PID 4298 | Cycle 1(1): loaded http://localhost:46529/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46529/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:33 INFO - PID 4298 | RSS: Main: 172167168 08:34:33 INFO - PID 4298 | 08:34:35 INFO - PID 4298 | Cycle 1(1): loaded http://localhost:46529/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46529/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:36 INFO - PID 4298 | RSS: Main: 172195840 08:34:36 INFO - PID 4298 | 08:34:38 INFO - PID 4298 | Cycle 1(1): loaded http://localhost:46529/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46529/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:38 INFO - PID 4298 | RSS: Main: 172347392 08:34:38 INFO - PID 4298 | 08:34:41 INFO - PID 4298 | Cycle 1(1): loaded http://localhost:46529/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46529/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:42 INFO - PID 4298 | RSS: Main: 172326912 08:34:42 INFO - PID 4298 | 08:34:45 INFO - PID 4298 | Cycle 1(1): loaded http://localhost:46529/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46529/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:45 INFO - PID 4298 | RSS: Main: 172535808 08:34:45 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | Cycle 1(1): loaded http://localhost:46529/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46529/tests/kraken/driver.html?testName=ai-astar) 08:34:47 INFO - PID 4298 | RSS: Main: 174051328 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | __start_tp_report 08:34:47 INFO - PID 4298 | _x_x_mozilla_page_load 08:34:47 INFO - PID 4298 | _x_x_mozilla_page_load_details 08:34:47 INFO - PID 4298 | |i|pagename|runs| 08:34:47 INFO - PID 4298 | |0;ai-astar;101;107;109;110;110;111;111;109;109;109 08:34:47 INFO - PID 4298 | |1;audio-beat-detection;157;125;154;185;120;156;145;122;177;124 08:34:47 INFO - PID 4298 | |2;audio-dft;163;163;162;161;161;169;164;166;175;164 08:34:47 INFO - PID 4298 | |3;audio-fft;74;74;74;179;75;75;75;74;93;78 08:34:47 INFO - PID 4298 | |4;audio-oscillator;82;82;130;82;82;82;130;81;82;134 08:34:47 INFO - PID 4298 | |5;imaging-gaussian-blur;114;114;114;114;114;113;113;114;113;115 08:34:47 INFO - PID 4298 | |6;imaging-darkroom;150;150;149;149;149;149;148;149;149;150 08:34:47 INFO - PID 4298 | |7;imaging-desaturate;94;95;94;94;95;94;95;95;95;94 08:34:47 INFO - PID 4298 | |8;json-parse-financial;55;56;56;54;58;55;55;55;55;56 08:34:47 INFO - PID 4298 | |9;json-stringify-tinderbox;55;54;54;54;54;54;54;54;53;55 08:34:47 INFO - PID 4298 | |10;stanford-crypto-aes;78;77;77;77;86;78;79;76;76;77 08:34:47 INFO - PID 4298 | |11;stanford-crypto-ccm;126;130;134;131;124;123;132;134;135;168 08:34:47 INFO - PID 4298 | |12;stanford-crypto-pbkdf2;189;182;186;197;185;190;178;194;190;178 08:34:47 INFO - PID 4298 | |13;stanford-crypto-sha256-iterative;68;69;67;68;67;67;69;67;67;68 08:34:47 INFO - PID 4298 | __end_tp_report 08:34:47 INFO - PID 4298 | __start_cc_report 08:34:47 INFO - PID 4298 | _x_x_mozilla_cycle_collect,960 08:34:47 INFO - PID 4298 | __end_cc_report 08:34:47 INFO - PID 4298 | __startTimestamp1500219287940__endTimestamp 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | ------- Summary: start ------- 08:34:47 INFO - PID 4298 | Number of tests: 14 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.50 stddev:2.91 (2.7%) stddev-sans-first:1.24 08:34:47 INFO - PID 4298 | Values: 101.0 107.0 109.0 110.0 110.0 111.0 111.0 109.0 109.0 109.0 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:155.00 stddev:23.43 (15.1%) stddev-sans-first:24.55 08:34:47 INFO - PID 4298 | Values: 157.0 125.0 154.0 185.0 120.0 156.0 145.0 122.0 177.0 124.0 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:4.32 (2.6%) stddev-sans-first:4.53 08:34:47 INFO - PID 4298 | Values: 163.0 163.0 162.0 161.0 161.0 169.0 164.0 166.0 175.0 164.0 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | [#3] audio-fft Cycles:10 Average:87.10 Median:75.00 stddev:32.81 (43.7%) stddev-sans-first:34.46 08:34:47 INFO - PID 4298 | Values: 74.0 74.0 74.0 179.0 75.0 75.0 75.0 74.0 93.0 78.0 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:82.00 stddev:23.93 (29.2%) stddev-sans-first:24.78 08:34:47 INFO - PID 4298 | Values: 82.0 82.0 130.0 82.0 82.0 82.0 130.0 81.0 82.0 134.0 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 08:34:47 INFO - PID 4298 | Values: 114.0 114.0 114.0 114.0 114.0 113.0 113.0 114.0 113.0 115.0 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 08:34:47 INFO - PID 4298 | Values: 150.0 150.0 149.0 149.0 149.0 149.0 148.0 149.0 149.0 150.0 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 08:34:47 INFO - PID 4298 | Values: 94.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.50 stddev:1.08 (1.9%) stddev-sans-first:1.13 08:34:47 INFO - PID 4298 | Values: 55.0 56.0 56.0 54.0 58.0 55.0 55.0 55.0 55.0 56.0 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:54.00 stddev:0.57 (1.1%) stddev-sans-first:0.50 08:34:47 INFO - PID 4298 | Values: 55.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 53.0 55.0 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:77.50 stddev:2.92 (3.8%) stddev-sans-first:3.10 08:34:47 INFO - PID 4298 | Values: 78.0 77.0 77.0 77.0 86.0 78.0 79.0 76.0 76.0 77.0 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:133.00 stddev:12.78 (9.6%) stddev-sans-first:13.25 08:34:47 INFO - PID 4298 | Values: 126.0 130.0 134.0 131.0 124.0 123.0 132.0 134.0 135.0 168.0 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.90 Median:189.50 stddev:6.35 (3.4%) stddev-sans-first:6.69 08:34:47 INFO - PID 4298 | Values: 189.0 182.0 186.0 197.0 185.0 190.0 178.0 194.0 190.0 178.0 08:34:47 INFO - PID 4298 | 08:34:47 INFO - PID 4298 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 08:34:47 INFO - PID 4298 | Values: 68.0 69.0 67.0 68.0 67.0 67.0 69.0 67.0 67.0 68.0 08:34:47 INFO - PID 4298 | -------- Summary: end -------- 08:34:47 INFO - PID 4298 | 08:34:48 INFO - PID 4298 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:34:48 INFO - TEST-INFO | 4298: exit 0 08:34:48 INFO - TEST-OK | kraken | took 61574ms 08:34:48 INFO - SUITE-END | took 1172s 08:34:49 INFO - Completed test suite (00:19:33) 08:34:49 INFO - javascript benchmark 08:34:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8312.258577194543, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.35102628448, 3158.9210269743253, 3161.6838316168387, 3171.3974344874478, 3203.695648913352, 5994.880102397955, 6007.819765407039, 6042.939570604292, 6064.9090263646085, 6095.451409373156, 6062.939370606293, 6075.45320921117, 6147.354527774586, 6156.0, 6165.475934545569, 5587.7485513151805, 5596.356419011825, 5649.322081350244, 5657.603967722272, 5693.975084484791, 5558.833235002957, 5573.8606534836545, 5621.522170615503, 5656.490915817576, 5720.8855822883515, 5429.212764149196, 5489.066858634042, 5496.395396506381, 5591.74837132326, 5637.182608521762, 5582.804601838957, 5605.5515558755205, 5627.521660658849, 5629.3526244482, 5646.350669672999, 5437.8368648940195, 5493.395726470085, 5568.693721845297, 5569.220309156681, 5588.804391846306, 5997.580169388145, 5998.190244317005, 6014.75940962361, 6030.457258846681, 6042.0, 6318.684065796738, 6400.39196276353, 6444.645544495051, 6448.097266382711, 6465.67671616422, 6463.1274777904855, 6469.74121035158, 6476.481881449473, 6479.6760161991715, 6486.772962946275, 5923.911141332884, 6004.789832355847, 6009.609375390585, 6023.247094113236, 6027.698615069229, 6615.17310336208, 6616.569922954993, 6617.073609694647, 6633.071370008106, 6645.0, 6276.278228003746, 6304.873902521924, 6312.842178945563, 6351.2696039956, 6356.555041147168, 6447.25856526496, 6450.290468048511, 6506.41442270198, 6575.638339891352, 6579.934200658028, 6454.9677251614385, 6467.385598368148, 6520.217573891164, 6549.279579246279, 6570.671466426659, 6332.651704156316, 6463.289038205794, 6480.0, 6576.605403675795, 6589.242237142694, 4843.176659967814, 5296.232046353257, 5300.416954135042, 5316.3354580677415, 5323.813666521731, 4554.7039442436135, 4556.863294101182, 4559.042601053816, 4577.06170235101, 4594.632429405639, 5534.0315444797, 5536.806211782568, 5611.859703507445, 5612.242347283064, 5626.409227031103, 6512.0, 6522.282548919615, 6529.15121034272, 6605.801825945229, 6634.900476492857, 5499.202615620713, 5560.972195138998, 5565.053940830068, 5565.833025009256, 5573.052581061148, 5780.884382312414, 5801.245838041028, 5801.767929282866, 5802.709864506758, 5808.099744539603, 5872.2366092408565, 6291.905621415683, 6346.11154438379, 6349.238091428966, 6378.553501254868, 6494.025896115431, 6501.934980650133, 6586.110875031809, 6596.0, 6603.834904127435, 6251.9687401562705, 6281.089242059968, 6341.556091073765, 6342.429181373698, 6379.7129129190225, 6370.044493326038, 6375.043743438521, 6380.361963803768, 6397.1363865879375, 6399.360063993563, 6504.869902601827, 6516.543841931019, 6520.119783829123, 6532.248791388861, 6538.607683539003, 6285.748570057147, 6289.7169627365965, 6295.905561416491, 6300.432961033529, 6309.968450157719, 5366.168243922199, 6251.4061164189325, 6280.27776805655, 6285.308616052322, 6300.054991751091, 6229.875402492015, 6247.937520624918, 6257.4994000480765, 6302.306746257999, 6309.211348581427, 6377.107204991212, 6381.106645069601, 6410.0, 6436.549441539048, 6462.870742585028, 6044.848878778066, 6188.81433556994, 6189.0, 6266.624002559861, 6268.749250029948], "value": 5926.694062537883, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.9779206623804, 787.5432249295409, 818.4925346285304, 838.2120806441947, 842.5829214538804, 39876.0, 40218.0, 40273.99999999996, 40438.191236175335, 40445.393319100236, 36577.81711091441, 36642.08394790125, 36739.81630091852, 36918.815405923, 37016.62983370172, 6683.2314283857495, 6699.464042876582, 6799.1840979082335, 6800.1159849219775, 6811.863762724743, 6661.93338066618, 6731.293214212511, 6782.932170678279, 6784.626845523494, 6806.319368063204, 6753.45972322213, 6755.729770809162, 6768.3908448239645, 6785.932140678604, 6789.253182149984, 6737.225219099817, 6771.322867713238, 6772.492063095238, 6775.695093720795, 6777.864442711168, 6062.0, 6073.0283154695035, 6118.571699981003, 6121.540884433685, 6127.203463549755, 33012.339753205044, 33049.50425743616, 33277.6672233277, 33325.16687082818, 33413.83293083544, 2831.6602007758993, 2922.1379692990618, 3344.4816053511745, 3392.5589673342306, 3400.0309911675054, 30288.0, 30378.088657340315, 30637.846810766026, 30668.38663226745, 30676.693233067606, 4897.902041959141, 4913.950860491385, 4935.136351138536, 4950.356453661037, 5047.671901326439, 179035.0, 179742.0, 180638.0, 187824.0, 187905.0, 46392.304115438295, 46889.5311046892, 46915.76542117268, 47187.29219061717, 47189.764051179525, 49702.50297497051, 50168.749156254715, 50205.0, 50213.0, 50253.49746502561, 15876.364945402054, 15926.920365398099, 15932.442364517186, 16013.359465621244, 16067.758983615255, 12959.222446653042, 13003.0, 13055.543055992996, 13106.934465327802, 13154.0, 14234.572962811133, 14308.642283942985, 14333.928330358282, 14423.134611923319, 14648.633784155481, 5638.323401191883, 5646.6583388493045, 5719.170720245625, 5755.568332375088, 5795.1017592273265, 1012.4937531234383, 1015.674984005126, 1022.3508072373947, 1044.3159730376615, 1047.015805143178, 22163.445913852283, 22253.888730556566, 22268.888655556617, 22884.42788930257, 23286.184983525494, 1071.3304184884448, 1085.1806885801327, 1121.428071683431, 1133.4729350851894, 1135.0862555642786, 11617.186796924303, 11834.408279585987, 11943.044556435465, 11986.820197697041, 12014.399280036137, 231832.0, 232776.0, 232810.0, 233393.0, 233523.0, 49447.25829112566, 49865.50134498681, 49875.50124498781, 49959.500404996215, 49999.0, 1474.2702362330715, 1477.5936617430077, 1497.610621238486, 1500.6398464368474, 1507.6984603079427, 21566.8921655397, 21990.45023874352, 22042.44893877666, 22213.445453773023, 26885.262289756298, 49261.753691231315, 49553.75223123861, 49706.254406183216, 49781.0, 49899.251511226634, 205359.0, 208272.0, 208348.0, 208473.0, 209933.0, 31124.533132002583, 31582.0, 31609.84195079102, 31707.365852682356, 34999.475007875415, 37263.44104838376, 37692.0, 37710.81144594259, 41542.58457415387, 42180.57819421889, 31010.844945775127, 31453.370932581678, 31760.205994849388, 32425.675743242267, 33425.66574334323, 32557.674423256412, 33731.15672108217, 33948.0, 34127.488087678204, 34578.0, 35543.82228088843, 36425.08937276589, 36878.078048049014, 37018.44472332971, 37148.44277335896, 31768.0, 32622.0, 32761.836190818893, 33055.173620658716, 33103.50344744782, 23379.298621041395, 23902.0, 23979.880100599385, 24192.758072419052, 24473.632895506937], "value": 16623.1702339344, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.4787547580748, 572.9570282228834, 574.8103125968428, 591.62136232811, 597.2564157623759, 21841.672374914368, 22545.210917617886, 22549.210777622786, 22574.887125564368, 22651.99999999996, 26065.60901586478, 26735.598966015525, 26785.33036674084, 26873.0, 26932.865335673294, 6479.481641468683, 6627.768028119017, 6632.701528431232, 6637.601743895381, 6645.0, 3863.1887303666263, 6483.481321494269, 6560.770373036945, 6569.080328753978, 6574.901376479356, 5277.815276465324, 6568.934310656904, 6592.439642630358, 6616.305287944769, 6630.436412904909, 6558.2130144382745, 6582.835429114262, 6584.5061620378665, 6607.405333519982, 6616.172978377703, 6123.693815309217, 6141.754329826802, 6158.753649854, 6166.7533298667995, 6172.043333283348, 28091.85954070237, 29939.700602993908, 29955.400891982037, 30031.699683003328, 30806.229844254074, 1916.626257879714, 1957.4812674641232, 1958.8530860185542, 1961.0292905011968, 1980.1386396917387, 18455.446336609923, 18861.90569047146, 19085.713714294296, 19116.426507204807, 19141.425757227167, 2194.473326401668, 2260.2654137405407, 2263.0834512022657, 2277.202978957368, 2389.3190440724484, 136008.0, 138494.3075284617, 140026.0, 140572.29713851467, 140841.0, 14693.55919322422, 15160.696786064216, 15223.0, 15642.279349271572, 16051.598710032342, 23691.28926132219, 23846.880765596063, 23888.880555597458, 24012.27963161108, 24169.0, 10140.543675534618, 10192.286539942133, 10328.277020608486, 10364.378137311785, 10470.581176752845, 9506.191973682176, 9550.331476796697, 9571.569279382444, 9708.660196893075, 9723.805523889483, 8695.695650652196, 9221.861672074925, 9272.0, 9481.478518681539, 9651.613935442643, 2843.5876797864194, 2916.5770963210216, 2926.195296293536, 2957.6155099836883, 2974.2897833745683, 950.6625148072472, 958.1137447860701, 960.9087136722001, 986.0780170540424, 1003.3277703938379, 19581.90209048974, 20388.184472621226, 20402.18391264333, 20490.59018819615, 20606.896965515076, 987.8863930648067, 1009.3237530854345, 1046.7958748044211, 1048.9475526223657, 1051.2588625019343, 10916.181286403551, 11038.448077596087, 11158.60944866942, 11168.776624467466, 11175.161862860155, 457116.0, 461766.0, 478178.0, 479906.0, 483713.0, 107307.0, 110589.0, 113697.43151284191, 114147.0, 114661.42669286767, 1197.1201167142144, 1222.9082818788627, 1300.8764167403892, 1305.5887395470397, 1306.1575283941995, 20365.49086272855, 21378.89310553437, 21661.133554657637, 21773.12907483683, 21936.451588709773, 56411.15383269172, 57805.13292300703, 58550.7072464635, 58892.70553647204, 60599.0, 73811.0, 75009.0, 75865.6206718963, 76038.6198069006, 76466.23533764813, 14387.496437624633, 14726.558203253919, 15002.699946001238, 15195.62010949691, 15221.238938052831, 18060.458186254433, 18256.72614910804, 23805.404864878517, 24317.635235471127, 24338.87830560836, 18542.0, 18663.44009679712, 18725.625487490448, 18860.434186974413, 19288.22847086101, 16228.51314460568, 16272.837271627606, 16997.40509082176, 17094.316227350766, 17527.649447011245, 18826.717599236297, 19417.902910485358, 19521.0, 19670.0, 19698.0, 14533.200673963034, 14680.41278348854, 14698.63253418673, 14756.557303280919, 14838.629034274229, 17718.025508596635, 18603.0, 18639.440816774975, 18683.626327473103, 18845.0], "value": 12096.010373594429, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.3625341709271, 1341.4835288413965, 1382.3917476310423, 1383.9723205535884, 1386.6048176269765, 13444.126131801439, 14053.859461405384, 14119.0, 14135.222562759043, 14176.078554893938, 13635.318234088305, 13913.095648782823, 14067.437302507913, 14068.929655351734, 14096.788548171786, 2685.3957859481607, 2760.7239276072332, 2762.557990721485, 2767.1698490452886, 2772.37621535155, 2610.2038878142157, 2669.7730692891128, 2696.5281075811754, 2696.5820297853866, 2702.6216329713857, 2251.977480225193, 2328.941776455585, 2351.623740201568, 2616.071294690386, 2683.597460380939, 2299.977000229993, 2615.6338112664243, 2730.2082396105307, 2733.8633068346503, 2738.096428178706, 2655.030913716499, 2672.906448274301, 2677.1700772760505, 2677.8794954227105, 2683.651125353711, 13537.932310338483, 13559.38982745769, 13657.726845463134, 13685.178889266675, 13709.17744935307, 7433.256674332523, 7786.1824508426935, 7832.177621349791, 7836.412269079842, 7845.1762564931005, 5202.635815492917, 5426.593005524562, 5543.334799824007, 5559.916601250984, 5585.664860108406, 1847.7690288713911, 1903.6954087345957, 1909.4844392014218, 1954.0913475233942, 1960.7941166177632, 22454.55090898189, 22721.431964200863, 22738.77261227383, 22742.772572274233, 22757.43106422353, 6433.5496515243485, 6496.772612958618, 6522.836929076716, 6600.108985287021, 6644.269130395653, 15573.377064917502, 15633.218339083, 15648.687026259411, 15652.452164174427, 15664.060156390653, 7400.407967362598, 7575.810604734926, 7576.393888489018, 7579.810504737426, 7587.0, 6871.931280687229, 6999.510034297652, 7088.964555177191, 7141.500094993301, 7178.8205294867, 4996.150654388763, 5093.312402825645, 5119.897602047939, 5162.406323272797, 5220.556252718486, 1457.9562613121623, 1483.7922690823293, 1489.2404873514586, 1508.3740247797261, 1514.4169494744383, 880.55972013993, 889.3374436045187, 909.3952521573079, 911.8768966189613, 912.1380295620575, 7034.648267586703, 7090.0, 7098.432125429953, 7105.111861017373, 7144.3570078693165, 714.9034880291094, 725.050184258623, 735.9337659610661, 739.8002539314355, 742.7957311739315, 5386.272853164773, 5484.2596249505805, 5600.60795744294, 5613.831585052455, 5635.154726790932, 18736.531586710167, 18781.7182742259, 19006.52483687891, 19007.90496047511, 19109.808901910805, 18201.180946857425, 18826.71759923602, 18848.246070157315, 18866.151023203714, 19126.808731912504, 10673.519691613896, 10680.038796508352, 10684.626038088629, 10731.248812583044, 10906.454677266105, 8202.712905048533, 8231.588420578828, 8373.246407823324, 8495.405321627426, 8590.012148602991, 15107.697846043238, 15810.209489525707, 16072.437464688679, 16179.0, 16326.673466530841, 15636.4527241546, 16942.152892355087, 17061.061641609333, 17171.65656686884, 17209.397671081453, 10190.949045255024, 10362.948185259327, 10382.0, 10389.9480502597, 10406.0, 12250.203736757083, 12343.444544995677, 12350.320732359807, 12381.195222310522, 12566.497340106293, 10347.482625868526, 10452.425116618355, 10611.0, 10658.573657053632, 10898.182636302468, 9955.701328960144, 10160.847587286344, 10212.591496340361, 10524.158067354747, 10590.576376944837, 9169.0, 9212.723618291462, 9231.0, 9258.0, 9263.953680231556, 6938.098047253825, 6943.861122777415, 6982.266861979419, 7053.153621565445, 7140.964295178491, 6955.965220174069, 7074.0, 7085.645717713991, 7101.502894797314, 7127.964360178166], "value": 6267.184293070075, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.0139245801708, 499.8578248701715, 523.2648129378223, 525.1387724132421, 528.3000024966917, 6050.576459647827, 6052.5473886267255, 6075.574709770318, 6076.422739839719, 6087.847803804907, 5855.619384739989, 5959.718660487994, 5977.910331345033, 5998.190244317016, 6054.485368743651, 4887.828925987591, 4903.803847846091, 4903.954237753849, 4934.28452874333, 4961.330220420251, 4866.756662166895, 4889.9511004889855, 4907.533784290486, 4910.288008238803, 4913.926291105637, 4780.187368147406, 4807.639427042968, 4828.155072862252, 4845.273209018657, 4912.287718280847, 4626.722396656194, 4823.855284341475, 4826.372571565709, 4838.201696720037, 4868.63678170113, 4371.562843715635, 4372.3878656988045, 4381.9561804381865, 4424.867253982386, 4432.534583868712, 5919.2009078774245, 5920.851978700523, 5920.881582368328, 5945.256842894638, 5951.49412299955, 5587.469190426903, 5605.7197140143235, 5612.466815652507, 5619.775208991636, 5647.576431767593, 6403.551751377406, 6413.16628838248, 6415.679216039226, 6437.967810160919, 6473.5366578880075, 4795.736234507101, 4804.7837847296605, 4805.5434733700595, 4817.56641902227, 4825.638077144193, 6652.800415987528, 6655.86688266232, 6744.865102697968, 6785.898211526831, 6791.388775010273, 4884.0476107159475, 4922.237053256751, 4935.7532123393685, 4953.306537084811, 5002.949970500321, 4949.455559888409, 4988.700677959334, 4998.300237966688, 5013.793930670493, 5049.368828896388, 5503.504684578407, 5520.723963801794, 5533.612647114744, 5562.276904002454, 5598.1322894951345, 6337.65142917144, 6342.809715708536, 6374.617522948638, 6483.967580162069, 6495.642739649365, 1716.7167417375992, 1737.2008875916968, 1739.1217435195144, 1746.2752957522487, 1747.1962897067237, 1112.4159816096453, 1204.7650708111835, 1215.4469716279073, 1219.3659297165425, 1231.802911534168, 5367.302250707383, 5455.208994695747, 5456.563474921997, 5579.302587176603, 5598.272224610774, 6554.737810487527, 6591.76928807499, 6611.636360000246, 6621.602703837785, 6626.204855417381, 5530.336359636789, 5571.777128914879, 5585.162225666182, 5618.381977982419, 5631.931925433555, 3396.2698019925833, 3450.7929524228125, 3470.4383027637664, 3471.8437670304897, 3489.8778542750883, 6319.399657032574, 6335.968320158369, 6383.329750376237, 6385.361463853577, 6406.8718625627225, 6711.261761206263, 6747.257801641816, 6752.898706519406, 6771.322867713189, 6779.0, 6376.202974628171, 6376.458001069868, 6453.19335083124, 6459.386358295955, 6468.870622587522, 6447.871042579216, 6481.222253329631, 6543.5419520633095, 6574.638394888136, 6587.179435927246, 6532.379423954717, 6536.398582347355, 6537.215534135934, 6546.574472659262, 6589.17635295588, 6389.4888408926245, 6393.168888044711, 6399.8080057598345, 6402.295747467868, 6408.455281300955, 4914.041761856403, 4926.482719314564, 4932.1122198004705, 4954.281629163823, 4956.677815941952, 6592.967035164794, 6626.271110177973, 6645.305447110955, 6669.199696036507, 6679.165104361955, 6356.872862542631, 6357.777477788255, 6392.584482008655, 6393.968030159819, 6435.774747883802, 6361.872762544631, 6377.649229292433, 6387.489000879826, 6391.32891046452, 6414.7434102637235, 6262.624242545279, 6278.497720182283, 6281.937180628135, 6332.525060620564, 6342.587731797418, 6375.776847810304, 6410.230772307353, 6416.0, 6464.935350646433, 6469.7412103515335, 5964.403559644001, 6234.781782637586, 6245.5628106032145, 6304.6847657617855, 6321.273053598895], "value": 4952.5745761609605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.3564868943046, 914.1681070226093, 923.3167456082501, 929.5863340813337, 930.1767935377189, 17971.730424043635, 18335.449936501893, 18378.448646540593, 18494.16776245069, 18939.337123200672, 19599.510012249702, 20502.384928452135, 21198.0, 21284.680729789066, 21514.03186856591, 1037.4034929915292, 1063.2769716592713, 1065.3661071662386, 1065.9926369580749, 1067.9626213082543, 1061.039759018086, 1061.824798908183, 1063.2185343772321, 1063.462951209638, 1064.2497039587072, 1023.7235946294496, 1063.8404239364118, 1115.8828323026087, 1124.5558004588183, 1128.949197286124, 1109.9223054386196, 1112.6105862947984, 1113.7661091170864, 1116.2967330581682, 1117.8602674665667, 791.3431851563246, 793.8055176481741, 794.6543253684608, 795.2127393880075, 795.2842441802367, 17916.28334866604, 18649.34727284552, 18912.43262702121, 19221.80778192214, 19233.03834808268, 19648.60702785936, 19680.50798730029, 20296.594068118702, 20299.492512687153, 20532.281370152123, 15325.770113448307, 15777.68444631101, 15916.20418979058, 15936.840631593652, 15985.520434386986, 3514.1566024154017, 3516.6483351664883, 3545.007397928584, 3547.7516573839844, 3551.893443196708, 101738.0, 102085.48957255167, 104621.95378046198, 105065.47467262691, 107576.0, 16208.67582648364, 16292.674146517003, 16663.50009499717, 16736.326367363166, 16883.662326753398, 27433.45133097327, 29451.558226626617, 29621.111366659035, 29681.85159074191, 29697.703022969927, 8538.487690738575, 8759.737207883774, 8774.956125219333, 8786.25316848075, 8800.47197168172, 3903.4925459690057, 3959.3269144245546, 4030.697697672628, 4034.515858097047, 4160.396742472385, 4762.809487620457, 4848.418189817245, 4858.271259311132, 4873.610111191097, 4889.706617602955, 909.1045320359441, 962.5716556132594, 971.3491960386558, 1056.8995945385177, 1084.0947808579924, 678.8336857469951, 697.2156324135348, 718.2745427118543, 720.1106633307861, 734.3280897978397, 11469.31184128955, 11956.880431195577, 12051.819222711667, 12460.937695311646, 12529.686757831127, 675.6385333846368, 706.7702996526046, 717.8959050937585, 734.3794493652855, 734.8860926556392, 5238.92141617876, 5371.75827087782, 5388.515033646991, 5443.836684899459, 5581.2186293918885, 97212.51393743127, 97824.0, 98022.0, 99695.50152249192, 101530.49234753779, 82809.58595206986, 82870.0, 83627.16372836316, 83790.58104709437, 85646.57176714076, 72145.0, 72656.63671681714, 72702.0, 75764.24235757682, 78369.0, 11102.281203836048, 11200.0, 11448.313101213955, 11488.310244909288, 11755.412229388325, 34754.652453475144, 35024.0, 35086.64913350834, 36700.0, 37490.2501949954, 58475.70762146332, 61674.69162654158, 67191.66404167948, 67221.66389168023, 67366.66316668582, 18575.53561160982, 19309.13108910074, 19321.0, 19582.0, 19605.8039419604, 18491.44525664232, 19919.402417927486, 20449.591008179457, 21045.89477052605, 21832.126714931226, 17115.914420427816, 17746.5563360917, 17833.821661783215, 18005.189766460804, 18600.162992665093, 18702.251909923452, 18930.0, 19271.51821204481, 19370.515737106685, 19380.806191938464, 14936.327865245872, 16907.91546042262, 16941.91529042347, 17389.91305043467, 17536.82463175403, 12657.936710316759, 13878.375473103533, 14024.018318717592, 14243.21662308583, 14377.993540452067, 13197.20816750998, 13539.932300338829, 13609.0, 14646.194459304841, 14692.485762998243], "value": 8916.91770919394, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 107.0, 109.0, 110.0, 110.0, 111.0, 111.0, 109.0, 109.0, 109.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 154.0, 185.0, 120.0, 156.0, 145.0, 122.0, 177.0, 124.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 161.0, 161.0, 169.0, 164.0, 166.0, 175.0, 164.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 179.0, 75.0, 75.0, 75.0, 74.0, 93.0, 78.0], "value": 87.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 130.0, 82.0, 82.0, 82.0, 130.0, 81.0, 82.0, 134.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 149.0, 149.0, 149.0, 148.0, 149.0, 149.0, 150.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 54.0, 58.0, 55.0, 55.0, 55.0, 55.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 55.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 77.0, 86.0, 78.0, 79.0, 76.0, 76.0, 77.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 130.0, 134.0, 131.0, 124.0, 123.0, 132.0, 134.0, 135.0, 168.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 182.0, 186.0, 197.0, 185.0, 190.0, 178.0, 194.0, 190.0, 178.0], "value": 186.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 68.0, 67.0, 67.0, 69.0, 67.0, 67.0, 68.0], "value": 67.7, "unit": "score"}]}]} 08:34:49 INFO - Return code: 0 08:34:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:34:49 INFO - # TBPL SUCCESS # 08:34:49 INFO - Running post-action listener: _package_coverage_data 08:34:49 INFO - Running post-action listener: _resource_record_post_action 08:34:49 INFO - [mozharness: 2017-07-16 15:34:49.247270Z] Finished run-tests step (success) 08:34:49 INFO - Running post-run listener: _resource_record_post_run 08:34:49 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 5881856; Write bytes: 443801600; Read time: 2896; Write time: 360492 08:34:49 INFO - TinderboxPrint: CPU usage
13.1% 08:34:49 INFO - TinderboxPrint: I/O read bytes / time
5,881,856 / 2,896 08:34:49 INFO - TinderboxPrint: I/O write bytes / time
443,801,600 / 360,492 08:34:49 INFO - TinderboxPrint: CPU idle
8,254.8 (86.9%) 08:34:49 INFO - TinderboxPrint: CPU user
1,195.3 (12.6%) 08:34:49 INFO - TinderboxPrint: Swap in / out
0 / 0 08:34:49 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 119996416; Read time: 0; Write time: 110164 08:34:49 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:34:49 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 3375104; Write bytes: 323805184; Read time: 1560; Write time: 250328 08:34:49 INFO - Running post-run listener: _upload_blobber_files 08:34:49 INFO - Blob upload gear active. 08:34:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:49 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 08:34:49 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'] 08:34:49 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 08:34:50 INFO - Traceback (most recent call last): 08:34:50 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 08:34:50 INFO - main() 08:34:50 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 08:34:50 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 08:34:50 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 08:34:50 INFO - return set(response.json().get('whitelist', [])) 08:34:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 08:34:50 INFO - return json.loads(self.text or self.content, **kwargs) 08:34:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 08:34:50 INFO - return _default_decoder.decode(s) 08:34:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 08:34:50 INFO - obj, end = self.raw_decode(s) 08:34:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 08:34:50 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 08:34:50 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 08:34:50 ERROR - Return code: 1 08:34:50 INFO - Setting buildbot property blobber_files to {} 08:34:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:34:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:34:50 INFO - Contents: 08:34:50 INFO - blobber_files:{} 08:34:50 INFO - Running post-run listener: copy_logs_to_upload_dir 08:34:50 INFO - Copying logs to upload dir... 08:34:50 INFO - mkdir: /builds/slave/test/build/upload/logs 08:34:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.903532 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-07-16 08:34:50.108361) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 08:34:50.113074) ========= 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=db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/OXnQqhCqRxGEYVX412N4ZQ/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 08:34:50.169097) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:34:50.172454) ========= 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=db0483c52d987ecb441a263b000001ad-1500198114.392011-547274313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004645 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:34:50.222063) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 08:34:50.225403) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 08:34:50.225714) ========= ========= Total master_lag: 0.22 =========