builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-085 starttime: 1494792433.02 results: success (0) revision: e66dedabe582ba7b394aee4f89ed70fe389b3c46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-14 13:07:13.023191) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-14 13:07:13.023606) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-14 13:07:13.023936) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-14 13:07:13.077689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 13:07:13.078044) ========= 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=5c37b704b588aaa989324530000001d0-1494788149.827762-502302647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-14 13:07:13-- 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% 110M=0s 2017-05-14 13:07:13 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.198800 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 13:07:13.315751) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 13:07:13.322108) ========= 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=5c37b704b588aaa989324530000001d0-1494788149.827762-502302647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.055496 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 13:07:13.387717) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 13:07:13.390122) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e66dedabe582ba7b394aee4f89ed70fe389b3c46 --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 e66dedabe582ba7b394aee4f89ed70fe389b3c46 --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=5c37b704b588aaa989324530000001d0-1494788149.827762-502302647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-14 13:07:13,493 truncating revision to first 12 chars 2017-05-14 13:07:13,493 Setting DEBUG logging. 2017-05-14 13:07:13,493 attempt 1/10 2017-05-14 13:07:13,493 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e66dedabe582?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-14 13:07:13,929 unpacking tar archive at: mozilla-central-e66dedabe582/testing/mozharness/ program finished with exit code 0 elapsedTime=0.748578 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 13:07:14.151627) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-14 13:07:14.151939) ========= script_repo_revision: e66dedabe582ba7b394aee4f89ed70fe389b3c46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-14 13:07:14.152300) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-14 13:07:14.152566) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-14 13:07:14.168208) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-05-14 13:07:14.168528) ========= /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=5c37b704b588aaa989324530000001d0-1494788149.827762-502302647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:07:14 INFO - MultiFileLogger online at 20170514 13:07:14 in /builds/slave/test 13:07:14 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 13:07:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:07:14 INFO - {'append_to_log': False, 13:07:14 INFO - 'base_work_dir': '/builds/slave/test', 13:07:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:07:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:07:14 INFO - 'branch': 'Firefox-Non-PGO', 13:07:14 INFO - 'buildbot_json_path': 'buildprops.json', 13:07:14 INFO - 'config_files': ('talos/linux_config.py',), 13:07:14 INFO - 'default_actions': ('clobber', 13:07:14 INFO - 'read-buildbot-config', 13:07:14 INFO - 'download-and-extract', 13:07:14 INFO - 'populate-webroot', 13:07:14 INFO - 'create-virtualenv', 13:07:14 INFO - 'install', 13:07:14 INFO - 'run-tests'), 13:07:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:07:14 INFO - 'download_minidump_stackwalk': True, 13:07:14 INFO - 'download_symbols': 'ondemand', 13:07:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:07:14 INFO - 'tooltool.py': '/tools/tooltool.py', 13:07:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:07:14 INFO - '/tools/misc-python/virtualenv.py')}, 13:07:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:07:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:07:14 INFO - 'gecko_profile': False, 13:07:14 INFO - 'gecko_profile_interval': 0, 13:07:14 INFO - 'installer_path': 'installer.exe', 13:07:14 INFO - 'log_level': 'info', 13:07:14 INFO - 'log_name': 'talos', 13:07:14 INFO - 'log_to_console': True, 13:07:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:07:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:07:14 INFO - 'opt_config_files': (), 13:07:14 INFO - 'pip_index': False, 13:07:14 INFO - 'suite': 'dromaeojs-e10s', 13:07:14 INFO - 'system_bits': '32', 13:07:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:07:14 INFO - 'title': 'talos-linux64-ix-085', 13:07:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:07:14 INFO - 'use_talos_json': True, 13:07:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:07:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:07:14 INFO - 'work_dir': 'build'} 13:07:14 INFO - [mozharness: 2017-05-14 20:07:14.505066Z] Running clobber step. 13:07:14 INFO - Running pre-action listener: _resource_record_pre_action 13:07:14 INFO - Running main action method: clobber 13:07:14 INFO - rmtree: /builds/slave/test/build 13:07:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:07:20 INFO - Running post-action listener: _resource_record_post_action 13:07:20 INFO - [mozharness: 2017-05-14 20:07:20.346061Z] Finished clobber step (success) 13:07:20 INFO - [mozharness: 2017-05-14 20:07:20.346233Z] Running read-buildbot-config step. 13:07:20 INFO - Running pre-action listener: _resource_record_pre_action 13:07:20 INFO - Running main action method: read_buildbot_config 13:07:20 INFO - Using buildbot properties: 13:07:20 INFO - { 13:07:20 INFO - "project": "", 13:07:20 INFO - "product": "firefox", 13:07:20 INFO - "who": "archaeopteryx@coole-files.de", 13:07:20 INFO - "installer_path": "public/build/target.tar.bz2", 13:07:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:07:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 13:07:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 13:07:20 INFO - "stage_platform": "linux64", 13:07:20 INFO - "basedir": "/builds/slave/test", 13:07:20 INFO - "buildnumber": 603, 13:07:20 INFO - "platform": "ubuntu64_hw", 13:07:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:07:20 INFO - "slavebuilddir": "test", 13:07:20 INFO - "taskId": "TNr4Uy1lQbeKu_kHVw74SA", 13:07:20 INFO - "branch": "mozilla-central", 13:07:20 INFO - "script_repo_revision": "production", 13:07:20 INFO - "revision": "e66dedabe582ba7b394aee4f89ed70fe389b3c46", 13:07:20 INFO - "slavename": "talos-linux64-ix-085", 13:07:20 INFO - "repo_path": "mozilla-central" 13:07:20 INFO - } 13:07:20 INFO - Finding installer, test and symbols from parent task. 13:07:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TNr4Uy1lQbeKu_kHVw74SA'}, attempt #1 13:07:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TNr4Uy1lQbeKu_kHVw74SA'}, attempt #1 13:07:21 INFO - Task dependencies: F7fxkM2qRa-0KSPg5Pr1eg 13:07:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg'}, attempt #1 13:07:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.tar.bz2 13:07:21 INFO - Set test_url: https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/test_packages.json 13:07:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.crashreporter-symbols.zip 13:07:21 INFO - Running post-action listener: _resource_record_post_action 13:07:21 INFO - [mozharness: 2017-05-14 20:07:21.699945Z] Finished read-buildbot-config step (success) 13:07:21 INFO - [mozharness: 2017-05-14 20:07:21.700167Z] Running download-and-extract step. 13:07:21 INFO - Running pre-action listener: _resource_record_pre_action 13:07:21 INFO - Running main action method: download_and_extract 13:07:21 INFO - mkdir: /builds/slave/test/build/tests 13:07:21 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')]} 13:07:21 INFO - trying https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.test_packages.json 13:07:21 INFO - Downloading https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:07:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:07:22 INFO - Downloaded 986 bytes. 13:07:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:07:22 INFO - Using the following test package requirements: 13:07:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:07:22 INFO - u'common': [u'target.common.tests.zip'], 13:07:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:07:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:07:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:07:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:07:22 INFO - u'mozbase': [u'target.common.tests.zip'], 13:07:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:07:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:07:22 INFO - u'web-platform': [u'target.common.tests.zip', 13:07:22 INFO - u'target.web-platform.tests.zip'], 13:07:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:07:22 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:07:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.common.tests.zip 13:07:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:07:22 INFO - Fetch https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.common.tests.zip into memory 13:07:23 INFO - Content-Length response header: 62448331 13:07:23 INFO - Bytes received: 62448331 13:07:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:07:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.common.tests.zip 13:07:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:07:35 INFO - Fetch https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.common.tests.zip into memory 13:07:36 INFO - Content-Length response header: 62448331 13:07:36 INFO - Bytes received: 62448331 13:07:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.talos.tests.zip 13:07:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:07:48 INFO - Fetch https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.talos.tests.zip into memory 13:07:48 INFO - Content-Length response header: 14410013 13:07:48 INFO - Bytes received: 14410013 13:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:49 INFO - trying https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.tar.bz2 13:07:49 INFO - Downloading https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:07:50 INFO - Downloaded 63544022 bytes. 13:07:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.tar.bz2 13:07:50 INFO - mkdir: /builds/slave/test/properties 13:07:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:07:50 INFO - Writing to file /builds/slave/test/properties/build_url 13:07:50 INFO - Contents: 13:07:50 INFO - build_url:https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.tar.bz2 13:07:50 INFO - Running post-action listener: _resource_record_post_action 13:07:50 INFO - Running post-action listener: set_extra_try_arguments 13:07:50 INFO - [mozharness: 2017-05-14 20:07:50.301426Z] Finished download-and-extract step (success) 13:07:50 INFO - [mozharness: 2017-05-14 20:07:50.301524Z] Running populate-webroot step. 13:07:50 INFO - Running pre-action listener: _resource_record_pre_action 13:07:50 INFO - Running main action method: populate_webroot 13:07:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:07:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:07:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:07:50 INFO - '--tppagecycles', 13:07:50 INFO - '7'], 13:07:50 INFO - 'tests': ['tsvgm']}}, 13:07:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:07:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:07:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:07:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:07:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:07:50 INFO - 'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:07:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:07:50 INFO - 'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['damp', 'tps']}, 13:07:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:07:50 INFO - 'tests': ['damp', 'tps']}, 13:07:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['dromaeo_dom']}, 13:07:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:07:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 13:07:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:07:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['a11yr', 13:07:50 INFO - 'ts_paint', 13:07:50 INFO - 'tpaint', 13:07:50 INFO - 'sessionrestore', 13:07:50 INFO - 'sessionrestore_no_auto_restore', 13:07:50 INFO - 'tabpaint']}, 13:07:50 INFO - 'other-e10s': {'tests': ['a11yr', 13:07:50 INFO - 'ts_paint', 13:07:50 INFO - 'tpaint', 13:07:50 INFO - 'sessionrestore', 13:07:50 INFO - 'sessionrestore_no_auto_restore', 13:07:50 INFO - 'tabpaint']}, 13:07:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:07:50 INFO - 'ts_paint', 13:07:50 INFO - 'tpaint', 13:07:50 INFO - 'sessionrestore', 13:07:50 INFO - 'sessionrestore_no_auto_restore', 13:07:50 INFO - 'tabpaint']}, 13:07:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:07:50 INFO - 'ts_paint', 13:07:50 INFO - 'tpaint', 13:07:50 INFO - 'sessionrestore', 13:07:50 INFO - 'sessionrestore_no_auto_restore', 13:07:50 INFO - 'tabpaint']}, 13:07:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['a11yr', 13:07:50 INFO - 'ts_paint', 13:07:50 INFO - 'tpaint', 13:07:50 INFO - 'sessionrestore', 13:07:50 INFO - 'sessionrestore_no_auto_restore', 13:07:50 INFO - 'tabpaint']}, 13:07:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['a11yr', 13:07:50 INFO - 'ts_paint', 13:07:50 INFO - 'tpaint', 13:07:50 INFO - 'sessionrestore', 13:07:50 INFO - 'sessionrestore_no_auto_restore', 13:07:50 INFO - 'tabpaint']}, 13:07:50 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 13:07:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 13:07:50 INFO - 'bloom_basic_ref']}, 13:07:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['tsvgx', 13:07:50 INFO - 'tsvgr_opacity', 13:07:50 INFO - 'tart', 13:07:50 INFO - 'tscrollx', 13:07:50 INFO - 'cart', 13:07:50 INFO - 'tsvg_static']}, 13:07:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:07:50 INFO - 'tsvgr_opacity', 13:07:50 INFO - 'tart', 13:07:50 INFO - 'tscrollx', 13:07:50 INFO - 'cart', 13:07:50 INFO - 'tsvg_static']}, 13:07:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:07:50 INFO - 'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['tp5o']}, 13:07:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:07:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:07:50 INFO - 'talos_options': ['--disable-e10s', 13:07:50 INFO - '--xperf_path', 13:07:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:50 INFO - 'tests': ['tp5n']}, 13:07:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:07:50 INFO - 'talos_options': ['--xperf_path', 13:07:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:50 INFO - 'tests': ['tp5n']}}, 13:07:50 INFO - 'talos.zip': {'path': '', 13:07:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:07:50 INFO - Running post-action listener: _resource_record_post_action 13:07:50 INFO - [mozharness: 2017-05-14 20:07:50.315210Z] Finished populate-webroot step (success) 13:07:50 INFO - [mozharness: 2017-05-14 20:07:50.315299Z] Running create-virtualenv step. 13:07:50 INFO - Running pre-action listener: _resource_record_pre_action 13:07:50 INFO - Running main action method: create_virtualenv 13:07:50 INFO - Creating virtualenv /builds/slave/test/build/venv 13:07:50 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 13:07:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:07:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:07:50 INFO - Using real prefix '/usr' 13:07:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:07:51 INFO - Installing distribute.............................................................................................................................................................................................done. 13:07:52 INFO - Installing pip.................done. 13:07:52 INFO - Return code: 0 13:07:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:07:53 INFO - Reading from file tmpfile_stdout 13:07:53 INFO - Output received: 13:07:53 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) 13:07:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:07:53 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')]} 13:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:53 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')]} 13:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:53 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 0x25331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a37a0>, '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 0x28a46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a4b30>, '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': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', '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 13:07:53 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 13:07:53 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 13:07:53 INFO - Using env: {'DISPLAY': ':0', 13:07:53 INFO - 'HOME': '/home/cltbld', 13:07:53 INFO - 'LANG': 'en_US.UTF-8', 13:07:53 INFO - 'LANGUAGE': 'en_US:en', 13:07:53 INFO - 'LOGNAME': 'cltbld', 13:07:53 INFO - 'MAIL': '/var/mail/cltbld', 13:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:53 INFO - 'MOZ_NO_REMOTE': '1', 13:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:53 INFO - 'NO_EM_RESTART': '1', 13:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:53 INFO - 'PWD': '/builds/slave/test', 13:07:53 INFO - 'SHELL': '/bin/bash', 13:07:53 INFO - 'SHLVL': '1', 13:07:53 INFO - 'TERM': 'linux', 13:07:53 INFO - 'TMOUT': '86400', 13:07:53 INFO - 'USER': 'cltbld', 13:07:53 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', 13:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:53 INFO - '_': '/tools/buildbot/bin/python'} 13:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:53 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 13:07:53 INFO - Cleaning up... 13:07:53 INFO - Return code: 0 13:07:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:07:53 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')]} 13:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:53 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')]} 13:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:53 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 0x25331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a37a0>, '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 0x28a46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a4b30>, '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': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', '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 13:07:53 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 13:07:53 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 13:07:53 INFO - Using env: {'DISPLAY': ':0', 13:07:53 INFO - 'HOME': '/home/cltbld', 13:07:53 INFO - 'LANG': 'en_US.UTF-8', 13:07:53 INFO - 'LANGUAGE': 'en_US:en', 13:07:53 INFO - 'LOGNAME': 'cltbld', 13:07:53 INFO - 'MAIL': '/var/mail/cltbld', 13:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:53 INFO - 'MOZ_NO_REMOTE': '1', 13:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:53 INFO - 'NO_EM_RESTART': '1', 13:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:53 INFO - 'PWD': '/builds/slave/test', 13:07:53 INFO - 'SHELL': '/bin/bash', 13:07:53 INFO - 'SHLVL': '1', 13:07:53 INFO - 'TERM': 'linux', 13:07:53 INFO - 'TMOUT': '86400', 13:07:53 INFO - 'USER': 'cltbld', 13:07:53 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', 13:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:53 INFO - '_': '/tools/buildbot/bin/python'} 13:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:53 INFO - Downloading/unpacking psutil>=3.1.1 13:07:53 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 13:07:53 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 13:07:53 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 13:07:53 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 13:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:07:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:54 INFO - Installing collected packages: psutil 13:07:54 INFO - Running setup.py install for psutil 13:07:55 INFO - building 'psutil._psutil_linux' extension 13:07:55 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 13:07:56 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 13:07:56 INFO - building 'psutil._psutil_posix' extension 13:07:56 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 13:07:56 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 13:07:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:56 INFO - Successfully installed psutil 13:07:56 INFO - Cleaning up... 13:07:56 INFO - Return code: 0 13:07:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a37a0>, '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 0x28a46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a4b30>, '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': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', '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 13:07:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:07:56 INFO - Using env: {'DISPLAY': ':0', 13:07:56 INFO - 'HOME': '/home/cltbld', 13:07:56 INFO - 'LANG': 'en_US.UTF-8', 13:07:56 INFO - 'LANGUAGE': 'en_US:en', 13:07:56 INFO - 'LOGNAME': 'cltbld', 13:07:56 INFO - 'MAIL': '/var/mail/cltbld', 13:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:56 INFO - 'MOZ_NO_REMOTE': '1', 13:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:56 INFO - 'NO_EM_RESTART': '1', 13:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:56 INFO - 'PWD': '/builds/slave/test', 13:07:56 INFO - 'SHELL': '/bin/bash', 13:07:56 INFO - 'SHLVL': '1', 13:07:56 INFO - 'TERM': 'linux', 13:07:56 INFO - 'TMOUT': '86400', 13:07:56 INFO - 'USER': 'cltbld', 13:07:56 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', 13:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:56 INFO - '_': '/tools/buildbot/bin/python'} 13:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:07:56 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 13:07:56 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 13:07:56 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 13:07:56 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 13:07:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:07:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:07:57 INFO - Installing collected packages: mozsystemmonitor 13:07:57 INFO - Running setup.py install for mozsystemmonitor 13:07:57 INFO - Successfully installed mozsystemmonitor 13:07:57 INFO - Cleaning up... 13:07:57 INFO - Return code: 0 13:07:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:07:57 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')]} 13:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:57 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')]} 13:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:57 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 0x25331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a37a0>, '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 0x28a46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a4b30>, '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': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', '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 13:07:57 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 13:07:57 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 13:07:57 INFO - Using env: {'DISPLAY': ':0', 13:07:57 INFO - 'HOME': '/home/cltbld', 13:07:57 INFO - 'LANG': 'en_US.UTF-8', 13:07:57 INFO - 'LANGUAGE': 'en_US:en', 13:07:57 INFO - 'LOGNAME': 'cltbld', 13:07:57 INFO - 'MAIL': '/var/mail/cltbld', 13:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:57 INFO - 'MOZ_NO_REMOTE': '1', 13:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:57 INFO - 'NO_EM_RESTART': '1', 13:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:57 INFO - 'PWD': '/builds/slave/test', 13:07:57 INFO - 'SHELL': '/bin/bash', 13:07:57 INFO - 'SHLVL': '1', 13:07:57 INFO - 'TERM': 'linux', 13:07:57 INFO - 'TMOUT': '86400', 13:07:57 INFO - 'USER': 'cltbld', 13:07:57 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', 13:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:57 INFO - '_': '/tools/buildbot/bin/python'} 13:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:58 INFO - Downloading/unpacking jsonschema==2.5.1 13:07: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 13:07: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 13:07: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 13:07: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 13:07:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:07:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:07:59 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 13:07:59 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 13:07:59 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 13:07:59 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 13:07:59 INFO - Downloading functools32-3.2.3-2.tar.gz 13:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:07:59 INFO - warning: no files found matching '*.txt' 13:07:59 INFO - no previously-included directories found matching 'build' 13:07:59 INFO - no previously-included directories found matching 'dist' 13:07:59 INFO - no previously-included directories found matching '.git*' 13:07:59 INFO - Installing collected packages: jsonschema, functools32 13:07:59 INFO - Running setup.py install for functools32 13:07:59 INFO - warning: no files found matching '*.txt' 13:07:59 INFO - no previously-included directories found matching 'build' 13:07:59 INFO - no previously-included directories found matching 'dist' 13:07:59 INFO - no previously-included directories found matching '.git*' 13:07:59 INFO - Successfully installed jsonschema functools32 13:07:59 INFO - Cleaning up... 13:07:59 INFO - Return code: 0 13:07:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:07:59 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')]} 13:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:59 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')]} 13:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:59 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 0x25331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a37a0>, '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 0x28a46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a4b30>, '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': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', '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 13:07:59 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 13:07:59 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 13:07:59 INFO - Using env: {'DISPLAY': ':0', 13:07:59 INFO - 'HOME': '/home/cltbld', 13:07:59 INFO - 'LANG': 'en_US.UTF-8', 13:07:59 INFO - 'LANGUAGE': 'en_US:en', 13:07:59 INFO - 'LOGNAME': 'cltbld', 13:07:59 INFO - 'MAIL': '/var/mail/cltbld', 13:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:59 INFO - 'MOZ_NO_REMOTE': '1', 13:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:59 INFO - 'NO_EM_RESTART': '1', 13:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:59 INFO - 'PWD': '/builds/slave/test', 13:07:59 INFO - 'SHELL': '/bin/bash', 13:07:59 INFO - 'SHLVL': '1', 13:07:59 INFO - 'TERM': 'linux', 13:07:59 INFO - 'TMOUT': '86400', 13:07:59 INFO - 'USER': 'cltbld', 13:07:59 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', 13:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:59 INFO - '_': '/tools/buildbot/bin/python'} 13:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:07:59 INFO - Cleaning up... 13:07:59 INFO - Return code: 0 13:07:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:07:59 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')]} 13:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:59 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')]} 13:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:59 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 0x25331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a37a0>, '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 0x28a46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a4b30>, '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': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', '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 13:07:59 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 13:07:59 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 13:07:59 INFO - Using env: {'DISPLAY': ':0', 13:07:59 INFO - 'HOME': '/home/cltbld', 13:07:59 INFO - 'LANG': 'en_US.UTF-8', 13:07:59 INFO - 'LANGUAGE': 'en_US:en', 13:07:59 INFO - 'LOGNAME': 'cltbld', 13:07:59 INFO - 'MAIL': '/var/mail/cltbld', 13:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:59 INFO - 'MOZ_NO_REMOTE': '1', 13:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:59 INFO - 'NO_EM_RESTART': '1', 13:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:59 INFO - 'PWD': '/builds/slave/test', 13:07:59 INFO - 'SHELL': '/bin/bash', 13:07:59 INFO - 'SHLVL': '1', 13:07:59 INFO - 'TERM': 'linux', 13:07:59 INFO - 'TMOUT': '86400', 13:07:59 INFO - 'USER': 'cltbld', 13:07:59 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', 13:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:59 INFO - '_': '/tools/buildbot/bin/python'} 13:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:00 INFO - Downloading/unpacking blobuploader==1.2.4 13:08: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 13:08: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 13:08: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 13:08: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 13:08:01 INFO - Downloading blobuploader-1.2.4.tar.gz 13:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:08:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:08: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 13:08: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 13:08: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 13:08: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 13:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:08:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:08: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 13:08: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 13:08: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 13:08: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 13:08:01 INFO - Downloading docopt-0.6.1.tar.gz 13:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:08:01 INFO - Installing collected packages: blobuploader, requests, docopt 13:08:01 INFO - Running setup.py install for blobuploader 13:08:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:08:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:08:01 INFO - Running setup.py install for requests 13:08:02 INFO - Running setup.py install for docopt 13:08:02 INFO - Successfully installed blobuploader requests docopt 13:08:02 INFO - Cleaning up... 13:08:02 INFO - Return code: 0 13:08:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:02 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')]} 13:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:02 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')]} 13:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:02 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 0x25331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a37a0>, '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 0x28a46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a4b30>, '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': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', '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 13:08:02 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 13:08:02 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 13:08:02 INFO - Using env: {'DISPLAY': ':0', 13:08:02 INFO - 'HOME': '/home/cltbld', 13:08:02 INFO - 'LANG': 'en_US.UTF-8', 13:08:02 INFO - 'LANGUAGE': 'en_US:en', 13:08:02 INFO - 'LOGNAME': 'cltbld', 13:08:02 INFO - 'MAIL': '/var/mail/cltbld', 13:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:02 INFO - 'MOZ_NO_REMOTE': '1', 13:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:02 INFO - 'NO_EM_RESTART': '1', 13:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:02 INFO - 'PWD': '/builds/slave/test', 13:08:02 INFO - 'SHELL': '/bin/bash', 13:08:02 INFO - 'SHLVL': '1', 13:08:02 INFO - 'TERM': 'linux', 13:08:02 INFO - 'TMOUT': '86400', 13:08:02 INFO - 'USER': 'cltbld', 13:08:02 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', 13:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:02 INFO - '_': '/tools/buildbot/bin/python'} 13:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:02 INFO - Running setup.py (path:/tmp/pip-T4MbZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:02 INFO - Running setup.py (path:/tmp/pip-gr9O2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:02 INFO - Running setup.py (path:/tmp/pip-x5li0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:02 INFO - Running setup.py (path:/tmp/pip-F7GGcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:02 INFO - Running setup.py (path:/tmp/pip-GlArok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:02 INFO - Running setup.py (path:/tmp/pip-lp64Op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:02 INFO - Running setup.py (path:/tmp/pip-_MiuaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:03 INFO - Running setup.py (path:/tmp/pip-IBnKcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:03 INFO - Running setup.py (path:/tmp/pip-UYbiK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:03 INFO - Running setup.py (path:/tmp/pip-2QgYJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:03 INFO - Running setup.py (path:/tmp/pip-CgPbZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:03 INFO - Running setup.py (path:/tmp/pip-PyMZcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:03 INFO - Running setup.py (path:/tmp/pip-cNBCmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:03 INFO - Running setup.py (path:/tmp/pip-Dz7ixW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:03 INFO - Running setup.py (path:/tmp/pip-UIkNbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:03 INFO - Running setup.py (path:/tmp/pip-jq2Kwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:03 INFO - Running setup.py (path:/tmp/pip-7H8zyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:08:03 INFO - Running setup.py install for manifestparser 13:08:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:08:03 INFO - Running setup.py install for mozcrash 13:08:04 INFO - Running setup.py install for mozdebug 13:08:04 INFO - Running setup.py install for mozdevice 13:08:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:08:04 INFO - Running setup.py install for mozfile 13:08:04 INFO - Running setup.py install for mozhttpd 13:08:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:08:04 INFO - Running setup.py install for mozinfo 13:08:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:08:04 INFO - Running setup.py install for mozInstall 13:08:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:08:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:08:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:08:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:08:04 INFO - Running setup.py install for mozleak 13:08:04 INFO - Running setup.py install for mozlog 13:08:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:08:04 INFO - Running setup.py install for moznetwork 13:08:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:08:04 INFO - Running setup.py install for mozprocess 13:08:05 INFO - Running setup.py install for mozprofile 13:08:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:08:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:08:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:08:05 INFO - Running setup.py install for mozrunner 13:08:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:08:05 INFO - Running setup.py install for mozscreenshot 13:08:05 INFO - Running setup.py install for moztest 13:08:05 INFO - Running setup.py install for mozversion 13:08:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:08:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:08:05 INFO - Cleaning up... 13:08:05 INFO - Return code: 0 13:08:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:05 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 0x25331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a37a0>, '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 0x28a46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a4b30>, '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': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', '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 13:08:05 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 13:08:05 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 13:08:05 INFO - Using env: {'DISPLAY': ':0', 13:08:05 INFO - 'HOME': '/home/cltbld', 13:08:05 INFO - 'LANG': 'en_US.UTF-8', 13:08:05 INFO - 'LANGUAGE': 'en_US:en', 13:08:05 INFO - 'LOGNAME': 'cltbld', 13:08:05 INFO - 'MAIL': '/var/mail/cltbld', 13:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:05 INFO - 'MOZ_NO_REMOTE': '1', 13:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:05 INFO - 'NO_EM_RESTART': '1', 13:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:05 INFO - 'PWD': '/builds/slave/test', 13:08:05 INFO - 'SHELL': '/bin/bash', 13:08:05 INFO - 'SHLVL': '1', 13:08:05 INFO - 'TERM': 'linux', 13:08:05 INFO - 'TMOUT': '86400', 13:08:05 INFO - 'USER': 'cltbld', 13:08:05 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', 13:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:05 INFO - '_': '/tools/buildbot/bin/python'} 13:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:05 INFO - Running setup.py (path:/tmp/pip-TbtpM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:05 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)) 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:05 INFO - Running setup.py (path:/tmp/pip-AKBnhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:05 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)) 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:05 INFO - Running setup.py (path:/tmp/pip-C1yu8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:06 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)) 13:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:06 INFO - Running setup.py (path:/tmp/pip-GVx5Tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:06 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)) 13:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:06 INFO - Running setup.py (path:/tmp/pip-GS3r5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:06 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)) 13:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:06 INFO - Running setup.py (path:/tmp/pip-88Isja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:06 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)) 13:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:06 INFO - Running setup.py (path:/tmp/pip-h2HXy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:06 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)) 13:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:06 INFO - Running setup.py (path:/tmp/pip-5578re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:06 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)) 13:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:06 INFO - Running setup.py (path:/tmp/pip-1_CDGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:06 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)) 13:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:06 INFO - Running setup.py (path:/tmp/pip-6_GUzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:06 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)) 13:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:06 INFO - Running setup.py (path:/tmp/pip-A7NKw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:06 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)) 13:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:06 INFO - Running setup.py (path:/tmp/pip-TMbsXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:06 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)) 13:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:06 INFO - Running setup.py (path:/tmp/pip-gw_hSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:06 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)) 13:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:06 INFO - Running setup.py (path:/tmp/pip-LuhT0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:06 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)) 13:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:06 INFO - Running setup.py (path:/tmp/pip-QWAUkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:06 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)) 13:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:06 INFO - Running setup.py (path:/tmp/pip-4QjTuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:06 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)) 13:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:06 INFO - Running setup.py (path:/tmp/pip-Ni67xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:07 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)) 13:08:07 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)) 13:08:07 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)) 13:08:07 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)) 13:08:07 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)) 13:08:07 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)) 13:08:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:08:07 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 13:08:07 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 13:08:07 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 13:08:07 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 13:08:08 INFO - Downloading blessings-1.6.tar.gz 13:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:08:08 INFO - Installing collected packages: blessings 13:08:08 INFO - Running setup.py install for blessings 13:08:08 INFO - Successfully installed blessings 13:08:08 INFO - Cleaning up... 13:08:08 INFO - Return code: 0 13:08:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:08 INFO - Reading from file tmpfile_stdout 13:08:08 INFO - Current package versions: 13:08:08 INFO - argparse == 1.2.1 13:08:08 INFO - blessings == 1.6 13:08:08 INFO - blobuploader == 1.2.4 13:08:08 INFO - docopt == 0.6.1 13:08:08 INFO - functools32 == 3.2.3-2 13:08:08 INFO - jsonschema == 2.5.1 13:08:08 INFO - manifestparser == 1.1 13:08:08 INFO - mozInstall == 1.12 13:08:08 INFO - mozcrash == 1.0 13:08:08 INFO - mozdebug == 0.1 13:08:08 INFO - mozdevice == 0.50 13:08:08 INFO - mozfile == 1.2 13:08:08 INFO - mozhttpd == 0.7 13:08:08 INFO - mozinfo == 0.9 13:08:08 INFO - mozleak == 0.1 13:08:08 INFO - mozlog == 3.4 13:08:08 INFO - moznetwork == 0.27 13:08:08 INFO - mozprocess == 0.25 13:08:08 INFO - mozprofile == 0.28 13:08:08 INFO - mozrunner == 6.13 13:08:08 INFO - mozscreenshot == 0.1 13:08:08 INFO - mozsystemmonitor == 0.3 13:08:08 INFO - moztest == 0.8 13:08:08 INFO - mozversion == 1.4 13:08:08 INFO - psutil == 3.1.1 13:08:08 INFO - requests == 1.2.3 13:08:08 INFO - wsgiref == 0.1.2 13:08:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:08 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 0x25331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a37a0>, '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 0x28a46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a4b30>, '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': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', '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 13:08:08 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 13:08:08 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 13:08:08 INFO - Using env: {'DISPLAY': ':0', 13:08:08 INFO - 'HOME': '/home/cltbld', 13:08:08 INFO - 'LANG': 'en_US.UTF-8', 13:08:08 INFO - 'LANGUAGE': 'en_US:en', 13:08:08 INFO - 'LOGNAME': 'cltbld', 13:08:08 INFO - 'MAIL': '/var/mail/cltbld', 13:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:08 INFO - 'MOZ_NO_REMOTE': '1', 13:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:08 INFO - 'NO_EM_RESTART': '1', 13:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:08 INFO - 'PWD': '/builds/slave/test', 13:08:08 INFO - 'SHELL': '/bin/bash', 13:08:08 INFO - 'SHLVL': '1', 13:08:08 INFO - 'TERM': 'linux', 13:08:08 INFO - 'TMOUT': '86400', 13:08:08 INFO - 'USER': 'cltbld', 13:08:08 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', 13:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:08 INFO - '_': '/tools/buildbot/bin/python'} 13:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:08 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)) 13:08:08 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)) 13:08:08 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)) 13:08:08 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)) 13:08:08 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)) 13:08:08 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)) 13:08:08 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)) 13:08:08 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)) 13:08:08 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)) 13:08:08 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)) 13:08:08 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)) 13:08:08 INFO - Cleaning up... 13:08:08 INFO - Return code: 0 13:08:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:08 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 0x25331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a37a0>, '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 0x28a46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a4b30>, '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': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', '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 13:08:08 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 13:08:08 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 13:08:08 INFO - Using env: {'DISPLAY': ':0', 13:08:08 INFO - 'HOME': '/home/cltbld', 13:08:08 INFO - 'LANG': 'en_US.UTF-8', 13:08:08 INFO - 'LANGUAGE': 'en_US:en', 13:08:08 INFO - 'LOGNAME': 'cltbld', 13:08:08 INFO - 'MAIL': '/var/mail/cltbld', 13:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:08 INFO - 'MOZ_NO_REMOTE': '1', 13:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:08 INFO - 'NO_EM_RESTART': '1', 13:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:08 INFO - 'PWD': '/builds/slave/test', 13:08:08 INFO - 'SHELL': '/bin/bash', 13:08:08 INFO - 'SHLVL': '1', 13:08:08 INFO - 'TERM': 'linux', 13:08:08 INFO - 'TMOUT': '86400', 13:08:08 INFO - 'USER': 'cltbld', 13:08:08 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', 13:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:08 INFO - '_': '/tools/buildbot/bin/python'} 13:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:08:09 INFO - Cleaning up... 13:08:09 INFO - Return code: 0 13:08:09 INFO - Running post-action listener: _resource_record_post_action 13:08:09 INFO - Running post-action listener: _start_resource_monitoring 13:08:09 INFO - Starting resource monitoring. 13:08:09 INFO - [mozharness: 2017-05-14 20:08:09.190153Z] Finished create-virtualenv step (success) 13:08:09 INFO - [mozharness: 2017-05-14 20:08:09.191096Z] Running install step. 13:08:09 INFO - Running pre-action listener: _resource_record_pre_action 13:08:09 INFO - Running main action method: install 13:08:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:09 INFO - Reading from file tmpfile_stdout 13:08:09 INFO - Detecting whether we're running mozinstall >=1.0... 13:08:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:08:09 INFO - Reading from file tmpfile_stdout 13:08:09 INFO - Output received: 13:08:09 INFO - Usage: mozinstall [options] installer 13:08:09 INFO - Options: 13:08:09 INFO - -h, --help show this help message and exit 13:08:09 INFO - -d DEST, --destination=DEST 13:08:09 INFO - Directory to install application into. [default: 13:08:09 INFO - "/builds/slave/test"] 13:08:09 INFO - --app=APP Application being installed. [default: firefox] 13:08:09 INFO - mkdir: /builds/slave/test/build/application 13:08:09 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'] 13:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:08:25 INFO - Reading from file tmpfile_stdout 13:08:25 INFO - Output received: 13:08:25 INFO - /builds/slave/test/build/application/firefox/firefox 13:08:25 INFO - Running post-action listener: _resource_record_post_action 13:08:25 INFO - [mozharness: 2017-05-14 20:08:25.371392Z] Finished install step (success) 13:08:25 INFO - [mozharness: 2017-05-14 20:08:25.371668Z] Running run-tests step. 13:08:25 INFO - Running pre-action listener: _resource_record_pre_action 13:08:25 INFO - Running main action method: run_tests 13:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:08:25 INFO - Python 2.7.3 13:08:25 INFO - Return code: 0 13:08:25 INFO - grabbing minidump binary from tooltool 13:08:25 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')]} 13:08:25 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 0x28a37a0>, '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 0x28a46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a4b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:08:25 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 13:08:25 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 13:08:25 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 13:08:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:08:25 INFO - Return code: 0 13:08:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:08:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:08:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:08:25 INFO - ENV: RUST_BACKTRACE is now 1 13:08:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:08:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:08:25 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/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 13:08:25 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/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-085 --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 13:08:25 INFO - Using env: {'DISPLAY': ':0', 13:08:25 INFO - 'HOME': '/home/cltbld', 13:08:25 INFO - 'LANG': 'en_US.UTF-8', 13:08:25 INFO - 'LANGUAGE': 'en_US:en', 13:08:25 INFO - 'LOGNAME': 'cltbld', 13:08:25 INFO - 'MAIL': '/var/mail/cltbld', 13:08:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:08:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:25 INFO - 'MOZ_NO_REMOTE': '1', 13:08:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:25 INFO - 'NO_EM_RESTART': '1', 13:08:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:25 INFO - 'PWD': '/builds/slave/test', 13:08:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:08:25 INFO - 'RUST_BACKTRACE': '1', 13:08:25 INFO - 'SHELL': '/bin/bash', 13:08:25 INFO - 'SHLVL': '1', 13:08:25 INFO - 'TERM': 'linux', 13:08:25 INFO - 'TMOUT': '86400', 13:08:25 INFO - 'USER': 'cltbld', 13:08:25 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1494788149.827762-502302647', 13:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:25 INFO - '_': '/tools/buildbot/bin/python'} 13:08:25 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/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 13:08:25 INFO - mozversion application_buildid: 20170514193907 13:08:25 INFO - mozversion application_changeset: e66dedabe582ba7b394aee4f89ed70fe389b3c46 13:08:25 INFO - mozversion application_display_name: Nightly 13:08:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:08:25 INFO - mozversion application_name: Firefox 13:08:25 INFO - mozversion application_remotingname: firefox 13:08:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:08:25 INFO - mozversion application_vendor: Mozilla 13:08:25 INFO - mozversion application_version: 55.0a1 13:08:25 INFO - mozversion platform_buildid: 20170514193907 13:08:25 INFO - mozversion platform_changeset: e66dedabe582ba7b394aee4f89ed70fe389b3c46 13:08:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:08:25 INFO - mozversion platform_version: 55.0a1 13:08:25 INFO - using testdate: 1494792505 13:08:25 INFO - actual date: 1494792505 13:08:25 INFO - starting webserver on 'localhost:58257' 13:08:25 INFO - SUITE-START | Running 2 tests 13:08:25 INFO - TEST-START | dromaeo_css 13:08:25 INFO - operating with platform_type : linux_ 13:08:25 INFO - Initialising browser for dromaeo_css test... 13:08:25 INFO - TEST-INFO | started process 3296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptdZKY1/profile http://localhost:58257/getInfo.html) 13:08:26 INFO - PID 3296 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 13:08:30 INFO - PID 3296 | __metrics Screen width/height:1600/1200 13:08:30 INFO - PID 3296 | colorDepth:24 13:08:30 INFO - PID 3296 | Browser inner width/height: 1024/695 13:08:30 INFO - PID 3296 | __metrics 13:08:32 INFO - TEST-INFO | 3296: exit 0 13:08:32 INFO - Browser initialized. 13:08:32 INFO - Running cycle 1/1 for dromaeo_css test... 13:08:32 INFO - TEST-INFO | started process 3467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptdZKY1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:08:44 INFO - PID 3467 | RSS: Main: 161370112 13:08:44 INFO - PID 3467 | 13:11:49 INFO - PID 3467 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58257/tests/dromaeo/cssquery-ext.html) 13:11:52 INFO - PID 3467 | RSS: Main: 169807872 13:11:52 INFO - PID 3467 | 13:14:54 INFO - PID 3467 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-ext.html (next: http://localhost:58257/tests/dromaeo/cssquery-jquery.html) 13:14:55 INFO - PID 3467 | RSS: Main: 166350848 13:14:55 INFO - PID 3467 | 13:17:56 INFO - PID 3467 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58257/tests/dromaeo/cssquery-mootools.html) 13:17:57 INFO - PID 3467 | RSS: Main: 169140224 13:17:57 INFO - PID 3467 | 13:20:59 INFO - PID 3467 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58257/tests/dromaeo/cssquery-prototype.html) 13:20:59 INFO - PID 3467 | RSS: Main: 167108608 13:20:59 INFO - PID 3467 | 13:24:02 INFO - PID 3467 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58257/tests/dromaeo/cssquery-yui.html) 13:24:03 INFO - PID 3467 | RSS: Main: 166625280 13:24:03 INFO - PID 3467 | 13:27:05 INFO - PID 3467 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-yui.html (next: http://localhost:58257/tests/dromaeo/cssquery-dojo.html) 13:27:05 INFO - PID 3467 | RSS: Main: 174583808 13:27:05 INFO - PID 3467 | 13:27:05 INFO - PID 3467 | __start_tp_report 13:27:05 INFO - PID 3467 | _x_x_mozilla_page_load 13:27:05 INFO - PID 3467 | _x_x_mozilla_page_load_details 13:27:05 INFO - PID 3467 | |i|pagename|runs| 13:27:05 INFO - PID 3467 | |0;dojo.html;2737.931551711207;2749.024096445763;2768.9030883919067;2779.3051737065734;2787.8745456454462;5123.871903202422;5252.238425428311;5281.260623512707;5285.92071118933;5303.124984377583;5207.713575753332;5240.502152295536;5244.423113457517;5283.63014588978;5305.389880163782;4684.812607495696;4708.0819240248165;4712.764361781914;4726.881827954294;4768.809247630091;4639;4726.26742854858;4758.690685105475;4789.49710280419;4833.130036593412;4668.649851261169;4691.554302341272;4723.315119307716;4724.881877953045;4774.952250477503;4710.976445117787;4715.669903106749;4732.976335118303;4735.313379559979;4762.857114286577;4682.742449165295;4697.859064228079;4700.623950083985;4703.365045718819;4728.05438912219;5156.123459011977;5188.5849132069725;5234.057869583474;5234.633575649668;5260.92108618371;5619.943800561983;5624.521915637176;5676.091825307973;5703.201551782754;5712.371639119735;5715.799947001877;5718.199452076754;5738.569607279471;5798.130280457923;5800.419958004166;5295.814646487432;5304.124819404755;5327.786888524415;5334.866628334245;5338.172583249602;5722.284714410699;5749.655020698688;5840.1239814027385;5861.77854842705;5865.178874957509;5494.148406996922;5520.585956053312;5538.086215774432;5540.833774986757;5541.2796336476;5615.241942337732;5687.544996400361;5711;5733.283339582552;5750.741216645261;5618.52242559387;5647.576431767634;5650.152477128464;5656.151577263443;5656.8020119295625;5508.669479831223;5637.577181711388;5646.265985421869;5647.1529270609735;5650.971745141248;4533.705309154894;4538;4596.839110631112;4623.676342655982;4624.676272660881;4033.4353190553347;4034.072163402434;4067.6745860331102;4077.32724100526;4119.505659320901;4927.77824997876;4929.309896614477;4932.53140951609;4942.382202224722;4976.3578019253555;5612.382637909826;5620.634658747168;5702.2301989231755;5732.885342293131;5744.167095771173;4852.56326930578;4883.755812209375;4910.926336104962;4919.508049195052;4963.081829861487;5018.222175562793;5021.648484606116;5022.547970682656;5023.14606516893;5035.697858128524;5367.543758780547;5370.570354371641;5374.247605335178;5400.810971615974;5421.7560209791445;5606.803761868315;5610.551155907599;5660.971695141498;5667.2632557768875;5706.885862282814;5215.0612889678705;5287.629865909349;5289.841304760864;5355;5405.135178371442;5558.499735023867;5571.554275658019;5576.721163941867;5578.386377498553;5582.078956972054;5669.433056694297;5676.886462270814;5677.943220567741;5679.602427830012;5680.375158732619;5421.756020978986;5486.177073439016;5488.039593071277;5497.532709719559;5498.147787093007;5485.561155107662;5489.615726899238;5500.752466138953;5502.312210973629;5505;5307.6284660073425;5307.708076055854;5388;5468.425815289337;5481.232627432083;5508.944910550843;5522.9447705524035;5523.8066667666435;5535.39110697831;5567.192757050286;5374.838754837361;5382.19267109921;5382.865428364165;5383.273258110105;5439.347278326468 13:27:05 INFO - PID 3467 | |1;ext.html;731.2979539641943;758.5335018963337;1048.4076496779319;1069.3797597393507;1159.2522822779301;32218;33064.33871322572;33300.66699333006;33308.16729581761;33359.16602084946;30719.539206911857;30922.84538577304;30937.38125237494;31080.68919310806;31151.84424077882;6306.211723534559;6407.615543067431;6411.134496842937;6678.76624318149;6841.589504629714;6835.624040677761;6926.134233220848;6936.237013928464;6945.930540694604;6950.826229344281;6872.862542749142;6980.057692211562;6986.441084713236;6987.930120698804;7005.824854378656;6886.139232595926;6930.792076237721;6938.271481494447;6953.096097507342;6974.965125174393;6878.7248510059535;6889.896651550231;6895.207051189127;6901.827454313682;6940.548864323803;30651.386972260654;30803.229919251975;30837;30926.690733092608;31041.37917241665;2932.135020169034;2949.130006648044;2966.6291713535807;2974.5240761478276;2974.970250297491;23738;23898.163564275168;23953.161639342714;24008.159714410085;24071.759282407125;3100.8139511629147;3133.185371803325;3142.9842850785826;3149.811011339327;3186.76099292554;148540;149058;149112.2544387271;149159;149638;35681;38413.23173536514;38672.41991370132;39544.60455395467;39843;40377.1924561513;40456;40577.79711101425;40658;40662.39006414906;12571.559995400117;12732.554360597334;12743.49026038948;12745.61763147107;12766.297853617954;10033.749156271151;10095;10107.797844043225;10111.140553052926;10111.494425278706;12318.630441086782;12399.194052386567;12447.813282800766;12512.746685861559;12642.87357126417;5159.380874295109;5201.45384734605;5220.086484865209;5251.6061295403;5311.336082989626;769.4690663442319;798.2376830127215;803.7669075967904;817.6729308276618;822.5188264865001;18771.718424223647;19018.524536886413;19040.904795475933;19598.216071356987;24672.42153585179;946.3895787217344;960.6877764726491;980.9558569864373;981.8674478945394;987.4420952162149;10984.121270298358;11433.25683830565;11460.770784584261;11463.770724585462;11566.710832229093;179693;180724;181567;181688;182119;39465;39538.209235815695;39608.801955990035;39704.404433933516;39746.60253397487;1126.7295848996182;1185.4843143232722;1244.5581818454318;1246.7506498700295;1247.906407019459;19640.705389418883;19866.70199946973;19878.90060549688;20861.791382085983;22965.88517057404;37083.629163708014;37443.43834842425;37583.24833503369;37611.43582846205;37667.81166094152;154997;155773;156043.43956560743;156131.21934390254;157171;27976;28482.715172848835;28671.42657146887;29034.854825725735;29415.852920736117;34236.31527369389;35169.1207719809;35224.64775352316;35580.11049723778;35912.8204358987;26432.603510946967;27005.72994270032;27019.72980270172;27271.181864544094;27730.168094957182;26494.205173844817;27043.45913081688;27386.5892011616;27488;28131.015414460395;28656.570151448163;30385.392292153592;30489.23776905595;30657.846710766302;31282.21794455066;26374.604380934685;26535.33661658474;26754.331141721614;26853.865730672;28038.859805700842;20296.695549567063;21814.345569632937;22112.973308504035;22323.218687345863;22507.549849003255 13:27:05 INFO - PID 3467 | |2;jquery.html;412.25587813995725;412.4596778220529;412.9648979836714;426.45839783474986;436.9388285640011;13492.865071349284;16985.490435286945;17566.38517651881;17614.647707045868;17726.20232089559;17881.407195956577;18353.54116147097;18453;18992.715109273373;19233.134508947096;5298.15229563269;5302.946970530284;5383.488568585978;5431.158170483582;5476.205950137228;5381.192821076831;5448;5456.945430545703;5465.945340546584;5489.231507588921;5327.627066105374;5423.810166644168;5427.402985671573;5520.696361700105;5559.3328800543995;5531.612787104904;5535.280413546254;5537.501624853742;5564.443555644443;5577.163425486169;4943.505649435064;4965.3048573199785;4978.502149785028;5004.424491183524;5006.023825354057;22054.558908821735;22437.102515899343;22591.774082259133;22883.42791430211;23034.193803216807;1606.5662271186832;1639.418006607661;1639.9344026238937;1653.875959303057;1661.808891977426;14807.259637018215;14927;14997.400103995828;15269.694606107927;15306.158161301124;2040.9081591328427;2098.8635738676935;2116.174691870172;2135.7330333708287;2155.795199456065;87418;88465.55767221187;89864;90793.54603227008;92949.53525232399;10890.891091088988;10895.455227238606;10924.399158046224;10970.561177552969;11226.158038147172;15218.543443696486;15274.541763747106;15280.847191527942;15356.539303820904;32351.35297294041;8727.60725767342;8748.69379571712;8786.428882122642;8894.155055269868;9035.728928132166;6770.526063175629;6864.7940561783225;6900.2409734929115;7047.753328633473;7337.119545654556;9153.405028673114;9342.2526197904;9680.75798105053;9700.466474343979;9837.458939758382;3586.5158203642695;3901.313258970246;3969.1069509360163;3979.263836190314;4017.9598204017584;825.1171246766023;874.6064271077913;874.7813046738315;883.7083762358407;888.5424006636588;16511.422100226435;16814.915925420293;16818.66362672764;17211.91394043047;17621.118944052745;870.5299138465284;881.1540920716184;883.7392969074139;886.9068747781519;902.5712786426526;9267.553090680589;9608.567614457366;9668.564914578861;9721.70834874955;9871.40771553709;359188;361705;366792;367010;367437;72826.63586682033;73019.26980730124;74192.25807741961;74945;76358.6182069086;1038.4703801061512;1039.859618951432;1075.8278675411896;1080.556971641639;1082.5236895765838;14571.562853114423;14704;14883.702325953636;15076.246187690353;15471.690566188388;37476.2504749898;37575.81212093922;37875.431868522544;38114.665986690336;38701.6129838698;45218;45768.084638307715;45854;46487.53512464967;48418;11205.66383008511;11658.300501969909;11672.76654466889;11871.287722736663;12128.878711212776;12595.496180153057;12827.10210285271;12841.807372889602;12907.548235811702;13116.213027218397;10242.384230878019;10746.677599672023;10917.890821091687;10957;11070.944645276722;10168.593256269667;10272.280940334105;10501.159907207559;10510.579576817148;10566.207534435101;10559.313644613076;10594;10652.360858348524;10691.732706682084;11061.225714199929;11333.489992950503;11343.489542970421;11457.140714446283;11487.655370338904;11862.881371186179;10637.255392122786;11029.669109926715;11048.392338421463;11083.612073577386;11411.429428528707 13:27:05 INFO - PID 3467 | |3;mootools.html;1217.914745967782;1265.2408554867081;1275.7320962597853;1283.4930202569985;1286.8262784524086;9732.513374331282;10112.99999999999;10142;10446.477676116183;10821.83767243492;10339.534720937558;10478.214133939948;10498.895011049906;10524.263301568893;10530.578776848917;2227.086894373311;2268.036084664011;2270.7275126984787;2270.9545809083806;2274.385915802732;2212.1372664660794;2283.7031185945802;2290.1526435218907;2294.1740973249616;2295;2162.5566758814484;2172.945676358088;2210.3810932938723;2214.0922221889027;2219.7336319641668;2141.4860433496005;2143;2211.436083798629;2214.4242496950746;2219.2010876084596;2108.968365474519;2190.1567896359857;2200.4388880835286;2252.4594097416502;2253.8873056347115;10202.846957295647;10292.279540432173;10305.021023002802;10310.845337319946;10315.79368412635;5415.214793854909;5601.047821870251;5641.633293835928;5647.209390685307;5663.886722265532;3066.1261540461082;3186.2193762528095;3259.5110733389943;3264.216588018858;3269.8038117712777;1010.4089107871904;1019.3883669798136;1032.7676272838626;1079.2930630437077;1082.2910993299402;14322.427102915872;14326.57020289393;14356.138631682132;14428.567142985727;14510.419583216764;4624.190766615829;4646.697964632288;4896.1921282987905;4916.72957987307;5033.647644664911;10888.510017049251;11003.064739497233;11003.394813285186;11009.174311926477;11049.889501105046;5679.488846003879;5687.7156142192725;5726.513246374105;5731.742071606787;5744.47771340595;4855.465898751135;5129.358830146231;5129.8717532061255;5208.557272631793;5252.1596544552685;3781.7541859779026;3801.6008319126645;3848.5766565677754;3883.8834834954996;3973.4834471518516;1083.5178345636273;1102.1843835561788;1102.3055475050828;1117.6144230240554;1119.9328040317607;678.1929503890354;697.4594689115976;699.7026263837848;715.8532500837316;719.481972979454;5215.13950198213;5294.629375943724;5375.059364611256;5440.91838622421;5480.1769151665785;530.3079481276893;530.7160669042044;532.1538753382064;536.5144544187516;544.300573762713;3256.6254880688552;3709.1283548366114;3757.2109856929806;3891.9610803892165;4009.178118485762;13596.93201533986;13821.101628394123;13844.861551384558;13889;13919.721605567833;13663;13757;13782.65543361424;13801.516946907012;13830;7435.628218589049;7728.497647652885;7770.368222673302;7814.570198639016;7870.567118808521;6000.159977603226;6099.2985806632805;6114.266288045463;6295.5907865988565;6494.805155845333;11836.940815295868;11908.940455297668;12125.81811272814;12218.327991960172;12315.75368492643;11760.294382337088;11897.762044759229;12010;12070.094742894142;12442.875571244173;8293.792655183668;8339.12439193876;8536.487810731376;8642.654293828176;8654.394192406471;9531.76170595713;9642.325037247325;9672.70981870545;9676.27427942893;9713.07725766051;8057.234562716532;8215.178482151738;8228;8264.256216940505;8679.86980195285;8204.548749818818;8263.462874913352;8280.171982801672;8298.917010829815;8559.101294364002;7460.962695186489;7482.176960534228;7566.924330756622;7569.621518924142;7576.545407275581;4934;4989.501049894981;4996.075725990703;5014.122528557561;5172.870678232924;5331.360236771612;5370.650907690988;5457.972710136424;5553.028220061554;5658.179563963285 13:27:05 INFO - PID 3467 | |4;prototype.html;350.54079156305244;368.60743308376595;376.3263757873406;376.58387481832574;388.9377699568069;5403.621746477748;5411.242426060355;5466.644668096571;5486.451354864512;5488.807891723791;5327.573794096473;5338.665333666583;5350.5452036576935;5353.116735738598;5368.731563421833;4136.296829538971;4178.35235538492;4201.915961680765;4210.663146948252;4211.578842115795;4187.623113919746;4192.517860446057;4195.559466256045;4198.706090573661;4200.789960501978;4159.521655009682;4170.47869016373;4175.958240417603;4176.477940257468;4197.937030944523;4071.77846646008;4168.333066709312;4174.038202045049;4174.603412675791;4197.391378250137;3727.9068023299365;3741.5118945900945;3742.9438558421375;3745.887623371303;3780.3006443807985;5217.34783152106;5232.529072383466;5235.424103348667;5256.737163141827;5267.762950667229;4861.465238823726;4945.23348880924;4949.331840201563;4950.851474455772;4982.725950072744;5627.991087931744;5634.887302253973;5658.943410565924;5659.971700141514;5673.6879471629045;4215.072684009513;4217.894552636178;4232.978835105805;4242.4272723182285;4243.6605071594195;5730.05454100073;5887.5584331174905;5917.851469221761;5942.197803296543;5969.522438204933;3961.1285517186748;3978.264021156095;3981.203759248162;3988.441618173458;3990.4014397840556;4034.253663072341;4052.5339585947995;4055.8174882130374;4064.6138616831354;4075.2664520386024;4615.884602884955;4645.907081858344;4670.206064968964;4679.508651591534;4702.811887524529;5614.157876318585;5643.379228284885;5644.74598643062;5652.491275785117;5653.462921022497;1381.979270310946;1400.1529074909736;1400.9229492377813;1405.283305514195;1406.296851574213;884.7080463447047;935.1677007463363;936.1387523478417;945.8013817098487;947.5830634520789;4981.950180498221;4984.551390374883;5006.599472042228;5008.474110218447;5029.245613158056;5868.325142608569;5889.0871914852405;5890.49930755882;5895.174675545427;5906.49794767441;4776.665633405628;4943.28322393251;4948.05986862495;4952.529509696573;4963.925541116886;3070.293832418556;3111.128883912508;3115.7507399408446;3118.5478105675;3121.9687803122133;5518.696471694096;5522.392536820947;5527.198556209327;5550.222968784374;5560.860978475571;5732.455416735404;5951.55363347742;6020.183852917648;6041.214642096587;6050.54620903434;5541.196526503715;5558.916616250759;5573.6098473106495;5578.525825304894;5583;5713.257276554022;5829.650220986754;5865.882682346414;5902.38025007368;5941.257342832146;5728.656280623176;5788.160716696139;5789.536837052941;5803.506701930214;5826;5388.757505912165;5502.862428439321;5507.614466987273;5546.140348246028;5566.747481816721;3996.840126395028;3999.8200080995844;4009.5589485157193;4016.397540368968;4031.6493974518867;5862.530997520103;5902.321233058254;5908.970455147697;5915.556333274935;5934.732937017759;5710.428957104256;5726.652072650193;5735.827925162252;5736.225609542658;5763.193152958505;5702.857428564319;5744.224529688438;5748.597598168088;5750.159948816338;5752.424757524382;5499.477549632778;5591.552675786009;5625.831225063254;5630.943690563042;5633.492985631149;5730.08318669011;5760.452756988079;5762.538996880324;5764.982256210293;5783.132530120515;5474.260974768515;5594.468525490072;5597.676964060032;5598.21624972496;5602.747876345656 13:27:05 INFO - PID 3467 | |5;yui.html;726.658470518856;741.6884908338498;745.8769303064995;750.272235931147;753.1790348520112;12047.578334758275;12698.68253293667;12847.357632118392;14768.556943291691;15521.146336951464;13861.376238069286;14970.775438368433;15575.37698492059;15822.208889555533;15984.360625574964;890.2610833008588;906.229704750963;909.513410325476;910.2808781062986;911.2436677557612;915.514777168102;916.4318122763863;916.5737931861682;917.7017469322464;919.8988111307751;965.1072757699101;966.8791401074866;967.8306296398138;968.0029569543382;970.2868391732071;956.3496822160963;957.3107362698846;958.0084612426141;958.9520523973808;960.0447554683135;701.7789396340188;702.820780700918;704.5983789240136;705.7353492440335;708.6704682322693;13322.467101315935;13583.796243056362;13961.301934903215;14052.92973535136;14146.646333841634;15309.31108100127;15744.842551574453;15868;15881.28534215963;16159.353625854952;12007.099467539969;12105;12200.328981905992;12496;12600.306983115925;2951.74910132639;2969.465496210681;2970.6138202033812;2988.193187839271;2992.341684829356;71742.9238561422;71746;72060;72637.63681181613;74979;12678.746425071631;12869.356532173353;13075.869241307655;13083.934580327037;13106.60680179596;21785.23751668684;22425.887870560542;22717.545649086926;22810.20164294242;22932.656010159862;6045.818625441244;6156.938430615726;6201.224846894138;6246.125542424064;6249.812505624838;2717.768989635903;2799.790015748786;2810.676772171186;2821.844798536059;2823.774098072149;3500.824958752052;3526.083218363244;3581.8746343877838;3591;3627.8730244441317;688.8863337549349;689.1764341611726;699.9370056694922;701.2216439751871;701.2496628607341;591.382005803936;599.7750843433712;607.1590846677384;611.8164550634792;622.0389498225162;8541.658333666584;8941.418807777474;9132.178103970675;9209.217216536535;9615.278854085971;570.597728601335;580.042929166878;584.8479395357152;599.8800239951939;616.5838059310038;4080.3471444568727;4144.254034273859;4155.4182414462;4196.979015104905;4204.579542045771;60572.697136514034;60607.39392606018;61159.18987696162;61384.336975974424;62407.37592624016;55609.1658625121;55640.72179639076;55731.442685573435;57074;58487.415125849046;47796.761016194694;48293;48392.5160748388;50247.24629130493;50353.49646503561;8160.551169685724;8403.537805420761;8415.5792210388;8417.579121044046;8657.047724750399;26043.869780650977;26274.21177364682;26744.732552674224;27331.31671708223;27438.725612743616;31630.36739265248;32007.519887201244;32229.35541289208;32494;44821;13382.866171338552;13401.865981340452;13558.457661693421;13634.590962271148;13636.65908352299;14919.252746598107;15399.61500962485;15450.0729956203;16266.755998659793;16599.91700041492;13664.24846633405;14122.082064665763;14182.574522764333;14447.855521444651;14480.85519144795;13474.595762127152;13643.931780341034;13863.514776982756;14097.154170749787;14353.784693229401;12869.2921889297;12978.480860765463;13080.82272595471;13252.536161234697;13481.123726957716;9739.269554783561;9806.80386392254;10126.44304563256;10214.233932455245;10567.682969510926;10628.787424251317;10771.138308935424;11127.666170014912;11264.098872090377;11302.43487825622 13:27:05 INFO - PID 3467 | __end_tp_report 13:27:05 INFO - PID 3467 | __start_cc_report 13:27:05 INFO - PID 3467 | _x_x_mozilla_cycle_collect,285 13:27:05 INFO - PID 3467 | __end_cc_report 13:27:05 INFO - PID 3467 | __startTimestamp1494793625337__endTimestamp 13:27:05 INFO - PID 3467 | 13:27:05 INFO - PID 3467 | ------- Summary: start ------- 13:27:05 INFO - PID 3467 | Number of tests: 6 13:27:05 INFO - PID 3467 | 13:27:05 INFO - PID 3467 | [#0] dojo.html Cycles:165 Average:5189.02 Median:5370.57 stddev:599.84 (11.2%) stddev-sans-first:570.03 13:27:05 INFO - PID 3467 | Values: 2737.9 2749.0 2768.9 2779.3 2787.9 5123.9 5252.2 5281.3 5285.9 5303.1 5207.7 5240.5 5244.4 5283.6 5305.4 4684.8 4708.1 4712.8 4726.9 4768.8 4639.0 4726.3 4758.7 4789.5 4833.1 4668.6 4691.6 4723.3 4724.9 4775.0 4711.0 4715.7 4733.0 4735.3 4762.9 4682.7 4697.9 4700.6 4703.4 4728.1 5156.1 5188.6 5234.1 5234.6 5260.9 5619.9 5624.5 5676.1 5703.2 5712.4 5715.8 5718.2 5738.6 5798.1 5800.4 5295.8 5304.1 5327.8 5334.9 5338.2 5722.3 5749.7 5840.1 5861.8 5865.2 5494.1 5520.6 5538.1 5540.8 5541.3 5615.2 5687.5 5711.0 5733.3 5750.7 5618.5 5647.6 5650.2 5656.2 5656.8 5508.7 5637.6 5646.3 5647.2 5651.0 4533.7 4538.0 4596.8 4623.7 4624.7 4033.4 4034.1 4067.7 4077.3 4119.5 4927.8 4929.3 4932.5 4942.4 4976.4 5612.4 5620.6 5702.2 5732.9 5744.2 4852.6 4883.8 4910.9 4919.5 4963.1 5018.2 5021.6 5022.5 5023.1 5035.7 5367.5 5370.6 5374.2 5400.8 5421.8 5606.8 5610.6 5661.0 5667.3 5706.9 5215.1 5287.6 5289.8 5355.0 5405.1 5558.5 5571.6 5576.7 5578.4 5582.1 5669.4 5676.9 5677.9 5679.6 5680.4 5421.8 5486.2 5488.0 5497.5 5498.1 5485.6 5489.6 5500.8 5502.3 5505.0 5307.6 5307.7 5388.0 5468.4 5481.2 5508.9 5522.9 5523.8 5535.4 5567.2 5374.8 5382.2 5382.9 5383.3 5439.3 13:27:05 INFO - PID 3467 | 13:27:05 INFO - PID 3467 | [#1] ext.html Cycles:180 Average:30431.68 Median:30570.31 stddev:41972.35 (137.3%) stddev-sans-first:42030.85 13:27:05 INFO - PID 3467 | Values: 731.3 758.5 1048.4 1069.4 1159.3 32218.0 33064.3 33300.7 33308.2 33359.2 30719.5 30922.8 30937.4 31080.7 31151.8 6306.2 6407.6 6411.1 6678.8 6841.6 6835.6 6926.1 6936.2 6945.9 6950.8 6872.9 6980.1 6986.4 6987.9 7005.8 6886.1 6930.8 6938.3 6953.1 6975.0 6878.7 6889.9 6895.2 6901.8 6940.5 30651.4 30803.2 30837.0 30926.7 31041.4 2932.1 2949.1 2966.6 2974.5 2975.0 23738.0 23898.2 23953.2 24008.2 24071.8 3100.8 3133.2 3143.0 3149.8 3186.8 148540.0 149058.0 149112.3 149159.0 149638.0 35681.0 38413.2 38672.4 39544.6 39843.0 40377.2 40456.0 40577.8 40658.0 40662.4 12571.6 12732.6 12743.5 12745.6 12766.3 10033.7 10095.0 10107.8 10111.1 10111.5 12318.6 12399.2 12447.8 12512.7 12642.9 5159.4 5201.5 5220.1 5251.6 5311.3 769.5 798.2 803.8 817.7 822.5 18771.7 19018.5 19040.9 19598.2 24672.4 946.4 960.7 981.0 981.9 987.4 10984.1 11433.3 11460.8 11463.8 11566.7 179693.0 180724.0 181567.0 181688.0 182119.0 39465.0 39538.2 39608.8 39704.4 39746.6 1126.7 1185.5 1244.6 1246.8 1247.9 19640.7 19866.7 19878.9 20861.8 22965.9 37083.6 37443.4 37583.2 37611.4 37667.8 154997.0 155773.0 156043.4 156131.2 157171.0 27976.0 28482.7 28671.4 29034.9 29415.9 34236.3 35169.1 35224.6 35580.1 35912.8 26432.6 27005.7 27019.7 27271.2 27730.2 26494.2 27043.5 27386.6 27488.0 28131.0 28656.6 30385.4 30489.2 30657.8 31282.2 26374.6 26535.3 26754.3 26853.9 28038.9 20296.7 21814.3 22113.0 22323.2 22507.5 13:27:05 INFO - PID 3467 | 13:27:05 INFO - PID 3467 | [#2] jquery.html Cycles:180 Average:24975.35 Median:181387.26 stddev:60566.24 (33.4%) stddev-sans-first:60708.06 13:27:05 INFO - PID 3467 | Values: 412.3 412.5 413.0 426.5 436.9 13492.9 16985.5 17566.4 17614.6 17726.2 17881.4 18353.5 18453.0 18992.7 19233.1 5298.2 5302.9 5383.5 5431.2 5476.2 5381.2 5448.0 5456.9 5465.9 5489.2 5327.6 5423.8 5427.4 5520.7 5559.3 5531.6 5535.3 5537.5 5564.4 5577.2 4943.5 4965.3 4978.5 5004.4 5006.0 22054.6 22437.1 22591.8 22883.4 23034.2 1606.6 1639.4 1639.9 1653.9 1661.8 14807.3 14927.0 14997.4 15269.7 15306.2 2040.9 2098.9 2116.2 2135.7 2155.8 87418.0 88465.6 89864.0 90793.5 92949.5 10890.9 10895.5 10924.4 10970.6 11226.2 15218.5 15274.5 15280.8 15356.5 32351.4 8727.6 8748.7 8786.4 8894.2 9035.7 6770.5 6864.8 6900.2 7047.8 7337.1 9153.4 9342.3 9680.8 9700.5 9837.5 3586.5 3901.3 3969.1 3979.3 4018.0 825.1 874.6 874.8 883.7 888.5 16511.4 16814.9 16818.7 17211.9 17621.1 870.5 881.2 883.7 886.9 902.6 9267.6 9608.6 9668.6 9721.7 9871.4 359188.0 361705.0 366792.0 367010.0 367437.0 72826.6 73019.3 74192.3 74945.0 76358.6 1038.5 1039.9 1075.8 1080.6 1082.5 14571.6 14704.0 14883.7 15076.2 15471.7 37476.3 37575.8 37875.4 38114.7 38701.6 45218.0 45768.1 45854.0 46487.5 48418.0 11205.7 11658.3 11672.8 11871.3 12128.9 12595.5 12827.1 12841.8 12907.5 13116.2 10242.4 10746.7 10917.9 10957.0 11070.9 10168.6 10272.3 10501.2 10510.6 10566.2 10559.3 10594.0 10652.4 10691.7 11061.2 11333.5 11343.5 11457.1 11487.7 11862.9 10637.3 11029.7 11048.4 11083.6 11411.4 13:27:05 INFO - PID 3467 | 13:27:05 INFO - PID 3467 | [#3] mootools.html Cycles:180 Average:6332.32 Median:3733.17 stddev:4095.21 (109.7%) stddev-sans-first:4088.67 13:27:05 INFO - PID 3467 | Values: 1217.9 1265.2 1275.7 1283.5 1286.8 9732.5 10113.0 10142.0 10446.5 10821.8 10339.5 10478.2 10498.9 10524.3 10530.6 2227.1 2268.0 2270.7 2271.0 2274.4 2212.1 2283.7 2290.2 2294.2 2295.0 2162.6 2172.9 2210.4 2214.1 2219.7 2141.5 2143.0 2211.4 2214.4 2219.2 2109.0 2190.2 2200.4 2252.5 2253.9 10202.8 10292.3 10305.0 10310.8 10315.8 5415.2 5601.0 5641.6 5647.2 5663.9 3066.1 3186.2 3259.5 3264.2 3269.8 1010.4 1019.4 1032.8 1079.3 1082.3 14322.4 14326.6 14356.1 14428.6 14510.4 4624.2 4646.7 4896.2 4916.7 5033.6 10888.5 11003.1 11003.4 11009.2 11049.9 5679.5 5687.7 5726.5 5731.7 5744.5 4855.5 5129.4 5129.9 5208.6 5252.2 3781.8 3801.6 3848.6 3883.9 3973.5 1083.5 1102.2 1102.3 1117.6 1119.9 678.2 697.5 699.7 715.9 719.5 5215.1 5294.6 5375.1 5440.9 5480.2 530.3 530.7 532.2 536.5 544.3 3256.6 3709.1 3757.2 3892.0 4009.2 13596.9 13821.1 13844.9 13889.0 13919.7 13663.0 13757.0 13782.7 13801.5 13830.0 7435.6 7728.5 7770.4 7814.6 7870.6 6000.2 6099.3 6114.3 6295.6 6494.8 11836.9 11908.9 12125.8 12218.3 12315.8 11760.3 11897.8 12010.0 12070.1 12442.9 8293.8 8339.1 8536.5 8642.7 8654.4 9531.8 9642.3 9672.7 9676.3 9713.1 8057.2 8215.2 8228.0 8264.3 8679.9 8204.5 8263.5 8280.2 8298.9 8559.1 7461.0 7482.2 7566.9 7569.6 7576.5 4934.0 4989.5 4996.1 5014.1 5172.9 5331.4 5370.7 5458.0 5553.0 5658.2 13:27:05 INFO - PID 3467 | 13:27:05 INFO - PID 3467 | [#4] prototype.html Cycles:180 Average:4713.72 Median:5396.19 stddev:1384.47 (25.7%) stddev-sans-first:1349.07 13:27:05 INFO - PID 3467 | Values: 350.5 368.6 376.3 376.6 388.9 5403.6 5411.2 5466.6 5486.5 5488.8 5327.6 5338.7 5350.5 5353.1 5368.7 4136.3 4178.4 4201.9 4210.7 4211.6 4187.6 4192.5 4195.6 4198.7 4200.8 4159.5 4170.5 4176.0 4176.5 4197.9 4071.8 4168.3 4174.0 4174.6 4197.4 3727.9 3741.5 3742.9 3745.9 3780.3 5217.3 5232.5 5235.4 5256.7 5267.8 4861.5 4945.2 4949.3 4950.9 4982.7 5628.0 5634.9 5658.9 5660.0 5673.7 4215.1 4217.9 4233.0 4242.4 4243.7 5730.1 5887.6 5917.9 5942.2 5969.5 3961.1 3978.3 3981.2 3988.4 3990.4 4034.3 4052.5 4055.8 4064.6 4075.3 4615.9 4645.9 4670.2 4679.5 4702.8 5614.2 5643.4 5644.7 5652.5 5653.5 1382.0 1400.2 1400.9 1405.3 1406.3 884.7 935.2 936.1 945.8 947.6 4982.0 4984.6 5006.6 5008.5 5029.2 5868.3 5889.1 5890.5 5895.2 5906.5 4776.7 4943.3 4948.1 4952.5 4963.9 3070.3 3111.1 3115.8 3118.5 3122.0 5518.7 5522.4 5527.2 5550.2 5560.9 5732.5 5951.6 6020.2 6041.2 6050.5 5541.2 5558.9 5573.6 5578.5 5583.0 5713.3 5829.7 5865.9 5902.4 5941.3 5728.7 5788.2 5789.5 5803.5 5826.0 5388.8 5502.9 5507.6 5546.1 5566.7 3996.8 3999.8 4009.6 4016.4 4031.6 5862.5 5902.3 5909.0 5915.6 5934.7 5710.4 5726.7 5735.8 5736.2 5763.2 5702.9 5744.2 5748.6 5750.2 5752.4 5499.5 5591.6 5625.8 5630.9 5633.5 5730.1 5760.5 5762.5 5765.0 5783.1 5474.3 5594.5 5597.7 5598.2 5602.7 13:27:05 INFO - PID 3467 | 13:27:05 INFO - PID 3467 | [#5] yui.html Cycles:180 Average:15078.05 Median:3609.44 stddev:17948.86 (497.3%) stddev-sans-first:17966.86 13:27:05 INFO - PID 3467 | Values: 726.7 741.7 745.9 750.3 753.2 12047.6 12698.7 12847.4 14768.6 15521.1 13861.4 14970.8 15575.4 15822.2 15984.4 890.3 906.2 909.5 910.3 911.2 915.5 916.4 916.6 917.7 919.9 965.1 966.9 967.8 968.0 970.3 956.3 957.3 958.0 959.0 960.0 701.8 702.8 704.6 705.7 708.7 13322.5 13583.8 13961.3 14052.9 14146.6 15309.3 15744.8 15868.0 15881.3 16159.4 12007.1 12105.0 12200.3 12496.0 12600.3 2951.7 2969.5 2970.6 2988.2 2992.3 71742.9 71746.0 72060.0 72637.6 74979.0 12678.7 12869.4 13075.9 13083.9 13106.6 21785.2 22425.9 22717.5 22810.2 22932.7 6045.8 6156.9 6201.2 6246.1 6249.8 2717.8 2799.8 2810.7 2821.8 2823.8 3500.8 3526.1 3581.9 3591.0 3627.9 688.9 689.2 699.9 701.2 701.2 591.4 599.8 607.2 611.8 622.0 8541.7 8941.4 9132.2 9209.2 9615.3 570.6 580.0 584.8 599.9 616.6 4080.3 4144.3 4155.4 4197.0 4204.6 60572.7 60607.4 61159.2 61384.3 62407.4 55609.2 55640.7 55731.4 57074.0 58487.4 47796.8 48293.0 48392.5 50247.2 50353.5 8160.6 8403.5 8415.6 8417.6 8657.0 26043.9 26274.2 26744.7 27331.3 27438.7 31630.4 32007.5 32229.4 32494.0 44821.0 13382.9 13401.9 13558.5 13634.6 13636.7 14919.3 15399.6 15450.1 16266.8 16599.9 13664.2 14122.1 14182.6 14447.9 14480.9 13474.6 13643.9 13863.5 14097.2 14353.8 12869.3 12978.5 13080.8 13252.5 13481.1 9739.3 9806.8 10126.4 10214.2 10567.7 10628.8 10771.1 11127.7 11264.1 11302.4 13:27:05 INFO - PID 3467 | -------- Summary: end -------- 13:27:05 INFO - PID 3467 | 13:27:06 INFO - TEST-INFO | 3467: exit 0 13:27:06 INFO - TEST-OK | dromaeo_css | took 1120387ms 13:27:06 INFO - TEST-START | kraken 13:27:06 INFO - operating with platform_type : linux_ 13:27:06 INFO - Initialising browser for kraken test... 13:27:06 INFO - TEST-INFO | started process 3887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAtoeqw/profile http://localhost:58257/getInfo.html) 13:27:06 INFO - PID 3887 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 13:27:10 INFO - PID 3887 | __metrics Screen width/height:1600/1200 13:27:10 INFO - PID 3887 | colorDepth:24 13:27:10 INFO - PID 3887 | Browser inner width/height: 1024/695 13:27:10 INFO - PID 3887 | __metrics 13:27:12 INFO - TEST-INFO | 3887: exit 0 13:27:12 INFO - Browser initialized. 13:27:12 INFO - Running cycle 1/1 for kraken test... 13:27:12 INFO - TEST-INFO | started process 4058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAtoeqw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:24 INFO - PID 4058 | RSS: Main: 161751040 13:27:24 INFO - PID 4058 | 13:27:26 INFO - PID 4058 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58257/tests/kraken/driver.html?testName=audio-beat-detection) 13:27:27 INFO - PID 4058 | RSS: Main: 167387136 13:27:27 INFO - PID 4058 | 13:27:30 INFO - PID 4058 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58257/tests/kraken/driver.html?testName=audio-dft) 13:27:31 INFO - PID 4058 | RSS: Main: 166338560 13:27:31 INFO - PID 4058 | 13:27:34 INFO - PID 4058 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58257/tests/kraken/driver.html?testName=audio-fft) 13:27:34 INFO - PID 4058 | RSS: Main: 161525760 13:27:34 INFO - PID 4058 | 13:27:36 INFO - PID 4058 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58257/tests/kraken/driver.html?testName=audio-oscillator) 13:27:37 INFO - PID 4058 | RSS: Main: 161951744 13:27:37 INFO - PID 4058 | 13:27:39 INFO - PID 4058 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58257/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:27:40 INFO - PID 4058 | RSS: Main: 162844672 13:27:40 INFO - PID 4058 | 13:27:43 INFO - PID 4058 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58257/tests/kraken/driver.html?testName=imaging-darkroom) 13:27:44 INFO - PID 4058 | RSS: Main: 166719488 13:27:44 INFO - PID 4058 | 13:27:47 INFO - PID 4058 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58257/tests/kraken/driver.html?testName=imaging-desaturate) 13:27:48 INFO - PID 4058 | RSS: Main: 164065280 13:27:48 INFO - PID 4058 | 13:27:51 INFO - PID 4058 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58257/tests/kraken/driver.html?testName=json-parse-financial) 13:27:51 INFO - PID 4058 | RSS: Main: 164982784 13:27:51 INFO - PID 4058 | 13:27:53 INFO - PID 4058 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58257/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:27:54 INFO - PID 4058 | RSS: Main: 165122048 13:27:54 INFO - PID 4058 | 13:27:55 INFO - PID 4058 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:27:56 INFO - PID 4058 | RSS: Main: 165744640 13:27:56 INFO - PID 4058 | 13:27:58 INFO - PID 4058 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:27:59 INFO - PID 4058 | RSS: Main: 165965824 13:27:59 INFO - PID 4058 | 13:28:01 INFO - PID 4058 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:28:02 INFO - PID 4058 | RSS: Main: 165249024 13:28:02 INFO - PID 4058 | 13:28:05 INFO - PID 4058 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:28:06 INFO - PID 4058 | RSS: Main: 165294080 13:28:06 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58257/tests/kraken/driver.html?testName=ai-astar) 13:28:08 INFO - PID 4058 | RSS: Main: 166469632 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | __start_tp_report 13:28:08 INFO - PID 4058 | _x_x_mozilla_page_load 13:28:08 INFO - PID 4058 | _x_x_mozilla_page_load_details 13:28:08 INFO - PID 4058 | |i|pagename|runs| 13:28:08 INFO - PID 4058 | |0;ai-astar;105;114;112;113;111;113;112;111;112;111 13:28:08 INFO - PID 4058 | |1;audio-beat-detection;153;128;126;169;125;126;126;124;151;125 13:28:08 INFO - PID 4058 | |2;audio-dft;164;166;165;163;166;168;168;166;164;163 13:28:08 INFO - PID 4058 | |3;audio-fft;75;78;74;108;77;76;81;78;101;75 13:28:08 INFO - PID 4058 | |4;audio-oscillator;84;85;112;85;85;85;97;85;84;112 13:28:08 INFO - PID 4058 | |5;imaging-gaussian-blur;114;115;114;114;113;114;115;114;113;115 13:28:08 INFO - PID 4058 | |6;imaging-darkroom;151;151;151;150;151;149;150;151;151;151 13:28:08 INFO - PID 4058 | |7;imaging-desaturate;95;95;94;95;95;94;95;94;95;94 13:28:08 INFO - PID 4058 | |8;json-parse-financial;60;55;55;56;55;57;57;57;54;56 13:28:08 INFO - PID 4058 | |9;json-stringify-tinderbox;58;56;58;58;58;57;56;56;57;56 13:28:08 INFO - PID 4058 | |10;stanford-crypto-aes;83;87;84;86;85;84;85;83;83;82 13:28:08 INFO - PID 4058 | |11;stanford-crypto-ccm;141;136;135;146;134;135;142;144;182;140 13:28:08 INFO - PID 4058 | |12;stanford-crypto-pbkdf2;190;185;196;192;193;192;184;199;195;195 13:28:08 INFO - PID 4058 | |13;stanford-crypto-sha256-iterative;78;76;77;76;82;74;75;77;74;76 13:28:08 INFO - PID 4058 | __end_tp_report 13:28:08 INFO - PID 4058 | __start_cc_report 13:28:08 INFO - PID 4058 | _x_x_mozilla_cycle_collect,769 13:28:08 INFO - PID 4058 | __end_cc_report 13:28:08 INFO - PID 4058 | __startTimestamp1494793688683__endTimestamp 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | ------- Summary: start ------- 13:28:08 INFO - PID 4058 | Number of tests: 14 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.46 (2.2%) stddev-sans-first:1.05 13:28:08 INFO - PID 4058 | Values: 105.0 114.0 112.0 113.0 111.0 113.0 112.0 111.0 112.0 111.0 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:127.00 stddev:16.15 (12.7%) stddev-sans-first:15.81 13:28:08 INFO - PID 4058 | Values: 153.0 128.0 126.0 169.0 125.0 126.0 126.0 124.0 151.0 125.0 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | [#2] audio-dft Cycles:10 Average:165.30 Median:166.00 stddev:1.83 (1.1%) stddev-sans-first:1.88 13:28:08 INFO - PID 4058 | Values: 164.0 166.0 165.0 163.0 166.0 168.0 168.0 166.0 164.0 163.0 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.50 stddev:11.98 (15.7%) stddev-sans-first:12.41 13:28:08 INFO - PID 4058 | Values: 75.0 78.0 74.0 108.0 77.0 76.0 81.0 78.0 101.0 75.0 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:85.00 stddev:11.52 (13.6%) stddev-sans-first:11.90 13:28:08 INFO - PID 4058 | Values: 84.0 85.0 112.0 85.0 85.0 85.0 97.0 85.0 84.0 112.0 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 13:28:08 INFO - PID 4058 | Values: 114.0 115.0 114.0 114.0 113.0 114.0 115.0 114.0 113.0 115.0 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 13:28:08 INFO - PID 4058 | Values: 151.0 151.0 151.0 150.0 151.0 149.0 150.0 151.0 151.0 151.0 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 13:28:08 INFO - PID 4058 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:1.69 (3.0%) stddev-sans-first:1.09 13:28:08 INFO - PID 4058 | Values: 60.0 55.0 55.0 56.0 55.0 57.0 57.0 57.0 54.0 56.0 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:57.50 stddev:0.94 (1.6%) stddev-sans-first:0.93 13:28:08 INFO - PID 4058 | Values: 58.0 56.0 58.0 58.0 58.0 57.0 56.0 56.0 57.0 56.0 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.50 stddev:1.55 (1.8%) stddev-sans-first:1.58 13:28:08 INFO - PID 4058 | Values: 83.0 87.0 84.0 86.0 85.0 84.0 85.0 83.0 83.0 82.0 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:141.50 stddev:14.14 (10.0%) stddev-sans-first:14.97 13:28:08 INFO - PID 4058 | Values: 141.0 136.0 135.0 146.0 134.0 135.0 142.0 144.0 182.0 140.0 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.10 Median:194.00 stddev:4.72 (2.4%) stddev-sans-first:4.95 13:28:08 INFO - PID 4058 | Values: 190.0 185.0 196.0 192.0 193.0 192.0 184.0 199.0 195.0 195.0 13:28:08 INFO - PID 4058 | 13:28:08 INFO - PID 4058 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.50 Median:76.50 stddev:2.32 (3.0%) stddev-sans-first:2.40 13:28:08 INFO - PID 4058 | Values: 78.0 76.0 77.0 76.0 82.0 74.0 75.0 77.0 74.0 76.0 13:28:08 INFO - PID 4058 | -------- Summary: end -------- 13:28:08 INFO - PID 4058 | 13:28:09 INFO - TEST-INFO | 4058: exit 0 13:28:09 INFO - TEST-OK | kraken | took 63563ms 13:28:09 INFO - SUITE-END | took 1183s 13:28:09 INFO - Completed test suite (00:19:43) 13:28:09 INFO - javascript benchmark 13:28:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6730.820350165057, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2737.931551711207, 2749.024096445763, 2768.9030883919067, 2779.3051737065734, 2787.8745456454462, 5123.871903202422, 5252.238425428311, 5281.260623512707, 5285.92071118933, 5303.124984377583, 5207.713575753332, 5240.502152295536, 5244.423113457517, 5283.63014588978, 5305.389880163782, 4684.812607495696, 4708.0819240248165, 4712.764361781914, 4726.881827954294, 4768.809247630091, 4639.0, 4726.26742854858, 4758.690685105475, 4789.49710280419, 4833.130036593412, 4668.649851261169, 4691.554302341272, 4723.315119307716, 4724.881877953045, 4774.952250477503, 4710.976445117787, 4715.669903106749, 4732.976335118303, 4735.313379559979, 4762.857114286577, 4682.742449165295, 4697.859064228079, 4700.623950083985, 4703.365045718819, 4728.05438912219, 5156.123459011977, 5188.5849132069725, 5234.057869583474, 5234.633575649668, 5260.92108618371, 5619.943800561983, 5624.521915637176, 5676.091825307973, 5703.201551782754, 5712.371639119735, 5715.799947001877, 5718.199452076754, 5738.569607279471, 5798.130280457923, 5800.419958004166, 5295.814646487432, 5304.124819404755, 5327.786888524415, 5334.866628334245, 5338.172583249602, 5722.284714410699, 5749.655020698688, 5840.1239814027385, 5861.77854842705, 5865.178874957509, 5494.148406996922, 5520.585956053312, 5538.086215774432, 5540.833774986757, 5541.2796336476, 5615.241942337732, 5687.544996400361, 5711.0, 5733.283339582552, 5750.741216645261, 5618.52242559387, 5647.576431767634, 5650.152477128464, 5656.151577263443, 5656.8020119295625, 5508.669479831223, 5637.577181711388, 5646.265985421869, 5647.1529270609735, 5650.971745141248, 4533.705309154894, 4538.0, 4596.839110631112, 4623.676342655982, 4624.676272660881, 4033.4353190553347, 4034.072163402434, 4067.6745860331102, 4077.32724100526, 4119.505659320901, 4927.77824997876, 4929.309896614477, 4932.53140951609, 4942.382202224722, 4976.3578019253555, 5612.382637909826, 5620.634658747168, 5702.2301989231755, 5732.885342293131, 5744.167095771173, 4852.56326930578, 4883.755812209375, 4910.926336104962, 4919.508049195052, 4963.081829861487, 5018.222175562793, 5021.648484606116, 5022.547970682656, 5023.14606516893, 5035.697858128524, 5367.543758780547, 5370.570354371641, 5374.247605335178, 5400.810971615974, 5421.7560209791445, 5606.803761868315, 5610.551155907599, 5660.971695141498, 5667.2632557768875, 5706.885862282814, 5215.0612889678705, 5287.629865909349, 5289.841304760864, 5355.0, 5405.135178371442, 5558.499735023867, 5571.554275658019, 5576.721163941867, 5578.386377498553, 5582.078956972054, 5669.433056694297, 5676.886462270814, 5677.943220567741, 5679.602427830012, 5680.375158732619, 5421.756020978986, 5486.177073439016, 5488.039593071277, 5497.532709719559, 5498.147787093007, 5485.561155107662, 5489.615726899238, 5500.752466138953, 5502.312210973629, 5505.0, 5307.6284660073425, 5307.708076055854, 5388.0, 5468.425815289337, 5481.232627432083, 5508.944910550843, 5522.9447705524035, 5523.8066667666435, 5535.39110697831, 5567.192757050286, 5374.838754837361, 5382.19267109921, 5382.865428364165, 5383.273258110105, 5439.347278326468], "value": 5146.047675655673, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.2979539641943, 758.5335018963337, 1048.4076496779319, 1069.3797597393507, 1159.2522822779301, 32218.0, 33064.33871322572, 33300.66699333006, 33308.16729581761, 33359.16602084946, 30719.539206911857, 30922.84538577304, 30937.38125237494, 31080.68919310806, 31151.84424077882, 6306.211723534559, 6407.615543067431, 6411.134496842937, 6678.76624318149, 6841.589504629714, 6835.624040677761, 6926.134233220848, 6936.237013928464, 6945.930540694604, 6950.826229344281, 6872.862542749142, 6980.057692211562, 6986.441084713236, 6987.930120698804, 7005.824854378656, 6886.139232595926, 6930.792076237721, 6938.271481494447, 6953.096097507342, 6974.965125174393, 6878.7248510059535, 6889.896651550231, 6895.207051189127, 6901.827454313682, 6940.548864323803, 30651.386972260654, 30803.229919251975, 30837.0, 30926.690733092608, 31041.37917241665, 2932.135020169034, 2949.130006648044, 2966.6291713535807, 2974.5240761478276, 2974.970250297491, 23738.0, 23898.163564275168, 23953.161639342714, 24008.159714410085, 24071.759282407125, 3100.8139511629147, 3133.185371803325, 3142.9842850785826, 3149.811011339327, 3186.76099292554, 148540.0, 149058.0, 149112.2544387271, 149159.0, 149638.0, 35681.0, 38413.23173536514, 38672.41991370132, 39544.60455395467, 39843.0, 40377.1924561513, 40456.0, 40577.79711101425, 40658.0, 40662.39006414906, 12571.559995400117, 12732.554360597334, 12743.49026038948, 12745.61763147107, 12766.297853617954, 10033.749156271151, 10095.0, 10107.797844043225, 10111.140553052926, 10111.494425278706, 12318.630441086782, 12399.194052386567, 12447.813282800766, 12512.746685861559, 12642.87357126417, 5159.380874295109, 5201.45384734605, 5220.086484865209, 5251.6061295403, 5311.336082989626, 769.4690663442319, 798.2376830127215, 803.7669075967904, 817.6729308276618, 822.5188264865001, 18771.718424223647, 19018.524536886413, 19040.904795475933, 19598.216071356987, 24672.42153585179, 946.3895787217344, 960.6877764726491, 980.9558569864373, 981.8674478945394, 987.4420952162149, 10984.121270298358, 11433.25683830565, 11460.770784584261, 11463.770724585462, 11566.710832229093, 179693.0, 180724.0, 181567.0, 181688.0, 182119.0, 39465.0, 39538.209235815695, 39608.801955990035, 39704.404433933516, 39746.60253397487, 1126.7295848996182, 1185.4843143232722, 1244.5581818454318, 1246.7506498700295, 1247.906407019459, 19640.705389418883, 19866.70199946973, 19878.90060549688, 20861.791382085983, 22965.88517057404, 37083.629163708014, 37443.43834842425, 37583.24833503369, 37611.43582846205, 37667.81166094152, 154997.0, 155773.0, 156043.43956560743, 156131.21934390254, 157171.0, 27976.0, 28482.715172848835, 28671.42657146887, 29034.854825725735, 29415.852920736117, 34236.31527369389, 35169.1207719809, 35224.64775352316, 35580.11049723778, 35912.8204358987, 26432.603510946967, 27005.72994270032, 27019.72980270172, 27271.181864544094, 27730.168094957182, 26494.205173844817, 27043.45913081688, 27386.5892011616, 27488.0, 28131.015414460395, 28656.570151448163, 30385.392292153592, 30489.23776905595, 30657.846710766302, 31282.21794455066, 26374.604380934685, 26535.33661658474, 26754.331141721614, 26853.865730672, 28038.859805700842, 20296.695549567063, 21814.345569632937, 22112.973308504035, 22323.218687345863, 22507.549849003255], "value": 14392.24450094583, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.25587813995725, 412.4596778220529, 412.9648979836714, 426.45839783474986, 436.9388285640011, 13492.865071349284, 16985.490435286945, 17566.38517651881, 17614.647707045868, 17726.20232089559, 17881.407195956577, 18353.54116147097, 18453.0, 18992.715109273373, 19233.134508947096, 5298.15229563269, 5302.946970530284, 5383.488568585978, 5431.158170483582, 5476.205950137228, 5381.192821076831, 5448.0, 5456.945430545703, 5465.945340546584, 5489.231507588921, 5327.627066105374, 5423.810166644168, 5427.402985671573, 5520.696361700105, 5559.3328800543995, 5531.612787104904, 5535.280413546254, 5537.501624853742, 5564.443555644443, 5577.163425486169, 4943.505649435064, 4965.3048573199785, 4978.502149785028, 5004.424491183524, 5006.023825354057, 22054.558908821735, 22437.102515899343, 22591.774082259133, 22883.42791430211, 23034.193803216807, 1606.5662271186832, 1639.418006607661, 1639.9344026238937, 1653.875959303057, 1661.808891977426, 14807.259637018215, 14927.0, 14997.400103995828, 15269.694606107927, 15306.158161301124, 2040.9081591328427, 2098.8635738676935, 2116.174691870172, 2135.7330333708287, 2155.795199456065, 87418.0, 88465.55767221187, 89864.0, 90793.54603227008, 92949.53525232399, 10890.891091088988, 10895.455227238606, 10924.399158046224, 10970.561177552969, 11226.158038147172, 15218.543443696486, 15274.541763747106, 15280.847191527942, 15356.539303820904, 32351.35297294041, 8727.60725767342, 8748.69379571712, 8786.428882122642, 8894.155055269868, 9035.728928132166, 6770.526063175629, 6864.7940561783225, 6900.2409734929115, 7047.753328633473, 7337.119545654556, 9153.405028673114, 9342.2526197904, 9680.75798105053, 9700.466474343979, 9837.458939758382, 3586.5158203642695, 3901.313258970246, 3969.1069509360163, 3979.263836190314, 4017.9598204017584, 825.1171246766023, 874.6064271077913, 874.7813046738315, 883.7083762358407, 888.5424006636588, 16511.422100226435, 16814.915925420293, 16818.66362672764, 17211.91394043047, 17621.118944052745, 870.5299138465284, 881.1540920716184, 883.7392969074139, 886.9068747781519, 902.5712786426526, 9267.553090680589, 9608.567614457366, 9668.564914578861, 9721.70834874955, 9871.40771553709, 359188.0, 361705.0, 366792.0, 367010.0, 367437.0, 72826.63586682033, 73019.26980730124, 74192.25807741961, 74945.0, 76358.6182069086, 1038.4703801061512, 1039.859618951432, 1075.8278675411896, 1080.556971641639, 1082.5236895765838, 14571.562853114423, 14704.0, 14883.702325953636, 15076.246187690353, 15471.690566188388, 37476.2504749898, 37575.81212093922, 37875.431868522544, 38114.665986690336, 38701.6129838698, 45218.0, 45768.084638307715, 45854.0, 46487.53512464967, 48418.0, 11205.66383008511, 11658.300501969909, 11672.76654466889, 11871.287722736663, 12128.878711212776, 12595.496180153057, 12827.10210285271, 12841.807372889602, 12907.548235811702, 13116.213027218397, 10242.384230878019, 10746.677599672023, 10917.890821091687, 10957.0, 11070.944645276722, 10168.593256269667, 10272.280940334105, 10501.159907207559, 10510.579576817148, 10566.207534435101, 10559.313644613076, 10594.0, 10652.360858348524, 10691.732706682084, 11061.225714199929, 11333.489992950503, 11343.489542970421, 11457.140714446283, 11487.655370338904, 11862.881371186179, 10637.255392122786, 11029.669109926715, 11048.392338421463, 11083.612073577386, 11411.429428528707], "value": 9260.853223322663, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.914745967782, 1265.2408554867081, 1275.7320962597853, 1283.4930202569985, 1286.8262784524086, 9732.513374331282, 10112.99999999999, 10142.0, 10446.477676116183, 10821.83767243492, 10339.534720937558, 10478.214133939948, 10498.895011049906, 10524.263301568893, 10530.578776848917, 2227.086894373311, 2268.036084664011, 2270.7275126984787, 2270.9545809083806, 2274.385915802732, 2212.1372664660794, 2283.7031185945802, 2290.1526435218907, 2294.1740973249616, 2295.0, 2162.5566758814484, 2172.945676358088, 2210.3810932938723, 2214.0922221889027, 2219.7336319641668, 2141.4860433496005, 2143.0, 2211.436083798629, 2214.4242496950746, 2219.2010876084596, 2108.968365474519, 2190.1567896359857, 2200.4388880835286, 2252.4594097416502, 2253.8873056347115, 10202.846957295647, 10292.279540432173, 10305.021023002802, 10310.845337319946, 10315.79368412635, 5415.214793854909, 5601.047821870251, 5641.633293835928, 5647.209390685307, 5663.886722265532, 3066.1261540461082, 3186.2193762528095, 3259.5110733389943, 3264.216588018858, 3269.8038117712777, 1010.4089107871904, 1019.3883669798136, 1032.7676272838626, 1079.2930630437077, 1082.2910993299402, 14322.427102915872, 14326.57020289393, 14356.138631682132, 14428.567142985727, 14510.419583216764, 4624.190766615829, 4646.697964632288, 4896.1921282987905, 4916.72957987307, 5033.647644664911, 10888.510017049251, 11003.064739497233, 11003.394813285186, 11009.174311926477, 11049.889501105046, 5679.488846003879, 5687.7156142192725, 5726.513246374105, 5731.742071606787, 5744.47771340595, 4855.465898751135, 5129.358830146231, 5129.8717532061255, 5208.557272631793, 5252.1596544552685, 3781.7541859779026, 3801.6008319126645, 3848.5766565677754, 3883.8834834954996, 3973.4834471518516, 1083.5178345636273, 1102.1843835561788, 1102.3055475050828, 1117.6144230240554, 1119.9328040317607, 678.1929503890354, 697.4594689115976, 699.7026263837848, 715.8532500837316, 719.481972979454, 5215.13950198213, 5294.629375943724, 5375.059364611256, 5440.91838622421, 5480.1769151665785, 530.3079481276893, 530.7160669042044, 532.1538753382064, 536.5144544187516, 544.300573762713, 3256.6254880688552, 3709.1283548366114, 3757.2109856929806, 3891.9610803892165, 4009.178118485762, 13596.93201533986, 13821.101628394123, 13844.861551384558, 13889.0, 13919.721605567833, 13663.0, 13757.0, 13782.65543361424, 13801.516946907012, 13830.0, 7435.628218589049, 7728.497647652885, 7770.368222673302, 7814.570198639016, 7870.567118808521, 6000.159977603226, 6099.2985806632805, 6114.266288045463, 6295.5907865988565, 6494.805155845333, 11836.940815295868, 11908.940455297668, 12125.81811272814, 12218.327991960172, 12315.75368492643, 11760.294382337088, 11897.762044759229, 12010.0, 12070.094742894142, 12442.875571244173, 8293.792655183668, 8339.12439193876, 8536.487810731376, 8642.654293828176, 8654.394192406471, 9531.76170595713, 9642.325037247325, 9672.70981870545, 9676.27427942893, 9713.07725766051, 8057.234562716532, 8215.178482151738, 8228.0, 8264.256216940505, 8679.86980195285, 8204.548749818818, 8263.462874913352, 8280.171982801672, 8298.917010829815, 8559.101294364002, 7460.962695186489, 7482.176960534228, 7566.924330756622, 7569.621518924142, 7576.545407275581, 4934.0, 4989.501049894981, 4996.075725990703, 5014.122528557561, 5172.870678232924, 5331.360236771612, 5370.650907690988, 5457.972710136424, 5553.028220061554, 5658.179563963285], "value": 4701.083108552743, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.54079156305244, 368.60743308376595, 376.3263757873406, 376.58387481832574, 388.9377699568069, 5403.621746477748, 5411.242426060355, 5466.644668096571, 5486.451354864512, 5488.807891723791, 5327.573794096473, 5338.665333666583, 5350.5452036576935, 5353.116735738598, 5368.731563421833, 4136.296829538971, 4178.35235538492, 4201.915961680765, 4210.663146948252, 4211.578842115795, 4187.623113919746, 4192.517860446057, 4195.559466256045, 4198.706090573661, 4200.789960501978, 4159.521655009682, 4170.47869016373, 4175.958240417603, 4176.477940257468, 4197.937030944523, 4071.77846646008, 4168.333066709312, 4174.038202045049, 4174.603412675791, 4197.391378250137, 3727.9068023299365, 3741.5118945900945, 3742.9438558421375, 3745.887623371303, 3780.3006443807985, 5217.34783152106, 5232.529072383466, 5235.424103348667, 5256.737163141827, 5267.762950667229, 4861.465238823726, 4945.23348880924, 4949.331840201563, 4950.851474455772, 4982.725950072744, 5627.991087931744, 5634.887302253973, 5658.943410565924, 5659.971700141514, 5673.6879471629045, 4215.072684009513, 4217.894552636178, 4232.978835105805, 4242.4272723182285, 4243.6605071594195, 5730.05454100073, 5887.5584331174905, 5917.851469221761, 5942.197803296543, 5969.522438204933, 3961.1285517186748, 3978.264021156095, 3981.203759248162, 3988.441618173458, 3990.4014397840556, 4034.253663072341, 4052.5339585947995, 4055.8174882130374, 4064.6138616831354, 4075.2664520386024, 4615.884602884955, 4645.907081858344, 4670.206064968964, 4679.508651591534, 4702.811887524529, 5614.157876318585, 5643.379228284885, 5644.74598643062, 5652.491275785117, 5653.462921022497, 1381.979270310946, 1400.1529074909736, 1400.9229492377813, 1405.283305514195, 1406.296851574213, 884.7080463447047, 935.1677007463363, 936.1387523478417, 945.8013817098487, 947.5830634520789, 4981.950180498221, 4984.551390374883, 5006.599472042228, 5008.474110218447, 5029.245613158056, 5868.325142608569, 5889.0871914852405, 5890.49930755882, 5895.174675545427, 5906.49794767441, 4776.665633405628, 4943.28322393251, 4948.05986862495, 4952.529509696573, 4963.925541116886, 3070.293832418556, 3111.128883912508, 3115.7507399408446, 3118.5478105675, 3121.9687803122133, 5518.696471694096, 5522.392536820947, 5527.198556209327, 5550.222968784374, 5560.860978475571, 5732.455416735404, 5951.55363347742, 6020.183852917648, 6041.214642096587, 6050.54620903434, 5541.196526503715, 5558.916616250759, 5573.6098473106495, 5578.525825304894, 5583.0, 5713.257276554022, 5829.650220986754, 5865.882682346414, 5902.38025007368, 5941.257342832146, 5728.656280623176, 5788.160716696139, 5789.536837052941, 5803.506701930214, 5826.0, 5388.757505912165, 5502.862428439321, 5507.614466987273, 5546.140348246028, 5566.747481816721, 3996.840126395028, 3999.8200080995844, 4009.5589485157193, 4016.397540368968, 4031.6493974518867, 5862.530997520103, 5902.321233058254, 5908.970455147697, 5915.556333274935, 5934.732937017759, 5710.428957104256, 5726.652072650193, 5735.827925162252, 5736.225609542658, 5763.193152958505, 5702.857428564319, 5744.224529688438, 5748.597598168088, 5750.159948816338, 5752.424757524382, 5499.477549632778, 5591.552675786009, 5625.831225063254, 5630.943690563042, 5633.492985631149, 5730.08318669011, 5760.452756988079, 5762.538996880324, 5764.982256210293, 5783.132530120515, 5474.260974768515, 5594.468525490072, 5597.676964060032, 5598.21624972496, 5602.747876345656], "value": 4280.145958872197, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.658470518856, 741.6884908338498, 745.8769303064995, 750.272235931147, 753.1790348520112, 12047.578334758275, 12698.68253293667, 12847.357632118392, 14768.556943291691, 15521.146336951464, 13861.376238069286, 14970.775438368433, 15575.37698492059, 15822.208889555533, 15984.360625574964, 890.2610833008588, 906.229704750963, 909.513410325476, 910.2808781062986, 911.2436677557612, 915.514777168102, 916.4318122763863, 916.5737931861682, 917.7017469322464, 919.8988111307751, 965.1072757699101, 966.8791401074866, 967.8306296398138, 968.0029569543382, 970.2868391732071, 956.3496822160963, 957.3107362698846, 958.0084612426141, 958.9520523973808, 960.0447554683135, 701.7789396340188, 702.820780700918, 704.5983789240136, 705.7353492440335, 708.6704682322693, 13322.467101315935, 13583.796243056362, 13961.301934903215, 14052.92973535136, 14146.646333841634, 15309.31108100127, 15744.842551574453, 15868.0, 15881.28534215963, 16159.353625854952, 12007.099467539969, 12105.0, 12200.328981905992, 12496.0, 12600.306983115925, 2951.74910132639, 2969.465496210681, 2970.6138202033812, 2988.193187839271, 2992.341684829356, 71742.9238561422, 71746.0, 72060.0, 72637.63681181613, 74979.0, 12678.746425071631, 12869.356532173353, 13075.869241307655, 13083.934580327037, 13106.60680179596, 21785.23751668684, 22425.887870560542, 22717.545649086926, 22810.20164294242, 22932.656010159862, 6045.818625441244, 6156.938430615726, 6201.224846894138, 6246.125542424064, 6249.812505624838, 2717.768989635903, 2799.790015748786, 2810.676772171186, 2821.844798536059, 2823.774098072149, 3500.824958752052, 3526.083218363244, 3581.8746343877838, 3591.0, 3627.8730244441317, 688.8863337549349, 689.1764341611726, 699.9370056694922, 701.2216439751871, 701.2496628607341, 591.382005803936, 599.7750843433712, 607.1590846677384, 611.8164550634792, 622.0389498225162, 8541.658333666584, 8941.418807777474, 9132.178103970675, 9209.217216536535, 9615.278854085971, 570.597728601335, 580.042929166878, 584.8479395357152, 599.8800239951939, 616.5838059310038, 4080.3471444568727, 4144.254034273859, 4155.4182414462, 4196.979015104905, 4204.579542045771, 60572.697136514034, 60607.39392606018, 61159.18987696162, 61384.336975974424, 62407.37592624016, 55609.1658625121, 55640.72179639076, 55731.442685573435, 57074.0, 58487.415125849046, 47796.761016194694, 48293.0, 48392.5160748388, 50247.24629130493, 50353.49646503561, 8160.551169685724, 8403.537805420761, 8415.5792210388, 8417.579121044046, 8657.047724750399, 26043.869780650977, 26274.21177364682, 26744.732552674224, 27331.31671708223, 27438.725612743616, 31630.36739265248, 32007.519887201244, 32229.35541289208, 32494.0, 44821.0, 13382.866171338552, 13401.865981340452, 13558.457661693421, 13634.590962271148, 13636.65908352299, 14919.252746598107, 15399.61500962485, 15450.0729956203, 16266.755998659793, 16599.91700041492, 13664.24846633405, 14122.082064665763, 14182.574522764333, 14447.855521444651, 14480.85519144795, 13474.595762127152, 13643.931780341034, 13863.514776982756, 14097.154170749787, 14353.784693229401, 12869.2921889297, 12978.480860765463, 13080.82272595471, 13252.536161234697, 13481.123726957716, 9739.269554783561, 9806.80386392254, 10126.44304563256, 10214.233932455245, 10567.682969510926, 10628.787424251317, 10771.138308935424, 11127.666170014912, 11264.098872090377, 11302.43487825622], "value": 6736.984098775206, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 112.0, 113.0, 111.0, 113.0, 112.0, 111.0, 112.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 126.0, 169.0, 125.0, 126.0, 126.0, 124.0, 151.0, 125.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 165.0, 163.0, 166.0, 168.0, 168.0, 166.0, 164.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 74.0, 108.0, 77.0, 76.0, 81.0, 78.0, 101.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 112.0, 85.0, 85.0, 85.0, 97.0, 85.0, 84.0, 112.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 115.0, 114.0, 113.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 150.0, 151.0, 149.0, 150.0, 151.0, 151.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 55.0, 55.0, 56.0, 55.0, 57.0, 57.0, 57.0, 54.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 58.0, 58.0, 58.0, 57.0, 56.0, 56.0, 57.0, 56.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 84.0, 86.0, 85.0, 84.0, 85.0, 83.0, 83.0, 82.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 136.0, 135.0, 146.0, 134.0, 135.0, 142.0, 144.0, 182.0, 140.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 185.0, 196.0, 192.0, 193.0, 192.0, 184.0, 199.0, 195.0, 195.0], "value": 192.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 77.0, 76.0, 82.0, 74.0, 75.0, 77.0, 74.0, 76.0], "value": 76.5, "unit": "score"}]}]} 13:28:09 INFO - Return code: 0 13:28:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:28:09 INFO - # TBPL SUCCESS # 13:28:09 INFO - Running post-action listener: _resource_record_post_action 13:28:09 INFO - [mozharness: 2017-05-14 20:28:09.970432Z] Finished run-tests step (success) 13:28:09 INFO - Running post-run listener: _resource_record_post_run 13:28:10 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7950336; Write bytes: 384966656; Read time: 1856; Write time: 500600 13:28:10 INFO - TinderboxPrint: CPU usage
13.3% 13:28:10 INFO - TinderboxPrint: I/O read bytes / time
7,950,336 / 1,856 13:28:10 INFO - TinderboxPrint: I/O write bytes / time
384,966,656 / 500,600 13:28:10 INFO - TinderboxPrint: CPU idle
8,300.7 (86.7%) 13:28:10 INFO - TinderboxPrint: CPU user
1,214.8 (12.7%) 13:28:10 INFO - TinderboxPrint: Swap in / out
0 / 0 13:28:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106528768; Read time: 0; Write time: 165124 13:28:10 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 5607424; Write bytes: 277835776; Read time: 1400; Write time: 335404 13:28:10 INFO - Running post-run listener: _upload_blobber_files 13:28:10 INFO - Blob upload gear active. 13:28:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:28:10 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 13:28:10 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'] 13:28:10 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 13:28:11 INFO - (blobuploader) - INFO - Open directory for files ... 13:28:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:28:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:28:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:11 INFO - (blobuploader) - INFO - Done attempting. 13:28:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:28:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:28:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:15 INFO - (blobuploader) - INFO - Done attempting. 13:28:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:28:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:28:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:16 INFO - (blobuploader) - INFO - Done attempting. 13:28:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:28:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:28:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:16 INFO - (blobuploader) - INFO - Done attempting. 13:28:16 INFO - (blobuploader) - INFO - Iteration through files over. 13:28:16 INFO - Return code: 0 13:28:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:28:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:28:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5a21bc97fc4d987bcf0d4a6e3fc6d2d5fec4b2e56f18c5811ab252f3070be6a970e649210a30d7c01e63f31d34c9c46dcf6b8c364f0d8b2342413e31464f453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1cf8b6c688a7039f59a745921690d8e18e67fc89c912040568208b19e6f1df3a09e4b56537754510f951ebc190113ce3353e16c38315e36ba674c64e114d822", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e40781f38938ed7a657aa007b89616539fd3162444beb6a76325a8a9273188773120fe51c1041fd4a40602ea7db9f1e5be8401d62152e801848b2782028f3355", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/710f09ae69e49cdced7451fde46bc078436a0b4320de2f7b6cba2077d7236322361145da1afe7a7f4fc1704c9a8179eb39226cbd8b794b025ad6d288ffe30e30"} 13:28:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:28:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:28:16 INFO - Contents: 13:28:16 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5a21bc97fc4d987bcf0d4a6e3fc6d2d5fec4b2e56f18c5811ab252f3070be6a970e649210a30d7c01e63f31d34c9c46dcf6b8c364f0d8b2342413e31464f453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1cf8b6c688a7039f59a745921690d8e18e67fc89c912040568208b19e6f1df3a09e4b56537754510f951ebc190113ce3353e16c38315e36ba674c64e114d822", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e40781f38938ed7a657aa007b89616539fd3162444beb6a76325a8a9273188773120fe51c1041fd4a40602ea7db9f1e5be8401d62152e801848b2782028f3355", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/710f09ae69e49cdced7451fde46bc078436a0b4320de2f7b6cba2077d7236322361145da1afe7a7f4fc1704c9a8179eb39226cbd8b794b025ad6d288ffe30e30"} 13:28:16 INFO - Running post-run listener: copy_logs_to_upload_dir 13:28:16 INFO - Copying logs to upload dir... 13:28:16 INFO - mkdir: /builds/slave/test/build/upload/logs 13:28:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.554286 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-05-14 13:28:16.742832) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-14 13:28:16.747248) ========= 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=5c37b704b588aaa989324530000001d0-1494788149.827762-502302647 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/a5a21bc97fc4d987bcf0d4a6e3fc6d2d5fec4b2e56f18c5811ab252f3070be6a970e649210a30d7c01e63f31d34c9c46dcf6b8c364f0d8b2342413e31464f453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1cf8b6c688a7039f59a745921690d8e18e67fc89c912040568208b19e6f1df3a09e4b56537754510f951ebc190113ce3353e16c38315e36ba674c64e114d822", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e40781f38938ed7a657aa007b89616539fd3162444beb6a76325a8a9273188773120fe51c1041fd4a40602ea7db9f1e5be8401d62152e801848b2782028f3355", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/710f09ae69e49cdced7451fde46bc078436a0b4320de2f7b6cba2077d7236322361145da1afe7a7f4fc1704c9a8179eb39226cbd8b794b025ad6d288ffe30e30"} build_url:https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/F7fxkM2qRa-0KSPg5Pr1eg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5a21bc97fc4d987bcf0d4a6e3fc6d2d5fec4b2e56f18c5811ab252f3070be6a970e649210a30d7c01e63f31d34c9c46dcf6b8c364f0d8b2342413e31464f453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1cf8b6c688a7039f59a745921690d8e18e67fc89c912040568208b19e6f1df3a09e4b56537754510f951ebc190113ce3353e16c38315e36ba674c64e114d822", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e40781f38938ed7a657aa007b89616539fd3162444beb6a76325a8a9273188773120fe51c1041fd4a40602ea7db9f1e5be8401d62152e801848b2782028f3355", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/710f09ae69e49cdced7451fde46bc078436a0b4320de2f7b6cba2077d7236322361145da1afe7a7f4fc1704c9a8179eb39226cbd8b794b025ad6d288ffe30e30"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-14 13:28:16.775434) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 13:28:16.775754) ========= 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=5c37b704b588aaa989324530000001d0-1494788149.827762-502302647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 13:28:16.858345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-14 13:28:16.858666) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-14 13:28:16.861981) ========= ========= Total master_lag: 0.18 =========