builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-074 starttime: 1495702677.55 results: success (0) revision: 6fae88419de6c9bf1980ef5ad1ad75471e12cc69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 01:57:57.549709) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 01:57:57.550173) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 01:57:57.550457) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 01:57:57.570918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 01:57:57.571317) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 01:57:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 86.7M=0s 2017-05-25 01:57:57 (86.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129419 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 01:57:57.713593) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 01:57:57.713900) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019622 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 01:57:57.767919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 01:57:57.768261) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6fae88419de6c9bf1980ef5ad1ad75471e12cc69 --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 6fae88419de6c9bf1980ef5ad1ad75471e12cc69 --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=23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 01:57:57,937 truncating revision to first 12 chars 2017-05-25 01:57:57,938 Setting DEBUG logging. 2017-05-25 01:57:57,938 attempt 1/10 2017-05-25 01:57:57,938 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6fae88419de6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 01:57:58,265 unpacking tar archive at: mozilla-central-6fae88419de6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662535 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 01:57:58.447320) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 01:57:58.447638) ========= script_repo_revision: 6fae88419de6c9bf1980ef5ad1ad75471e12cc69 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 01:57:58.448030) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 01:57:58.450355) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 01:57:58.461797) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-25 01:57:58.462228) ========= /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=23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:57:58 INFO - MultiFileLogger online at 20170525 01:57:58 in /builds/slave/test 01:57:58 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 01:57:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:57:58 INFO - {'append_to_log': False, 01:57:58 INFO - 'base_work_dir': '/builds/slave/test', 01:57:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 01:57:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:57:58 INFO - 'branch': 'Firefox-Non-PGO', 01:57:58 INFO - 'buildbot_json_path': 'buildprops.json', 01:57:58 INFO - 'config_files': ('talos/linux_config.py',), 01:57:58 INFO - 'default_actions': ('clobber', 01:57:58 INFO - 'read-buildbot-config', 01:57:58 INFO - 'download-and-extract', 01:57:58 INFO - 'populate-webroot', 01:57:58 INFO - 'create-virtualenv', 01:57:58 INFO - 'install', 01:57:58 INFO - 'run-tests'), 01:57:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:57:58 INFO - 'download_minidump_stackwalk': True, 01:57:58 INFO - 'download_symbols': 'ondemand', 01:57:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:57:58 INFO - 'tooltool.py': '/tools/tooltool.py', 01:57:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:57:58 INFO - '/tools/misc-python/virtualenv.py')}, 01:57:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:57:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:57:58 INFO - 'gecko_profile': False, 01:57:58 INFO - 'gecko_profile_interval': 0, 01:57:58 INFO - 'installer_path': 'installer.exe', 01:57:58 INFO - 'log_level': 'info', 01:57:58 INFO - 'log_name': 'talos', 01:57:58 INFO - 'log_to_console': True, 01:57:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:57:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:57:58 INFO - 'opt_config_files': (), 01:57:58 INFO - 'pip_index': False, 01:57:58 INFO - 'suite': 'dromaeojs-e10s', 01:57:58 INFO - 'system_bits': '32', 01:57:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:57:58 INFO - 'title': 'talos-linux64-ix-074', 01:57:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:57:58 INFO - 'use_talos_json': True, 01:57:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:57:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:57:58 INFO - 'work_dir': 'build'} 01:57:58 INFO - [mozharness: 2017-05-25 08:57:58.725209Z] Running clobber step. 01:57:58 INFO - Running pre-action listener: _resource_record_pre_action 01:57:58 INFO - Running main action method: clobber 01:57:58 INFO - rmtree: /builds/slave/test/build 01:57:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:58:00 INFO - Running post-action listener: _resource_record_post_action 01:58:00 INFO - [mozharness: 2017-05-25 08:58:00.241781Z] Finished clobber step (success) 01:58:00 INFO - [mozharness: 2017-05-25 08:58:00.241880Z] Running read-buildbot-config step. 01:58:00 INFO - Running pre-action listener: _resource_record_pre_action 01:58:00 INFO - Running main action method: read_buildbot_config 01:58:00 INFO - Using buildbot properties: 01:58:00 INFO - { 01:58:00 INFO - "project": "", 01:58:00 INFO - "product": "firefox", 01:58:00 INFO - "who": "archaeopteryx@coole-files.de", 01:58:00 INFO - "installer_path": "public/build/target.tar.bz2", 01:58:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 01:58:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 01:58:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 01:58:00 INFO - "stage_platform": "linux64", 01:58:00 INFO - "basedir": "/builds/slave/test", 01:58:00 INFO - "buildnumber": 631, 01:58:00 INFO - "platform": "ubuntu64_hw", 01:58:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:58:00 INFO - "slavebuilddir": "test", 01:58:00 INFO - "taskId": "SvS9puvvQ_GGs1LH1ueLOw", 01:58:00 INFO - "branch": "mozilla-central", 01:58:00 INFO - "script_repo_revision": "production", 01:58:00 INFO - "revision": "6fae88419de6c9bf1980ef5ad1ad75471e12cc69", 01:58:00 INFO - "slavename": "talos-linux64-ix-074", 01:58:00 INFO - "repo_path": "mozilla-central" 01:58:00 INFO - } 01:58:00 INFO - Finding installer, test and symbols from parent task. 01:58:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SvS9puvvQ_GGs1LH1ueLOw'}, attempt #1 01:58:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SvS9puvvQ_GGs1LH1ueLOw'}, attempt #1 01:58:01 INFO - Task dependencies: Kqo0NhBlRteP43dtIWCumQ 01:58:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ'}, attempt #1 01:58:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.tar.bz2 01:58:01 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/test_packages.json 01:58:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.crashreporter-symbols.zip 01:58:01 INFO - Running post-action listener: _resource_record_post_action 01:58:01 INFO - [mozharness: 2017-05-25 08:58:01.594734Z] Finished read-buildbot-config step (success) 01:58:01 INFO - [mozharness: 2017-05-25 08:58:01.594954Z] Running download-and-extract step. 01:58:01 INFO - Running pre-action listener: _resource_record_pre_action 01:58:01 INFO - Running main action method: download_and_extract 01:58:01 INFO - mkdir: /builds/slave/test/build/tests 01:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:01 INFO - trying https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.test_packages.json 01:58:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:58:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:58:02 INFO - Downloaded 989 bytes. 01:58:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:58:02 INFO - Using the following test package requirements: 01:58:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 01:58:02 INFO - u'common': [u'target.common.tests.zip'], 01:58:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:58:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:58:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:58:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:58:02 INFO - u'mozbase': [u'target.common.tests.zip'], 01:58:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:58:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:58:02 INFO - u'web-platform': [u'target.common.tests.zip', 01:58:02 INFO - u'target.web-platform.tests.tar.gz'], 01:58:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:58:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:58:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.common.tests.zip 01:58:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:58:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.common.tests.zip into memory 01:58:03 INFO - Content-Length response header: 63524935 01:58:03 INFO - Bytes received: 63524935 01:58:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:58:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.common.tests.zip 01:58:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:58:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.common.tests.zip into memory 01:58:15 INFO - Content-Length response header: 63524935 01:58:15 INFO - Bytes received: 63524935 01:58:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.talos.tests.zip 01:58:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:58:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.talos.tests.zip into memory 01:58:29 INFO - Content-Length response header: 14411859 01:58:29 INFO - Bytes received: 14411859 01:58:29 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')]} 01:58:29 INFO - trying https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.tar.bz2 01:58:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:58:30 INFO - Downloaded 53882684 bytes. 01:58:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.tar.bz2 01:58:30 INFO - mkdir: /builds/slave/test/properties 01:58:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:58:30 INFO - Writing to file /builds/slave/test/properties/build_url 01:58:30 INFO - Contents: 01:58:30 INFO - build_url:https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.tar.bz2 01:58:30 INFO - Running post-action listener: _resource_record_post_action 01:58:30 INFO - Running post-action listener: set_extra_try_arguments 01:58:30 INFO - [mozharness: 2017-05-25 08:58:30.788449Z] Finished download-and-extract step (success) 01:58:30 INFO - [mozharness: 2017-05-25 08:58:30.788547Z] Running populate-webroot step. 01:58:30 INFO - Running pre-action listener: _resource_record_pre_action 01:58:30 INFO - Running main action method: populate_webroot 01:58:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:58:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:58:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:58:30 INFO - '--tppagecycles', 01:58:30 INFO - '7'], 01:58:30 INFO - 'tests': ['tsvgm']}}, 01:58:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:58:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:58:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:58:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:58:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:58:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:58:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:58:30 INFO - 'talos_options': ['--disable-e10s'], 01:58:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:58:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:58:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:58:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:58:30 INFO - 'talos_options': ['--disable-e10s'], 01:58:30 INFO - 'tests': ['damp', 'tps']}, 01:58:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:58:30 INFO - 'tests': ['damp', 'tps']}, 01:58:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:58:30 INFO - 'tests': ['dromaeo_dom']}, 01:58:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:58:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:58:30 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 01:58:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 01:58:30 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 01:58:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 01:58:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:58:30 INFO - 'tests': ['a11yr', 01:58:30 INFO - 'ts_paint', 01:58:30 INFO - 'tpaint', 01:58:30 INFO - 'sessionrestore', 01:58:30 INFO - 'sessionrestore_no_auto_restore', 01:58:30 INFO - 'tabpaint']}, 01:58:30 INFO - 'other-e10s': {'tests': ['a11yr', 01:58:30 INFO - 'ts_paint', 01:58:30 INFO - 'tpaint', 01:58:30 INFO - 'sessionrestore', 01:58:30 INFO - 'sessionrestore_no_auto_restore', 01:58:30 INFO - 'tabpaint']}, 01:58:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:58:30 INFO - 'ts_paint', 01:58:30 INFO - 'tpaint', 01:58:30 INFO - 'sessionrestore', 01:58:30 INFO - 'sessionrestore_no_auto_restore', 01:58:30 INFO - 'tabpaint']}, 01:58:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:58:30 INFO - 'ts_paint', 01:58:30 INFO - 'tpaint', 01:58:30 INFO - 'sessionrestore', 01:58:30 INFO - 'sessionrestore_no_auto_restore', 01:58:30 INFO - 'tabpaint']}, 01:58:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:58:30 INFO - 'tests': ['a11yr', 01:58:30 INFO - 'ts_paint', 01:58:30 INFO - 'tpaint', 01:58:30 INFO - 'sessionrestore', 01:58:30 INFO - 'sessionrestore_no_auto_restore', 01:58:30 INFO - 'tabpaint']}, 01:58:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:58:30 INFO - 'tests': ['a11yr', 01:58:30 INFO - 'ts_paint', 01:58:30 INFO - 'tpaint', 01:58:30 INFO - 'sessionrestore', 01:58:30 INFO - 'sessionrestore_no_auto_restore', 01:58:30 INFO - 'tabpaint']}, 01:58:30 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 01:58:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 01:58:30 INFO - 'bloom_basic_ref']}, 01:58:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:58:30 INFO - 'tests': ['tsvgx', 01:58:30 INFO - 'tsvgr_opacity', 01:58:30 INFO - 'tart', 01:58:30 INFO - 'tscrollx', 01:58:30 INFO - 'cart', 01:58:30 INFO - 'tsvg_static']}, 01:58:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:58:30 INFO - 'tsvgr_opacity', 01:58:30 INFO - 'tart', 01:58:30 INFO - 'tscrollx', 01:58:30 INFO - 'cart', 01:58:30 INFO - 'tsvg_static']}, 01:58:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:58:30 INFO - 'talos_options': ['--disable-e10s'], 01:58:30 INFO - 'tests': ['tp5o']}, 01:58:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:58:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:58:30 INFO - 'talos_options': ['--disable-e10s', 01:58:30 INFO - '--xperf_path', 01:58:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:58:30 INFO - 'tests': ['tp5n']}, 01:58:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:58:30 INFO - 'talos_options': ['--xperf_path', 01:58:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:58:30 INFO - 'tests': ['tp5n']}}, 01:58:30 INFO - 'talos.zip': {'path': '', 01:58:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:58:30 INFO - Running post-action listener: _resource_record_post_action 01:58:30 INFO - [mozharness: 2017-05-25 08:58:30.802955Z] Finished populate-webroot step (success) 01:58:30 INFO - [mozharness: 2017-05-25 08:58:30.803044Z] Running create-virtualenv step. 01:58:30 INFO - Running pre-action listener: _resource_record_pre_action 01:58:30 INFO - Running main action method: create_virtualenv 01:58:30 INFO - Creating virtualenv /builds/slave/test/build/venv 01:58:30 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 01:58:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:58:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:58:30 INFO - Using real prefix '/usr' 01:58:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:58:31 INFO - Installing distribute.............................................................................................................................................................................................done. 01:58:33 INFO - Installing pip.................done. 01:58:33 INFO - Return code: 0 01:58:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:58:33 INFO - Reading from file tmpfile_stdout 01:58:33 INFO - Output received: 01:58:33 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) 01:58:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c445c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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 0x1c426a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42b30>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', '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 01:58:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:58:33 INFO - Using env: {'DISPLAY': ':0', 01:58:33 INFO - 'HOME': '/home/cltbld', 01:58:33 INFO - 'LANG': 'en_US.UTF-8', 01:58:33 INFO - 'LANGUAGE': 'en_US:en', 01:58:33 INFO - 'LOGNAME': 'cltbld', 01:58:33 INFO - 'MAIL': '/var/mail/cltbld', 01:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:33 INFO - 'MOZ_NO_REMOTE': '1', 01:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:33 INFO - 'NO_EM_RESTART': '1', 01:58:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:33 INFO - 'PWD': '/builds/slave/test', 01:58:33 INFO - 'SHELL': '/bin/bash', 01:58:33 INFO - 'SHLVL': '1', 01:58:33 INFO - 'TERM': 'linux', 01:58:33 INFO - 'TMOUT': '86400', 01:58:33 INFO - 'USER': 'cltbld', 01:58:33 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', 01:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:33 INFO - '_': '/tools/buildbot/bin/python'} 01:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:33 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 01:58:33 INFO - Cleaning up... 01:58:33 INFO - Return code: 0 01:58:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c445c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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 0x1c426a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42b30>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', '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 01:58:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:58:33 INFO - Using env: {'DISPLAY': ':0', 01:58:33 INFO - 'HOME': '/home/cltbld', 01:58:33 INFO - 'LANG': 'en_US.UTF-8', 01:58:33 INFO - 'LANGUAGE': 'en_US:en', 01:58:33 INFO - 'LOGNAME': 'cltbld', 01:58:33 INFO - 'MAIL': '/var/mail/cltbld', 01:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:33 INFO - 'MOZ_NO_REMOTE': '1', 01:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:33 INFO - 'NO_EM_RESTART': '1', 01:58:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:33 INFO - 'PWD': '/builds/slave/test', 01:58:33 INFO - 'SHELL': '/bin/bash', 01:58:33 INFO - 'SHLVL': '1', 01:58:33 INFO - 'TERM': 'linux', 01:58:33 INFO - 'TMOUT': '86400', 01:58:33 INFO - 'USER': 'cltbld', 01:58:33 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', 01:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:33 INFO - '_': '/tools/buildbot/bin/python'} 01:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:34 INFO - Downloading/unpacking psutil>=3.1.1 01:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:58:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:58:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:58:35 INFO - Installing collected packages: psutil 01:58:35 INFO - Running setup.py install for psutil 01:58:35 INFO - building 'psutil._psutil_linux' extension 01:58:35 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 01:58:35 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 01:58:35 INFO - building 'psutil._psutil_posix' extension 01:58:35 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 01:58:35 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 01:58:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:58:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:58:35 INFO - Successfully installed psutil 01:58:35 INFO - Cleaning up... 01:58:35 INFO - Return code: 0 01:58:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:58:35 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')]} 01:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:35 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')]} 01:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:35 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 0x18d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c445c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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 0x1c426a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42b30>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', '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 01:58:35 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 01:58:35 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 01:58:35 INFO - Using env: {'DISPLAY': ':0', 01:58:35 INFO - 'HOME': '/home/cltbld', 01:58:35 INFO - 'LANG': 'en_US.UTF-8', 01:58:35 INFO - 'LANGUAGE': 'en_US:en', 01:58:35 INFO - 'LOGNAME': 'cltbld', 01:58:35 INFO - 'MAIL': '/var/mail/cltbld', 01:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:35 INFO - 'MOZ_NO_REMOTE': '1', 01:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:35 INFO - 'NO_EM_RESTART': '1', 01:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:35 INFO - 'PWD': '/builds/slave/test', 01:58:35 INFO - 'SHELL': '/bin/bash', 01:58:35 INFO - 'SHLVL': '1', 01:58:35 INFO - 'TERM': 'linux', 01:58:35 INFO - 'TMOUT': '86400', 01:58:35 INFO - 'USER': 'cltbld', 01:58:35 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', 01:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:35 INFO - '_': '/tools/buildbot/bin/python'} 01:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:58:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:58:37 INFO - Installing collected packages: mozsystemmonitor 01:58:37 INFO - Running setup.py install for mozsystemmonitor 01:58:37 INFO - Successfully installed mozsystemmonitor 01:58:37 INFO - Cleaning up... 01:58:37 INFO - Return code: 0 01:58:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c445c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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 0x1c426a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42b30>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', '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 01:58:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:58:37 INFO - Using env: {'DISPLAY': ':0', 01:58:37 INFO - 'HOME': '/home/cltbld', 01:58:37 INFO - 'LANG': 'en_US.UTF-8', 01:58:37 INFO - 'LANGUAGE': 'en_US:en', 01:58:37 INFO - 'LOGNAME': 'cltbld', 01:58:37 INFO - 'MAIL': '/var/mail/cltbld', 01:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:37 INFO - 'MOZ_NO_REMOTE': '1', 01:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:37 INFO - 'NO_EM_RESTART': '1', 01:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:37 INFO - 'PWD': '/builds/slave/test', 01:58:37 INFO - 'SHELL': '/bin/bash', 01:58:37 INFO - 'SHLVL': '1', 01:58:37 INFO - 'TERM': 'linux', 01:58:37 INFO - 'TMOUT': '86400', 01:58:37 INFO - 'USER': 'cltbld', 01:58:37 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', 01:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:37 INFO - '_': '/tools/buildbot/bin/python'} 01:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:37 INFO - Downloading/unpacking jsonschema==2.5.1 01:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:58:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:38 INFO - Downloading functools32-3.2.3-2.tar.gz 01:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:58:38 INFO - warning: no files found matching '*.txt' 01:58:38 INFO - no previously-included directories found matching 'build' 01:58:38 INFO - no previously-included directories found matching 'dist' 01:58:38 INFO - no previously-included directories found matching '.git*' 01:58:38 INFO - Installing collected packages: jsonschema, functools32 01:58:38 INFO - Running setup.py install for functools32 01:58:38 INFO - warning: no files found matching '*.txt' 01:58:38 INFO - no previously-included directories found matching 'build' 01:58:38 INFO - no previously-included directories found matching 'dist' 01:58:38 INFO - no previously-included directories found matching '.git*' 01:58:38 INFO - Successfully installed jsonschema functools32 01:58:38 INFO - Cleaning up... 01:58:38 INFO - Return code: 0 01:58:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:58: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')]} 01:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58: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')]} 01:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58: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', '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 0x18d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c445c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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 0x1c426a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42b30>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', '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 01:58: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:58: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 functools32==3.2.3-2 01:58:38 INFO - Using env: {'DISPLAY': ':0', 01:58:38 INFO - 'HOME': '/home/cltbld', 01:58:38 INFO - 'LANG': 'en_US.UTF-8', 01:58:38 INFO - 'LANGUAGE': 'en_US:en', 01:58:38 INFO - 'LOGNAME': 'cltbld', 01:58:38 INFO - 'MAIL': '/var/mail/cltbld', 01:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:38 INFO - 'MOZ_NO_REMOTE': '1', 01:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:38 INFO - 'NO_EM_RESTART': '1', 01:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:38 INFO - 'PWD': '/builds/slave/test', 01:58:38 INFO - 'SHELL': '/bin/bash', 01:58:38 INFO - 'SHLVL': '1', 01:58:38 INFO - 'TERM': 'linux', 01:58:38 INFO - 'TMOUT': '86400', 01:58:38 INFO - 'USER': 'cltbld', 01:58:38 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', 01:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:38 INFO - '_': '/tools/buildbot/bin/python'} 01:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:58:39 INFO - Cleaning up... 01:58:39 INFO - Return code: 0 01:58:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:58: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')]} 01:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58: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')]} 01:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58: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', '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 0x18d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c445c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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 0x1c426a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42b30>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', '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 01:58: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:58: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 blobuploader==1.2.4 01:58:39 INFO - Using env: {'DISPLAY': ':0', 01:58:39 INFO - 'HOME': '/home/cltbld', 01:58:39 INFO - 'LANG': 'en_US.UTF-8', 01:58:39 INFO - 'LANGUAGE': 'en_US:en', 01:58:39 INFO - 'LOGNAME': 'cltbld', 01:58:39 INFO - 'MAIL': '/var/mail/cltbld', 01:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:39 INFO - 'MOZ_NO_REMOTE': '1', 01:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:39 INFO - 'NO_EM_RESTART': '1', 01:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:39 INFO - 'PWD': '/builds/slave/test', 01:58:39 INFO - 'SHELL': '/bin/bash', 01:58:39 INFO - 'SHLVL': '1', 01:58:39 INFO - 'TERM': 'linux', 01:58:39 INFO - 'TMOUT': '86400', 01:58:39 INFO - 'USER': 'cltbld', 01:58:39 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', 01:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:39 INFO - '_': '/tools/buildbot/bin/python'} 01:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:39 INFO - Downloading/unpacking blobuploader==1.2.4 01:58: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 01:58: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 01:58: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 01:58: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 01:58:40 INFO - Downloading blobuploader-1.2.4.tar.gz 01:58:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:58:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:58:40 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 01:58:40 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 01:58:40 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 01:58:40 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 01:58:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:58:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:58:40 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 01:58:40 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 01:58:40 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 01:58:40 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 01:58:40 INFO - Downloading docopt-0.6.1.tar.gz 01:58:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:58:41 INFO - Installing collected packages: blobuploader, requests, docopt 01:58:41 INFO - Running setup.py install for blobuploader 01:58:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:58:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:58:41 INFO - Running setup.py install for requests 01:58:41 INFO - Running setup.py install for docopt 01:58:41 INFO - Successfully installed blobuploader requests docopt 01:58:41 INFO - Cleaning up... 01:58:41 INFO - Return code: 0 01:58:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:58:41 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')]} 01:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:41 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')]} 01:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:41 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 0x18d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c445c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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 0x1c426a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42b30>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', '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 01:58:41 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 01:58:41 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 01:58:41 INFO - Using env: {'DISPLAY': ':0', 01:58:41 INFO - 'HOME': '/home/cltbld', 01:58:41 INFO - 'LANG': 'en_US.UTF-8', 01:58:41 INFO - 'LANGUAGE': 'en_US:en', 01:58:41 INFO - 'LOGNAME': 'cltbld', 01:58:41 INFO - 'MAIL': '/var/mail/cltbld', 01:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:41 INFO - 'MOZ_NO_REMOTE': '1', 01:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:41 INFO - 'NO_EM_RESTART': '1', 01:58:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:41 INFO - 'PWD': '/builds/slave/test', 01:58:41 INFO - 'SHELL': '/bin/bash', 01:58:41 INFO - 'SHLVL': '1', 01:58:41 INFO - 'TERM': 'linux', 01:58:41 INFO - 'TMOUT': '86400', 01:58:41 INFO - 'USER': 'cltbld', 01:58:41 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', 01:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:41 INFO - '_': '/tools/buildbot/bin/python'} 01:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:58:41 INFO - Running setup.py (path:/tmp/pip-wpShup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:58:41 INFO - Running setup.py (path:/tmp/pip-DxJ5g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:58:42 INFO - Running setup.py (path:/tmp/pip-SBsQdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:58:42 INFO - Running setup.py (path:/tmp/pip-42SJYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:58:42 INFO - Running setup.py (path:/tmp/pip-WdbPr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:58:42 INFO - Running setup.py (path:/tmp/pip-WY_Td3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:58:42 INFO - Running setup.py (path:/tmp/pip-ZhB6Le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:58:42 INFO - Running setup.py (path:/tmp/pip-UwrIrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:58:42 INFO - Running setup.py (path:/tmp/pip-RPoyIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:58:42 INFO - Running setup.py (path:/tmp/pip-mTFuq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:58:42 INFO - Running setup.py (path:/tmp/pip-gcIkBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:58:42 INFO - Running setup.py (path:/tmp/pip-XvI2y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:58:42 INFO - Running setup.py (path:/tmp/pip-e_hO1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:58:42 INFO - Running setup.py (path:/tmp/pip-ZCbcVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:42 INFO - Running setup.py (path:/tmp/pip-KEeV3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:58:42 INFO - Running setup.py (path:/tmp/pip-f2iyyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:58:43 INFO - Running setup.py (path:/tmp/pip-lVwEwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:58:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:58:43 INFO - Running setup.py install for manifestparser 01:58:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:58:43 INFO - Running setup.py install for mozcrash 01:58:43 INFO - Running setup.py install for mozdebug 01:58:43 INFO - Running setup.py install for mozdevice 01:58:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:58:43 INFO - Running setup.py install for mozfile 01:58:43 INFO - Running setup.py install for mozhttpd 01:58:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:58:43 INFO - Running setup.py install for mozinfo 01:58:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:58:43 INFO - Running setup.py install for mozInstall 01:58:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:58:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:58:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:58:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:58:43 INFO - Running setup.py install for mozleak 01:58:43 INFO - Running setup.py install for mozlog 01:58:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:58:44 INFO - Running setup.py install for moznetwork 01:58:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:58:44 INFO - Running setup.py install for mozprocess 01:58:44 INFO - Running setup.py install for mozprofile 01:58:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:58:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:58:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:58:44 INFO - Running setup.py install for mozrunner 01:58:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:58:44 INFO - Running setup.py install for mozscreenshot 01:58:44 INFO - Running setup.py install for moztest 01:58:44 INFO - Running setup.py install for mozversion 01:58:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:58:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:58:44 INFO - Cleaning up... 01:58:44 INFO - Return code: 0 01:58:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:44 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 0x18d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c445c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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 0x1c426a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42b30>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', '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 01:58:44 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 01:58:44 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 01:58:44 INFO - Using env: {'DISPLAY': ':0', 01:58:44 INFO - 'HOME': '/home/cltbld', 01:58:44 INFO - 'LANG': 'en_US.UTF-8', 01:58:44 INFO - 'LANGUAGE': 'en_US:en', 01:58:44 INFO - 'LOGNAME': 'cltbld', 01:58:44 INFO - 'MAIL': '/var/mail/cltbld', 01:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:44 INFO - 'MOZ_NO_REMOTE': '1', 01:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:44 INFO - 'NO_EM_RESTART': '1', 01:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:44 INFO - 'PWD': '/builds/slave/test', 01:58:44 INFO - 'SHELL': '/bin/bash', 01:58:44 INFO - 'SHLVL': '1', 01:58:44 INFO - 'TERM': 'linux', 01:58:44 INFO - 'TMOUT': '86400', 01:58:44 INFO - 'USER': 'cltbld', 01:58:44 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', 01:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:44 INFO - '_': '/tools/buildbot/bin/python'} 01:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:58:45 INFO - Running setup.py (path:/tmp/pip-YJPCoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:58:45 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)) 01:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:58:45 INFO - Running setup.py (path:/tmp/pip-ZxoEqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:58:45 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)) 01:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:58:45 INFO - Running setup.py (path:/tmp/pip-h4qQSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:58:45 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)) 01:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:58:45 INFO - Running setup.py (path:/tmp/pip-tyUrph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:58:45 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)) 01:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:58:45 INFO - Running setup.py (path:/tmp/pip-srMmme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:58:45 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)) 01:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:58:45 INFO - Running setup.py (path:/tmp/pip-WmgJdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:58:45 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)) 01:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:58:45 INFO - Running setup.py (path:/tmp/pip-TP3xif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:58:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 01:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:58:45 INFO - Running setup.py (path:/tmp/pip-3Uw3Io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:58:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 01:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:58:45 INFO - Running setup.py (path:/tmp/pip-HOzMPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:58:45 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)) 01:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:58:45 INFO - Running setup.py (path:/tmp/pip-A2BBDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:58:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 01:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:58:45 INFO - Running setup.py (path:/tmp/pip-j3dx2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:58:45 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)) 01:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:58:45 INFO - Running setup.py (path:/tmp/pip-kDfXAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:58:46 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)) 01:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:58:46 INFO - Running setup.py (path:/tmp/pip-DhDe6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:58:46 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)) 01:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:58:46 INFO - Running setup.py (path:/tmp/pip-z_sohe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:58:46 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)) 01:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:46 INFO - Running setup.py (path:/tmp/pip-Tvxa0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:46 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)) 01:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:58:46 INFO - Running setup.py (path:/tmp/pip-h_KOHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:58:46 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)) 01:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:58:46 INFO - Running setup.py (path:/tmp/pip-te4qco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:58:46 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)) 01:58:46 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)) 01:58:46 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)) 01:58:46 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)) 01:58:46 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)) 01:58:46 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)) 01:58:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:58: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 01:58: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 01:58: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 01:58: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 01:58:47 INFO - Downloading blessings-1.6.tar.gz 01:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:58:47 INFO - Installing collected packages: blessings 01:58:47 INFO - Running setup.py install for blessings 01:58:47 INFO - Successfully installed blessings 01:58:47 INFO - Cleaning up... 01:58:47 INFO - Return code: 0 01:58:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:58:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:58:47 INFO - Reading from file tmpfile_stdout 01:58:47 INFO - Current package versions: 01:58:47 INFO - argparse == 1.2.1 01:58:47 INFO - blessings == 1.6 01:58:47 INFO - blobuploader == 1.2.4 01:58:47 INFO - docopt == 0.6.1 01:58:47 INFO - functools32 == 3.2.3-2 01:58:47 INFO - jsonschema == 2.5.1 01:58:47 INFO - manifestparser == 1.1 01:58:47 INFO - mozInstall == 1.12 01:58:47 INFO - mozcrash == 1.0 01:58:47 INFO - mozdebug == 0.1 01:58:47 INFO - mozdevice == 0.51 01:58:47 INFO - mozfile == 1.2 01:58:47 INFO - mozhttpd == 0.7 01:58:47 INFO - mozinfo == 0.9 01:58:47 INFO - mozleak == 0.1 01:58:47 INFO - mozlog == 3.4 01:58:47 INFO - moznetwork == 0.27 01:58:47 INFO - mozprocess == 0.25 01:58:47 INFO - mozprofile == 0.28 01:58:47 INFO - mozrunner == 6.13 01:58:47 INFO - mozscreenshot == 0.1 01:58:47 INFO - mozsystemmonitor == 0.3 01:58:47 INFO - moztest == 0.8 01:58:47 INFO - mozversion == 1.4 01:58:47 INFO - psutil == 3.1.1 01:58:47 INFO - requests == 1.2.3 01:58:47 INFO - wsgiref == 0.1.2 01:58:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:58: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')]} 01:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58: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')]} 01:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:47 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 0x18d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c445c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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 0x1c426a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42b30>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', '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 01:58:47 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 01:58:47 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 01:58:47 INFO - Using env: {'DISPLAY': ':0', 01:58:47 INFO - 'HOME': '/home/cltbld', 01:58:47 INFO - 'LANG': 'en_US.UTF-8', 01:58:47 INFO - 'LANGUAGE': 'en_US:en', 01:58:47 INFO - 'LOGNAME': 'cltbld', 01:58:47 INFO - 'MAIL': '/var/mail/cltbld', 01:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:47 INFO - 'MOZ_NO_REMOTE': '1', 01:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:47 INFO - 'NO_EM_RESTART': '1', 01:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:47 INFO - 'PWD': '/builds/slave/test', 01:58:47 INFO - 'SHELL': '/bin/bash', 01:58:47 INFO - 'SHLVL': '1', 01:58:47 INFO - 'TERM': 'linux', 01:58:47 INFO - 'TMOUT': '86400', 01:58:47 INFO - 'USER': 'cltbld', 01:58:47 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', 01:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:47 INFO - '_': '/tools/buildbot/bin/python'} 01:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:48 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)) 01:58:48 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)) 01:58:48 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)) 01:58:48 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)) 01:58:48 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)) 01:58:48 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)) 01:58:48 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)) 01:58:48 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)) 01:58:48 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)) 01:58:48 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 01:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:49 INFO - Downloading marionette_driver-1.4.0.tar.gz 01:58:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 01:58:49 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)) 01:58:49 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)) 01:58:49 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)) 01:58:49 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)) 01:58:49 INFO - Installing collected packages: marionette-driver 01:58:49 INFO - Running setup.py install for marionette-driver 01:58:49 INFO - Successfully installed marionette-driver 01:58:49 INFO - Cleaning up... 01:58:49 INFO - Return code: 0 01:58:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c445c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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 0x1c426a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42b30>, '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': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', '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 01:58:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:58:49 INFO - Using env: {'DISPLAY': ':0', 01:58:49 INFO - 'HOME': '/home/cltbld', 01:58:49 INFO - 'LANG': 'en_US.UTF-8', 01:58:49 INFO - 'LANGUAGE': 'en_US:en', 01:58:49 INFO - 'LOGNAME': 'cltbld', 01:58:49 INFO - 'MAIL': '/var/mail/cltbld', 01:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:49 INFO - 'MOZ_NO_REMOTE': '1', 01:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:49 INFO - 'NO_EM_RESTART': '1', 01:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:49 INFO - 'PWD': '/builds/slave/test', 01:58:49 INFO - 'SHELL': '/bin/bash', 01:58:49 INFO - 'SHLVL': '1', 01:58:49 INFO - 'TERM': 'linux', 01:58:49 INFO - 'TMOUT': '86400', 01:58:49 INFO - 'USER': 'cltbld', 01:58:49 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', 01:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:49 INFO - '_': '/tools/buildbot/bin/python'} 01:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:58:49 INFO - Cleaning up... 01:58:49 INFO - Return code: 0 01:58:49 INFO - Running post-action listener: _resource_record_post_action 01:58:49 INFO - Running post-action listener: _start_resource_monitoring 01:58:49 INFO - Starting resource monitoring. 01:58:49 INFO - [mozharness: 2017-05-25 08:58:49.703231Z] Finished create-virtualenv step (success) 01:58:49 INFO - [mozharness: 2017-05-25 08:58:49.703685Z] Running install step. 01:58:49 INFO - Running pre-action listener: _resource_record_pre_action 01:58:49 INFO - Running main action method: install 01:58:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:58:49 INFO - Reading from file tmpfile_stdout 01:58:49 INFO - Detecting whether we're running mozinstall >=1.0... 01:58:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:58:50 INFO - Reading from file tmpfile_stdout 01:58:50 INFO - Output received: 01:58:50 INFO - Usage: mozinstall [options] installer 01:58:50 INFO - Options: 01:58:50 INFO - -h, --help show this help message and exit 01:58:50 INFO - -d DEST, --destination=DEST 01:58:50 INFO - Directory to install application into. [default: 01:58:50 INFO - "/builds/slave/test"] 01:58:50 INFO - --app=APP Application being installed. [default: firefox] 01:58:50 INFO - mkdir: /builds/slave/test/build/application 01:58:50 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'] 01:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:59:07 INFO - Reading from file tmpfile_stdout 01:59:07 INFO - Output received: 01:59:07 INFO - /builds/slave/test/build/application/firefox/firefox 01:59:07 INFO - Running post-action listener: _resource_record_post_action 01:59:07 INFO - [mozharness: 2017-05-25 08:59:07.008504Z] Finished install step (success) 01:59:07 INFO - [mozharness: 2017-05-25 08:59:07.008651Z] Running run-tests step. 01:59:07 INFO - Running pre-action listener: _resource_record_pre_action 01:59:07 INFO - Running main action method: run_tests 01:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:59:07 INFO - Python 2.7.3 01:59:07 INFO - Return code: 0 01:59:07 INFO - grabbing minidump binary from tooltool 01:59:07 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')]} 01:59:07 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 0x1c417a0>, '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 0x1c426a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:59:07 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 01:59:07 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 01:59:07 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 01:59:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:59:07 INFO - Return code: 0 01:59:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:59:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:59:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:59:07 INFO - ENV: RUST_BACKTRACE is now 1 01:59:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:59:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:59:07 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/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--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 01:59:07 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/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-074 --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 01:59:07 INFO - Using env: {'DISPLAY': ':0', 01:59:07 INFO - 'HOME': '/home/cltbld', 01:59:07 INFO - 'LANG': 'en_US.UTF-8', 01:59:07 INFO - 'LANGUAGE': 'en_US:en', 01:59:07 INFO - 'LOGNAME': 'cltbld', 01:59:07 INFO - 'MAIL': '/var/mail/cltbld', 01:59:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:59:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:07 INFO - 'MOZ_NO_REMOTE': '1', 01:59:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:07 INFO - 'NO_EM_RESTART': '1', 01:59:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:07 INFO - 'PWD': '/builds/slave/test', 01:59:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:59:07 INFO - 'RUST_BACKTRACE': '1', 01:59:07 INFO - 'SHELL': '/bin/bash', 01:59:07 INFO - 'SHLVL': '1', 01:59:07 INFO - 'TERM': 'linux', 01:59:07 INFO - 'TMOUT': '86400', 01:59:07 INFO - 'USER': 'cltbld', 01:59:07 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401', 01:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:07 INFO - '_': '/tools/buildbot/bin/python'} 01:59:07 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/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--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 01:59:07 INFO - mozversion application_buildid: 20170525083043 01:59:07 INFO - mozversion application_changeset: 6fae88419de6c9bf1980ef5ad1ad75471e12cc69 01:59:07 INFO - mozversion application_display_name: Nightly 01:59:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:59:07 INFO - mozversion application_name: Firefox 01:59:07 INFO - mozversion application_remotingname: firefox 01:59:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:59:07 INFO - mozversion application_vendor: Mozilla 01:59:07 INFO - mozversion application_version: 55.0a1 01:59:07 INFO - mozversion platform_buildid: 20170525083043 01:59:07 INFO - mozversion platform_changeset: 6fae88419de6c9bf1980ef5ad1ad75471e12cc69 01:59:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:59:07 INFO - mozversion platform_version: 55.0a1 01:59:07 INFO - using testdate: 1495702747 01:59:07 INFO - actual date: 1495702747 01:59:07 INFO - starting webserver on 'localhost:42052' 01:59:07 INFO - SUITE-START | Running 2 tests 01:59:07 INFO - TEST-START | dromaeo_css 01:59:07 INFO - operating with platform_type : linux_ 01:59:07 INFO - Initialising browser for dromaeo_css test... 01:59:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42052/getInfo.html -profile /tmp/tmpYRBAN3/profile 01:59:07 INFO - TEST-INFO | started process 5524 (/builds/slave/test/build/application/firefox/firefox http://localhost:42052/getInfo.html) 01:59:42 INFO - TEST-INFO | 5524: killed by SIGTERM 01:59:42 INFO - Browser initialized. 01:59:42 INFO - Running cycle 1/1 for dromaeo_css test... 01:59:42 INFO - TEST-INFO | started process 5728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYRBAN3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:59:54 INFO - PID 5728 | RSS: Main: 172662784 01:59:54 INFO - PID 5728 | 02:02:58 INFO - PID 5728 | Cycle 1(1): loaded http://localhost:42052/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42052/tests/dromaeo/cssquery-ext.html) 02:03:00 INFO - PID 5728 | RSS: Main: 171012096 02:03:00 INFO - PID 5728 | 02:06:02 INFO - PID 5728 | Cycle 1(1): loaded http://localhost:42052/tests/dromaeo/cssquery-ext.html (next: http://localhost:42052/tests/dromaeo/cssquery-jquery.html) 02:06:02 INFO - PID 5728 | RSS: Main: 178290688 02:06:02 INFO - PID 5728 | 02:09:04 INFO - PID 5728 | Cycle 1(1): loaded http://localhost:42052/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42052/tests/dromaeo/cssquery-mootools.html) 02:09:05 INFO - PID 5728 | RSS: Main: 175636480 02:09:05 INFO - PID 5728 | 02:12:06 INFO - PID 5728 | Cycle 1(1): loaded http://localhost:42052/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42052/tests/dromaeo/cssquery-prototype.html) 02:12:07 INFO - PID 5728 | RSS: Main: 179118080 02:12:07 INFO - PID 5728 | 02:15:10 INFO - PID 5728 | Cycle 1(1): loaded http://localhost:42052/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42052/tests/dromaeo/cssquery-yui.html) 02:15:10 INFO - PID 5728 | RSS: Main: 177623040 02:15:10 INFO - PID 5728 | 02:18:12 INFO - PID 5728 | Cycle 1(1): loaded http://localhost:42052/tests/dromaeo/cssquery-yui.html (next: http://localhost:42052/tests/dromaeo/cssquery-dojo.html) 02:18:12 INFO - PID 5728 | RSS: Main: 174723072 02:18:12 INFO - PID 5728 | 02:18:12 INFO - PID 5728 | __start_tp_report 02:18:12 INFO - PID 5728 | _x_x_mozilla_page_load 02:18:12 INFO - PID 5728 | _x_x_mozilla_page_load_details 02:18:12 INFO - PID 5728 | |i|pagename|runs| 02:18:12 INFO - PID 5728 | |0;dojo.html;2703.756661900429;2719.836809791414;2743.7256274372567;2756.076714300708;2763.5854621806725;5057.822976195834;5165.457626949173;5189.74051297435;5199.142141546645;5240.34495688039;5126.820561280356;5136.666116702411;5149.845504634857;5265.86835329117;5266.736663166846;4590.655700822444;4617.58441740245;4652.209124448835;4656.930146047812;4683.789229484664;4493.730376177424;4573.908521829561;4599.586037256646;4625.629949604024;4657.254839225725;4534.6825722199455;4591.678582499227;4597.2184728595885;4655.976720116411;4700.788464519105;4570.885727856797;4606.332081848147;4640.025594625133;4671.369365135697;4676.11153880765;4596.103759766846;4597.908041839178;4617.676762626617;4623.352730617717;4657.4876763555985;5154.974225128851;5185.118529849897;5198.636095473318;5198.896022079537;5233.267342572043;5497.587680923947;5547.583931205176;5559.471850174227;5560.2493663355735;5635.80274690388;5678.14827775837;5688.943110568925;5692.402297758758;5735.541156707495;5738.684372359518;5268.446813084647;5275.63070585063;5287.603429742785;5293.57651387888;5295.655782374133;5542.806001789918;5642.238297829823;5793.681347525842;5811.854703632443;5860.033094539353;5426.430224826337;5449.264349312872;5464.3442786865835;5584.385717571064;5590.776368945197;5615.185798059259;5618.157276408489;5627.352854421712;5627.971860140673;5646.350669672958;5474.644148130359;5563.721813909288;5568.526675232651;5584.106542953108;5590.580706447033;5373.301470808769;5461.371942226615;5461.563074953994;5537.446255374511;5620.241267428926;4614.930776038362;4625.028743963738;4634.745089020069;4661.813527458864;4673.696209746356;4013.7591744495426;4014.6186112319283;4042.514898212233;4058.918821623551;4064.248114098901;4646.465656449484;4695.272232803921;4782.545658162469;4803.1114243864995;4842.491538388489;5558.833235002957;5623.325200975909;5638.351589567253;5644.74598643062;5657.858553536194;4763.356946812205;4778;4780.043991201774;4784.928226076611;4816.566509014136;4821.951780482221;4944.53026962438;4947.90104197914;4961.156603377434;4998.9500104999215;5216.191490319006;5258.106121959199;5270;5300.257963885137;5322.680639161663;5428.45715428454;5628.971855140698;5670.404607516151;5680.517156041617;5684.8010319638615;5184.455632158569;5199.974000129975;5208.192730126836;5216.66091704038;5316.734163291742;5467.125259958388;5563.972180139073;5583.050881350099;5635.0702134147405;5636.436356364495;5510.6969116698965;5607.607467477401;5656.632318899258;5691.487766100905;5697.3448053474385;5427.701476418835;5466.781328746805;5479.726013699379;5512.145617429305;5527.53015993645;5477.178423236546;5502.147167189092;5503.724813759376;5505.532029777513;5511.696856672921;5365.973170134124;5428.45715428454;5429.267048948342;5432.59255555827;5478.096114141282;5373.328333958255;5434.64674796137;5455.672659640434;5456.836294911159;5519.779208831763;5317.627766056339;5320.52115309624;5362.919556206738;5414.214938833768;5419.430959749169 02:18:12 INFO - PID 5728 | |1;ext.html;618.2117799805251;680.8604236131594;695.1831597872499;1153.0890596428821;1190.2858285028979;34089.65910340899;35821.46267805985;35878.46182307264;35890.82054589724;35946.281074378494;33223.33553328932;33468;33668;33713.32573348538;33787.66212337876;6286;6392.808215753535;6629.204495460552;6732.528722989393;6765.391114799667;6768.661566921634;6819.522633415663;6855.177378714561;6873.518853680244;6885.9311406886045;6828.214755303154;6897.517173797836;6901.551399159039;6902.516823822334;6906.274841141683;6833.965830170867;6865;6869.622170780605;6893.069435626201;6894.689738961759;6676.432503237231;6706.597604143767;6718.05947167397;6718.05947167397;6732.4950628703045;31961.680383196337;31985;32163.51754723681;32258.677413225803;32365.51451728226;2962.822230666167;2994.6107006089287;3000.774941879368;3002.084364268897;3004.1137864330076;24773.5045299093;24825.5034899301;24898.751012490007;24903;24968.250952471455;2584.470183612355;2613.8693065346656;2614.4640348728467;2614.7254538273396;2623.134365659328;144463;144863;145441;155316;161651.19174404172;39673;39867.80066099651;39954;40104.79947600243;40156.397654035216;40899.97750056272;40976;40979.795101024305;40983.38524922128;41013;12945.288009159587;13001.349932503337;13019.479220831061;13020.674483137997;13100.213987160801;10568.207384446043;10611.84082238767;10675.519601617945;10675.89324106749;10701.732456688489;12473.625791226277;12548.372581370895;12551.497940082294;12588.937055314665;12729.490820367268;5325.201219817059;5358.839234822962;5404.594655400861;5421.457854214547;5464.453554644583;857.3055824781947;897.2059727141527;904.3895370624933;918.3800934369274;938.0759951447818;20720.378388648365;21462.463438414165;21551.46121346979;21560.460988475414;21586.244481443387;970.1608108985818;987.787625660472;1009.6365308488938;1011.4740335025746;1017.7048655889857;11019.669409917715;11100.223964165694;11318.773624527463;11411.657650270505;11462.083033357312;175655;176475;177192;177704;177746;40501.594984050374;40895.795521022206;40922.590774092474;41022.79488602538;41054.58945410568;1204.2533629149982;1231;1239.1635645938954;1243.7636848998661;1253.6865783554113;20230.494237644176;20236.696449552976;20821.37535873926;21078.683819742408;21586.6761998567;30174.396512070074;30261;37349.81325093357;37938;38248.808755956044;162742;163989;164030;164365;165042;30456;30469.847650761603;30496.390072197988;30591.54112688356;30849;35526;35858;36320.09199770027;36464;36534.63465365312;25997.74002260029;26943.05699300515;27254.727452726012;27681;28010.579841302806;27023.86488067547;27338.316542086606;27944.86027569849;28035.57946630843;28904.42191156123;30947;31016.379672406878;31086.68913310838;31202.843985779928;31234;26160;26788.732112678623;27181.72818271871;27685;27765;21738;22742;22977.540449190587;23014.309570712907;23289.53420931538 02:18:12 INFO - PID 5728 | |2;jquery.html;388.7550842968929;394.3611349613626;403.77792214282135;415.5145355354606;416.4274123080763;17112.91443542782;18092.63814723705;18108.366207182753;18642.813571864277;19412.22351105954;18361.357352492665;18712.064396780173;18749.343772967914;18793.342233021813;18797.436076917682;5176.50823171798;5319.441458646845;5475.425080366564;5653.265075540195;5675.659460432387;5399.83800485986;5403.405625381205;5409.107497262947;5452.536534394581;5454.61817672763;5229.581633469314;5335.279737235482;5406.107992181285;5406.972965135169;5407.161889907051;5331.840044798643;5381.0852155133525;5386.326709161355;5393.2719082923895;5415.756290966916;4866.975665121687;4891.461939186686;4897.755112244374;4899.1426500362295;4933.851984440473;21901;22024.44938876525;22438;22484;22782.658260125947;1552.6273694313397;1596.529023937941;1596.9121698306587;1601.4875239923228;1605.9759103613455;14478.058926169766;14514.637134071627;14744.483943061941;14921.626959325995;15074.849251507454;1806.1059775411256;1840.6042700819255;1854.8423384012376;1857.4241984984699;1865.7854346750162;88540;89661;91012;91653;93625.5318723402;10494.580216791242;10647.94676026615;10944.835827462595;11048.668539943814;11398.316101033965;15216.619584510476;15314.463993760388;15366.462173823862;15386.153561591142;15443.459478918185;7272.23641517633;7524.360429363565;7617.466777325534;7662.272084151997;7742.458027937991;6947.3747362737595;6969.656290241558;7091.936209568503;7146.285371462812;7170.856582868313;6931.232535703464;6958.930410695828;6962.825929351807;6975.4070903972715;7075.363217310467;1890.6691329017367;1897.3264491105735;1923.2114832918437;1957.2366776956999;2131.637621604331;835.7785186925348;861.0958493581714;891.2201823404521;906.2840356118593;907.2424525521131;16767.58081047959;16773.580660483585;16783.328666853435;17140.228689708994;17452;869.7912500999714;870.2334261449269;873.6112429968603;883.885094937654;900.8603666431713;9124.680636177702;9174.311926605531;9435;9537.2370210383;9600.375975561567;353019;359407;363253;363793.8878251455;367430;74107.25892741111;74446.62776686082;75317;75784.62107689427;78365.60817195992;1016.9694909152737;1025.6717850287985;1049.18163832211;1049.3839487189643;1059.6609085092696;14393;14673.706525869637;14691.191984440531;14764.778528321869;15332.310046048178;38043.80978095092;38902.80548597239;38910.41634375543;39387.40918886162;39559;46632.30051549162;47410.288845666655;47987.04025919392;48997.5100248993;49103.26345104898;8057.194280571896;8102.513849169069;8183.099859015384;8192.672293108448;8317.83364332722;11088.833667494833;11566.421678915853;11603.88396116028;11772.352520611448;12128.75742485163;10053.899461005296;10299.948500257751;10313.329633573794;10331;10540.051395374454;9379.34344595899;9452.149306562442;9511.714648560554;9583.616655333708;9985.950070249603;10223.182145428496;10293.845592316271;10295.455681647813;10317.071463568314;10520.684379468628;7771.378289736695;7811.960940195263;8008;8104.500667376554;8304.70933517324;9896.307258491837;10090.798184036132;10220.437875916896;10315.432651203955;10588.629397971034 02:18:12 INFO - PID 5728 | |3;mootools.html;1229.7601967616315;1271.9427625756846;1272.7454509098184;1274.7705413025656;1275.0373468031635;10034.297599168061;10498.317609355387;10546.841797373036;10563.471826408677;10860;10493.317934334264;10661.093807026413;10712.839307410375;10776.245662803607;10827.566897324117;2152.11763177097;2201.2955854126685;2205.878676672782;2207.7681843406453;2210.613142700029;2081.927132550361;2117.1743020222125;2121.533262682215;2130.2331160782105;2138.721966144399;2055.7635871874777;2119.682047692843;2123.108294516307;2130.8614940028924;2137.465633591602;2039.367795983235;2044.7750747417772;2063.329417939161;2065.607534568427;2066.937991860239;1937.5349916020195;1986.9503262418411;2047.119738512439;2165.523584811355;2175.967360489594;10200.336978096475;10397.584096636125;10437.2172087093;10437.478126093665;10446.79106417875;5424.159255315432;5646.548276137899;5697.287839020122;5700.201971723962;5712.485876271156;3019.909402717922;3112.4086423579447;3120.984395078033;3194.297254603983;3197.1207917822553;899.4917871402637;904.1681652879302;920.516728717422;927.2720914082413;931.585444477208;15280.312385942549;15343.309551070228;15475.14886681232;15493.845061549353;15513.224338783128;4429.933550996738;4519.728816271035;4591.885202869955;4631.120087183492;4641.025384669189;10857.131429485622;10892.074173695166;10893.237473376947;10895.019448249695;10913.83629245562;5300.31095957523;5448.073827449343;5492.450754924475;5502.449755024466;5503.367112782002;4974.676646017997;5118.718470484159;5123.718195499283;5134.845954621367;5138.691678499302;3651.470536772153;3688.7602305850032;3712.3132220539287;3746.606606306353;3769.5476542815036;1060.1359891688248;1061.596593294543;1067.4609322292347;1082.5886163257912;1085.831696087092;703.5391818358983;726.9382102521345;729.8722723523363;738.8226825561826;750.5159172333814;5558.888822223533;5733.88532229353;5736.196932429463;5828.154917536934;5846.766129354864;538.1604696673203;564.5229780835188;566.0744682444233;569.4419468920481;571.9685417302005;3719.776813391205;3737.5141231640255;3837.884863454101;3960.386140148282;3990.4612877261197;13209.801852972214;13273.137246078973;13513.797293040612;13557;13649.658758530917;12607.747845043048;13372.197668139943;13392.598222053353;13489.730205395837;13503.59489215325;6991.161060672752;7147.857042859114;7231.674574644154;7263.491555591164;7309.780706578811;6088.360722124113;6140.293866205265;6237.376262373727;6499.512536559682;6513.772017979348;11902.036164032837;12034.939825300817;12051.81922271149;12245;12260;12353.38233088324;12509.124361294622;12512.624621261377;12613.936930315289;12731.108822382344;7343.853122937405;7444.478886477895;7505.66224519887;7508.662110205163;7583.203763604742;9561.474118923526;9599.904000959901;9653.131218190396;9703.320767546204;9731.464769437465;7941.991346282502;8109.553974531222;8123.7156699515235;8138.593070346577;8320.791980200544;7886.211378862068;7909.9209007909185;8023.959880200561;8107.635156418093;8109.635066422144;7157.606331651601;7240.565566066053;7294.525855819355;7305.634718263959;7311.524750891175;5066.189409694432;5562.360328562106;5609.214709940693;5700;5858.414158584278;5782.190493331022;5868.2958045033165;5894.764209431574;6023.518118550418;6025.758969641341 02:18:12 INFO - PID 5728 | |4;prototype.html;325.0832651921581;343.3030947177231;344.139650872818;345.4334890779121;353.01860826901213;5407.242985981966;5438.592105592082;5466.617336786427;5490.423505531921;5502.697351645668;5376.086065368887;5376.569874410047;5378.418359187583;5383.892322153554;5386.811461598845;3835.865744698936;3945.270125026879;3953.4267531207956;3990.6607938325133;3991.7804520751347;3937.4684417603685;3958.703097267702;3966.6231707987695;3978.661813745835;3986.581408952062;3933.6853051755934;3939.330313846653;3947.934057804391;3955.4487355655583;3958.4260282259056;3826.211691811158;3906.1601755622537;3937.7046721496004;3939.074317535377;3940.4286378474962;3339.3154403347257;3376.74674399421;3386.305807309496;3402.897913062612;3404.3021180657906;5178.326817513736;5203.297554830126;5214.348206474191;5236.947630523684;5237.973810130925;4464.397306363632;4579.519150489217;4600.88497787558;4616.884577885546;4642.957098876517;5598.3282006159525;5623.044082505984;5624.3813180550105;5643.294588176478;5659.236003139565;3800.904977375588;3835.347990841564;3835.6547910688173;3837.1174629835295;3839.347310957144;5442.809501667462;5868.237129173265;5949.6727679977585;5995.130706047598;6009.57932944694;3840.519935008124;3885.203533275672;3893.688504919656;3893.824777885002;3902.726809123334;3938.291107600602;3942.211557688474;3946.1121247719607;3949;3954.4661470701085;4619.683390233768;4629.189891768927;4637.930431043537;4642.582167604932;4643.721376717408;5482.698451585121;5676.403977582295;5693.971530142323;5696.6582005079;5722.942770572325;1341.8456877459023;1355.3155656393458;1355.390074466494;1355.9288162351631;1356.3082827757914;864.7016779211162;887.0287035695902;909.2044461096541;909.8908131024319;911.3984770051734;4932.4327702314695;4945.307656928033;4946.480619534897;4963.230699241623;4966.627502937222;5847.9415205848245;5856.970715146397;5871.266091738533;5889.116632505158;5901.645901245939;4848.490908454562;4901.5588597026435;4908.631852611068;4923.87690307738;4945.629077819106;3072.3701641163507;3102.674219206996;3122.7345675617826;3124.781265311452;3126.89055883043;5499.835004949858;5500.779968801283;5509.421510741315;5509.559235261169;5524.972375138099;5784.942150578525;5876.236089308362;6020.57855950088;6032.306284777219;6036.8188954331445;5488.615796894179;5492.890142197213;5510.586705997066;5514.558835293167;5526.4749848763495;5802.622829516068;5891.3224979126235;5914.201582786269;5920.763169473173;5921.585489015728;5675.8864822704145;5775.509081727932;5789.768409263751;5812.854678633068;5837.1244313351635;5481.150421684645;5492.368377636463;5497.615166938436;5502.889942201214;5527.8894422112135;3811.466394704799;3831.233753249417;3833.4441505980917;3844.8077596119524;3848.653621173996;5851.473367396955;5868.559858010581;5884.852878678067;5902.583379988858;5928;5723.399043100415;5729.197912292366;5731.8567035824435;5735.25441692594;5737.368889422244;5535.861603459945;5654.105874532078;5657.717114144359;5721.456461636304;5739.311282646109;5620.8875822482505;5622.465865742748;5623.718814059363;5644.774209031592;5656;5550.195221692913;5719.828405147852;5731.398203188772;5734.741936612946;5779.584001919557;5458.6724796512335;5529.889402212014;5543.861403464945;5575.330960284792;5579.497845193952 02:18:12 INFO - PID 5728 | |5;yui.html;689.1936434371785;708.7377670262001;745.5340412242349;752.2853289375093;761.2045412543891;13012.869871301284;14011.649708757286;14013.859861401383;15501.534953951372;16180.919095404535;15558.766618500731;15665.686686266268;15719.899607027513;15727.921360393211;15876.52370428886;887.6848718704864;900.5947323704327;904.5115637555712;910.4446287764458;912.393258483108;903.6566104880136;909.6543313540845;911.9908800912006;912.3157631776168;912.4753266871543;915.5742579700438;940.9388389754678;948.8813898262717;953.580424613168;957.34421920984;945.2201933404934;950.5057370167543;950.6150009246267;951.5432592355708;953.9570719317647;685.2804555217052;685.5235611250183;686.2040033561045;686.2314208086974;687.2474640268897;14545.78181327281;14561.78157327641;14608.926955365156;14636.926815365856;14709.632259193499;15022.474213402587;15507.689846203013;15595.766063509056;15616.687666246726;15654.608634784108;12603;12638;12937.223766573941;12991.675208119777;13017.414216360286;3022.5466180072945;3032.651245106797;3033.135556366425;3036.817790932551;3048.7713421493477;85143;86565;87037.56481217616;87101.56449217777;88299.55850220837;12373.13388062845;12510.18683785551;12586.18189817659;12810.167339123114;12830.358482075859;20413.38759837207;20627.79372206289;21180.78819211788;21247.36257912265;21327;5526.640768350045;5586.1062230043;5611.775528978795;5628.549716022709;6358.427741503287;2998.9550156747664;3040.300730831921;3060.3726236121543;3070.7082827131385;3072.2933725242874;3337.6996070353784;3426.623071462137;3439.673231043097;3446.190145315849;3447;674.7874419557824;677.0555075669414;679.78926532775;682.5529278322607;685.2120061928722;593.2436143916541;604.5556515960766;614.4255121461448;615.3569519851766;622.2595111816923;9257.583408746623;10755.247132700635;12103.757924841453;12115.273083615011;12277.201981871329;558.8016254229772;565.3752603373296;574.6178791103953;603.6408337039454;632.9050642403677;3906.746061505993;4190.874273771792;4222.809973551198;4264.33902745075;4314.395984562164;83480;85064;86077.56961215154;86423.56788216019;88300.55849720711;69885.65057174681;70370;72017;72076.279237208;73483;59221.70389148027;60259.987000649795;60648;62392;65088.999999999054;10388;10589.099926506025;10589.417582033062;10664.146868250677;10907.727306817393;27934.44131117407;28151.155465336073;28242.43515129727;28615.283083015085;29267.707322926497;34273;34874.47688284627;35192;35299.64700352964;35330.1167470805;14012.43950241979;14174.362153702901;14194.716105678035;14433.35049922735;14447.349869255699;17004.574885627957;17041.57396065059;17096.48710538686;17119.058451785273;17156.142192890555;14459.13245205291;14633;14711.411543538567;14795.556133316019;14960.326785294905;14222.857771422154;14600.926995364955;14828.184449855362;14874.033187842755;14907.18010509389;15298.311575978885;15463.768043479582;15607.765883511984;15658.530244092695;15896.920515397349;9681.225501959685;9781.462019588991;9875.160611348116;10212;10517.579296828042;11464.140189485988;12166.57416990401;12195.390230488618;12234.75530489403;12423 02:18:12 INFO - PID 5728 | __end_tp_report 02:18:12 INFO - PID 5728 | __start_cc_report 02:18:12 INFO - PID 5728 | _x_x_mozilla_cycle_collect,344 02:18:12 INFO - PID 5728 | __end_cc_report 02:18:12 INFO - PID 5728 | __startTimestamp1495703892816__endTimestamp 02:18:12 INFO - PID 5728 | 02:18:12 INFO - PID 5728 | ------- Summary: start ------- 02:18:12 INFO - PID 5728 | Number of tests: 6 02:18:12 INFO - PID 5728 | 02:18:12 INFO - PID 5728 | [#0] dojo.html Cycles:165 Average:5126.61 Median:5300.26 stddev:602.99 (11.4%) stddev-sans-first:574.10 02:18:12 INFO - PID 5728 | Values: 2703.8 2719.8 2743.7 2756.1 2763.6 5057.8 5165.5 5189.7 5199.1 5240.3 5126.8 5136.7 5149.8 5265.9 5266.7 4590.7 4617.6 4652.2 4656.9 4683.8 4493.7 4573.9 4599.6 4625.6 4657.3 4534.7 4591.7 4597.2 4656.0 4700.8 4570.9 4606.3 4640.0 4671.4 4676.1 4596.1 4597.9 4617.7 4623.4 4657.5 5155.0 5185.1 5198.6 5198.9 5233.3 5497.6 5547.6 5559.5 5560.2 5635.8 5678.1 5688.9 5692.4 5735.5 5738.7 5268.4 5275.6 5287.6 5293.6 5295.7 5542.8 5642.2 5793.7 5811.9 5860.0 5426.4 5449.3 5464.3 5584.4 5590.8 5615.2 5618.2 5627.4 5628.0 5646.4 5474.6 5563.7 5568.5 5584.1 5590.6 5373.3 5461.4 5461.6 5537.4 5620.2 4614.9 4625.0 4634.7 4661.8 4673.7 4013.8 4014.6 4042.5 4058.9 4064.2 4646.5 4695.3 4782.5 4803.1 4842.5 5558.8 5623.3 5638.4 5644.7 5657.9 4763.4 4778.0 4780.0 4784.9 4816.6 4822.0 4944.5 4947.9 4961.2 4999.0 5216.2 5258.1 5270.0 5300.3 5322.7 5428.5 5629.0 5670.4 5680.5 5684.8 5184.5 5200.0 5208.2 5216.7 5316.7 5467.1 5564.0 5583.1 5635.1 5636.4 5510.7 5607.6 5656.6 5691.5 5697.3 5427.7 5466.8 5479.7 5512.1 5527.5 5477.2 5502.1 5503.7 5505.5 5511.7 5366.0 5428.5 5429.3 5432.6 5478.1 5373.3 5434.6 5455.7 5456.8 5519.8 5317.6 5320.5 5362.9 5414.2 5419.4 02:18:12 INFO - PID 5728 | 02:18:12 INFO - PID 5728 | [#1] ext.html Cycles:180 Average:30980.52 Median:30217.70 stddev:42362.56 (140.2%) stddev-sans-first:42420.05 02:18:12 INFO - PID 5728 | Values: 618.2 680.9 695.2 1153.1 1190.3 34089.7 35821.5 35878.5 35890.8 35946.3 33223.3 33468.0 33668.0 33713.3 33787.7 6286.0 6392.8 6629.2 6732.5 6765.4 6768.7 6819.5 6855.2 6873.5 6885.9 6828.2 6897.5 6901.6 6902.5 6906.3 6834.0 6865.0 6869.6 6893.1 6894.7 6676.4 6706.6 6718.1 6718.1 6732.5 31961.7 31985.0 32163.5 32258.7 32365.5 2962.8 2994.6 3000.8 3002.1 3004.1 24773.5 24825.5 24898.8 24903.0 24968.3 2584.5 2613.9 2614.5 2614.7 2623.1 144463.0 144863.0 145441.0 155316.0 161651.2 39673.0 39867.8 39954.0 40104.8 40156.4 40900.0 40976.0 40979.8 40983.4 41013.0 12945.3 13001.3 13019.5 13020.7 13100.2 10568.2 10611.8 10675.5 10675.9 10701.7 12473.6 12548.4 12551.5 12588.9 12729.5 5325.2 5358.8 5404.6 5421.5 5464.5 857.3 897.2 904.4 918.4 938.1 20720.4 21462.5 21551.5 21560.5 21586.2 970.2 987.8 1009.6 1011.5 1017.7 11019.7 11100.2 11318.8 11411.7 11462.1 175655.0 176475.0 177192.0 177704.0 177746.0 40501.6 40895.8 40922.6 41022.8 41054.6 1204.3 1231.0 1239.2 1243.8 1253.7 20230.5 20236.7 20821.4 21078.7 21586.7 30174.4 30261.0 37349.8 37938.0 38248.8 162742.0 163989.0 164030.0 164365.0 165042.0 30456.0 30469.8 30496.4 30591.5 30849.0 35526.0 35858.0 36320.1 36464.0 36534.6 25997.7 26943.1 27254.7 27681.0 28010.6 27023.9 27338.3 27944.9 28035.6 28904.4 30947.0 31016.4 31086.7 31202.8 31234.0 26160.0 26788.7 27181.7 27685.0 27765.0 21738.0 22742.0 22977.5 23014.3 23289.5 02:18:12 INFO - PID 5728 | 02:18:12 INFO - PID 5728 | [#2] jquery.html Cycles:180 Average:24479.31 Median:19981.39 stddev:60304.32 (301.8%) stddev-sans-first:60446.36 02:18:12 INFO - PID 5728 | Values: 388.8 394.4 403.8 415.5 416.4 17112.9 18092.6 18108.4 18642.8 19412.2 18361.4 18712.1 18749.3 18793.3 18797.4 5176.5 5319.4 5475.4 5653.3 5675.7 5399.8 5403.4 5409.1 5452.5 5454.6 5229.6 5335.3 5406.1 5407.0 5407.2 5331.8 5381.1 5386.3 5393.3 5415.8 4867.0 4891.5 4897.8 4899.1 4933.9 21901.0 22024.4 22438.0 22484.0 22782.7 1552.6 1596.5 1596.9 1601.5 1606.0 14478.1 14514.6 14744.5 14921.6 15074.8 1806.1 1840.6 1854.8 1857.4 1865.8 88540.0 89661.0 91012.0 91653.0 93625.5 10494.6 10647.9 10944.8 11048.7 11398.3 15216.6 15314.5 15366.5 15386.2 15443.5 7272.2 7524.4 7617.5 7662.3 7742.5 6947.4 6969.7 7091.9 7146.3 7170.9 6931.2 6958.9 6962.8 6975.4 7075.4 1890.7 1897.3 1923.2 1957.2 2131.6 835.8 861.1 891.2 906.3 907.2 16767.6 16773.6 16783.3 17140.2 17452.0 869.8 870.2 873.6 883.9 900.9 9124.7 9174.3 9435.0 9537.2 9600.4 353019.0 359407.0 363253.0 363793.9 367430.0 74107.3 74446.6 75317.0 75784.6 78365.6 1017.0 1025.7 1049.2 1049.4 1059.7 14393.0 14673.7 14691.2 14764.8 15332.3 38043.8 38902.8 38910.4 39387.4 39559.0 46632.3 47410.3 47987.0 48997.5 49103.3 8057.2 8102.5 8183.1 8192.7 8317.8 11088.8 11566.4 11603.9 11772.4 12128.8 10053.9 10299.9 10313.3 10331.0 10540.1 9379.3 9452.1 9511.7 9583.6 9986.0 10223.2 10293.8 10295.5 10317.1 10520.7 7771.4 7812.0 8008.0 8104.5 8304.7 9896.3 10090.8 10220.4 10315.4 10588.6 02:18:12 INFO - PID 5728 | 02:18:12 INFO - PID 5728 | [#3] mootools.html Cycles:180 Average:6305.62 Median:3758.08 stddev:4141.51 (110.2%) stddev-sans-first:4135.56 02:18:12 INFO - PID 5728 | Values: 1229.8 1271.9 1272.7 1274.8 1275.0 10034.3 10498.3 10546.8 10563.5 10860.0 10493.3 10661.1 10712.8 10776.2 10827.6 2152.1 2201.3 2205.9 2207.8 2210.6 2081.9 2117.2 2121.5 2130.2 2138.7 2055.8 2119.7 2123.1 2130.9 2137.5 2039.4 2044.8 2063.3 2065.6 2066.9 1937.5 1987.0 2047.1 2165.5 2176.0 10200.3 10397.6 10437.2 10437.5 10446.8 5424.2 5646.5 5697.3 5700.2 5712.5 3019.9 3112.4 3121.0 3194.3 3197.1 899.5 904.2 920.5 927.3 931.6 15280.3 15343.3 15475.1 15493.8 15513.2 4429.9 4519.7 4591.9 4631.1 4641.0 10857.1 10892.1 10893.2 10895.0 10913.8 5300.3 5448.1 5492.5 5502.4 5503.4 4974.7 5118.7 5123.7 5134.8 5138.7 3651.5 3688.8 3712.3 3746.6 3769.5 1060.1 1061.6 1067.5 1082.6 1085.8 703.5 726.9 729.9 738.8 750.5 5558.9 5733.9 5736.2 5828.2 5846.8 538.2 564.5 566.1 569.4 572.0 3719.8 3737.5 3837.9 3960.4 3990.5 13209.8 13273.1 13513.8 13557.0 13649.7 12607.7 13372.2 13392.6 13489.7 13503.6 6991.2 7147.9 7231.7 7263.5 7309.8 6088.4 6140.3 6237.4 6499.5 6513.8 11902.0 12034.9 12051.8 12245.0 12260.0 12353.4 12509.1 12512.6 12613.9 12731.1 7343.9 7444.5 7505.7 7508.7 7583.2 9561.5 9599.9 9653.1 9703.3 9731.5 7942.0 8109.6 8123.7 8138.6 8320.8 7886.2 7909.9 8024.0 8107.6 8109.6 7157.6 7240.6 7294.5 7305.6 7311.5 5066.2 5562.4 5609.2 5700.0 5858.4 5782.2 5868.3 5894.8 6023.5 6025.8 02:18:12 INFO - PID 5728 | 02:18:12 INFO - PID 5728 | [#4] prototype.html Cycles:180 Average:4632.48 Median:5422.92 stddev:1417.00 (26.1%) stddev-sans-first:1383.60 02:18:12 INFO - PID 5728 | Values: 325.1 343.3 344.1 345.4 353.0 5407.2 5438.6 5466.6 5490.4 5502.7 5376.1 5376.6 5378.4 5383.9 5386.8 3835.9 3945.3 3953.4 3990.7 3991.8 3937.5 3958.7 3966.6 3978.7 3986.6 3933.7 3939.3 3947.9 3955.4 3958.4 3826.2 3906.2 3937.7 3939.1 3940.4 3339.3 3376.7 3386.3 3402.9 3404.3 5178.3 5203.3 5214.3 5236.9 5238.0 4464.4 4579.5 4600.9 4616.9 4643.0 5598.3 5623.0 5624.4 5643.3 5659.2 3800.9 3835.3 3835.7 3837.1 3839.3 5442.8 5868.2 5949.7 5995.1 6009.6 3840.5 3885.2 3893.7 3893.8 3902.7 3938.3 3942.2 3946.1 3949.0 3954.5 4619.7 4629.2 4637.9 4642.6 4643.7 5482.7 5676.4 5694.0 5696.7 5722.9 1341.8 1355.3 1355.4 1355.9 1356.3 864.7 887.0 909.2 909.9 911.4 4932.4 4945.3 4946.5 4963.2 4966.6 5847.9 5857.0 5871.3 5889.1 5901.6 4848.5 4901.6 4908.6 4923.9 4945.6 3072.4 3102.7 3122.7 3124.8 3126.9 5499.8 5500.8 5509.4 5509.6 5525.0 5784.9 5876.2 6020.6 6032.3 6036.8 5488.6 5492.9 5510.6 5514.6 5526.5 5802.6 5891.3 5914.2 5920.8 5921.6 5675.9 5775.5 5789.8 5812.9 5837.1 5481.2 5492.4 5497.6 5502.9 5527.9 3811.5 3831.2 3833.4 3844.8 3848.7 5851.5 5868.6 5884.9 5902.6 5928.0 5723.4 5729.2 5731.9 5735.3 5737.4 5535.9 5654.1 5657.7 5721.5 5739.3 5620.9 5622.5 5623.7 5644.8 5656.0 5550.2 5719.8 5731.4 5734.7 5779.6 5458.7 5529.9 5543.9 5575.3 5579.5 02:18:12 INFO - PID 5728 | 02:18:12 INFO - PID 5728 | [#5] yui.html Cycles:180 Average:17299.25 Median:3205.00 stddev:22739.28 (709.5%) stddev-sans-first:22768.87 02:18:12 INFO - PID 5728 | Values: 689.2 708.7 745.5 752.3 761.2 13012.9 14011.6 14013.9 15501.5 16180.9 15558.8 15665.7 15719.9 15727.9 15876.5 887.7 900.6 904.5 910.4 912.4 903.7 909.7 912.0 912.3 912.5 915.6 940.9 948.9 953.6 957.3 945.2 950.5 950.6 951.5 954.0 685.3 685.5 686.2 686.2 687.2 14545.8 14561.8 14608.9 14636.9 14709.6 15022.5 15507.7 15595.8 15616.7 15654.6 12603.0 12638.0 12937.2 12991.7 13017.4 3022.5 3032.7 3033.1 3036.8 3048.8 85143.0 86565.0 87037.6 87101.6 88299.6 12373.1 12510.2 12586.2 12810.2 12830.4 20413.4 20627.8 21180.8 21247.4 21327.0 5526.6 5586.1 5611.8 5628.5 6358.4 2999.0 3040.3 3060.4 3070.7 3072.3 3337.7 3426.6 3439.7 3446.2 3447.0 674.8 677.1 679.8 682.6 685.2 593.2 604.6 614.4 615.4 622.3 9257.6 10755.2 12103.8 12115.3 12277.2 558.8 565.4 574.6 603.6 632.9 3906.7 4190.9 4222.8 4264.3 4314.4 83480.0 85064.0 86077.6 86423.6 88300.6 69885.7 70370.0 72017.0 72076.3 73483.0 59221.7 60260.0 60648.0 62392.0 65089.0 10388.0 10589.1 10589.4 10664.1 10907.7 27934.4 28151.2 28242.4 28615.3 29267.7 34273.0 34874.5 35192.0 35299.6 35330.1 14012.4 14174.4 14194.7 14433.4 14447.3 17004.6 17041.6 17096.5 17119.1 17156.1 14459.1 14633.0 14711.4 14795.6 14960.3 14222.9 14600.9 14828.2 14874.0 14907.2 15298.3 15463.8 15607.8 15658.5 15896.9 9681.2 9781.5 9875.2 10212.0 10517.6 11464.1 12166.6 12195.4 12234.8 12423.0 02:18:12 INFO - PID 5728 | -------- Summary: end -------- 02:18:12 INFO - PID 5728 | 02:18:13 INFO - TEST-INFO | 5728: exit 0 02:18:13 INFO - TEST-OK | dromaeo_css | took 1146249ms 02:18:13 INFO - TEST-START | kraken 02:18:13 INFO - operating with platform_type : linux_ 02:18:13 INFO - Initialising browser for kraken test... 02:18:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42052/getInfo.html -profile /tmp/tmpq53Cm9/profile 02:18:13 INFO - TEST-INFO | started process 6133 (/builds/slave/test/build/application/firefox/firefox http://localhost:42052/getInfo.html) 02:18:48 INFO - TEST-INFO | 6133: killed by SIGTERM 02:18:48 INFO - Browser initialized. 02:18:48 INFO - Running cycle 1/1 for kraken test... 02:18:48 INFO - TEST-INFO | started process 6332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq53Cm9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:19:00 INFO - PID 6332 | RSS: Main: 173293568 02:19:00 INFO - PID 6332 | 02:19:03 INFO - PID 6332 | Cycle 1(1): loaded http://localhost:42052/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42052/tests/kraken/driver.html?testName=audio-beat-detection) 02:19:04 INFO - PID 6332 | RSS: Main: 178798592 02:19:04 INFO - PID 6332 | 02:19:06 INFO - PID 6332 | Cycle 1(1): loaded http://localhost:42052/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42052/tests/kraken/driver.html?testName=audio-dft) 02:19:07 INFO - PID 6332 | RSS: Main: 178245632 02:19:07 INFO - PID 6332 | 02:19:10 INFO - PID 6332 | Cycle 1(1): loaded http://localhost:42052/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42052/tests/kraken/driver.html?testName=audio-fft) 02:19:10 INFO - PID 6332 | RSS: Main: 175538176 02:19:10 INFO - PID 6332 | 02:19:13 INFO - PID 6332 | Cycle 1(1): loaded http://localhost:42052/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42052/tests/kraken/driver.html?testName=audio-oscillator) 02:19:13 INFO - PID 6332 | RSS: Main: 175689728 02:19:13 INFO - PID 6332 | 02:19:15 INFO - PID 6332 | Cycle 1(1): loaded http://localhost:42052/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42052/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:19:16 INFO - PID 6332 | RSS: Main: 175845376 02:19:16 INFO - PID 6332 | 02:19:19 INFO - PID 6332 | Cycle 1(1): loaded http://localhost:42052/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42052/tests/kraken/driver.html?testName=imaging-darkroom) 02:19:20 INFO - PID 6332 | RSS: Main: 176918528 02:19:20 INFO - PID 6332 | 02:19:23 INFO - PID 6332 | Cycle 1(1): loaded http://localhost:42052/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42052/tests/kraken/driver.html?testName=imaging-desaturate) 02:19:24 INFO - PID 6332 | RSS: Main: 175742976 02:19:24 INFO - PID 6332 | 02:19:27 INFO - PID 6332 | Cycle 1(1): loaded http://localhost:42052/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42052/tests/kraken/driver.html?testName=json-parse-financial) 02:19:27 INFO - PID 6332 | RSS: Main: 176562176 02:19:27 INFO - PID 6332 | 02:19:29 INFO - PID 6332 | Cycle 1(1): loaded http://localhost:42052/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42052/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:19:29 INFO - PID 6332 | RSS: Main: 176586752 02:19:29 INFO - PID 6332 | 02:19:31 INFO - PID 6332 | Cycle 1(1): loaded http://localhost:42052/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42052/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:19:32 INFO - PID 6332 | RSS: Main: 176050176 02:19:32 INFO - PID 6332 | 02:19:34 INFO - PID 6332 | Cycle 1(1): loaded http://localhost:42052/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42052/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:19:35 INFO - PID 6332 | RSS: Main: 176386048 02:19:35 INFO - PID 6332 | 02:19:38 INFO - PID 6332 | Cycle 1(1): loaded http://localhost:42052/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:19:38 INFO - PID 6332 | RSS: Main: 176599040 02:19:38 INFO - PID 6332 | 02:19:41 INFO - PID 6332 | Cycle 1(1): loaded http://localhost:42052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:19:42 INFO - PID 6332 | RSS: Main: 176537600 02:19:42 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | Cycle 1(1): loaded http://localhost:42052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42052/tests/kraken/driver.html?testName=ai-astar) 02:19:44 INFO - PID 6332 | RSS: Main: 178069504 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | __start_tp_report 02:19:44 INFO - PID 6332 | _x_x_mozilla_page_load 02:19:44 INFO - PID 6332 | _x_x_mozilla_page_load_details 02:19:44 INFO - PID 6332 | |i|pagename|runs| 02:19:44 INFO - PID 6332 | |0;ai-astar;107;113;114;111;113;113;112;113;116;115 02:19:44 INFO - PID 6332 | |1;audio-beat-detection;153;125;124;161;127;124;124;123;150;126 02:19:44 INFO - PID 6332 | |2;audio-dft;169;163;164;165;173;168;167;163;164;165 02:19:44 INFO - PID 6332 | |3;audio-fft;74;75;78;110;79;75;73;73;108;76 02:19:44 INFO - PID 6332 | |4;audio-oscillator;84;83;102;84;82;84;98;83;82;101 02:19:44 INFO - PID 6332 | |5;imaging-gaussian-blur;115;115;115;115;114;114;114;115;114;114 02:19:44 INFO - PID 6332 | |6;imaging-darkroom;152;151;151;151;150;152;151;150;152;151 02:19:44 INFO - PID 6332 | |7;imaging-desaturate;95;95;94;95;94;94;95;94;94;95 02:19:44 INFO - PID 6332 | |8;json-parse-financial;55;55;54;53;56;56;56;54;55;54 02:19:44 INFO - PID 6332 | |9;json-stringify-tinderbox;57;57;57;58;58;56;56;57;57;56 02:19:44 INFO - PID 6332 | |10;stanford-crypto-aes;87;87;87;89;92;87;88;89;131;95 02:19:44 INFO - PID 6332 | |11;stanford-crypto-ccm;141;145;140;148;142;138;154;134;132;134 02:19:44 INFO - PID 6332 | |12;stanford-crypto-pbkdf2;193;197;185;195;197;193;198;199;200;202 02:19:44 INFO - PID 6332 | |13;stanford-crypto-sha256-iterative;76;79;74;79;75;76;72;73;76;73 02:19:44 INFO - PID 6332 | __end_tp_report 02:19:44 INFO - PID 6332 | __start_cc_report 02:19:44 INFO - PID 6332 | _x_x_mozilla_cycle_collect,915 02:19:44 INFO - PID 6332 | __end_cc_report 02:19:44 INFO - PID 6332 | __startTimestamp1495703984690__endTimestamp 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | ------- Summary: start ------- 02:19:44 INFO - PID 6332 | Number of tests: 14 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:2.45 (2.2%) stddev-sans-first:1.50 02:19:44 INFO - PID 6332 | Values: 107.0 113.0 114.0 111.0 113.0 113.0 112.0 113.0 116.0 115.0 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:126.50 stddev:14.76 (11.7%) stddev-sans-first:13.90 02:19:44 INFO - PID 6332 | Values: 153.0 125.0 124.0 161.0 127.0 124.0 124.0 123.0 150.0 126.0 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.00 stddev:3.18 (1.9%) stddev-sans-first:3.19 02:19:44 INFO - PID 6332 | Values: 169.0 163.0 164.0 165.0 173.0 168.0 167.0 163.0 164.0 165.0 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:14.32 (19.1%) stddev-sans-first:14.88 02:19:44 INFO - PID 6332 | Values: 74.0 75.0 78.0 110.0 79.0 75.0 73.0 73.0 108.0 76.0 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:83.50 stddev:8.39 (10.1%) stddev-sans-first:8.76 02:19:44 INFO - PID 6332 | Values: 84.0 83.0 102.0 84.0 82.0 84.0 98.0 83.0 82.0 101.0 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:115.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:19:44 INFO - PID 6332 | Values: 115.0 115.0 115.0 115.0 114.0 114.0 114.0 115.0 114.0 114.0 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 02:19:44 INFO - PID 6332 | Values: 152.0 151.0 151.0 151.0 150.0 152.0 151.0 150.0 152.0 151.0 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 02:19:44 INFO - PID 6332 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 95.0 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.03 (1.9%) stddev-sans-first:1.09 02:19:44 INFO - PID 6332 | Values: 55.0 55.0 54.0 53.0 56.0 56.0 56.0 54.0 55.0 54.0 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 02:19:44 INFO - PID 6332 | Values: 57.0 57.0 57.0 58.0 58.0 56.0 56.0 57.0 57.0 56.0 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | [#10] stanford-crypto-aes Cycles:10 Average:93.20 Median:88.50 stddev:13.54 (15.3%) stddev-sans-first:14.17 02:19:44 INFO - PID 6332 | Values: 87.0 87.0 87.0 89.0 92.0 87.0 88.0 89.0 131.0 95.0 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:141.50 stddev:6.86 (4.8%) stddev-sans-first:7.28 02:19:44 INFO - PID 6332 | Values: 141.0 145.0 140.0 148.0 142.0 138.0 154.0 134.0 132.0 134.0 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.90 Median:197.50 stddev:4.79 (2.4%) stddev-sans-first:4.97 02:19:44 INFO - PID 6332 | Values: 193.0 197.0 185.0 195.0 197.0 193.0 198.0 199.0 200.0 202.0 02:19:44 INFO - PID 6332 | 02:19:44 INFO - PID 6332 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:76.00 stddev:2.41 (3.2%) stddev-sans-first:2.54 02:19:44 INFO - PID 6332 | Values: 76.0 79.0 74.0 79.0 75.0 76.0 72.0 73.0 76.0 73.0 02:19:44 INFO - PID 6332 | -------- Summary: end -------- 02:19:44 INFO - PID 6332 | 02:19:45 INFO - TEST-INFO | 6332: exit 0 02:19:45 INFO - TEST-OK | kraken | took 92168ms 02:19:45 INFO - SUITE-END | took 1238s 02:19:45 INFO - Completed test suite (00:20:38) 02:19:45 INFO - javascript benchmark 02:19:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6674.1738662634425, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2703.756661900429, 2719.836809791414, 2743.7256274372567, 2756.076714300708, 2763.5854621806725, 5057.822976195834, 5165.457626949173, 5189.74051297435, 5199.142141546645, 5240.34495688039, 5126.820561280356, 5136.666116702411, 5149.845504634857, 5265.86835329117, 5266.736663166846, 4590.655700822444, 4617.58441740245, 4652.209124448835, 4656.930146047812, 4683.789229484664, 4493.730376177424, 4573.908521829561, 4599.586037256646, 4625.629949604024, 4657.254839225725, 4534.6825722199455, 4591.678582499227, 4597.2184728595885, 4655.976720116411, 4700.788464519105, 4570.885727856797, 4606.332081848147, 4640.025594625133, 4671.369365135697, 4676.11153880765, 4596.103759766846, 4597.908041839178, 4617.676762626617, 4623.352730617717, 4657.4876763555985, 5154.974225128851, 5185.118529849897, 5198.636095473318, 5198.896022079537, 5233.267342572043, 5497.587680923947, 5547.583931205176, 5559.471850174227, 5560.2493663355735, 5635.80274690388, 5678.14827775837, 5688.943110568925, 5692.402297758758, 5735.541156707495, 5738.684372359518, 5268.446813084647, 5275.63070585063, 5287.603429742785, 5293.57651387888, 5295.655782374133, 5542.806001789918, 5642.238297829823, 5793.681347525842, 5811.854703632443, 5860.033094539353, 5426.430224826337, 5449.264349312872, 5464.3442786865835, 5584.385717571064, 5590.776368945197, 5615.185798059259, 5618.157276408489, 5627.352854421712, 5627.971860140673, 5646.350669672958, 5474.644148130359, 5563.721813909288, 5568.526675232651, 5584.106542953108, 5590.580706447033, 5373.301470808769, 5461.371942226615, 5461.563074953994, 5537.446255374511, 5620.241267428926, 4614.930776038362, 4625.028743963738, 4634.745089020069, 4661.813527458864, 4673.696209746356, 4013.7591744495426, 4014.6186112319283, 4042.514898212233, 4058.918821623551, 4064.248114098901, 4646.465656449484, 4695.272232803921, 4782.545658162469, 4803.1114243864995, 4842.491538388489, 5558.833235002957, 5623.325200975909, 5638.351589567253, 5644.74598643062, 5657.858553536194, 4763.356946812205, 4778.0, 4780.043991201774, 4784.928226076611, 4816.566509014136, 4821.951780482221, 4944.53026962438, 4947.90104197914, 4961.156603377434, 4998.9500104999215, 5216.191490319006, 5258.106121959199, 5270.0, 5300.257963885137, 5322.680639161663, 5428.45715428454, 5628.971855140698, 5670.404607516151, 5680.517156041617, 5684.8010319638615, 5184.455632158569, 5199.974000129975, 5208.192730126836, 5216.66091704038, 5316.734163291742, 5467.125259958388, 5563.972180139073, 5583.050881350099, 5635.0702134147405, 5636.436356364495, 5510.6969116698965, 5607.607467477401, 5656.632318899258, 5691.487766100905, 5697.3448053474385, 5427.701476418835, 5466.781328746805, 5479.726013699379, 5512.145617429305, 5527.53015993645, 5477.178423236546, 5502.147167189092, 5503.724813759376, 5505.532029777513, 5511.696856672921, 5365.973170134124, 5428.45715428454, 5429.267048948342, 5432.59255555827, 5478.096114141282, 5373.328333958255, 5434.64674796137, 5455.672659640434, 5456.836294911159, 5519.779208831763, 5317.627766056339, 5320.52115309624, 5362.919556206738, 5414.214938833768, 5419.430959749169], "value": 5083.190696067045, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.2117799805251, 680.8604236131594, 695.1831597872499, 1153.0890596428821, 1190.2858285028979, 34089.65910340899, 35821.46267805985, 35878.46182307264, 35890.82054589724, 35946.281074378494, 33223.33553328932, 33468.0, 33668.0, 33713.32573348538, 33787.66212337876, 6286.0, 6392.808215753535, 6629.204495460552, 6732.528722989393, 6765.391114799667, 6768.661566921634, 6819.522633415663, 6855.177378714561, 6873.518853680244, 6885.9311406886045, 6828.214755303154, 6897.517173797836, 6901.551399159039, 6902.516823822334, 6906.274841141683, 6833.965830170867, 6865.0, 6869.622170780605, 6893.069435626201, 6894.689738961759, 6676.432503237231, 6706.597604143767, 6718.05947167397, 6718.05947167397, 6732.4950628703045, 31961.680383196337, 31985.0, 32163.51754723681, 32258.677413225803, 32365.51451728226, 2962.822230666167, 2994.6107006089287, 3000.774941879368, 3002.084364268897, 3004.1137864330076, 24773.5045299093, 24825.5034899301, 24898.751012490007, 24903.0, 24968.250952471455, 2584.470183612355, 2613.8693065346656, 2614.4640348728467, 2614.7254538273396, 2623.134365659328, 144463.0, 144863.0, 145441.0, 155316.0, 161651.19174404172, 39673.0, 39867.80066099651, 39954.0, 40104.79947600243, 40156.397654035216, 40899.97750056272, 40976.0, 40979.795101024305, 40983.38524922128, 41013.0, 12945.288009159587, 13001.349932503337, 13019.479220831061, 13020.674483137997, 13100.213987160801, 10568.207384446043, 10611.84082238767, 10675.519601617945, 10675.89324106749, 10701.732456688489, 12473.625791226277, 12548.372581370895, 12551.497940082294, 12588.937055314665, 12729.490820367268, 5325.201219817059, 5358.839234822962, 5404.594655400861, 5421.457854214547, 5464.453554644583, 857.3055824781947, 897.2059727141527, 904.3895370624933, 918.3800934369274, 938.0759951447818, 20720.378388648365, 21462.463438414165, 21551.46121346979, 21560.460988475414, 21586.244481443387, 970.1608108985818, 987.787625660472, 1009.6365308488938, 1011.4740335025746, 1017.7048655889857, 11019.669409917715, 11100.223964165694, 11318.773624527463, 11411.657650270505, 11462.083033357312, 175655.0, 176475.0, 177192.0, 177704.0, 177746.0, 40501.594984050374, 40895.795521022206, 40922.590774092474, 41022.79488602538, 41054.58945410568, 1204.2533629149982, 1231.0, 1239.1635645938954, 1243.7636848998661, 1253.6865783554113, 20230.494237644176, 20236.696449552976, 20821.37535873926, 21078.683819742408, 21586.6761998567, 30174.396512070074, 30261.0, 37349.81325093357, 37938.0, 38248.808755956044, 162742.0, 163989.0, 164030.0, 164365.0, 165042.0, 30456.0, 30469.847650761603, 30496.390072197988, 30591.54112688356, 30849.0, 35526.0, 35858.0, 36320.09199770027, 36464.0, 36534.63465365312, 25997.74002260029, 26943.05699300515, 27254.727452726012, 27681.0, 28010.579841302806, 27023.86488067547, 27338.316542086606, 27944.86027569849, 28035.57946630843, 28904.42191156123, 30947.0, 31016.379672406878, 31086.68913310838, 31202.843985779928, 31234.0, 26160.0, 26788.732112678623, 27181.72818271871, 27685.0, 27765.0, 21738.0, 22742.0, 22977.540449190587, 23014.309570712907, 23289.53420931538], "value": 14582.583284070803, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.7550842968929, 394.3611349613626, 403.77792214282135, 415.5145355354606, 416.4274123080763, 17112.91443542782, 18092.63814723705, 18108.366207182753, 18642.813571864277, 19412.22351105954, 18361.357352492665, 18712.064396780173, 18749.343772967914, 18793.342233021813, 18797.436076917682, 5176.50823171798, 5319.441458646845, 5475.425080366564, 5653.265075540195, 5675.659460432387, 5399.83800485986, 5403.405625381205, 5409.107497262947, 5452.536534394581, 5454.61817672763, 5229.581633469314, 5335.279737235482, 5406.107992181285, 5406.972965135169, 5407.161889907051, 5331.840044798643, 5381.0852155133525, 5386.326709161355, 5393.2719082923895, 5415.756290966916, 4866.975665121687, 4891.461939186686, 4897.755112244374, 4899.1426500362295, 4933.851984440473, 21901.0, 22024.44938876525, 22438.0, 22484.0, 22782.658260125947, 1552.6273694313397, 1596.529023937941, 1596.9121698306587, 1601.4875239923228, 1605.9759103613455, 14478.058926169766, 14514.637134071627, 14744.483943061941, 14921.626959325995, 15074.849251507454, 1806.1059775411256, 1840.6042700819255, 1854.8423384012376, 1857.4241984984699, 1865.7854346750162, 88540.0, 89661.0, 91012.0, 91653.0, 93625.5318723402, 10494.580216791242, 10647.94676026615, 10944.835827462595, 11048.668539943814, 11398.316101033965, 15216.619584510476, 15314.463993760388, 15366.462173823862, 15386.153561591142, 15443.459478918185, 7272.23641517633, 7524.360429363565, 7617.466777325534, 7662.272084151997, 7742.458027937991, 6947.3747362737595, 6969.656290241558, 7091.936209568503, 7146.285371462812, 7170.856582868313, 6931.232535703464, 6958.930410695828, 6962.825929351807, 6975.4070903972715, 7075.363217310467, 1890.6691329017367, 1897.3264491105735, 1923.2114832918437, 1957.2366776956999, 2131.637621604331, 835.7785186925348, 861.0958493581714, 891.2201823404521, 906.2840356118593, 907.2424525521131, 16767.58081047959, 16773.580660483585, 16783.328666853435, 17140.228689708994, 17452.0, 869.7912500999714, 870.2334261449269, 873.6112429968603, 883.885094937654, 900.8603666431713, 9124.680636177702, 9174.311926605531, 9435.0, 9537.2370210383, 9600.375975561567, 353019.0, 359407.0, 363253.0, 363793.8878251455, 367430.0, 74107.25892741111, 74446.62776686082, 75317.0, 75784.62107689427, 78365.60817195992, 1016.9694909152737, 1025.6717850287985, 1049.18163832211, 1049.3839487189643, 1059.6609085092696, 14393.0, 14673.706525869637, 14691.191984440531, 14764.778528321869, 15332.310046048178, 38043.80978095092, 38902.80548597239, 38910.41634375543, 39387.40918886162, 39559.0, 46632.30051549162, 47410.288845666655, 47987.04025919392, 48997.5100248993, 49103.26345104898, 8057.194280571896, 8102.513849169069, 8183.099859015384, 8192.672293108448, 8317.83364332722, 11088.833667494833, 11566.421678915853, 11603.88396116028, 11772.352520611448, 12128.75742485163, 10053.899461005296, 10299.948500257751, 10313.329633573794, 10331.0, 10540.051395374454, 9379.34344595899, 9452.149306562442, 9511.714648560554, 9583.616655333708, 9985.950070249603, 10223.182145428496, 10293.845592316271, 10295.455681647813, 10317.071463568314, 10520.684379468628, 7771.378289736695, 7811.960940195263, 8008.0, 8104.500667376554, 8304.70933517324, 9896.307258491837, 10090.798184036132, 10220.437875916896, 10315.432651203955, 10588.629397971034], "value": 8620.98911705077, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1229.7601967616315, 1271.9427625756846, 1272.7454509098184, 1274.7705413025656, 1275.0373468031635, 10034.297599168061, 10498.317609355387, 10546.841797373036, 10563.471826408677, 10860.0, 10493.317934334264, 10661.093807026413, 10712.839307410375, 10776.245662803607, 10827.566897324117, 2152.11763177097, 2201.2955854126685, 2205.878676672782, 2207.7681843406453, 2210.613142700029, 2081.927132550361, 2117.1743020222125, 2121.533262682215, 2130.2331160782105, 2138.721966144399, 2055.7635871874777, 2119.682047692843, 2123.108294516307, 2130.8614940028924, 2137.465633591602, 2039.367795983235, 2044.7750747417772, 2063.329417939161, 2065.607534568427, 2066.937991860239, 1937.5349916020195, 1986.9503262418411, 2047.119738512439, 2165.523584811355, 2175.967360489594, 10200.336978096475, 10397.584096636125, 10437.2172087093, 10437.478126093665, 10446.79106417875, 5424.159255315432, 5646.548276137899, 5697.287839020122, 5700.201971723962, 5712.485876271156, 3019.909402717922, 3112.4086423579447, 3120.984395078033, 3194.297254603983, 3197.1207917822553, 899.4917871402637, 904.1681652879302, 920.516728717422, 927.2720914082413, 931.585444477208, 15280.312385942549, 15343.309551070228, 15475.14886681232, 15493.845061549353, 15513.224338783128, 4429.933550996738, 4519.728816271035, 4591.885202869955, 4631.120087183492, 4641.025384669189, 10857.131429485622, 10892.074173695166, 10893.237473376947, 10895.019448249695, 10913.83629245562, 5300.31095957523, 5448.073827449343, 5492.450754924475, 5502.449755024466, 5503.367112782002, 4974.676646017997, 5118.718470484159, 5123.718195499283, 5134.845954621367, 5138.691678499302, 3651.470536772153, 3688.7602305850032, 3712.3132220539287, 3746.606606306353, 3769.5476542815036, 1060.1359891688248, 1061.596593294543, 1067.4609322292347, 1082.5886163257912, 1085.831696087092, 703.5391818358983, 726.9382102521345, 729.8722723523363, 738.8226825561826, 750.5159172333814, 5558.888822223533, 5733.88532229353, 5736.196932429463, 5828.154917536934, 5846.766129354864, 538.1604696673203, 564.5229780835188, 566.0744682444233, 569.4419468920481, 571.9685417302005, 3719.776813391205, 3737.5141231640255, 3837.884863454101, 3960.386140148282, 3990.4612877261197, 13209.801852972214, 13273.137246078973, 13513.797293040612, 13557.0, 13649.658758530917, 12607.747845043048, 13372.197668139943, 13392.598222053353, 13489.730205395837, 13503.59489215325, 6991.161060672752, 7147.857042859114, 7231.674574644154, 7263.491555591164, 7309.780706578811, 6088.360722124113, 6140.293866205265, 6237.376262373727, 6499.512536559682, 6513.772017979348, 11902.036164032837, 12034.939825300817, 12051.81922271149, 12245.0, 12260.0, 12353.38233088324, 12509.124361294622, 12512.624621261377, 12613.936930315289, 12731.108822382344, 7343.853122937405, 7444.478886477895, 7505.66224519887, 7508.662110205163, 7583.203763604742, 9561.474118923526, 9599.904000959901, 9653.131218190396, 9703.320767546204, 9731.464769437465, 7941.991346282502, 8109.553974531222, 8123.7156699515235, 8138.593070346577, 8320.791980200544, 7886.211378862068, 7909.9209007909185, 8023.959880200561, 8107.635156418093, 8109.635066422144, 7157.606331651601, 7240.565566066053, 7294.525855819355, 7305.634718263959, 7311.524750891175, 5066.189409694432, 5562.360328562106, 5609.214709940693, 5700.0, 5858.414158584278, 5782.190493331022, 5868.2958045033165, 5894.764209431574, 6023.518118550418, 6025.758969641341], "value": 4648.339717347964, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.0832651921581, 343.3030947177231, 344.139650872818, 345.4334890779121, 353.01860826901213, 5407.242985981966, 5438.592105592082, 5466.617336786427, 5490.423505531921, 5502.697351645668, 5376.086065368887, 5376.569874410047, 5378.418359187583, 5383.892322153554, 5386.811461598845, 3835.865744698936, 3945.270125026879, 3953.4267531207956, 3990.6607938325133, 3991.7804520751347, 3937.4684417603685, 3958.703097267702, 3966.6231707987695, 3978.661813745835, 3986.581408952062, 3933.6853051755934, 3939.330313846653, 3947.934057804391, 3955.4487355655583, 3958.4260282259056, 3826.211691811158, 3906.1601755622537, 3937.7046721496004, 3939.074317535377, 3940.4286378474962, 3339.3154403347257, 3376.74674399421, 3386.305807309496, 3402.897913062612, 3404.3021180657906, 5178.326817513736, 5203.297554830126, 5214.348206474191, 5236.947630523684, 5237.973810130925, 4464.397306363632, 4579.519150489217, 4600.88497787558, 4616.884577885546, 4642.957098876517, 5598.3282006159525, 5623.044082505984, 5624.3813180550105, 5643.294588176478, 5659.236003139565, 3800.904977375588, 3835.347990841564, 3835.6547910688173, 3837.1174629835295, 3839.347310957144, 5442.809501667462, 5868.237129173265, 5949.6727679977585, 5995.130706047598, 6009.57932944694, 3840.519935008124, 3885.203533275672, 3893.688504919656, 3893.824777885002, 3902.726809123334, 3938.291107600602, 3942.211557688474, 3946.1121247719607, 3949.0, 3954.4661470701085, 4619.683390233768, 4629.189891768927, 4637.930431043537, 4642.582167604932, 4643.721376717408, 5482.698451585121, 5676.403977582295, 5693.971530142323, 5696.6582005079, 5722.942770572325, 1341.8456877459023, 1355.3155656393458, 1355.390074466494, 1355.9288162351631, 1356.3082827757914, 864.7016779211162, 887.0287035695902, 909.2044461096541, 909.8908131024319, 911.3984770051734, 4932.4327702314695, 4945.307656928033, 4946.480619534897, 4963.230699241623, 4966.627502937222, 5847.9415205848245, 5856.970715146397, 5871.266091738533, 5889.116632505158, 5901.645901245939, 4848.490908454562, 4901.5588597026435, 4908.631852611068, 4923.87690307738, 4945.629077819106, 3072.3701641163507, 3102.674219206996, 3122.7345675617826, 3124.781265311452, 3126.89055883043, 5499.835004949858, 5500.779968801283, 5509.421510741315, 5509.559235261169, 5524.972375138099, 5784.942150578525, 5876.236089308362, 6020.57855950088, 6032.306284777219, 6036.8188954331445, 5488.615796894179, 5492.890142197213, 5510.586705997066, 5514.558835293167, 5526.4749848763495, 5802.622829516068, 5891.3224979126235, 5914.201582786269, 5920.763169473173, 5921.585489015728, 5675.8864822704145, 5775.509081727932, 5789.768409263751, 5812.854678633068, 5837.1244313351635, 5481.150421684645, 5492.368377636463, 5497.615166938436, 5502.889942201214, 5527.8894422112135, 3811.466394704799, 3831.233753249417, 3833.4441505980917, 3844.8077596119524, 3848.653621173996, 5851.473367396955, 5868.559858010581, 5884.852878678067, 5902.583379988858, 5928.0, 5723.399043100415, 5729.197912292366, 5731.8567035824435, 5735.25441692594, 5737.368889422244, 5535.861603459945, 5654.105874532078, 5657.717114144359, 5721.456461636304, 5739.311282646109, 5620.8875822482505, 5622.465865742748, 5623.718814059363, 5644.774209031592, 5656.0, 5550.195221692913, 5719.828405147852, 5731.398203188772, 5734.741936612946, 5779.584001919557, 5458.6724796512335, 5529.889402212014, 5543.861403464945, 5575.330960284792, 5579.497845193952], "value": 4182.836582077735, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.1936434371785, 708.7377670262001, 745.5340412242349, 752.2853289375093, 761.2045412543891, 13012.869871301284, 14011.649708757286, 14013.859861401383, 15501.534953951372, 16180.919095404535, 15558.766618500731, 15665.686686266268, 15719.899607027513, 15727.921360393211, 15876.52370428886, 887.6848718704864, 900.5947323704327, 904.5115637555712, 910.4446287764458, 912.393258483108, 903.6566104880136, 909.6543313540845, 911.9908800912006, 912.3157631776168, 912.4753266871543, 915.5742579700438, 940.9388389754678, 948.8813898262717, 953.580424613168, 957.34421920984, 945.2201933404934, 950.5057370167543, 950.6150009246267, 951.5432592355708, 953.9570719317647, 685.2804555217052, 685.5235611250183, 686.2040033561045, 686.2314208086974, 687.2474640268897, 14545.78181327281, 14561.78157327641, 14608.926955365156, 14636.926815365856, 14709.632259193499, 15022.474213402587, 15507.689846203013, 15595.766063509056, 15616.687666246726, 15654.608634784108, 12603.0, 12638.0, 12937.223766573941, 12991.675208119777, 13017.414216360286, 3022.5466180072945, 3032.651245106797, 3033.135556366425, 3036.817790932551, 3048.7713421493477, 85143.0, 86565.0, 87037.56481217616, 87101.56449217777, 88299.55850220837, 12373.13388062845, 12510.18683785551, 12586.18189817659, 12810.167339123114, 12830.358482075859, 20413.38759837207, 20627.79372206289, 21180.78819211788, 21247.36257912265, 21327.0, 5526.640768350045, 5586.1062230043, 5611.775528978795, 5628.549716022709, 6358.427741503287, 2998.9550156747664, 3040.300730831921, 3060.3726236121543, 3070.7082827131385, 3072.2933725242874, 3337.6996070353784, 3426.623071462137, 3439.673231043097, 3446.190145315849, 3447.0, 674.7874419557824, 677.0555075669414, 679.78926532775, 682.5529278322607, 685.2120061928722, 593.2436143916541, 604.5556515960766, 614.4255121461448, 615.3569519851766, 622.2595111816923, 9257.583408746623, 10755.247132700635, 12103.757924841453, 12115.273083615011, 12277.201981871329, 558.8016254229772, 565.3752603373296, 574.6178791103953, 603.6408337039454, 632.9050642403677, 3906.746061505993, 4190.874273771792, 4222.809973551198, 4264.33902745075, 4314.395984562164, 83480.0, 85064.0, 86077.56961215154, 86423.56788216019, 88300.55849720711, 69885.65057174681, 70370.0, 72017.0, 72076.279237208, 73483.0, 59221.70389148027, 60259.987000649795, 60648.0, 62392.0, 65088.999999999054, 10388.0, 10589.099926506025, 10589.417582033062, 10664.146868250677, 10907.727306817393, 27934.44131117407, 28151.155465336073, 28242.43515129727, 28615.283083015085, 29267.707322926497, 34273.0, 34874.47688284627, 35192.0, 35299.64700352964, 35330.1167470805, 14012.43950241979, 14174.362153702901, 14194.716105678035, 14433.35049922735, 14447.349869255699, 17004.574885627957, 17041.57396065059, 17096.48710538686, 17119.058451785273, 17156.142192890555, 14459.13245205291, 14633.0, 14711.411543538567, 14795.556133316019, 14960.326785294905, 14222.857771422154, 14600.926995364955, 14828.184449855362, 14874.033187842755, 14907.18010509389, 15298.311575978885, 15463.768043479582, 15607.765883511984, 15658.530244092695, 15896.920515397349, 9681.225501959685, 9781.462019588991, 9875.160611348116, 10212.0, 10517.579296828042, 11464.140189485988, 12166.57416990401, 12195.390230488618, 12234.75530489403, 12423.0], "value": 7113.034245204935, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 114.0, 111.0, 113.0, 113.0, 112.0, 113.0, 116.0, 115.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 124.0, 161.0, 127.0, 124.0, 124.0, 123.0, 150.0, 126.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 163.0, 164.0, 165.0, 173.0, 168.0, 167.0, 163.0, 164.0, 165.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 78.0, 110.0, 79.0, 75.0, 73.0, 73.0, 108.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 102.0, 84.0, 82.0, 84.0, 98.0, 83.0, 82.0, 101.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 151.0, 151.0, 150.0, 152.0, 151.0, 150.0, 152.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 53.0, 56.0, 56.0, 56.0, 54.0, 55.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 58.0, 58.0, 56.0, 56.0, 57.0, 57.0, 56.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 89.0, 92.0, 87.0, 88.0, 89.0, 131.0, 95.0], "value": 93.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 145.0, 140.0, 148.0, 142.0, 138.0, 154.0, 134.0, 132.0, 134.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 197.0, 185.0, 195.0, 197.0, 193.0, 198.0, 199.0, 200.0, 202.0], "value": 195.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 74.0, 79.0, 75.0, 76.0, 72.0, 73.0, 76.0, 73.0], "value": 75.3, "unit": "score"}]}]} 02:19:45 INFO - Return code: 0 02:19:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:19:45 INFO - # TBPL SUCCESS # 02:19:45 INFO - Running post-action listener: _resource_record_post_action 02:19:45 INFO - [mozharness: 2017-05-25 09:19:45.970559Z] Finished run-tests step (success) 02:19:45 INFO - Running post-run listener: _resource_record_post_run 02:19:46 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 589824; Write bytes: 411385856; Read time: 228; Write time: 242728 02:19:46 INFO - TinderboxPrint: CPU usage
12.8% 02:19:46 INFO - TinderboxPrint: I/O read bytes / time
589,824 / 228 02:19:46 INFO - TinderboxPrint: I/O write bytes / time
411,385,856 / 242,728 02:19:46 INFO - TinderboxPrint: CPU idle
8,746.2 (87.2%) 02:19:46 INFO - TinderboxPrint: CPU user
1,225.1 (12.2%) 02:19:46 INFO - TinderboxPrint: Swap in / out
0 / 0 02:19:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108167168; Read time: 60; Write time: 70380 02:19:46 INFO - run-tests - Wall time: 1239s; CPU: 13.0%; Read bytes: 581632; Write bytes: 303218688; Read time: 148; Write time: 172348 02:19:46 INFO - Running post-run listener: _upload_blobber_files 02:19:46 INFO - Blob upload gear active. 02:19:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:19:46 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 02:19:46 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'] 02:19:46 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 02:19:47 INFO - (blobuploader) - INFO - Open directory for files ... 02:19:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:19:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:19:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:19:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:19:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:19:53 INFO - (blobuploader) - INFO - Done attempting. 02:19:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:19:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:19:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:19:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:19:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:19:54 INFO - (blobuploader) - INFO - Done attempting. 02:19:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:19:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:19:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:19:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:19:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:19:55 INFO - (blobuploader) - INFO - Done attempting. 02:19:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:19:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:19:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:19:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:19:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:19:56 INFO - (blobuploader) - INFO - Done attempting. 02:19:56 INFO - (blobuploader) - INFO - Iteration through files over. 02:19:56 INFO - Return code: 0 02:19:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:19:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:19:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f40022727aaf74747bf179a18887d4fd01011832be14b02850d834aaaa825bddde556f4ad9735bc8f4459255f6b77155bf14fa83f50d63b5f2609466129b052", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e447038507dad12ddec4b2b8a48a84e3e5c2d07a7eb3993c39c69695f142ccd45e738f4f6fde8faba2a9f8d713a5ccc124d1a5b94d9d937c7949123538529044", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f022d7375af4b1993ae570182723fe4b2df276b5dbda08411338129b9970185d49142490dad9c00352dadf7e38821f9502f39f8210d6f5f3af057b4d8c419fbd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48ff7d10bbb88cca30dea7e7e16b0afaea01ff01ebbddd9b8c23798a4fcb5b2e92ec64e6559025fd43564bc7bd633c7d22d5a1281e886b4024cb523b245d0670"} 02:19:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:19:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:19:56 INFO - Contents: 02:19:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f40022727aaf74747bf179a18887d4fd01011832be14b02850d834aaaa825bddde556f4ad9735bc8f4459255f6b77155bf14fa83f50d63b5f2609466129b052", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e447038507dad12ddec4b2b8a48a84e3e5c2d07a7eb3993c39c69695f142ccd45e738f4f6fde8faba2a9f8d713a5ccc124d1a5b94d9d937c7949123538529044", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f022d7375af4b1993ae570182723fe4b2df276b5dbda08411338129b9970185d49142490dad9c00352dadf7e38821f9502f39f8210d6f5f3af057b4d8c419fbd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48ff7d10bbb88cca30dea7e7e16b0afaea01ff01ebbddd9b8c23798a4fcb5b2e92ec64e6559025fd43564bc7bd633c7d22d5a1281e886b4024cb523b245d0670"} 02:19:56 INFO - Running post-run listener: copy_logs_to_upload_dir 02:19:56 INFO - Copying logs to upload dir... 02:19:56 INFO - mkdir: /builds/slave/test/build/upload/logs 02:19:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.915060 ========= master_lag: -0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-25 02:19:56.347171) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 02:19:56.351570) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f40022727aaf74747bf179a18887d4fd01011832be14b02850d834aaaa825bddde556f4ad9735bc8f4459255f6b77155bf14fa83f50d63b5f2609466129b052", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e447038507dad12ddec4b2b8a48a84e3e5c2d07a7eb3993c39c69695f142ccd45e738f4f6fde8faba2a9f8d713a5ccc124d1a5b94d9d937c7949123538529044", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f022d7375af4b1993ae570182723fe4b2df276b5dbda08411338129b9970185d49142490dad9c00352dadf7e38821f9502f39f8210d6f5f3af057b4d8c419fbd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48ff7d10bbb88cca30dea7e7e16b0afaea01ff01ebbddd9b8c23798a4fcb5b2e92ec64e6559025fd43564bc7bd633c7d22d5a1281e886b4024cb523b245d0670"} build_url:https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/Kqo0NhBlRteP43dtIWCumQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f40022727aaf74747bf179a18887d4fd01011832be14b02850d834aaaa825bddde556f4ad9735bc8f4459255f6b77155bf14fa83f50d63b5f2609466129b052", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e447038507dad12ddec4b2b8a48a84e3e5c2d07a7eb3993c39c69695f142ccd45e738f4f6fde8faba2a9f8d713a5ccc124d1a5b94d9d937c7949123538529044", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f022d7375af4b1993ae570182723fe4b2df276b5dbda08411338129b9970185d49142490dad9c00352dadf7e38821f9502f39f8210d6f5f3af057b4d8c419fbd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48ff7d10bbb88cca30dea7e7e16b0afaea01ff01ebbddd9b8c23798a4fcb5b2e92ec64e6559025fd43564bc7bd633c7d22d5a1281e886b4024cb523b245d0670"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 02:19:56.378642) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 02:19:56.379130) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1495699479.991040-1319820401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 02:19:56.458937) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 02:19:56.462297) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 02:19:56.462610) ========= ========= Total master_lag: 0.12 =========