builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-009 starttime: 1494780621.73 results: success (0) revision: 626efff0df630961981fc6875571fe05725f3636 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-14 09:50:21.729755) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-14 09:50:21.730194) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-14 09:50:21.730475) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-14 09:50:21.744945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 09:50:21.745205) ========= 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=17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-14 09:50:22-- 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% 42.7M=0s 2017-05-14 09:50:22 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159744 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 09:50:21.918527) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 09:50:21.918823) ========= 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=17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018684 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 09:50:21.971066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-14 09:50:21.974417) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 626efff0df630961981fc6875571fe05725f3636 --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 626efff0df630961981fc6875571fe05725f3636 --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=17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-14 09:50:22,849 truncating revision to first 12 chars 2017-05-14 09:50:22,850 Setting DEBUG logging. 2017-05-14 09:50:22,850 attempt 1/10 2017-05-14 09:50:22,850 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/626efff0df63?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-14 09:50:23,715 unpacking tar archive at: mozilla-central-626efff0df63/testing/mozharness/ program finished with exit code 0 elapsedTime=1.190880 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-14 09:50:23.181757) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-14 09:50:23.182063) ========= script_repo_revision: 626efff0df630961981fc6875571fe05725f3636 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-14 09:50:23.182433) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-14 09:50:23.182694) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-14 09:50:23.192484) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-14 09:50:23.192869) ========= /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=17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:50:24 INFO - MultiFileLogger online at 20170514 09:50:24 in /builds/slave/test 09:50:24 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 09:50:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:50:24 INFO - {'append_to_log': False, 09:50:24 INFO - 'base_work_dir': '/builds/slave/test', 09:50:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:50:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:50:24 INFO - 'branch': 'Firefox-Non-PGO', 09:50:24 INFO - 'buildbot_json_path': 'buildprops.json', 09:50:24 INFO - 'config_files': ('talos/linux_config.py',), 09:50:24 INFO - 'default_actions': ('clobber', 09:50:24 INFO - 'read-buildbot-config', 09:50:24 INFO - 'download-and-extract', 09:50:24 INFO - 'populate-webroot', 09:50:24 INFO - 'create-virtualenv', 09:50:24 INFO - 'install', 09:50:24 INFO - 'run-tests'), 09:50:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:50:24 INFO - 'download_minidump_stackwalk': True, 09:50:24 INFO - 'download_symbols': 'ondemand', 09:50:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:50:24 INFO - 'tooltool.py': '/tools/tooltool.py', 09:50:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:50:24 INFO - '/tools/misc-python/virtualenv.py')}, 09:50:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:50:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:50:24 INFO - 'gecko_profile': False, 09:50:24 INFO - 'gecko_profile_interval': 0, 09:50:24 INFO - 'installer_path': 'installer.exe', 09:50:24 INFO - 'log_level': 'info', 09:50:24 INFO - 'log_name': 'talos', 09:50:24 INFO - 'log_to_console': True, 09:50:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:50:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:50:24 INFO - 'opt_config_files': (), 09:50:24 INFO - 'pip_index': False, 09:50:24 INFO - 'suite': 'dromaeojs-e10s', 09:50:24 INFO - 'system_bits': '32', 09:50:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:50:24 INFO - 'title': 'talos-linux64-ix-009', 09:50:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:50:24 INFO - 'use_talos_json': True, 09:50:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:50:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:50:24 INFO - 'work_dir': 'build'} 09:50:24 INFO - [mozharness: 2017-05-14 16:50:24.172472Z] Running clobber step. 09:50:24 INFO - Running pre-action listener: _resource_record_pre_action 09:50:24 INFO - Running main action method: clobber 09:50:24 INFO - rmtree: /builds/slave/test/build 09:50:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:50:25 INFO - Running post-action listener: _resource_record_post_action 09:50:25 INFO - [mozharness: 2017-05-14 16:50:25.706878Z] Finished clobber step (success) 09:50:25 INFO - [mozharness: 2017-05-14 16:50:25.706977Z] Running read-buildbot-config step. 09:50:25 INFO - Running pre-action listener: _resource_record_pre_action 09:50:25 INFO - Running main action method: read_buildbot_config 09:50:25 INFO - Using buildbot properties: 09:50:25 INFO - { 09:50:25 INFO - "project": "", 09:50:25 INFO - "product": "firefox", 09:50:25 INFO - "who": "archaeopteryx@coole-files.de", 09:50:25 INFO - "installer_path": "public/build/target.tar.bz2", 09:50:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:50:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:50:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:50:25 INFO - "stage_platform": "linux64", 09:50:25 INFO - "basedir": "/builds/slave/test", 09:50:25 INFO - "buildnumber": 602, 09:50:25 INFO - "platform": "ubuntu64_hw", 09:50:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:50:25 INFO - "slavebuilddir": "test", 09:50:25 INFO - "taskId": "VB-dmGEuRseo2FHgR-DpAg", 09:50:25 INFO - "branch": "mozilla-central", 09:50:25 INFO - "script_repo_revision": "production", 09:50:25 INFO - "revision": "626efff0df630961981fc6875571fe05725f3636", 09:50:25 INFO - "slavename": "talos-linux64-ix-009", 09:50:25 INFO - "repo_path": "mozilla-central" 09:50:25 INFO - } 09:50:25 INFO - Finding installer, test and symbols from parent task. 09:50:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VB-dmGEuRseo2FHgR-DpAg'}, attempt #1 09:50:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VB-dmGEuRseo2FHgR-DpAg'}, attempt #1 09:50:26 INFO - Task dependencies: emG3M_GGSs6hsnt_UwjNVQ 09:50:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ'}, attempt #1 09:50:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.tar.bz2 09:50:27 INFO - Set test_url: https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/test_packages.json 09:50:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.crashreporter-symbols.zip 09:50:27 INFO - Running post-action listener: _resource_record_post_action 09:50:27 INFO - [mozharness: 2017-05-14 16:50:27.055888Z] Finished read-buildbot-config step (success) 09:50:27 INFO - [mozharness: 2017-05-14 16:50:27.056109Z] Running download-and-extract step. 09:50:27 INFO - Running pre-action listener: _resource_record_pre_action 09:50:27 INFO - Running main action method: download_and_extract 09:50:27 INFO - mkdir: /builds/slave/test/build/tests 09:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:27 INFO - trying https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.test_packages.json 09:50:27 INFO - Downloading https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:50:27 INFO - Downloaded 986 bytes. 09:50:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:50:27 INFO - Using the following test package requirements: 09:50:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:50:27 INFO - u'common': [u'target.common.tests.zip'], 09:50:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:50:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:50:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:50:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:50:27 INFO - u'mozbase': [u'target.common.tests.zip'], 09:50:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:50:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:50:27 INFO - u'web-platform': [u'target.common.tests.zip', 09:50:27 INFO - u'target.web-platform.tests.zip'], 09:50:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:50:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:50:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.common.tests.zip 09:50:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:50:27 INFO - Fetch https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.common.tests.zip into memory 09:50:28 INFO - Content-Length response header: 62448378 09:50:28 INFO - Bytes received: 62448378 09:50:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:50:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.common.tests.zip 09:50:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:50:39 INFO - Fetch https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.common.tests.zip into memory 09:50:40 INFO - Content-Length response header: 62448378 09:50:40 INFO - Bytes received: 62448378 09:50:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.talos.tests.zip 09:50:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:50:53 INFO - Fetch https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.talos.tests.zip into memory 09:50:53 INFO - Content-Length response header: 14410013 09:50:53 INFO - Bytes received: 14410013 09:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:54 INFO - trying https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.tar.bz2 09:50:54 INFO - Downloading https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:50:55 INFO - Downloaded 63360444 bytes. 09:50:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.tar.bz2 09:50:55 INFO - mkdir: /builds/slave/test/properties 09:50:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:50:55 INFO - Writing to file /builds/slave/test/properties/build_url 09:50:55 INFO - Contents: 09:50:55 INFO - build_url:https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.tar.bz2 09:50:55 INFO - Running post-action listener: _resource_record_post_action 09:50:55 INFO - Running post-action listener: set_extra_try_arguments 09:50:55 INFO - [mozharness: 2017-05-14 16:50:55.238819Z] Finished download-and-extract step (success) 09:50:55 INFO - [mozharness: 2017-05-14 16:50:55.238917Z] Running populate-webroot step. 09:50:55 INFO - Running pre-action listener: _resource_record_pre_action 09:50:55 INFO - Running main action method: populate_webroot 09:50:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:50:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:50:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:50:55 INFO - '--tppagecycles', 09:50:55 INFO - '7'], 09:50:55 INFO - 'tests': ['tsvgm']}}, 09:50:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:50:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:50:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:50:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:50:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:50:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:50:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:50:55 INFO - 'talos_options': ['--disable-e10s'], 09:50:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:50:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:50:55 INFO - 'talos_options': ['--disable-e10s'], 09:50:55 INFO - 'tests': ['damp', 'tps']}, 09:50:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:50:55 INFO - 'tests': ['damp', 'tps']}, 09:50:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:50:55 INFO - 'tests': ['dromaeo_dom']}, 09:50:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:50:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:50:55 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:50:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:50:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:50:55 INFO - 'tests': ['a11yr', 09:50:55 INFO - 'ts_paint', 09:50:55 INFO - 'tpaint', 09:50:55 INFO - 'sessionrestore', 09:50:55 INFO - 'sessionrestore_no_auto_restore', 09:50:55 INFO - 'tabpaint']}, 09:50:55 INFO - 'other-e10s': {'tests': ['a11yr', 09:50:55 INFO - 'ts_paint', 09:50:55 INFO - 'tpaint', 09:50:55 INFO - 'sessionrestore', 09:50:55 INFO - 'sessionrestore_no_auto_restore', 09:50:55 INFO - 'tabpaint']}, 09:50:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:50:55 INFO - 'ts_paint', 09:50:55 INFO - 'tpaint', 09:50:55 INFO - 'sessionrestore', 09:50:55 INFO - 'sessionrestore_no_auto_restore', 09:50:55 INFO - 'tabpaint']}, 09:50:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:50:55 INFO - 'ts_paint', 09:50:55 INFO - 'tpaint', 09:50:55 INFO - 'sessionrestore', 09:50:55 INFO - 'sessionrestore_no_auto_restore', 09:50:55 INFO - 'tabpaint']}, 09:50:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:50:55 INFO - 'tests': ['a11yr', 09:50:55 INFO - 'ts_paint', 09:50:55 INFO - 'tpaint', 09:50:55 INFO - 'sessionrestore', 09:50:55 INFO - 'sessionrestore_no_auto_restore', 09:50:55 INFO - 'tabpaint']}, 09:50:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:50:55 INFO - 'tests': ['a11yr', 09:50:55 INFO - 'ts_paint', 09:50:55 INFO - 'tpaint', 09:50:55 INFO - 'sessionrestore', 09:50:55 INFO - 'sessionrestore_no_auto_restore', 09:50:55 INFO - 'tabpaint']}, 09:50:55 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:50:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:50:55 INFO - 'bloom_basic_ref']}, 09:50:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:50:55 INFO - 'tests': ['tsvgx', 09:50:55 INFO - 'tsvgr_opacity', 09:50:55 INFO - 'tart', 09:50:55 INFO - 'tscrollx', 09:50:55 INFO - 'cart', 09:50:55 INFO - 'tsvg_static']}, 09:50:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:50:55 INFO - 'tsvgr_opacity', 09:50:55 INFO - 'tart', 09:50:55 INFO - 'tscrollx', 09:50:55 INFO - 'cart', 09:50:55 INFO - 'tsvg_static']}, 09:50:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:50:55 INFO - 'talos_options': ['--disable-e10s'], 09:50:55 INFO - 'tests': ['tp5o']}, 09:50:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:50:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:50:55 INFO - 'talos_options': ['--disable-e10s', 09:50:55 INFO - '--xperf_path', 09:50:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:55 INFO - 'tests': ['tp5n']}, 09:50:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:50:55 INFO - 'talos_options': ['--xperf_path', 09:50:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:55 INFO - 'tests': ['tp5n']}}, 09:50:55 INFO - 'talos.zip': {'path': '', 09:50:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:50:55 INFO - Running post-action listener: _resource_record_post_action 09:50:55 INFO - [mozharness: 2017-05-14 16:50:55.252646Z] Finished populate-webroot step (success) 09:50:55 INFO - [mozharness: 2017-05-14 16:50:55.252746Z] Running create-virtualenv step. 09:50:55 INFO - Running pre-action listener: _resource_record_pre_action 09:50:55 INFO - Running main action method: create_virtualenv 09:50:55 INFO - Creating virtualenv /builds/slave/test/build/venv 09:50:55 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 09:50:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:50:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:50:55 INFO - Using real prefix '/usr' 09:50:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:50:55 INFO - Installing distribute.............................................................................................................................................................................................done. 09:50:57 INFO - Installing pip.................done. 09:50:57 INFO - Return code: 0 09:50:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:50:58 INFO - Reading from file tmpfile_stdout 09:50:58 INFO - Output received: 09:50:58 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) 09:50:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:50:58 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')]} 09:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:58 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')]} 09:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:58 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 0x241b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b7a0>, '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 0x278c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278cb30>, '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': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', '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 09:50:58 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 09:50:58 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 09:50:58 INFO - Using env: {'DISPLAY': ':0', 09:50:58 INFO - 'HOME': '/home/cltbld', 09:50:58 INFO - 'LANG': 'en_US.UTF-8', 09:50:58 INFO - 'LANGUAGE': 'en_US:en', 09:50:58 INFO - 'LOGNAME': 'cltbld', 09:50:58 INFO - 'MAIL': '/var/mail/cltbld', 09:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:58 INFO - 'MOZ_NO_REMOTE': '1', 09:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:58 INFO - 'NO_EM_RESTART': '1', 09:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:58 INFO - 'PWD': '/builds/slave/test', 09:50:58 INFO - 'SHELL': '/bin/bash', 09:50:58 INFO - 'SHLVL': '1', 09:50:58 INFO - 'TERM': 'linux', 09:50:58 INFO - 'TMOUT': '86400', 09:50:58 INFO - 'USER': 'cltbld', 09:50:58 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', 09:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:58 INFO - '_': '/tools/buildbot/bin/python'} 09:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:58 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 09:50:58 INFO - Cleaning up... 09:50:58 INFO - Return code: 0 09:50:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:50:58 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')]} 09:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:58 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')]} 09:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:58 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 0x241b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b7a0>, '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 0x278c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278cb30>, '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': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', '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 09:50:58 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 09:50:58 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 09:50:58 INFO - Using env: {'DISPLAY': ':0', 09:50:58 INFO - 'HOME': '/home/cltbld', 09:50:58 INFO - 'LANG': 'en_US.UTF-8', 09:50:58 INFO - 'LANGUAGE': 'en_US:en', 09:50:58 INFO - 'LOGNAME': 'cltbld', 09:50:58 INFO - 'MAIL': '/var/mail/cltbld', 09:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:58 INFO - 'MOZ_NO_REMOTE': '1', 09:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:58 INFO - 'NO_EM_RESTART': '1', 09:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:58 INFO - 'PWD': '/builds/slave/test', 09:50:58 INFO - 'SHELL': '/bin/bash', 09:50:58 INFO - 'SHLVL': '1', 09:50:58 INFO - 'TERM': 'linux', 09:50:58 INFO - 'TMOUT': '86400', 09:50:58 INFO - 'USER': 'cltbld', 09:50:58 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', 09:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:58 INFO - '_': '/tools/buildbot/bin/python'} 09:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:58 INFO - Downloading/unpacking psutil>=3.1.1 09:50:58 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 09:50:58 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 09:50:58 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 09:50:58 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 09:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:50:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:59 INFO - Installing collected packages: psutil 09:50:59 INFO - Running setup.py install for psutil 09:50:59 INFO - building 'psutil._psutil_linux' extension 09:50:59 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 09:50:59 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 09:50:59 INFO - building 'psutil._psutil_posix' extension 09:50:59 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 09:51:00 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 09:51:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:00 INFO - Successfully installed psutil 09:51:00 INFO - Cleaning up... 09:51:00 INFO - Return code: 0 09:51:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:51:00 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')]} 09:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:00 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')]} 09:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:00 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 0x241b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b7a0>, '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 0x278c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278cb30>, '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': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', '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 09:51:00 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 09:51:00 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 09:51:00 INFO - Using env: {'DISPLAY': ':0', 09:51:00 INFO - 'HOME': '/home/cltbld', 09:51:00 INFO - 'LANG': 'en_US.UTF-8', 09:51:00 INFO - 'LANGUAGE': 'en_US:en', 09:51:00 INFO - 'LOGNAME': 'cltbld', 09:51:00 INFO - 'MAIL': '/var/mail/cltbld', 09:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:00 INFO - 'MOZ_NO_REMOTE': '1', 09:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:00 INFO - 'NO_EM_RESTART': '1', 09:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:00 INFO - 'PWD': '/builds/slave/test', 09:51:00 INFO - 'SHELL': '/bin/bash', 09:51:00 INFO - 'SHLVL': '1', 09:51:00 INFO - 'TERM': 'linux', 09:51:00 INFO - 'TMOUT': '86400', 09:51:00 INFO - 'USER': 'cltbld', 09:51:00 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', 09:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:00 INFO - '_': '/tools/buildbot/bin/python'} 09:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:51:00 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 09:51:00 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 09:51:00 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 09:51:00 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 09:51:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:51:01 INFO - Installing collected packages: mozsystemmonitor 09:51:01 INFO - Running setup.py install for mozsystemmonitor 09:51:01 INFO - Successfully installed mozsystemmonitor 09:51:01 INFO - Cleaning up... 09:51:01 INFO - Return code: 0 09:51:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51: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')]} 09:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:01 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 0x241b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b7a0>, '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 0x278c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278cb30>, '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': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', '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 09:51:01 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 09:51:01 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 09:51:01 INFO - Using env: {'DISPLAY': ':0', 09:51:01 INFO - 'HOME': '/home/cltbld', 09:51:01 INFO - 'LANG': 'en_US.UTF-8', 09:51:01 INFO - 'LANGUAGE': 'en_US:en', 09:51:01 INFO - 'LOGNAME': 'cltbld', 09:51:01 INFO - 'MAIL': '/var/mail/cltbld', 09:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:01 INFO - 'MOZ_NO_REMOTE': '1', 09:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:01 INFO - 'NO_EM_RESTART': '1', 09:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:01 INFO - 'PWD': '/builds/slave/test', 09:51:01 INFO - 'SHELL': '/bin/bash', 09:51:01 INFO - 'SHLVL': '1', 09:51:01 INFO - 'TERM': 'linux', 09:51:01 INFO - 'TMOUT': '86400', 09:51:01 INFO - 'USER': 'cltbld', 09:51:01 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', 09:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:01 INFO - '_': '/tools/buildbot/bin/python'} 09:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:01 INFO - Downloading/unpacking jsonschema==2.5.1 09:51:01 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 09:51:01 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 09:51:01 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 09:51:01 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 09:51:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:51:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:51:02 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 09:51:02 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 09:51:02 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 09:51:02 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 09:51:03 INFO - Downloading functools32-3.2.3-2.tar.gz 09:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:51:03 INFO - warning: no files found matching '*.txt' 09:51:03 INFO - no previously-included directories found matching 'build' 09:51:03 INFO - no previously-included directories found matching 'dist' 09:51:03 INFO - no previously-included directories found matching '.git*' 09:51:03 INFO - Installing collected packages: jsonschema, functools32 09:51:03 INFO - Running setup.py install for functools32 09:51:03 INFO - warning: no files found matching '*.txt' 09:51:03 INFO - no previously-included directories found matching 'build' 09:51:03 INFO - no previously-included directories found matching 'dist' 09:51:03 INFO - no previously-included directories found matching '.git*' 09:51:03 INFO - Successfully installed jsonschema functools32 09:51:03 INFO - Cleaning up... 09:51:03 INFO - Return code: 0 09:51:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:51:03 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')]} 09:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:03 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')]} 09:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:03 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 0x241b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b7a0>, '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 0x278c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278cb30>, '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': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', '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 09:51:03 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 09:51:03 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 09:51:03 INFO - Using env: {'DISPLAY': ':0', 09:51:03 INFO - 'HOME': '/home/cltbld', 09:51:03 INFO - 'LANG': 'en_US.UTF-8', 09:51:03 INFO - 'LANGUAGE': 'en_US:en', 09:51:03 INFO - 'LOGNAME': 'cltbld', 09:51:03 INFO - 'MAIL': '/var/mail/cltbld', 09:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:03 INFO - 'MOZ_NO_REMOTE': '1', 09:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:03 INFO - 'NO_EM_RESTART': '1', 09:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:03 INFO - 'PWD': '/builds/slave/test', 09:51:03 INFO - 'SHELL': '/bin/bash', 09:51:03 INFO - 'SHLVL': '1', 09:51:03 INFO - 'TERM': 'linux', 09:51:03 INFO - 'TMOUT': '86400', 09:51:03 INFO - 'USER': 'cltbld', 09:51:03 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', 09:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:03 INFO - '_': '/tools/buildbot/bin/python'} 09:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:51:03 INFO - Cleaning up... 09:51:03 INFO - Return code: 0 09:51:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:51:03 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')]} 09:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:03 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')]} 09:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:03 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 0x241b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b7a0>, '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 0x278c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278cb30>, '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': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', '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 09:51:03 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 09:51:03 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 09:51:03 INFO - Using env: {'DISPLAY': ':0', 09:51:03 INFO - 'HOME': '/home/cltbld', 09:51:03 INFO - 'LANG': 'en_US.UTF-8', 09:51:03 INFO - 'LANGUAGE': 'en_US:en', 09:51:03 INFO - 'LOGNAME': 'cltbld', 09:51:03 INFO - 'MAIL': '/var/mail/cltbld', 09:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:03 INFO - 'MOZ_NO_REMOTE': '1', 09:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:03 INFO - 'NO_EM_RESTART': '1', 09:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:03 INFO - 'PWD': '/builds/slave/test', 09:51:03 INFO - 'SHELL': '/bin/bash', 09:51:03 INFO - 'SHLVL': '1', 09:51:03 INFO - 'TERM': 'linux', 09:51:03 INFO - 'TMOUT': '86400', 09:51:03 INFO - 'USER': 'cltbld', 09:51:03 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', 09:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:03 INFO - '_': '/tools/buildbot/bin/python'} 09:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:03 INFO - Downloading/unpacking blobuploader==1.2.4 09:51:03 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 09:51:03 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 09:51:03 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 09:51:03 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 09:51:04 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51:04 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 09:51:04 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 09:51:04 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 09:51:04 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 09:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:51:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51:05 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 09:51:05 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 09:51:05 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 09:51:05 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 09:51:05 INFO - Downloading docopt-0.6.1.tar.gz 09:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:05 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:05 INFO - Running setup.py install for blobuploader 09:51:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:51:05 INFO - Running setup.py install for requests 09:51:05 INFO - Running setup.py install for docopt 09:51:06 INFO - Successfully installed blobuploader requests docopt 09:51:06 INFO - Cleaning up... 09:51:06 INFO - Return code: 0 09:51:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:06 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 0x241b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b7a0>, '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 0x278c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278cb30>, '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': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', '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 09:51:06 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 09:51:06 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 09:51:06 INFO - Using env: {'DISPLAY': ':0', 09:51:06 INFO - 'HOME': '/home/cltbld', 09:51:06 INFO - 'LANG': 'en_US.UTF-8', 09:51:06 INFO - 'LANGUAGE': 'en_US:en', 09:51:06 INFO - 'LOGNAME': 'cltbld', 09:51:06 INFO - 'MAIL': '/var/mail/cltbld', 09:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:06 INFO - 'MOZ_NO_REMOTE': '1', 09:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:06 INFO - 'NO_EM_RESTART': '1', 09:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:06 INFO - 'PWD': '/builds/slave/test', 09:51:06 INFO - 'SHELL': '/bin/bash', 09:51:06 INFO - 'SHLVL': '1', 09:51:06 INFO - 'TERM': 'linux', 09:51:06 INFO - 'TMOUT': '86400', 09:51:06 INFO - 'USER': 'cltbld', 09:51:06 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', 09:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:06 INFO - '_': '/tools/buildbot/bin/python'} 09:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:06 INFO - Running setup.py (path:/tmp/pip-x9ussF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:06 INFO - Running setup.py (path:/tmp/pip-y4_YkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:06 INFO - Running setup.py (path:/tmp/pip-DHED4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:06 INFO - Running setup.py (path:/tmp/pip-gLvWnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:06 INFO - Running setup.py (path:/tmp/pip-dz5Wu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:06 INFO - Running setup.py (path:/tmp/pip-9Z_dE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:06 INFO - Running setup.py (path:/tmp/pip-RxXtT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:06 INFO - Running setup.py (path:/tmp/pip-JzyC3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:06 INFO - Running setup.py (path:/tmp/pip-wQTxt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:06 INFO - Running setup.py (path:/tmp/pip-Izh2b8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:07 INFO - Running setup.py (path:/tmp/pip-ouTqCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:07 INFO - Running setup.py (path:/tmp/pip-zNiQXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:07 INFO - Running setup.py (path:/tmp/pip-z3JRLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:07 INFO - Running setup.py (path:/tmp/pip-uVUpHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:07 INFO - Running setup.py (path:/tmp/pip-YxzsGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:07 INFO - Running setup.py (path:/tmp/pip-l96LPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:07 INFO - Running setup.py (path:/tmp/pip-VWxdtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:07 INFO - Running setup.py install for manifestparser 09:51:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:51:07 INFO - Running setup.py install for mozcrash 09:51:07 INFO - Running setup.py install for mozdebug 09:51:07 INFO - Running setup.py install for mozdevice 09:51:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:51:07 INFO - Running setup.py install for mozfile 09:51:08 INFO - Running setup.py install for mozhttpd 09:51:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Running setup.py install for mozinfo 09:51:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Running setup.py install for mozInstall 09:51:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Running setup.py install for mozleak 09:51:08 INFO - Running setup.py install for mozlog 09:51:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Running setup.py install for moznetwork 09:51:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Running setup.py install for mozprocess 09:51:08 INFO - Running setup.py install for mozprofile 09:51:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Running setup.py install for mozrunner 09:51:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:51:09 INFO - Running setup.py install for mozscreenshot 09:51:09 INFO - Running setup.py install for moztest 09:51:09 INFO - Running setup.py install for mozversion 09:51:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:51:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:09 INFO - Cleaning up... 09:51:09 INFO - Return code: 0 09:51:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:09 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')]} 09:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:09 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')]} 09:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:09 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 0x241b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b7a0>, '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 0x278c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278cb30>, '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': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', '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 09:51:09 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 09:51:09 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 09:51:09 INFO - Using env: {'DISPLAY': ':0', 09:51:09 INFO - 'HOME': '/home/cltbld', 09:51:09 INFO - 'LANG': 'en_US.UTF-8', 09:51:09 INFO - 'LANGUAGE': 'en_US:en', 09:51:09 INFO - 'LOGNAME': 'cltbld', 09:51:09 INFO - 'MAIL': '/var/mail/cltbld', 09:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:09 INFO - 'MOZ_NO_REMOTE': '1', 09:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:09 INFO - 'NO_EM_RESTART': '1', 09:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:09 INFO - 'PWD': '/builds/slave/test', 09:51:09 INFO - 'SHELL': '/bin/bash', 09:51:09 INFO - 'SHLVL': '1', 09:51:09 INFO - 'TERM': 'linux', 09:51:09 INFO - 'TMOUT': '86400', 09:51:09 INFO - 'USER': 'cltbld', 09:51:09 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', 09:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:09 INFO - '_': '/tools/buildbot/bin/python'} 09:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:09 INFO - Running setup.py (path:/tmp/pip-zw09_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:09 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)) 09:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:09 INFO - Running setup.py (path:/tmp/pip-M0R8SG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:09 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)) 09:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:09 INFO - Running setup.py (path:/tmp/pip-NhORU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:09 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)) 09:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:09 INFO - Running setup.py (path:/tmp/pip-wCzaQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 09:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:09 INFO - Running setup.py (path:/tmp/pip-HPT9p8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:09 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)) 09:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:09 INFO - Running setup.py (path:/tmp/pip-3aVJwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:09 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)) 09:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:10 INFO - Running setup.py (path:/tmp/pip-RVG_Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:10 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)) 09:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:10 INFO - Running setup.py (path:/tmp/pip-m5NhR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:10 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)) 09:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:10 INFO - Running setup.py (path:/tmp/pip-72ZOf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:10 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)) 09:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:10 INFO - Running setup.py (path:/tmp/pip-MRZ7ML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:10 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)) 09:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:10 INFO - Running setup.py (path:/tmp/pip-TMGyRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:10 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)) 09:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:10 INFO - Running setup.py (path:/tmp/pip-nYuKia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:10 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)) 09:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:10 INFO - Running setup.py (path:/tmp/pip-RXcErq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:10 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)) 09:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:10 INFO - Running setup.py (path:/tmp/pip-BCd3vR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:10 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)) 09:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:10 INFO - Running setup.py (path:/tmp/pip-a6XVvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:10 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)) 09:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:10 INFO - Running setup.py (path:/tmp/pip-hWgUFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:10 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)) 09:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:10 INFO - Running setup.py (path:/tmp/pip-_8yRdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:10 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)) 09:51:10 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)) 09:51:10 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)) 09:51:10 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)) 09:51:10 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:10 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:10 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 09:51:10 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 09:51:10 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 09:51:10 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 09:51:11 INFO - Downloading blessings-1.6.tar.gz 09:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:11 INFO - Installing collected packages: blessings 09:51:11 INFO - Running setup.py install for blessings 09:51:12 INFO - Successfully installed blessings 09:51:12 INFO - Cleaning up... 09:51:12 INFO - Return code: 0 09:51:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:12 INFO - Reading from file tmpfile_stdout 09:51:12 INFO - Current package versions: 09:51:12 INFO - argparse == 1.2.1 09:51:12 INFO - blessings == 1.6 09:51:12 INFO - blobuploader == 1.2.4 09:51:12 INFO - docopt == 0.6.1 09:51:12 INFO - functools32 == 3.2.3-2 09:51:12 INFO - jsonschema == 2.5.1 09:51:12 INFO - manifestparser == 1.1 09:51:12 INFO - mozInstall == 1.12 09:51:12 INFO - mozcrash == 1.0 09:51:12 INFO - mozdebug == 0.1 09:51:12 INFO - mozdevice == 0.50 09:51:12 INFO - mozfile == 1.2 09:51:12 INFO - mozhttpd == 0.7 09:51:12 INFO - mozinfo == 0.9 09:51:12 INFO - mozleak == 0.1 09:51:12 INFO - mozlog == 3.4 09:51:12 INFO - moznetwork == 0.27 09:51:12 INFO - mozprocess == 0.25 09:51:12 INFO - mozprofile == 0.28 09:51:12 INFO - mozrunner == 6.13 09:51:12 INFO - mozscreenshot == 0.1 09:51:12 INFO - mozsystemmonitor == 0.3 09:51:12 INFO - moztest == 0.8 09:51:12 INFO - mozversion == 1.4 09:51:12 INFO - psutil == 3.1.1 09:51:12 INFO - requests == 1.2.3 09:51:12 INFO - wsgiref == 0.1.2 09:51:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:12 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')]} 09:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:12 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')]} 09:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:12 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 0x241b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b7a0>, '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 0x278c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278cb30>, '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': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', '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 09:51:12 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 09:51:12 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 09:51:12 INFO - Using env: {'DISPLAY': ':0', 09:51:12 INFO - 'HOME': '/home/cltbld', 09:51:12 INFO - 'LANG': 'en_US.UTF-8', 09:51:12 INFO - 'LANGUAGE': 'en_US:en', 09:51:12 INFO - 'LOGNAME': 'cltbld', 09:51:12 INFO - 'MAIL': '/var/mail/cltbld', 09:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:12 INFO - 'MOZ_NO_REMOTE': '1', 09:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:12 INFO - 'NO_EM_RESTART': '1', 09:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:12 INFO - 'PWD': '/builds/slave/test', 09:51:12 INFO - 'SHELL': '/bin/bash', 09:51:12 INFO - 'SHLVL': '1', 09:51:12 INFO - 'TERM': 'linux', 09:51:12 INFO - 'TMOUT': '86400', 09:51:12 INFO - 'USER': 'cltbld', 09:51:12 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', 09:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:12 INFO - '_': '/tools/buildbot/bin/python'} 09:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:12 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)) 09:51:12 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)) 09:51:12 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)) 09:51:12 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)) 09:51:12 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)) 09:51:12 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)) 09:51:12 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)) 09:51:12 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)) 09:51:12 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)) 09:51:12 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)) 09:51:12 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)) 09:51:12 INFO - Cleaning up... 09:51:12 INFO - Return code: 0 09:51:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:51:12 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')]} 09:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:12 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')]} 09:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:12 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 0x241b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b7a0>, '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 0x278c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278cb30>, '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': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', '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 09:51:12 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 09:51:12 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 09:51:12 INFO - Using env: {'DISPLAY': ':0', 09:51:12 INFO - 'HOME': '/home/cltbld', 09:51:12 INFO - 'LANG': 'en_US.UTF-8', 09:51:12 INFO - 'LANGUAGE': 'en_US:en', 09:51:12 INFO - 'LOGNAME': 'cltbld', 09:51:12 INFO - 'MAIL': '/var/mail/cltbld', 09:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:12 INFO - 'MOZ_NO_REMOTE': '1', 09:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:12 INFO - 'NO_EM_RESTART': '1', 09:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:12 INFO - 'PWD': '/builds/slave/test', 09:51:12 INFO - 'SHELL': '/bin/bash', 09:51:12 INFO - 'SHLVL': '1', 09:51:12 INFO - 'TERM': 'linux', 09:51:12 INFO - 'TMOUT': '86400', 09:51:12 INFO - 'USER': 'cltbld', 09:51:12 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', 09:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:12 INFO - '_': '/tools/buildbot/bin/python'} 09:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:51:12 INFO - Cleaning up... 09:51:12 INFO - Return code: 0 09:51:12 INFO - Running post-action listener: _resource_record_post_action 09:51:12 INFO - Running post-action listener: _start_resource_monitoring 09:51:12 INFO - Starting resource monitoring. 09:51:12 INFO - [mozharness: 2017-05-14 16:51:12.805884Z] Finished create-virtualenv step (success) 09:51:12 INFO - [mozharness: 2017-05-14 16:51:12.806346Z] Running install step. 09:51:12 INFO - Running pre-action listener: _resource_record_pre_action 09:51:12 INFO - Running main action method: install 09:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:13 INFO - Reading from file tmpfile_stdout 09:51:13 INFO - Detecting whether we're running mozinstall >=1.0... 09:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:51:13 INFO - Reading from file tmpfile_stdout 09:51:13 INFO - Output received: 09:51:13 INFO - Usage: mozinstall [options] installer 09:51:13 INFO - Options: 09:51:13 INFO - -h, --help show this help message and exit 09:51:13 INFO - -d DEST, --destination=DEST 09:51:13 INFO - Directory to install application into. [default: 09:51:13 INFO - "/builds/slave/test"] 09:51:13 INFO - --app=APP Application being installed. [default: firefox] 09:51:13 INFO - mkdir: /builds/slave/test/build/application 09:51:13 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'] 09:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:51:29 INFO - Reading from file tmpfile_stdout 09:51:29 INFO - Output received: 09:51:29 INFO - /builds/slave/test/build/application/firefox/firefox 09:51:29 INFO - Running post-action listener: _resource_record_post_action 09:51:29 INFO - [mozharness: 2017-05-14 16:51:29.273147Z] Finished install step (success) 09:51:29 INFO - [mozharness: 2017-05-14 16:51:29.273423Z] Running run-tests step. 09:51:29 INFO - Running pre-action listener: _resource_record_pre_action 09:51:29 INFO - Running main action method: run_tests 09:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:51:29 INFO - Python 2.7.3 09:51:29 INFO - Return code: 0 09:51:29 INFO - grabbing minidump binary from tooltool 09:51: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')]} 09:51:29 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 0x278b7a0>, '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 0x278c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278cb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:51:29 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 09:51:29 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 09:51:29 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 09:51:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:51:29 INFO - Return code: 0 09:51:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:51:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:51:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:51:29 INFO - ENV: RUST_BACKTRACE is now 1 09:51:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:51:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:51:29 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/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 09:51:29 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/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 09:51:29 INFO - Using env: {'DISPLAY': ':0', 09:51:29 INFO - 'HOME': '/home/cltbld', 09:51:29 INFO - 'LANG': 'en_US.UTF-8', 09:51:29 INFO - 'LANGUAGE': 'en_US:en', 09:51:29 INFO - 'LOGNAME': 'cltbld', 09:51:29 INFO - 'MAIL': '/var/mail/cltbld', 09:51:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:51:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:29 INFO - 'MOZ_NO_REMOTE': '1', 09:51:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:29 INFO - 'NO_EM_RESTART': '1', 09:51:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:29 INFO - 'PWD': '/builds/slave/test', 09:51:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:51:29 INFO - 'RUST_BACKTRACE': '1', 09:51:29 INFO - 'SHELL': '/bin/bash', 09:51:29 INFO - 'SHLVL': '1', 09:51:29 INFO - 'TERM': 'linux', 09:51:29 INFO - 'TMOUT': '86400', 09:51:29 INFO - 'USER': 'cltbld', 09:51:29 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163', 09:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:29 INFO - '_': '/tools/buildbot/bin/python'} 09:51:29 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/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 09:51:29 INFO - mozversion application_buildid: 20170514160450 09:51:29 INFO - mozversion application_changeset: 626efff0df630961981fc6875571fe05725f3636 09:51:29 INFO - mozversion application_display_name: Nightly 09:51:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:51:29 INFO - mozversion application_name: Firefox 09:51:29 INFO - mozversion application_remotingname: firefox 09:51:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:51:29 INFO - mozversion application_vendor: Mozilla 09:51:29 INFO - mozversion application_version: 55.0a1 09:51:29 INFO - mozversion platform_buildid: 20170514160450 09:51:29 INFO - mozversion platform_changeset: 626efff0df630961981fc6875571fe05725f3636 09:51:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:51:29 INFO - mozversion platform_version: 55.0a1 09:51:29 INFO - using testdate: 1494780689 09:51:29 INFO - actual date: 1494780689 09:51:29 INFO - starting webserver on 'localhost:56081' 09:51:29 INFO - SUITE-START | Running 2 tests 09:51:29 INFO - TEST-START | dromaeo_css 09:51:29 INFO - operating with platform_type : linux_ 09:51:29 INFO - Initialising browser for dromaeo_css test... 09:51:29 INFO - TEST-INFO | started process 9960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI10Zrq/profile http://localhost:56081/getInfo.html) 09:51:30 INFO - PID 9960 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 09:51:33 INFO - PID 9960 | __metrics Screen width/height:1600/1200 09:51:33 INFO - PID 9960 | colorDepth:24 09:51:33 INFO - PID 9960 | Browser inner width/height: 1024/695 09:51:33 INFO - PID 9960 | __metrics 09:51:35 INFO - TEST-INFO | 9960: exit 0 09:51:35 INFO - Browser initialized. 09:51:35 INFO - Running cycle 1/1 for dromaeo_css test... 09:51:35 INFO - TEST-INFO | started process 10131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI10Zrq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:47 INFO - PID 10131 | RSS: Main: 162578432 09:51:47 INFO - PID 10131 | 09:54:53 INFO - PID 10131 | Cycle 1(1): loaded http://localhost:56081/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56081/tests/dromaeo/cssquery-ext.html) 09:54:55 INFO - PID 10131 | RSS: Main: 168304640 09:54:55 INFO - PID 10131 | 09:57:57 INFO - PID 10131 | Cycle 1(1): loaded http://localhost:56081/tests/dromaeo/cssquery-ext.html (next: http://localhost:56081/tests/dromaeo/cssquery-jquery.html) 09:57:57 INFO - PID 10131 | RSS: Main: 167538688 09:57:57 INFO - PID 10131 | 10:00:59 INFO - PID 10131 | Cycle 1(1): loaded http://localhost:56081/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56081/tests/dromaeo/cssquery-mootools.html) 10:01:00 INFO - PID 10131 | RSS: Main: 170905600 10:01:00 INFO - PID 10131 | 10:04:01 INFO - PID 10131 | Cycle 1(1): loaded http://localhost:56081/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56081/tests/dromaeo/cssquery-prototype.html) 10:04:02 INFO - PID 10131 | RSS: Main: 167096320 10:04:02 INFO - PID 10131 | 10:07:05 INFO - PID 10131 | Cycle 1(1): loaded http://localhost:56081/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56081/tests/dromaeo/cssquery-yui.html) 10:07:05 INFO - PID 10131 | RSS: Main: 167698432 10:07:05 INFO - PID 10131 | 10:10:07 INFO - PID 10131 | Cycle 1(1): loaded http://localhost:56081/tests/dromaeo/cssquery-yui.html (next: http://localhost:56081/tests/dromaeo/cssquery-dojo.html) 10:10:07 INFO - PID 10131 | RSS: Main: 174673920 10:10:07 INFO - PID 10131 | 10:10:08 INFO - PID 10131 | __start_tp_report 10:10:08 INFO - PID 10131 | _x_x_mozilla_page_load 10:10:08 INFO - PID 10131 | _x_x_mozilla_page_load_details 10:10:08 INFO - PID 10131 | |i|pagename|runs| 10:10:08 INFO - PID 10131 | |0;dojo.html;2731.1942976821833;2746.3134216445887;2759.4619049285398;2767.944641107178;2784.777217822573;5258.710770907599;5324.254604355388;5332.493413125757;5357.928414317143;5374.785008599656;5324.600654950875;5339.439358867321;5408.134698448259;5411.783528658849;5434.7826086956475;4693.108309421199;4701.600363969067;4719.575238228559;4775.761211939406;4790.496997815231;4706.458757242909;4770.0936822003705;4815.927761083569;4816.157172494817;4852.514748525137;4654.674172807905;4754.952450475485;4785.497522760095;4804.1352556539805;4811.4707382187935;4691.859244222679;4707.7175369477945;4733.928991065137;4767.666263361566;4797.40032495938;4630.097131059445;4685.0629874025335;4685.672002959795;4705.106029854351;4778;5334.439883812182;5334.639666884958;5347.598930080259;5359.705216213107;5384.326959130109;5688.97155514224;5718.34239062509;5766.135079738031;5822.592418530662;5847.795327163529;5825.038868586678;5826.854328641775;5827.3298570664065;5831.154482600042;5877.177195192677;5367.838964831061;5385.78456861729;5388.407275199725;5390.245365648812;5391.433899440581;5757.539396848242;5803.564732644984;5848.210491583582;5859.560532960045;5942.821715348547;5609.186667933127;5610.298712660918;5612.719364031864;5616.185653080281;5671.688057156814;5657.858553536194;5725.456081672234;5726.742296596663;5774.653520788766;5851.765929362778;5739.2252045973255;5745.569082318842;5764.913526297025;5791.942080579224;5801.7099145042575;5710.257666503411;5712.514436272963;5715.428457154335;5732.082866741302;5758.654480731169;4762.404699412574;4830.154722923475;4838.104950584153;4839.153148199051;4909;4174.91650167001;4180.038591124058;4208.494980602347;4211.410402543646;4276.957230427656;4880.8779780505065;4922.630802689812;4925;4928.531789479994;4984.152694042022;5705.800296989585;5792.536597072309;5792.82621521355;5853.678047707417;5860.033094539439;4850.6362022848425;4870.975645121752;4873.293372460973;4873.926891096637;4884.169691152512;5117.974410127926;5146.485351464824;5148.150555158357;5156.458571849977;5164.2770012198325;5303.443138470405;5308.442613525602;5320.228566857862;5321.441248668834;5344.225087362233;5707.086866101404;5713.143028545752;5714.628549144292;5715.171300161536;5735.713214339183;5276.762545685377;5331.973340133274;5335.786568537215;5341.305630268041;5342.171963345688;5675.489205971482;5708.628939118944;5745.339285982165;5765.279340082489;5768.2501274834;5731;5732.512736417451;5740.024195886793;5754.539636829128;5757.510611598061;5522;5544.528715059104;5549.223108764695;5569.944300556943;5573.526250268773;5577.135543990526;5582.441755824385;5666.34836993751;5667.603267771216;5677.318721753416;5524.198991146181;5527.972360138174;5549.72251387421;5555.972220138873;5578;5577.74900129487;5632.7183640816975;5652.236948012131;5695.345035320991;5705.4009329019855;5409.675419474844;5477.72611369422;5489.478499542537;5495.2856128703015;5507.972460137674 10:10:08 INFO - PID 10131 | |1;ext.html;691.7475121580621;734.0713996794054;756.7313603670697;1055.6199768083488;1068.4817863336286;32391.51412728808;33217.66782332179;33287;33412.16469588255;33418.66581334192;34428.31143377131;34717.47923781145;34863.302733945304;34905.825470872674;35021.29957400857;6681.632510211936;6716.798496045127;6841.144856892888;6845.315468453165;6868.553544019623;6738.22510411304;6765.526413151081;6853.965730171342;6856.17725872896;6867.278935711754;6811.080504131953;6883.105196324495;6892.4830637702125;6896.793096207121;6901.896471552931;6808.59148451092;6824.488163387716;6838.042674025641;6853.383195512428;6867.622280774555;6772.966135169342;6819.659017049128;6832.965835170792;6845.520813543054;6868.107146071029;31584.684153158403;31667;31748.365032699447;31832.522512162337;31839.044828655176;2952.8818847246084;3005.2787331040613;3006.1733023418515;3007.624046994126;3009.0371081254007;24091.879540602185;24132.396690082714;24184.153554625504;24282.15012474555;24455.266342009767;3043.6651968283472;3094.7214750672547;3098.597182366278;3102;3129.202053476372;143645;144232;156973.21513392474;157508;158857;39185.80407098003;39241.6075839238;39324.41013384802;39348.40977385284;39387;40877.59122408797;40997.97505062397;41070.38394424086;41159.38260926089;41409.79295103505;11686.298822070534;11769.176157669051;11769.293842369314;11859.34773587461;11878.227915185658;9351.802326453279;9460.668876589287;9475.289353298393;9485.573149208301;9517.524123793783;12359.938200309121;12381.380930953417;12454.688632784253;12512.68718282032;12646.683832904251;5364.463553644682;5465.508104270635;5465.808696695596;5471.206675032098;5508.091164957737;832.8417600655856;854.8974123105143;870.2124577257592;884.3544212724619;886.4371124335964;18578.88526688403;18678.81321186798;18724.625507489774;19538.413847584594;19671.311504097575;936.194872409727;936.9484678342757;940.2290122099812;940.5955439161089;960.7646126698863;10100.393976361442;10156.644517441853;10183.796324073477;14061.367238474293;14747.55757327282;182008;182282;182717;183230;183503;43476.130477390274;43562.346564801555;43607.34588981168;43791.34312985308;43868.341974870404;1156.3697784707354;1189.6966273600176;1195.820626905971;1207.6135636596205;1209.897158741517;24028.759712403353;24258.272251832474;24626.87686561556;25013.249602511954;25055.498890022463;29681.85159074191;36287.092822679646;37179;37235.44146837745;37295.62704372922;164965;165009;165779;166286;166809;29420.411591768472;29542.113736587937;29797;29912.401751965273;30402.543961840147;34880.82559587186;35815.82092089523;35929.46105808362;36143.09642258859;36414;27199.728002720512;27610;27682;27717.58423623607;28438.85780571084;27789;28106.2973425666;28142;28192.436151276448;29643;31364.37271254608;31423.685763142075;31541.684583153874;31686.366272673957;31716.207094822814;26794.732052679225;26984.73015269901;27098.864505677346;27445.725542744316;28601.42797144087;21268;22312.888435557717;22387.44031399228;22463.550728985003;22614 10:10:08 INFO - PID 10131 | |2;jquery.html;404.86639408995035;412.3670166294737;417.80154426647346;428.7770359413105;439.6636573021639;14063;17028.829711702878;17873.553161170978;17881.317802329657;17893.552661183476;18189.363372281972;18269.908650456728;18387.72418413725;18522.722159167624;18554.907225463852;5417.214503896933;5422.53908417785;5622.859428514279;5678.886422271552;5695.288088988877;5502.614816962814;5603.103503439451;5636.2954630671165;5638.4361563843695;5673.8297851064535;5424.538914192299;5471.042567550663;5483.533899618517;5516.889662206753;5621.4940655341015;5531.889362212753;5545.473180047889;5627.212190293362;5636.689982050985;5641.041023026095;4875.8781030474165;4939.703617782944;4983.6760610560195;4990.326305948687;4992.425871024806;21167.364979050653;21328;21328;21379.251726189665;21495.677564836384;1518.3622878390993;1617.8867479276455;1638.7541868719668;1641.8440248176523;1663.8336166383385;14603.269836508132;14627.488037918622;14633.414663413558;14791.186484743443;14844.777328340084;2071.2336435518955;2115.206797450956;2144.667576525641;2156.2453141400542;2161.9891900540397;87392;88560;90830.545847271;91140.99999999933;92475;10650.946745266225;10727.624533141303;10778.838317425245;10877.891221087846;10954.452277386259;14686.92656536732;14961.700765984619;15049.247537623076;15052.247387630574;15093.169875656944;7329.083864516935;7347.963260183772;7358.926410735931;7525.736599219001;7549.169591344948;6658.500612454085;6659.700313485905;6841.692123854438;6862.313768623198;6876.346747059021;6670.465792867668;6850.349216824394;6858.3141685831015;6943.930560694429;7036.894446583306;1925.1914196037417;1927.9421617351502;1941.1847024249848;1943.2518480385154;1988.4829944214318;794.9244821741926;825.0800357601231;828.9005319361595;846.3948276981987;859.6561375449745;15114.395424182909;15349;15422.460213892684;15662.295196716175;15884.126373049594;801.9157988411133;819.5041999590281;832.862577674689;842.3808500751942;858.8239410920871;8127.390445716476;8424.831503369898;8562.914370856211;8615.956920215483;8666.848757231917;369169;370245;375677;383360;384273;75318.62340688371;76943.23056769361;77197.61401192957;77314.22685773183;80210;979.8481235408523;1011.5650270383659;1015.4821041269006;1021.2595867995643;1022.9488525573692;12962.157459765462;13329.266890321125;13465.124766890121;13831.170129792245;13833.30833458303;36126.819365903;36800.44799328066;36855.26289474249;37537.81231093827;38175.6182438172;48912;49445.752771235915;51102;51154;51238.64533471892;8204.548749818818;8295.211954864279;8352.329534093327;8410.243078122998;8490.61792219364;12592.370381480707;12971.481140754264;13236.470541178245;13285.535006274735;13563.660908476972;10746.301490403099;10869.619563315246;10923.344599324066;10997.395143267197;11255.099592032453;10615.628453004416;10851.511681974487;10931.617393391192;10966.561337546409;11255.549778008788;10841.837372439577;10908.181886358714;11158.330500170016;11481.196316257781;11801;8086.636101375335;8217.342612590859;8406.07533171363;8411.803514664389;8487.745367638981;11054;11172.888271117185;11228.719282017688;11277.210595258253;11678.70803229926 10:10:08 INFO - PID 10131 | |3;mootools.html;1285.0940087238498;1319.4062671797687;1331.8734720201578;1345.273552281768;1355.0988592585927;9716.174125199357;10147.289689721712;10197.490125493723;10420.583176672942;10504.737381565446;10657.893421065786;10804.945975270113;10824.296420732648;10830.241883068189;10846;2248.7976082152563;2282.897269622871;2285.90856365746;2291.4761683480465;2299.850509716863;2257.413072601119;2290.931272061841;2315;2318.5362927414585;2322.500662357593;2289.7710228977135;2291.0377641390655;2327.173853282086;2331.277304035746;2337.0301324950124;2189.3431970408815;2226.3543572363997;2269.693591365178;2283.9657405138937;2304.5736538740302;2119.088791819517;2232.6427771556637;2232.9218477353215;2257.7855103765114;2261.547690461914;10312.226583006304;10422.270441069128;10435.791284174275;10436.269461137723;10437.634682786065;5708.97145514274;5915.763369465216;5920.111983202511;5926.348101708852;5933.317668468138;3147.590813194293;3309.073459431363;3387.305602351512;3401.880934167317;3404.0468668772783;1034.332855308322;1060.533365319257;1075.2204651627585;1099.1042300525046;1104.845321654969;15220.238988050663;15252.618684532865;15305;15412.152331621757;15413.306401211972;4670.976645116821;4847.224444088929;5052;5069.214271787879;5091.159958606789;11074.889251107386;11091.500882460308;11118.666440006813;11181.664550063511;11187.888121118847;5622.269105016322;5644.971775141098;5651.886962260732;5674.148877668383;5690.857728556819;5148.56237219833;5239.947600523946;5290.418054014055;5299.920501192485;5378.408375078817;3691.5570131583845;3793.975626580808;3846.74996125251;3915.530136383652;3999.9800000999808;1119.5521791283388;1130.0846314485293;1136.5169802833764;1137.3517095255625;1145.4330106597122;620.8623639384133;643.3277225299573;670.7317073170673;672.5292295393244;680.1260380411148;5507.118860982304;5599.468050535193;5656.321241451053;5669.801556945569;5828.358880523139;543.3398420918603;545.8771776350369;547.8849441617225;556.349071586245;559.2785306953983;3547.858085676544;3709.1351669509895;3726.32926073304;3914.72596918213;3935.685145188378;13309.201447913156;13611.319434028259;13831.170129792245;13857.752802247845;13920.443182272596;13619.523316683868;13857.37641806121;13875.791863122062;13888.652783680287;13916.652083697989;7642.847143057108;7901.446898717149;8008.758642410436;8028.197180282042;8032.1164671886045;5863.413658634103;5985.102234664835;6022.548308876764;6088.634681919099;6261.467775238973;12027.338496382783;12153.392330383269;12192.695182620151;12492.312922789333;12492.43784029739;12638.873611263769;12657.556985505464;12668.809967850673;12821.038422118565;12884.48462061507;7605.087389513073;7615.847683046419;7692.884606731015;7788.610569471391;7805.570693611906;9578.952105239428;9659.806803863743;9740;9763;9775.755606109904;7794.766157015299;7968.0438347398685;8026.357891368793;8119.918800812153;8247;7750.806229844299;7885.6451459685595;7918.802029949297;7938.920610793818;8027.438079334391;7240.167380751281;7340.449466290156;7423.777286681408;7432.925670743223;7440.62796860144;5102.285680004877;5200.921986170135;5216.739163041909;5426.104692725656;5448.673079615236;5399.541039011728;5648.350439699487;5650.26546548946;5732.885342293047;5735.025045742151 10:10:08 INFO - PID 10131 | |4;prototype.html;383.2163226202416;383.33108725274366;389.2701185277605;390.33253137135495;393.84443144957754;5385.838424847261;5507.2840530731;5508.201310809935;5526.143447765598;5608.186812912136;5326.227696983935;5372.516473517392;5399.325084364455;5418.214358917954;5426.403095659474;3994.1612261425134;4085.734427262233;4091.3044782387065;4116.300228961069;4120.649744771698;4079.7348172368847;4101.774402407867;4103.384492326145;4117.402976568395;4120.423140760296;4073.494800697579;4089.5705950875176;4091.6931230157707;4093.856715014975;4099.836006559734;3976.1848820991627;4000.879973600797;4050.3721923101966;4075.714699971003;4080.9795951020205;3519.894403167909;3544.8936531904083;3554.1647712787476;3556.9644303556893;3557.075160458274;5320.201969704536;5334.59990500714;5345.578829549092;5346.978956889345;5360.3299587551555;4740.146773580754;4805.639577031737;4817.445993710733;4828.299896515021;4829.3721816164025;5721.9427805721825;5768.250127483442;5793.826185214451;5796.362400135981;5815.563832712563;3959.544652364957;3979.2240513099955;4004.5795191504762;4005.35914253718;4011.3782363733376;6017.819465416044;6069.696515174268;6103.450689437927;6159.137720719103;6177.039157213266;4106.137711080706;4109.198706252312;4110.807865718968;4115.506139263248;4119.155573107506;4152.792360381969;4156.584341565819;4162.229987452331;4178.415021896937;4188.623023927861;4720.693154944986;4830.830920917751;4847.491013443609;4848.442429120696;4849.58778503824;5792.131180322901;5818.796342128006;5819.79630712923;5823.107490065746;5831.183634291203;1414.816073910385;1426.2939844776695;1435.9210243436712;1436.8634979676915;1437.8777803886787;903.7153296711515;956.2636769687441;957.1433566957534;963.992627704051;970.737900766789;5016.749162541858;5040.672356296829;5052.317937078447;5074.2895994560795;5075.746212689424;5934.347221805598;5964.1650168976375;6014.939850601438;6048.213732214872;6064.545159112996;4815.929150465264;5010.991207034358;5011.123053465629;5024.397072351341;5030.496950305013;3162.6521082681347;3183.42698314301;3195.785601471426;3197.7441804655573;3200.1839530919465;5414.8104816332025;5491.803278688557;5572.58205634579;5594.496495315441;5598.552115830724;6124.35694252106;6145.262568491809;6149.354317796657;6172.98145805937;6188.4739797117745;5393.2179833923865;5562.221289019541;5566.972165139148;5584.732931235273;5588.524975377139;5998.880022399615;6042.123892035543;6068;6075.149479072845;6088.178095957166;5826.184334193301;5951.976328048311;5967.8209653710455;5970.880582388415;6025.939740602538;5583.106702927512;5598.776048957996;5612.522935550524;5614.691191984317;5631.465010823965;4603.6777425579885;4645.558671926162;4647.5135802345585;4649.86050418488;4657.697249678896;5943.881122377442;6043.189916688761;6075.969620152047;6085.847853803691;6111.938880611137;5885.264341957255;5886.911696324473;5901.616394934315;5902.468777810018;5910.734016969161;5695.601307908572;5825.737841797045;5879.735411906389;5893.675847828239;5899.952548637681;5765.798197063083;5772.422757724194;5795.130730390475;5801.6519008859605;5816.883662326814;5792.507636850914;5924.31870334917;5926.259217597801;5940.584159108821;5947.881042379215;5713.228714123707;5722.4277572242445;5729.713514324184;5734.168545560787;5749.683767392834 10:10:08 INFO - PID 10131 | |5;yui.html;653.225927276178;678.4674030885752;734.5886303669945;749.816295007723;764.9196834332395;11354.091672666187;11852;11909.166358354907;12517.248965062103;12538.122331436804;14083.718325633481;14086.225257610828;14567.271636418163;14569.053011554268;14611.269436528157;827.5862068965503;836.3184005035906;838.4131108224237;844.1600607395619;845.8731190321439;899.6671231644301;905.741863568883;905.7916679163797;906.0169715858302;906.9274458043341;900.3967341880956;902.0708670069838;911.2527727263647;911.9361644684875;951.6621599332241;894.789724414762;895.2032690905099;900.4867225681331;902.1114202510522;947.1712251779693;661.305629089459;664.9534532582721;667.7596065416446;684.565301033847;701.176118061281;12168.148229623841;12372.62882113538;12448.439820208112;13554.93222533881;13790.65523361914;15338.769918451233;15516.379344826193;15818.209089545477;15902;15946.20268986546;12288.877111228863;12422.875771242263;12537.185082969578;12581.496740130384;12621.368931553385;2760.3789147441867;2784.860756962164;2800.8739606717745;2810.269329974201;2820.957685634717;67207;67222;67564;68412.1849642781;69692;10454.843177352346;10560.2079844012;10587.205959553065;10630.149588032938;10685.252032357661;17234.224459899084;17306.826931730775;17449.302027918995;17688.91155544214;17745.645087098444;5481.890362192814;6339.461145802658;6500;6580.703868325937;6588.143541339595;2840.8721607527295;2891.349446374591;2893.884244630191;2903.346746981912;2910.9126726198247;3453.9654603454146;3521.260535287567;3538.628444013393;3540.5751309842985;3556.270964452281;725.9165196002527;730.6164263761568;733.1312394812164;737.3584981066507;737.5390381011867;496.5258178439582;525.1649876695996;526.18178732072;528.4161002092709;531.7713383245165;8905.910940890508;9154.496502692416;9356.157945784911;9589.328746987643;9823.950880245553;582.6969975612658;588.7556663984399;595.3510673366052;600.1957377114687;609.3906093906094;4097.160082183145;4131.710780245354;4135.152293779768;4152.5432202457705;4171.561985991488;61868.69065654733;62401.68799156066;62681.68659156675;62718.68640656768;62973.68513157405;57824;58114;58594.41405585975;58728.70635646794;58947;50764.49235507671;52224.216636750476;52319.738401307746;52625.7368713154;53089.2036619451;8330.208630180123;8342.708005219789;8415.200555947175;8504.44721093127;8513.616887239965;26598.335041624116;27618.5857212146;27750.722492774814;28203;28923;32278;33135.668643314224;33691.15772105717;33965;34659.13352166216;11758.764824703629;11966.880331196577;12037.45831437605;12120.151589388659;12185.207961482829;15210.391584336503;16118.435854745028;16137.515874523782;16145.919270404043;16167.676646466769;13893.305334733424;13968.231747253998;14092.084014539023;14313.57059288223;14346.713065738835;14158.079724817853;14226.50207242783;14680.192589407257;14821.851781482048;14892;12967.925131978838;14002.57992260234;14193.645158871112;14433.711325773216;14589.197594132;10607.787844243227;10719.678409647722;10765;10910;11163.051140652811;11580.189386742848;12066.336351500751;12264.816027759769;12313.50745970187;12356.320402377956 10:10:08 INFO - PID 10131 | __end_tp_report 10:10:08 INFO - PID 10131 | __start_cc_report 10:10:08 INFO - PID 10131 | _x_x_mozilla_cycle_collect,283 10:10:08 INFO - PID 10131 | __end_cc_report 10:10:08 INFO - PID 10131 | __startTimestamp1494781807999__endTimestamp 10:10:08 INFO - PID 10131 | 10:10:08 INFO - PID 10131 | ------- Summary: start ------- 10:10:08 INFO - PID 10131 | Number of tests: 6 10:10:08 INFO - PID 10131 | 10:10:08 INFO - PID 10131 | [#0] dojo.html Cycles:165 Average:5264.91 Median:5408.13 stddev:616.99 (11.4%) stddev-sans-first:585.99 10:10:08 INFO - PID 10131 | Values: 2731.2 2746.3 2759.5 2767.9 2784.8 5258.7 5324.3 5332.5 5357.9 5374.8 5324.6 5339.4 5408.1 5411.8 5434.8 4693.1 4701.6 4719.6 4775.8 4790.5 4706.5 4770.1 4815.9 4816.2 4852.5 4654.7 4755.0 4785.5 4804.1 4811.5 4691.9 4707.7 4733.9 4767.7 4797.4 4630.1 4685.1 4685.7 4705.1 4778.0 5334.4 5334.6 5347.6 5359.7 5384.3 5689.0 5718.3 5766.1 5822.6 5847.8 5825.0 5826.9 5827.3 5831.2 5877.2 5367.8 5385.8 5388.4 5390.2 5391.4 5757.5 5803.6 5848.2 5859.6 5942.8 5609.2 5610.3 5612.7 5616.2 5671.7 5657.9 5725.5 5726.7 5774.7 5851.8 5739.2 5745.6 5764.9 5791.9 5801.7 5710.3 5712.5 5715.4 5732.1 5758.7 4762.4 4830.2 4838.1 4839.2 4909.0 4174.9 4180.0 4208.5 4211.4 4277.0 4880.9 4922.6 4925.0 4928.5 4984.2 5705.8 5792.5 5792.8 5853.7 5860.0 4850.6 4871.0 4873.3 4873.9 4884.2 5118.0 5146.5 5148.2 5156.5 5164.3 5303.4 5308.4 5320.2 5321.4 5344.2 5707.1 5713.1 5714.6 5715.2 5735.7 5276.8 5332.0 5335.8 5341.3 5342.2 5675.5 5708.6 5745.3 5765.3 5768.3 5731.0 5732.5 5740.0 5754.5 5757.5 5522.0 5544.5 5549.2 5569.9 5573.5 5577.1 5582.4 5666.3 5667.6 5677.3 5524.2 5528.0 5549.7 5556.0 5578.0 5577.7 5632.7 5652.2 5695.3 5705.4 5409.7 5477.7 5489.5 5495.3 5508.0 10:10:08 INFO - PID 10131 | 10:10:08 INFO - PID 10131 | [#1] ext.html Cycles:180 Average:31275.40 Median:31563.18 stddev:43251.96 (137.0%) stddev-sans-first:43312.33 10:10:08 INFO - PID 10131 | Values: 691.7 734.1 756.7 1055.6 1068.5 32391.5 33217.7 33287.0 33412.2 33418.7 34428.3 34717.5 34863.3 34905.8 35021.3 6681.6 6716.8 6841.1 6845.3 6868.6 6738.2 6765.5 6854.0 6856.2 6867.3 6811.1 6883.1 6892.5 6896.8 6901.9 6808.6 6824.5 6838.0 6853.4 6867.6 6773.0 6819.7 6833.0 6845.5 6868.1 31584.7 31667.0 31748.4 31832.5 31839.0 2952.9 3005.3 3006.2 3007.6 3009.0 24091.9 24132.4 24184.2 24282.2 24455.3 3043.7 3094.7 3098.6 3102.0 3129.2 143645.0 144232.0 156973.2 157508.0 158857.0 39185.8 39241.6 39324.4 39348.4 39387.0 40877.6 40998.0 41070.4 41159.4 41409.8 11686.3 11769.2 11769.3 11859.3 11878.2 9351.8 9460.7 9475.3 9485.6 9517.5 12359.9 12381.4 12454.7 12512.7 12646.7 5364.5 5465.5 5465.8 5471.2 5508.1 832.8 854.9 870.2 884.4 886.4 18578.9 18678.8 18724.6 19538.4 19671.3 936.2 936.9 940.2 940.6 960.8 10100.4 10156.6 10183.8 14061.4 14747.6 182008.0 182282.0 182717.0 183230.0 183503.0 43476.1 43562.3 43607.3 43791.3 43868.3 1156.4 1189.7 1195.8 1207.6 1209.9 24028.8 24258.3 24626.9 25013.2 25055.5 29681.9 36287.1 37179.0 37235.4 37295.6 164965.0 165009.0 165779.0 166286.0 166809.0 29420.4 29542.1 29797.0 29912.4 30402.5 34880.8 35815.8 35929.5 36143.1 36414.0 27199.7 27610.0 27682.0 27717.6 28438.9 27789.0 28106.3 28142.0 28192.4 29643.0 31364.4 31423.7 31541.7 31686.4 31716.2 26794.7 26984.7 27098.9 27445.7 28601.4 21268.0 22312.9 22387.4 22463.6 22614.0 10:10:08 INFO - PID 10131 | 10:10:08 INFO - PID 10131 | [#2] jquery.html Cycles:180 Average:24927.18 Median:206926.31 stddev:62698.01 (30.3%) stddev-sans-first:62846.86 10:10:08 INFO - PID 10131 | Values: 404.9 412.4 417.8 428.8 439.7 14063.0 17028.8 17873.6 17881.3 17893.6 18189.4 18269.9 18387.7 18522.7 18554.9 5417.2 5422.5 5622.9 5678.9 5695.3 5502.6 5603.1 5636.3 5638.4 5673.8 5424.5 5471.0 5483.5 5516.9 5621.5 5531.9 5545.5 5627.2 5636.7 5641.0 4875.9 4939.7 4983.7 4990.3 4992.4 21167.4 21328.0 21328.0 21379.3 21495.7 1518.4 1617.9 1638.8 1641.8 1663.8 14603.3 14627.5 14633.4 14791.2 14844.8 2071.2 2115.2 2144.7 2156.2 2162.0 87392.0 88560.0 90830.5 91141.0 92475.0 10650.9 10727.6 10778.8 10877.9 10954.5 14686.9 14961.7 15049.2 15052.2 15093.2 7329.1 7348.0 7358.9 7525.7 7549.2 6658.5 6659.7 6841.7 6862.3 6876.3 6670.5 6850.3 6858.3 6943.9 7036.9 1925.2 1927.9 1941.2 1943.3 1988.5 794.9 825.1 828.9 846.4 859.7 15114.4 15349.0 15422.5 15662.3 15884.1 801.9 819.5 832.9 842.4 858.8 8127.4 8424.8 8562.9 8616.0 8666.8 369169.0 370245.0 375677.0 383360.0 384273.0 75318.6 76943.2 77197.6 77314.2 80210.0 979.8 1011.6 1015.5 1021.3 1022.9 12962.2 13329.3 13465.1 13831.2 13833.3 36126.8 36800.4 36855.3 37537.8 38175.6 48912.0 49445.8 51102.0 51154.0 51238.6 8204.5 8295.2 8352.3 8410.2 8490.6 12592.4 12971.5 13236.5 13285.5 13563.7 10746.3 10869.6 10923.3 10997.4 11255.1 10615.6 10851.5 10931.6 10966.6 11255.5 10841.8 10908.2 11158.3 11481.2 11801.0 8086.6 8217.3 8406.1 8411.8 8487.7 11054.0 11172.9 11228.7 11277.2 11678.7 10:10:08 INFO - PID 10131 | 10:10:08 INFO - PID 10131 | [#3] mootools.html Cycles:180 Average:6401.68 Median:3700.35 stddev:4161.16 (112.5%) stddev-sans-first:4155.07 10:10:08 INFO - PID 10131 | Values: 1285.1 1319.4 1331.9 1345.3 1355.1 9716.2 10147.3 10197.5 10420.6 10504.7 10657.9 10804.9 10824.3 10830.2 10846.0 2248.8 2282.9 2285.9 2291.5 2299.9 2257.4 2290.9 2315.0 2318.5 2322.5 2289.8 2291.0 2327.2 2331.3 2337.0 2189.3 2226.4 2269.7 2284.0 2304.6 2119.1 2232.6 2232.9 2257.8 2261.5 10312.2 10422.3 10435.8 10436.3 10437.6 5709.0 5915.8 5920.1 5926.3 5933.3 3147.6 3309.1 3387.3 3401.9 3404.0 1034.3 1060.5 1075.2 1099.1 1104.8 15220.2 15252.6 15305.0 15412.2 15413.3 4671.0 4847.2 5052.0 5069.2 5091.2 11074.9 11091.5 11118.7 11181.7 11187.9 5622.3 5645.0 5651.9 5674.1 5690.9 5148.6 5239.9 5290.4 5299.9 5378.4 3691.6 3794.0 3846.7 3915.5 4000.0 1119.6 1130.1 1136.5 1137.4 1145.4 620.9 643.3 670.7 672.5 680.1 5507.1 5599.5 5656.3 5669.8 5828.4 543.3 545.9 547.9 556.3 559.3 3547.9 3709.1 3726.3 3914.7 3935.7 13309.2 13611.3 13831.2 13857.8 13920.4 13619.5 13857.4 13875.8 13888.7 13916.7 7642.8 7901.4 8008.8 8028.2 8032.1 5863.4 5985.1 6022.5 6088.6 6261.5 12027.3 12153.4 12192.7 12492.3 12492.4 12638.9 12657.6 12668.8 12821.0 12884.5 7605.1 7615.8 7692.9 7788.6 7805.6 9579.0 9659.8 9740.0 9763.0 9775.8 7794.8 7968.0 8026.4 8119.9 8247.0 7750.8 7885.6 7918.8 7938.9 8027.4 7240.2 7340.4 7423.8 7432.9 7440.6 5102.3 5200.9 5216.7 5426.1 5448.7 5399.5 5648.4 5650.3 5732.9 5735.0 10:10:08 INFO - PID 10131 | 10:10:08 INFO - PID 10131 | [#4] prototype.html Cycles:180 Average:4788.41 Median:5416.51 stddev:1430.71 (26.4%) stddev-sans-first:1395.99 10:10:08 INFO - PID 10131 | Values: 383.2 383.3 389.3 390.3 393.8 5385.8 5507.3 5508.2 5526.1 5608.2 5326.2 5372.5 5399.3 5418.2 5426.4 3994.2 4085.7 4091.3 4116.3 4120.6 4079.7 4101.8 4103.4 4117.4 4120.4 4073.5 4089.6 4091.7 4093.9 4099.8 3976.2 4000.9 4050.4 4075.7 4081.0 3519.9 3544.9 3554.2 3557.0 3557.1 5320.2 5334.6 5345.6 5347.0 5360.3 4740.1 4805.6 4817.4 4828.3 4829.4 5721.9 5768.3 5793.8 5796.4 5815.6 3959.5 3979.2 4004.6 4005.4 4011.4 6017.8 6069.7 6103.5 6159.1 6177.0 4106.1 4109.2 4110.8 4115.5 4119.2 4152.8 4156.6 4162.2 4178.4 4188.6 4720.7 4830.8 4847.5 4848.4 4849.6 5792.1 5818.8 5819.8 5823.1 5831.2 1414.8 1426.3 1435.9 1436.9 1437.9 903.7 956.3 957.1 964.0 970.7 5016.7 5040.7 5052.3 5074.3 5075.7 5934.3 5964.2 6014.9 6048.2 6064.5 4815.9 5011.0 5011.1 5024.4 5030.5 3162.7 3183.4 3195.8 3197.7 3200.2 5414.8 5491.8 5572.6 5594.5 5598.6 6124.4 6145.3 6149.4 6173.0 6188.5 5393.2 5562.2 5567.0 5584.7 5588.5 5998.9 6042.1 6068.0 6075.1 6088.2 5826.2 5952.0 5967.8 5970.9 6025.9 5583.1 5598.8 5612.5 5614.7 5631.5 4603.7 4645.6 4647.5 4649.9 4657.7 5943.9 6043.2 6076.0 6085.8 6111.9 5885.3 5886.9 5901.6 5902.5 5910.7 5695.6 5825.7 5879.7 5893.7 5900.0 5765.8 5772.4 5795.1 5801.7 5816.9 5792.5 5924.3 5926.3 5940.6 5947.9 5713.2 5722.4 5729.7 5734.2 5749.7 10:10:08 INFO - PID 10131 | 10:10:08 INFO - PID 10131 | [#5] yui.html Cycles:180 Average:14888.31 Median:19090.20 stddev:17891.59 (93.7%) stddev-sans-first:17909.85 10:10:08 INFO - PID 10131 | Values: 653.2 678.5 734.6 749.8 764.9 11354.1 11852.0 11909.2 12517.2 12538.1 14083.7 14086.2 14567.3 14569.1 14611.3 827.6 836.3 838.4 844.2 845.9 899.7 905.7 905.8 906.0 906.9 900.4 902.1 911.3 911.9 951.7 894.8 895.2 900.5 902.1 947.2 661.3 665.0 667.8 684.6 701.2 12168.1 12372.6 12448.4 13554.9 13790.7 15338.8 15516.4 15818.2 15902.0 15946.2 12288.9 12422.9 12537.2 12581.5 12621.4 2760.4 2784.9 2800.9 2810.3 2821.0 67207.0 67222.0 67564.0 68412.2 69692.0 10454.8 10560.2 10587.2 10630.1 10685.3 17234.2 17306.8 17449.3 17688.9 17745.6 5481.9 6339.5 6500.0 6580.7 6588.1 2840.9 2891.3 2893.9 2903.3 2910.9 3454.0 3521.3 3538.6 3540.6 3556.3 725.9 730.6 733.1 737.4 737.5 496.5 525.2 526.2 528.4 531.8 8905.9 9154.5 9356.2 9589.3 9824.0 582.7 588.8 595.4 600.2 609.4 4097.2 4131.7 4135.2 4152.5 4171.6 61868.7 62401.7 62681.7 62718.7 62973.7 57824.0 58114.0 58594.4 58728.7 58947.0 50764.5 52224.2 52319.7 52625.7 53089.2 8330.2 8342.7 8415.2 8504.4 8513.6 26598.3 27618.6 27750.7 28203.0 28923.0 32278.0 33135.7 33691.2 33965.0 34659.1 11758.8 11966.9 12037.5 12120.2 12185.2 15210.4 16118.4 16137.5 16145.9 16167.7 13893.3 13968.2 14092.1 14313.6 14346.7 14158.1 14226.5 14680.2 14821.9 14892.0 12967.9 14002.6 14193.6 14433.7 14589.2 10607.8 10719.7 10765.0 10910.0 11163.1 11580.2 12066.3 12264.8 12313.5 12356.3 10:10:08 INFO - PID 10131 | -------- Summary: end -------- 10:10:08 INFO - PID 10131 | 10:10:08 INFO - TEST-INFO | 10131: exit 0 10:10:08 INFO - TEST-OK | dromaeo_css | took 1119290ms 10:10:08 INFO - TEST-START | kraken 10:10:08 INFO - operating with platform_type : linux_ 10:10:08 INFO - Initialising browser for kraken test... 10:10:08 INFO - TEST-INFO | started process 10542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1SBJuW/profile http://localhost:56081/getInfo.html) 10:10:09 INFO - PID 10542 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 10:10:12 INFO - PID 10542 | __metrics Screen width/height:1600/1200 10:10:12 INFO - PID 10542 | colorDepth:24 10:10:12 INFO - PID 10542 | Browser inner width/height: 1024/695 10:10:12 INFO - PID 10542 | __metrics 10:10:14 INFO - TEST-INFO | 10542: exit 0 10:10:14 INFO - Browser initialized. 10:10:14 INFO - Running cycle 1/1 for kraken test... 10:10:14 INFO - TEST-INFO | started process 10717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1SBJuW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:26 INFO - PID 10717 | RSS: Main: 161804288 10:10:26 INFO - PID 10717 | 10:10:28 INFO - PID 10717 | Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56081/tests/kraken/driver.html?testName=audio-beat-detection) 10:10:29 INFO - PID 10717 | RSS: Main: 167378944 10:10:29 INFO - PID 10717 | 10:10:32 INFO - PID 10717 | Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56081/tests/kraken/driver.html?testName=audio-dft) 10:10:33 INFO - PID 10717 | RSS: Main: 166051840 10:10:33 INFO - PID 10717 | 10:10:36 INFO - PID 10717 | Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56081/tests/kraken/driver.html?testName=audio-fft) 10:10:36 INFO - PID 10717 | RSS: Main: 161837056 10:10:36 INFO - PID 10717 | 10:10:38 INFO - PID 10717 | Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56081/tests/kraken/driver.html?testName=audio-oscillator) 10:10:39 INFO - PID 10717 | RSS: Main: 162385920 10:10:39 INFO - PID 10717 | 10:10:41 INFO - PID 10717 | Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56081/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:10:42 INFO - PID 10717 | RSS: Main: 162590720 10:10:42 INFO - PID 10717 | 10:10:45 INFO - PID 10717 | Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56081/tests/kraken/driver.html?testName=imaging-darkroom) 10:10:45 INFO - PID 10717 | RSS: Main: 167313408 10:10:45 INFO - PID 10717 | 10:10:49 INFO - PID 10717 | Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56081/tests/kraken/driver.html?testName=imaging-desaturate) 10:10:50 INFO - PID 10717 | RSS: Main: 165134336 10:10:50 INFO - PID 10717 | 10:10:52 INFO - PID 10717 | Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56081/tests/kraken/driver.html?testName=json-parse-financial) 10:10:53 INFO - PID 10717 | RSS: Main: 165715968 10:10:53 INFO - PID 10717 | 10:10:55 INFO - PID 10717 | Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56081/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:10:55 INFO - PID 10717 | RSS: Main: 165593088 10:10:55 INFO - PID 10717 | 10:10:57 INFO - PID 10717 | Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:10:58 INFO - PID 10717 | RSS: Main: 165523456 10:10:58 INFO - PID 10717 | 10:11:00 INFO - PID 10717 | Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:01 INFO - PID 10717 | RSS: Main: 165416960 10:11:01 INFO - PID 10717 | 10:11:03 INFO - PID 10717 | Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:04 INFO - PID 10717 | RSS: Main: 165494784 10:11:04 INFO - PID 10717 | 10:11:07 INFO - PID 10717 | Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:08 INFO - PID 10717 | RSS: Main: 165642240 10:11:08 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56081/tests/kraken/driver.html?testName=ai-astar) 10:11:10 INFO - PID 10717 | RSS: Main: 166666240 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | __start_tp_report 10:11:10 INFO - PID 10717 | _x_x_mozilla_page_load 10:11:10 INFO - PID 10717 | _x_x_mozilla_page_load_details 10:11:10 INFO - PID 10717 | |i|pagename|runs| 10:11:10 INFO - PID 10717 | |0;ai-astar;103;113;111;111;113;111;112;111;114;113 10:11:10 INFO - PID 10717 | |1;audio-beat-detection;154;123;125;169;124;130;125;124;144;124 10:11:10 INFO - PID 10717 | |2;audio-dft;165;166;166;166;165;164;166;181;165;166 10:11:10 INFO - PID 10717 | |3;audio-fft;75;78;78;110;77;76;75;76;98;77 10:11:10 INFO - PID 10717 | |4;audio-oscillator;84;84;112;85;84;83;96;84;84;107 10:11:10 INFO - PID 10717 | |5;imaging-gaussian-blur;114;114;115;114;115;114;115;114;113;116 10:11:10 INFO - PID 10717 | |6;imaging-darkroom;150;151;150;151;152;151;152;151;152;150 10:11:10 INFO - PID 10717 | |7;imaging-desaturate;94;97;95;94;94;95;94;95;95;95 10:11:10 INFO - PID 10717 | |8;json-parse-financial;57;57;56;56;58;56;56;56;57;58 10:11:10 INFO - PID 10717 | |9;json-stringify-tinderbox;55;56;56;56;56;55;56;55;55;55 10:11:10 INFO - PID 10717 | |10;stanford-crypto-aes;83;83;82;83;82;83;82;83;81;81 10:11:10 INFO - PID 10717 | |11;stanford-crypto-ccm;146;130;133;133;140;137;134;136;185;139 10:11:10 INFO - PID 10717 | |12;stanford-crypto-pbkdf2;184;198;194;192;187;193;202;193;189;205 10:11:10 INFO - PID 10717 | |13;stanford-crypto-sha256-iterative;75;74;73;76;74;74;71;77;74;84 10:11:10 INFO - PID 10717 | __end_tp_report 10:11:10 INFO - PID 10717 | __start_cc_report 10:11:10 INFO - PID 10717 | _x_x_mozilla_cycle_collect,785 10:11:10 INFO - PID 10717 | __end_cc_report 10:11:10 INFO - PID 10717 | __startTimestamp1494781870436__endTimestamp 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | ------- Summary: start ------- 10:11:10 INFO - PID 10717 | Number of tests: 14 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.50 stddev:3.08 (2.7%) stddev-sans-first:1.17 10:11:10 INFO - PID 10717 | Values: 103.0 113.0 111.0 111.0 113.0 111.0 112.0 111.0 114.0 113.0 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:127.50 stddev:16.07 (12.6%) stddev-sans-first:15.36 10:11:10 INFO - PID 10717 | Values: 154.0 123.0 125.0 169.0 124.0 130.0 125.0 124.0 144.0 124.0 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | [#2] audio-dft Cycles:10 Average:167.00 Median:166.00 stddev:4.97 (3.0%) stddev-sans-first:5.21 10:11:10 INFO - PID 10717 | Values: 165.0 166.0 166.0 166.0 165.0 164.0 166.0 181.0 165.0 166.0 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | [#3] audio-fft Cycles:10 Average:82.00 Median:77.00 stddev:11.98 (15.6%) stddev-sans-first:12.44 10:11:10 INFO - PID 10717 | Values: 75.0 78.0 78.0 110.0 77.0 76.0 75.0 76.0 98.0 77.0 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:84.00 stddev:10.86 (12.9%) stddev-sans-first:11.28 10:11:10 INFO - PID 10717 | Values: 84.0 84.0 112.0 85.0 84.0 83.0 96.0 84.0 84.0 107.0 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 10:11:10 INFO - PID 10717 | Values: 114.0 114.0 115.0 114.0 115.0 114.0 115.0 114.0 113.0 116.0 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 10:11:10 INFO - PID 10717 | Values: 150.0 151.0 150.0 151.0 152.0 151.0 152.0 151.0 152.0 150.0 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 10:11:10 INFO - PID 10717 | Values: 94.0 97.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 10:11:10 INFO - PID 10717 | Values: 57.0 57.0 56.0 56.0 58.0 56.0 56.0 56.0 57.0 58.0 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:56.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 10:11:10 INFO - PID 10717 | Values: 55.0 56.0 56.0 56.0 56.0 55.0 56.0 55.0 55.0 55.0 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 10:11:10 INFO - PID 10717 | Values: 83.0 83.0 82.0 83.0 82.0 83.0 82.0 83.0 81.0 81.0 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:138.00 stddev:16.00 (11.6%) stddev-sans-first:16.88 10:11:10 INFO - PID 10717 | Values: 146.0 130.0 133.0 133.0 140.0 137.0 134.0 136.0 185.0 139.0 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.70 Median:193.50 stddev:6.50 (3.4%) stddev-sans-first:5.87 10:11:10 INFO - PID 10717 | Values: 184.0 198.0 194.0 192.0 187.0 193.0 202.0 193.0 189.0 205.0 10:11:10 INFO - PID 10717 | 10:11:10 INFO - PID 10717 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:74.50 stddev:3.49 (4.7%) stddev-sans-first:3.70 10:11:10 INFO - PID 10717 | Values: 75.0 74.0 73.0 76.0 74.0 74.0 71.0 77.0 74.0 84.0 10:11:10 INFO - PID 10717 | -------- Summary: end -------- 10:11:10 INFO - PID 10717 | 10:11:11 INFO - TEST-INFO | 10717: exit 0 10:11:11 INFO - TEST-OK | kraken | took 62709ms 10:11:11 INFO - SUITE-END | took 1182s 10:11:11 INFO - Completed test suite (00:19:42) 10:11:11 INFO - javascript benchmark 10:11:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6694.624122166529, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2731.1942976821833, 2746.3134216445887, 2759.4619049285398, 2767.944641107178, 2784.777217822573, 5258.710770907599, 5324.254604355388, 5332.493413125757, 5357.928414317143, 5374.785008599656, 5324.600654950875, 5339.439358867321, 5408.134698448259, 5411.783528658849, 5434.7826086956475, 4693.108309421199, 4701.600363969067, 4719.575238228559, 4775.761211939406, 4790.496997815231, 4706.458757242909, 4770.0936822003705, 4815.927761083569, 4816.157172494817, 4852.514748525137, 4654.674172807905, 4754.952450475485, 4785.497522760095, 4804.1352556539805, 4811.4707382187935, 4691.859244222679, 4707.7175369477945, 4733.928991065137, 4767.666263361566, 4797.40032495938, 4630.097131059445, 4685.0629874025335, 4685.672002959795, 4705.106029854351, 4778.0, 5334.439883812182, 5334.639666884958, 5347.598930080259, 5359.705216213107, 5384.326959130109, 5688.97155514224, 5718.34239062509, 5766.135079738031, 5822.592418530662, 5847.795327163529, 5825.038868586678, 5826.854328641775, 5827.3298570664065, 5831.154482600042, 5877.177195192677, 5367.838964831061, 5385.78456861729, 5388.407275199725, 5390.245365648812, 5391.433899440581, 5757.539396848242, 5803.564732644984, 5848.210491583582, 5859.560532960045, 5942.821715348547, 5609.186667933127, 5610.298712660918, 5612.719364031864, 5616.185653080281, 5671.688057156814, 5657.858553536194, 5725.456081672234, 5726.742296596663, 5774.653520788766, 5851.765929362778, 5739.2252045973255, 5745.569082318842, 5764.913526297025, 5791.942080579224, 5801.7099145042575, 5710.257666503411, 5712.514436272963, 5715.428457154335, 5732.082866741302, 5758.654480731169, 4762.404699412574, 4830.154722923475, 4838.104950584153, 4839.153148199051, 4909.0, 4174.91650167001, 4180.038591124058, 4208.494980602347, 4211.410402543646, 4276.957230427656, 4880.8779780505065, 4922.630802689812, 4925.0, 4928.531789479994, 4984.152694042022, 5705.800296989585, 5792.536597072309, 5792.82621521355, 5853.678047707417, 5860.033094539439, 4850.6362022848425, 4870.975645121752, 4873.293372460973, 4873.926891096637, 4884.169691152512, 5117.974410127926, 5146.485351464824, 5148.150555158357, 5156.458571849977, 5164.2770012198325, 5303.443138470405, 5308.442613525602, 5320.228566857862, 5321.441248668834, 5344.225087362233, 5707.086866101404, 5713.143028545752, 5714.628549144292, 5715.171300161536, 5735.713214339183, 5276.762545685377, 5331.973340133274, 5335.786568537215, 5341.305630268041, 5342.171963345688, 5675.489205971482, 5708.628939118944, 5745.339285982165, 5765.279340082489, 5768.2501274834, 5731.0, 5732.512736417451, 5740.024195886793, 5754.539636829128, 5757.510611598061, 5522.0, 5544.528715059104, 5549.223108764695, 5569.944300556943, 5573.526250268773, 5577.135543990526, 5582.441755824385, 5666.34836993751, 5667.603267771216, 5677.318721753416, 5524.198991146181, 5527.972360138174, 5549.72251387421, 5555.972220138873, 5578.0, 5577.74900129487, 5632.7183640816975, 5652.236948012131, 5695.345035320991, 5705.4009329019855, 5409.675419474844, 5477.72611369422, 5489.478499542537, 5495.2856128703015, 5507.972460137674], "value": 5219.87832563504, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.7475121580621, 734.0713996794054, 756.7313603670697, 1055.6199768083488, 1068.4817863336286, 32391.51412728808, 33217.66782332179, 33287.0, 33412.16469588255, 33418.66581334192, 34428.31143377131, 34717.47923781145, 34863.302733945304, 34905.825470872674, 35021.29957400857, 6681.632510211936, 6716.798496045127, 6841.144856892888, 6845.315468453165, 6868.553544019623, 6738.22510411304, 6765.526413151081, 6853.965730171342, 6856.17725872896, 6867.278935711754, 6811.080504131953, 6883.105196324495, 6892.4830637702125, 6896.793096207121, 6901.896471552931, 6808.59148451092, 6824.488163387716, 6838.042674025641, 6853.383195512428, 6867.622280774555, 6772.966135169342, 6819.659017049128, 6832.965835170792, 6845.520813543054, 6868.107146071029, 31584.684153158403, 31667.0, 31748.365032699447, 31832.522512162337, 31839.044828655176, 2952.8818847246084, 3005.2787331040613, 3006.1733023418515, 3007.624046994126, 3009.0371081254007, 24091.879540602185, 24132.396690082714, 24184.153554625504, 24282.15012474555, 24455.266342009767, 3043.6651968283472, 3094.7214750672547, 3098.597182366278, 3102.0, 3129.202053476372, 143645.0, 144232.0, 156973.21513392474, 157508.0, 158857.0, 39185.80407098003, 39241.6075839238, 39324.41013384802, 39348.40977385284, 39387.0, 40877.59122408797, 40997.97505062397, 41070.38394424086, 41159.38260926089, 41409.79295103505, 11686.298822070534, 11769.176157669051, 11769.293842369314, 11859.34773587461, 11878.227915185658, 9351.802326453279, 9460.668876589287, 9475.289353298393, 9485.573149208301, 9517.524123793783, 12359.938200309121, 12381.380930953417, 12454.688632784253, 12512.68718282032, 12646.683832904251, 5364.463553644682, 5465.508104270635, 5465.808696695596, 5471.206675032098, 5508.091164957737, 832.8417600655856, 854.8974123105143, 870.2124577257592, 884.3544212724619, 886.4371124335964, 18578.88526688403, 18678.81321186798, 18724.625507489774, 19538.413847584594, 19671.311504097575, 936.194872409727, 936.9484678342757, 940.2290122099812, 940.5955439161089, 960.7646126698863, 10100.393976361442, 10156.644517441853, 10183.796324073477, 14061.367238474293, 14747.55757327282, 182008.0, 182282.0, 182717.0, 183230.0, 183503.0, 43476.130477390274, 43562.346564801555, 43607.34588981168, 43791.34312985308, 43868.341974870404, 1156.3697784707354, 1189.6966273600176, 1195.820626905971, 1207.6135636596205, 1209.897158741517, 24028.759712403353, 24258.272251832474, 24626.87686561556, 25013.249602511954, 25055.498890022463, 29681.85159074191, 36287.092822679646, 37179.0, 37235.44146837745, 37295.62704372922, 164965.0, 165009.0, 165779.0, 166286.0, 166809.0, 29420.411591768472, 29542.113736587937, 29797.0, 29912.401751965273, 30402.543961840147, 34880.82559587186, 35815.82092089523, 35929.46105808362, 36143.09642258859, 36414.0, 27199.728002720512, 27610.0, 27682.0, 27717.58423623607, 28438.85780571084, 27789.0, 28106.2973425666, 28142.0, 28192.436151276448, 29643.0, 31364.37271254608, 31423.685763142075, 31541.684583153874, 31686.366272673957, 31716.207094822814, 26794.732052679225, 26984.73015269901, 27098.864505677346, 27445.725542744316, 28601.42797144087, 21268.0, 22312.888435557717, 22387.44031399228, 22463.550728985003, 22614.0], "value": 14590.795681966676, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.86639408995035, 412.3670166294737, 417.80154426647346, 428.7770359413105, 439.6636573021639, 14063.0, 17028.829711702878, 17873.553161170978, 17881.317802329657, 17893.552661183476, 18189.363372281972, 18269.908650456728, 18387.72418413725, 18522.722159167624, 18554.907225463852, 5417.214503896933, 5422.53908417785, 5622.859428514279, 5678.886422271552, 5695.288088988877, 5502.614816962814, 5603.103503439451, 5636.2954630671165, 5638.4361563843695, 5673.8297851064535, 5424.538914192299, 5471.042567550663, 5483.533899618517, 5516.889662206753, 5621.4940655341015, 5531.889362212753, 5545.473180047889, 5627.212190293362, 5636.689982050985, 5641.041023026095, 4875.8781030474165, 4939.703617782944, 4983.6760610560195, 4990.326305948687, 4992.425871024806, 21167.364979050653, 21328.0, 21328.0, 21379.251726189665, 21495.677564836384, 1518.3622878390993, 1617.8867479276455, 1638.7541868719668, 1641.8440248176523, 1663.8336166383385, 14603.269836508132, 14627.488037918622, 14633.414663413558, 14791.186484743443, 14844.777328340084, 2071.2336435518955, 2115.206797450956, 2144.667576525641, 2156.2453141400542, 2161.9891900540397, 87392.0, 88560.0, 90830.545847271, 91140.99999999933, 92475.0, 10650.946745266225, 10727.624533141303, 10778.838317425245, 10877.891221087846, 10954.452277386259, 14686.92656536732, 14961.700765984619, 15049.247537623076, 15052.247387630574, 15093.169875656944, 7329.083864516935, 7347.963260183772, 7358.926410735931, 7525.736599219001, 7549.169591344948, 6658.500612454085, 6659.700313485905, 6841.692123854438, 6862.313768623198, 6876.346747059021, 6670.465792867668, 6850.349216824394, 6858.3141685831015, 6943.930560694429, 7036.894446583306, 1925.1914196037417, 1927.9421617351502, 1941.1847024249848, 1943.2518480385154, 1988.4829944214318, 794.9244821741926, 825.0800357601231, 828.9005319361595, 846.3948276981987, 859.6561375449745, 15114.395424182909, 15349.0, 15422.460213892684, 15662.295196716175, 15884.126373049594, 801.9157988411133, 819.5041999590281, 832.862577674689, 842.3808500751942, 858.8239410920871, 8127.390445716476, 8424.831503369898, 8562.914370856211, 8615.956920215483, 8666.848757231917, 369169.0, 370245.0, 375677.0, 383360.0, 384273.0, 75318.62340688371, 76943.23056769361, 77197.61401192957, 77314.22685773183, 80210.0, 979.8481235408523, 1011.5650270383659, 1015.4821041269006, 1021.2595867995643, 1022.9488525573692, 12962.157459765462, 13329.266890321125, 13465.124766890121, 13831.170129792245, 13833.30833458303, 36126.819365903, 36800.44799328066, 36855.26289474249, 37537.81231093827, 38175.6182438172, 48912.0, 49445.752771235915, 51102.0, 51154.0, 51238.64533471892, 8204.548749818818, 8295.211954864279, 8352.329534093327, 8410.243078122998, 8490.61792219364, 12592.370381480707, 12971.481140754264, 13236.470541178245, 13285.535006274735, 13563.660908476972, 10746.301490403099, 10869.619563315246, 10923.344599324066, 10997.395143267197, 11255.099592032453, 10615.628453004416, 10851.511681974487, 10931.617393391192, 10966.561337546409, 11255.549778008788, 10841.837372439577, 10908.181886358714, 11158.330500170016, 11481.196316257781, 11801.0, 8086.636101375335, 8217.342612590859, 8406.07533171363, 8411.803514664389, 8487.745367638981, 11054.0, 11172.888271117185, 11228.719282017688, 11277.210595258253, 11678.70803229926], "value": 8683.015483380139, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.0940087238498, 1319.4062671797687, 1331.8734720201578, 1345.273552281768, 1355.0988592585927, 9716.174125199357, 10147.289689721712, 10197.490125493723, 10420.583176672942, 10504.737381565446, 10657.893421065786, 10804.945975270113, 10824.296420732648, 10830.241883068189, 10846.0, 2248.7976082152563, 2282.897269622871, 2285.90856365746, 2291.4761683480465, 2299.850509716863, 2257.413072601119, 2290.931272061841, 2315.0, 2318.5362927414585, 2322.500662357593, 2289.7710228977135, 2291.0377641390655, 2327.173853282086, 2331.277304035746, 2337.0301324950124, 2189.3431970408815, 2226.3543572363997, 2269.693591365178, 2283.9657405138937, 2304.5736538740302, 2119.088791819517, 2232.6427771556637, 2232.9218477353215, 2257.7855103765114, 2261.547690461914, 10312.226583006304, 10422.270441069128, 10435.791284174275, 10436.269461137723, 10437.634682786065, 5708.97145514274, 5915.763369465216, 5920.111983202511, 5926.348101708852, 5933.317668468138, 3147.590813194293, 3309.073459431363, 3387.305602351512, 3401.880934167317, 3404.0468668772783, 1034.332855308322, 1060.533365319257, 1075.2204651627585, 1099.1042300525046, 1104.845321654969, 15220.238988050663, 15252.618684532865, 15305.0, 15412.152331621757, 15413.306401211972, 4670.976645116821, 4847.224444088929, 5052.0, 5069.214271787879, 5091.159958606789, 11074.889251107386, 11091.500882460308, 11118.666440006813, 11181.664550063511, 11187.888121118847, 5622.269105016322, 5644.971775141098, 5651.886962260732, 5674.148877668383, 5690.857728556819, 5148.56237219833, 5239.947600523946, 5290.418054014055, 5299.920501192485, 5378.408375078817, 3691.5570131583845, 3793.975626580808, 3846.74996125251, 3915.530136383652, 3999.9800000999808, 1119.5521791283388, 1130.0846314485293, 1136.5169802833764, 1137.3517095255625, 1145.4330106597122, 620.8623639384133, 643.3277225299573, 670.7317073170673, 672.5292295393244, 680.1260380411148, 5507.118860982304, 5599.468050535193, 5656.321241451053, 5669.801556945569, 5828.358880523139, 543.3398420918603, 545.8771776350369, 547.8849441617225, 556.349071586245, 559.2785306953983, 3547.858085676544, 3709.1351669509895, 3726.32926073304, 3914.72596918213, 3935.685145188378, 13309.201447913156, 13611.319434028259, 13831.170129792245, 13857.752802247845, 13920.443182272596, 13619.523316683868, 13857.37641806121, 13875.791863122062, 13888.652783680287, 13916.652083697989, 7642.847143057108, 7901.446898717149, 8008.758642410436, 8028.197180282042, 8032.1164671886045, 5863.413658634103, 5985.102234664835, 6022.548308876764, 6088.634681919099, 6261.467775238973, 12027.338496382783, 12153.392330383269, 12192.695182620151, 12492.312922789333, 12492.43784029739, 12638.873611263769, 12657.556985505464, 12668.809967850673, 12821.038422118565, 12884.48462061507, 7605.087389513073, 7615.847683046419, 7692.884606731015, 7788.610569471391, 7805.570693611906, 9578.952105239428, 9659.806803863743, 9740.0, 9763.0, 9775.755606109904, 7794.766157015299, 7968.0438347398685, 8026.357891368793, 8119.918800812153, 8247.0, 7750.806229844299, 7885.6451459685595, 7918.802029949297, 7938.920610793818, 8027.438079334391, 7240.167380751281, 7340.449466290156, 7423.777286681408, 7432.925670743223, 7440.62796860144, 5102.285680004877, 5200.921986170135, 5216.739163041909, 5426.104692725656, 5448.673079615236, 5399.541039011728, 5648.350439699487, 5650.26546548946, 5732.885342293047, 5735.025045742151], "value": 4758.21652407955, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.2163226202416, 383.33108725274366, 389.2701185277605, 390.33253137135495, 393.84443144957754, 5385.838424847261, 5507.2840530731, 5508.201310809935, 5526.143447765598, 5608.186812912136, 5326.227696983935, 5372.516473517392, 5399.325084364455, 5418.214358917954, 5426.403095659474, 3994.1612261425134, 4085.734427262233, 4091.3044782387065, 4116.300228961069, 4120.649744771698, 4079.7348172368847, 4101.774402407867, 4103.384492326145, 4117.402976568395, 4120.423140760296, 4073.494800697579, 4089.5705950875176, 4091.6931230157707, 4093.856715014975, 4099.836006559734, 3976.1848820991627, 4000.879973600797, 4050.3721923101966, 4075.714699971003, 4080.9795951020205, 3519.894403167909, 3544.8936531904083, 3554.1647712787476, 3556.9644303556893, 3557.075160458274, 5320.201969704536, 5334.59990500714, 5345.578829549092, 5346.978956889345, 5360.3299587551555, 4740.146773580754, 4805.639577031737, 4817.445993710733, 4828.299896515021, 4829.3721816164025, 5721.9427805721825, 5768.250127483442, 5793.826185214451, 5796.362400135981, 5815.563832712563, 3959.544652364957, 3979.2240513099955, 4004.5795191504762, 4005.35914253718, 4011.3782363733376, 6017.819465416044, 6069.696515174268, 6103.450689437927, 6159.137720719103, 6177.039157213266, 4106.137711080706, 4109.198706252312, 4110.807865718968, 4115.506139263248, 4119.155573107506, 4152.792360381969, 4156.584341565819, 4162.229987452331, 4178.415021896937, 4188.623023927861, 4720.693154944986, 4830.830920917751, 4847.491013443609, 4848.442429120696, 4849.58778503824, 5792.131180322901, 5818.796342128006, 5819.79630712923, 5823.107490065746, 5831.183634291203, 1414.816073910385, 1426.2939844776695, 1435.9210243436712, 1436.8634979676915, 1437.8777803886787, 903.7153296711515, 956.2636769687441, 957.1433566957534, 963.992627704051, 970.737900766789, 5016.749162541858, 5040.672356296829, 5052.317937078447, 5074.2895994560795, 5075.746212689424, 5934.347221805598, 5964.1650168976375, 6014.939850601438, 6048.213732214872, 6064.545159112996, 4815.929150465264, 5010.991207034358, 5011.123053465629, 5024.397072351341, 5030.496950305013, 3162.6521082681347, 3183.42698314301, 3195.785601471426, 3197.7441804655573, 3200.1839530919465, 5414.8104816332025, 5491.803278688557, 5572.58205634579, 5594.496495315441, 5598.552115830724, 6124.35694252106, 6145.262568491809, 6149.354317796657, 6172.98145805937, 6188.4739797117745, 5393.2179833923865, 5562.221289019541, 5566.972165139148, 5584.732931235273, 5588.524975377139, 5998.880022399615, 6042.123892035543, 6068.0, 6075.149479072845, 6088.178095957166, 5826.184334193301, 5951.976328048311, 5967.8209653710455, 5970.880582388415, 6025.939740602538, 5583.106702927512, 5598.776048957996, 5612.522935550524, 5614.691191984317, 5631.465010823965, 4603.6777425579885, 4645.558671926162, 4647.5135802345585, 4649.86050418488, 4657.697249678896, 5943.881122377442, 6043.189916688761, 6075.969620152047, 6085.847853803691, 6111.938880611137, 5885.264341957255, 5886.911696324473, 5901.616394934315, 5902.468777810018, 5910.734016969161, 5695.601307908572, 5825.737841797045, 5879.735411906389, 5893.675847828239, 5899.952548637681, 5765.798197063083, 5772.422757724194, 5795.130730390475, 5801.6519008859605, 5816.883662326814, 5792.507636850914, 5924.31870334917, 5926.259217597801, 5940.584159108821, 5947.881042379215, 5713.228714123707, 5722.4277572242445, 5729.713514324184, 5734.168545560787, 5749.683767392834], "value": 4345.23865903349, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.225927276178, 678.4674030885752, 734.5886303669945, 749.816295007723, 764.9196834332395, 11354.091672666187, 11852.0, 11909.166358354907, 12517.248965062103, 12538.122331436804, 14083.718325633481, 14086.225257610828, 14567.271636418163, 14569.053011554268, 14611.269436528157, 827.5862068965503, 836.3184005035906, 838.4131108224237, 844.1600607395619, 845.8731190321439, 899.6671231644301, 905.741863568883, 905.7916679163797, 906.0169715858302, 906.9274458043341, 900.3967341880956, 902.0708670069838, 911.2527727263647, 911.9361644684875, 951.6621599332241, 894.789724414762, 895.2032690905099, 900.4867225681331, 902.1114202510522, 947.1712251779693, 661.305629089459, 664.9534532582721, 667.7596065416446, 684.565301033847, 701.176118061281, 12168.148229623841, 12372.62882113538, 12448.439820208112, 13554.93222533881, 13790.65523361914, 15338.769918451233, 15516.379344826193, 15818.209089545477, 15902.0, 15946.20268986546, 12288.877111228863, 12422.875771242263, 12537.185082969578, 12581.496740130384, 12621.368931553385, 2760.3789147441867, 2784.860756962164, 2800.8739606717745, 2810.269329974201, 2820.957685634717, 67207.0, 67222.0, 67564.0, 68412.1849642781, 69692.0, 10454.843177352346, 10560.2079844012, 10587.205959553065, 10630.149588032938, 10685.252032357661, 17234.224459899084, 17306.826931730775, 17449.302027918995, 17688.91155544214, 17745.645087098444, 5481.890362192814, 6339.461145802658, 6500.0, 6580.703868325937, 6588.143541339595, 2840.8721607527295, 2891.349446374591, 2893.884244630191, 2903.346746981912, 2910.9126726198247, 3453.9654603454146, 3521.260535287567, 3538.628444013393, 3540.5751309842985, 3556.270964452281, 725.9165196002527, 730.6164263761568, 733.1312394812164, 737.3584981066507, 737.5390381011867, 496.5258178439582, 525.1649876695996, 526.18178732072, 528.4161002092709, 531.7713383245165, 8905.910940890508, 9154.496502692416, 9356.157945784911, 9589.328746987643, 9823.950880245553, 582.6969975612658, 588.7556663984399, 595.3510673366052, 600.1957377114687, 609.3906093906094, 4097.160082183145, 4131.710780245354, 4135.152293779768, 4152.5432202457705, 4171.561985991488, 61868.69065654733, 62401.68799156066, 62681.68659156675, 62718.68640656768, 62973.68513157405, 57824.0, 58114.0, 58594.41405585975, 58728.70635646794, 58947.0, 50764.49235507671, 52224.216636750476, 52319.738401307746, 52625.7368713154, 53089.2036619451, 8330.208630180123, 8342.708005219789, 8415.200555947175, 8504.44721093127, 8513.616887239965, 26598.335041624116, 27618.5857212146, 27750.722492774814, 28203.0, 28923.0, 32278.0, 33135.668643314224, 33691.15772105717, 33965.0, 34659.13352166216, 11758.764824703629, 11966.880331196577, 12037.45831437605, 12120.151589388659, 12185.207961482829, 15210.391584336503, 16118.435854745028, 16137.515874523782, 16145.919270404043, 16167.676646466769, 13893.305334733424, 13968.231747253998, 14092.084014539023, 14313.57059288223, 14346.713065738835, 14158.079724817853, 14226.50207242783, 14680.192589407257, 14821.851781482048, 14892.0, 12967.925131978838, 14002.57992260234, 14193.645158871112, 14433.711325773216, 14589.197594132, 10607.787844243227, 10719.678409647722, 10765.0, 10910.0, 11163.051140652811, 11580.189386742848, 12066.336351500751, 12264.816027759769, 12313.50745970187, 12356.320402377956], "value": 6583.525086992014, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 111.0, 111.0, 113.0, 111.0, 112.0, 111.0, 114.0, 113.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 125.0, 169.0, 124.0, 130.0, 125.0, 124.0, 144.0, 124.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 166.0, 166.0, 165.0, 164.0, 166.0, 181.0, 165.0, 166.0], "value": 167.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 78.0, 110.0, 77.0, 76.0, 75.0, 76.0, 98.0, 77.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 112.0, 85.0, 84.0, 83.0, 96.0, 84.0, 84.0, 107.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 115.0, 114.0, 115.0, 114.0, 113.0, 116.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 151.0, 152.0, 151.0, 152.0, 151.0, 152.0, 150.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 56.0, 58.0, 56.0, 56.0, 56.0, 57.0, 58.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 56.0, 55.0, 56.0, 55.0, 55.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 83.0, 82.0, 83.0, 82.0, 83.0, 81.0, 81.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 130.0, 133.0, 133.0, 140.0, 137.0, 134.0, 136.0, 185.0, 139.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 198.0, 194.0, 192.0, 187.0, 193.0, 202.0, 193.0, 189.0, 205.0], "value": 193.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 76.0, 74.0, 74.0, 71.0, 77.0, 74.0, 84.0], "value": 75.2, "unit": "score"}]}]} 10:11:11 INFO - Return code: 0 10:11:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:11:11 INFO - # TBPL SUCCESS # 10:11:11 INFO - Running post-action listener: _resource_record_post_action 10:11:11 INFO - [mozharness: 2017-05-14 17:11:11.706894Z] Finished run-tests step (success) 10:11:11 INFO - Running post-run listener: _resource_record_post_run 10:11:11 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 388612096; Read time: 184; Write time: 272936 10:11:11 INFO - TinderboxPrint: CPU usage
13.3% 10:11:11 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 184 10:11:11 INFO - TinderboxPrint: I/O write bytes / time
388,612,096 / 272,936 10:11:11 INFO - TinderboxPrint: CPU idle
8,291.9 (86.7%) 10:11:11 INFO - TinderboxPrint: CPU user
1,214.4 (12.7%) 10:11:11 INFO - TinderboxPrint: Swap in / out
0 / 0 10:11:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 120979456; Read time: 84; Write time: 111900 10:11:11 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 267059200; Read time: 88; Write time: 161004 10:11:12 INFO - Running post-run listener: _upload_blobber_files 10:11:12 INFO - Blob upload gear active. 10:11:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:11:12 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 10:11:12 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'] 10:11:12 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 10:11:12 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:11:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:11:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:13 INFO - (blobuploader) - INFO - Done attempting. 10:11:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:11:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:11:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:17 INFO - (blobuploader) - INFO - Done attempting. 10:11:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:11:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:11:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:18 INFO - (blobuploader) - INFO - Done attempting. 10:11:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:11:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:11:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:18 INFO - (blobuploader) - INFO - Done attempting. 10:11:18 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:18 INFO - Return code: 0 10:11:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:11:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12575151fe1ff4b16e9b9fe6f6d3232c0f0d67a70525d37258670f0454dc6204cdd3a9812037e52eebf7d447c089c1526e6246519536c70a16f21468b7cdde4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7ea5b68dc55c40ec7c36df4c12e6df3e5b1c6c0b57cb2833ca8bd146a4e51492e72d927cac7d50a8a80508a152bc14a9fcab89d323c2043ce0b4b74671e67db", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/378ea3bf0c01880d32e7e9413f34ba5acd8eb4ee0875acc10829c62a9c3a0ecd533c81dc6c45b72de6ba07619c00017a78e94bbc9f77e1049fe72e7835052cf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2526a1a114f386518d54a6f00732986f4fe06779821e3307f545e80b9da62cf686a05fd36331b0550aba7be19040ac36a45a43370f6b0a22580b74475cda11ce"} 10:11:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:11:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:11:18 INFO - Contents: 10:11:18 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12575151fe1ff4b16e9b9fe6f6d3232c0f0d67a70525d37258670f0454dc6204cdd3a9812037e52eebf7d447c089c1526e6246519536c70a16f21468b7cdde4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7ea5b68dc55c40ec7c36df4c12e6df3e5b1c6c0b57cb2833ca8bd146a4e51492e72d927cac7d50a8a80508a152bc14a9fcab89d323c2043ce0b4b74671e67db", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/378ea3bf0c01880d32e7e9413f34ba5acd8eb4ee0875acc10829c62a9c3a0ecd533c81dc6c45b72de6ba07619c00017a78e94bbc9f77e1049fe72e7835052cf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2526a1a114f386518d54a6f00732986f4fe06779821e3307f545e80b9da62cf686a05fd36331b0550aba7be19040ac36a45a43370f6b0a22580b74475cda11ce"} 10:11:18 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:18 INFO - Copying logs to upload dir... 10:11:18 INFO - mkdir: /builds/slave/test/build/upload/logs 10:11:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.769069 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-14 10:11:17.992983) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-14 10:11:18.000741) ========= 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=17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12575151fe1ff4b16e9b9fe6f6d3232c0f0d67a70525d37258670f0454dc6204cdd3a9812037e52eebf7d447c089c1526e6246519536c70a16f21468b7cdde4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7ea5b68dc55c40ec7c36df4c12e6df3e5b1c6c0b57cb2833ca8bd146a4e51492e72d927cac7d50a8a80508a152bc14a9fcab89d323c2043ce0b4b74671e67db", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/378ea3bf0c01880d32e7e9413f34ba5acd8eb4ee0875acc10829c62a9c3a0ecd533c81dc6c45b72de6ba07619c00017a78e94bbc9f77e1049fe72e7835052cf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2526a1a114f386518d54a6f00732986f4fe06779821e3307f545e80b9da62cf686a05fd36331b0550aba7be19040ac36a45a43370f6b0a22580b74475cda11ce"} build_url:https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/emG3M_GGSs6hsnt_UwjNVQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12575151fe1ff4b16e9b9fe6f6d3232c0f0d67a70525d37258670f0454dc6204cdd3a9812037e52eebf7d447c089c1526e6246519536c70a16f21468b7cdde4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7ea5b68dc55c40ec7c36df4c12e6df3e5b1c6c0b57cb2833ca8bd146a4e51492e72d927cac7d50a8a80508a152bc14a9fcab89d323c2043ce0b4b74671e67db", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/378ea3bf0c01880d32e7e9413f34ba5acd8eb4ee0875acc10829c62a9c3a0ecd533c81dc6c45b72de6ba07619c00017a78e94bbc9f77e1049fe72e7835052cf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2526a1a114f386518d54a6f00732986f4fe06779821e3307f545e80b9da62cf686a05fd36331b0550aba7be19040ac36a45a43370f6b0a22580b74475cda11ce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-14 10:11:18.029289) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 10:11:18.029622) ========= 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=17051fcd5208b27b50bedfeb000001dd-1494779288.97433-519342163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 10:11:18.109095) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-14 10:11:18.112426) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-14 10:11:18.112720) ========= ========= Total master_lag: 0.19 =========