builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1485823530.19 results: success (0) revision: 1fe66bd0efba89df59d2046e8c91418eb5ae10b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 16:45:30.190910) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 16:45:30.191365) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 16:45:30.191638) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 16:45:30.204880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 16:45:30.205218) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-30 16:45:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-01-30 16:45:30 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104602 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 16:45:30.321673) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 16:45:30.322109) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014737 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 16:45:30.371873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 16:45:30.372215) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1fe66bd0efba89df59d2046e8c91418eb5ae10b8 --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 1fe66bd0efba89df59d2046e8c91418eb5ae10b8 --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=769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-30 16:45:31,067 truncating revision to first 12 chars 2017-01-30 16:45:31,067 Setting DEBUG logging. 2017-01-30 16:45:31,067 attempt 1/10 2017-01-30 16:45:31,067 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1fe66bd0efba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-30 16:45:32,296 unpacking tar archive at: mozilla-central-1fe66bd0efba/testing/mozharness/ program finished with exit code 0 elapsedTime=1.588238 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 16:45:31.974661) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 16:45:31.975130) ========= script_repo_revision: 1fe66bd0efba89df59d2046e8c91418eb5ae10b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 16:45:31.975803) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 16:45:31.976130) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 16:45:31.987260) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-01-30 16:45:31.987710) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:45:32 INFO - MultiFileLogger online at 20170130 16:45:32 in /builds/slave/test 16:45:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:45:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:45:32 INFO - {'append_to_log': False, 16:45:32 INFO - 'base_work_dir': '/builds/slave/test', 16:45:32 INFO - 'blob_upload_branch': 'Firefox', 16:45:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:45:32 INFO - 'branch': 'Firefox', 16:45:32 INFO - 'buildbot_json_path': 'buildprops.json', 16:45:32 INFO - 'config_files': ('talos/linux_config.py',), 16:45:32 INFO - 'default_actions': ('clobber', 16:45:32 INFO - 'read-buildbot-config', 16:45:32 INFO - 'download-and-extract', 16:45:32 INFO - 'populate-webroot', 16:45:32 INFO - 'create-virtualenv', 16:45:32 INFO - 'install', 16:45:32 INFO - 'run-tests'), 16:45:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:45:32 INFO - 'download_minidump_stackwalk': True, 16:45:32 INFO - 'download_symbols': 'ondemand', 16:45:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:45:32 INFO - 'tooltool.py': '/tools/tooltool.py', 16:45:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:45:32 INFO - '/tools/misc-python/virtualenv.py')}, 16:45:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:45:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:45:32 INFO - 'installer_path': 'installer.exe', 16:45:32 INFO - 'log_level': 'info', 16:45:32 INFO - 'log_name': 'talos', 16:45:32 INFO - 'log_to_console': True, 16:45:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:45:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:45:32 INFO - 'opt_config_files': (), 16:45:32 INFO - 'pip_index': False, 16:45:32 INFO - 'sps_profile': False, 16:45:32 INFO - 'sps_profile_interval': 0, 16:45:32 INFO - 'suite': 'dromaeojs', 16:45:32 INFO - 'system_bits': '32', 16:45:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:45:32 INFO - 'title': 'talos-linux64-ix-063', 16:45:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:45:32 INFO - 'use_talos_json': True, 16:45:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:45:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:45:32 INFO - 'work_dir': 'build'} 16:45:32 INFO - [mozharness: 2017-01-31 00:45:32.777557Z] Running clobber step. 16:45:32 INFO - Running pre-action listener: _resource_record_pre_action 16:45:32 INFO - Running main action method: clobber 16:45:32 INFO - rmtree: /builds/slave/test/build 16:45:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:45:33 INFO - Running post-action listener: _resource_record_post_action 16:45:33 INFO - [mozharness: 2017-01-31 00:45:33.810912Z] Finished clobber step (success) 16:45:33 INFO - [mozharness: 2017-01-31 00:45:33.811013Z] Running read-buildbot-config step. 16:45:33 INFO - Running pre-action listener: _resource_record_pre_action 16:45:33 INFO - Running main action method: read_buildbot_config 16:45:33 INFO - Using buildbot properties: 16:45:33 INFO - { 16:45:33 INFO - "project": "", 16:45:33 INFO - "product": "firefox", 16:45:33 INFO - "who": "kwierso@gmail.com", 16:45:33 INFO - "installer_path": "public/build/target.tar.bz2", 16:45:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:45:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:45:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 16:45:33 INFO - "stage_platform": "linux64-pgo", 16:45:33 INFO - "basedir": "/builds/slave/test", 16:45:33 INFO - "buildnumber": 6, 16:45:33 INFO - "platform": "ubuntu64_hw", 16:45:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:45:33 INFO - "slavebuilddir": "test", 16:45:33 INFO - "taskId": "IhhVnIVhRLW4htsVE1aXPg", 16:45:33 INFO - "branch": "mozilla-central", 16:45:33 INFO - "script_repo_revision": "production", 16:45:33 INFO - "revision": "1fe66bd0efba89df59d2046e8c91418eb5ae10b8", 16:45:33 INFO - "slavename": "talos-linux64-ix-063", 16:45:33 INFO - "repo_path": "mozilla-central" 16:45:33 INFO - } 16:45:33 INFO - Finding installer, test and symbols from parent task. 16:45:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IhhVnIVhRLW4htsVE1aXPg'}, attempt #1 16:45:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IhhVnIVhRLW4htsVE1aXPg'}, attempt #1 16:45:34 INFO - Task dependencies: aCgRT0ZuSUyqCqXxdTPWgw 16:45:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw'}, attempt #1 16:45:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.tar.bz2 16:45:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/test_packages.json 16:45:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.crashreporter-symbols.zip 16:45:35 INFO - Running post-action listener: _resource_record_post_action 16:45:35 INFO - [mozharness: 2017-01-31 00:45:35.324845Z] Finished read-buildbot-config step (success) 16:45:35 INFO - [mozharness: 2017-01-31 00:45:35.325105Z] Running download-and-extract step. 16:45:35 INFO - Running pre-action listener: _resource_record_pre_action 16:45:35 INFO - Running main action method: download_and_extract 16:45:35 INFO - mkdir: /builds/slave/test/build/tests 16:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:45:35 INFO - trying https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.test_packages.json 16:45:35 INFO - Downloading https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:45:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:45:35 INFO - Downloaded 896 bytes. 16:45:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:45:35 INFO - Using the following test package requirements: 16:45:35 INFO - {u'common': [u'target.common.tests.zip'], 16:45:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:45:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:45:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:45:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:45:35 INFO - u'mozbase': [u'target.common.tests.zip'], 16:45:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:45:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:45:35 INFO - u'web-platform': [u'target.common.tests.zip', 16:45:35 INFO - u'target.web-platform.tests.zip'], 16:45:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:45:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:45:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.common.tests.zip 16:45:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:45:35 INFO - Fetch https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.common.tests.zip into memory 16:45:38 INFO - Expected file size: 21893676 16:45:38 INFO - Obtained file size: 21893676 16:45:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:45:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.common.tests.zip 16:45:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:45:42 INFO - Fetch https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.common.tests.zip into memory 16:45:43 INFO - Expected file size: 21893676 16:45:43 INFO - Obtained file size: 21893676 16:45:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.talos.tests.zip 16:45:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:45:47 INFO - Fetch https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.talos.tests.zip into memory 16:45:48 INFO - Expected file size: 14403454 16:45:48 INFO - Obtained file size: 14403454 16:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:45:48 INFO - trying https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.tar.bz2 16:45:48 INFO - Downloading https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:45:49 INFO - Downloaded 61615302 bytes. 16:45:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.tar.bz2 16:45:49 INFO - mkdir: /builds/slave/test/properties 16:45:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:45:49 INFO - Writing to file /builds/slave/test/properties/build_url 16:45:49 INFO - Contents: 16:45:49 INFO - build_url:https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.tar.bz2 16:45:49 INFO - Running post-action listener: _resource_record_post_action 16:45:49 INFO - Running post-action listener: set_extra_try_arguments 16:45:49 INFO - [mozharness: 2017-01-31 00:45:49.816307Z] Finished download-and-extract step (success) 16:45:49 INFO - [mozharness: 2017-01-31 00:45:49.816404Z] Running populate-webroot step. 16:45:49 INFO - Running pre-action listener: _resource_record_pre_action 16:45:49 INFO - Running main action method: populate_webroot 16:45:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:45:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:45:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:45:49 INFO - '--tppagecycles', 16:45:49 INFO - '7'], 16:45:49 INFO - 'tests': ['tsvgm']}}, 16:45:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:45:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:45:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:45:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:45:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:45:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:45:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:45:49 INFO - 'talos_options': ['--disable-e10s'], 16:45:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:45:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:45:49 INFO - 'talos_options': ['--disable-e10s'], 16:45:49 INFO - 'tests': ['damp', 'tps']}, 16:45:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:45:49 INFO - 'tests': ['damp', 'tps']}, 16:45:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:45:49 INFO - 'tests': ['dromaeo_dom']}, 16:45:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:45:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:45:49 INFO - 'tests': ['basic_compositor_video']}, 16:45:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:45:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:45:49 INFO - 'tests': ['a11yr', 16:45:49 INFO - 'ts_paint', 16:45:49 INFO - 'tpaint', 16:45:49 INFO - 'sessionrestore', 16:45:49 INFO - 'sessionrestore_no_auto_restore', 16:45:49 INFO - 'tabpaint']}, 16:45:49 INFO - 'other-e10s': {'tests': ['a11yr', 16:45:49 INFO - 'ts_paint', 16:45:49 INFO - 'tpaint', 16:45:49 INFO - 'sessionrestore', 16:45:49 INFO - 'sessionrestore_no_auto_restore', 16:45:49 INFO - 'tabpaint']}, 16:45:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:45:49 INFO - 'ts_paint', 16:45:49 INFO - 'tpaint', 16:45:49 INFO - 'sessionrestore', 16:45:49 INFO - 'sessionrestore_no_auto_restore', 16:45:49 INFO - 'tabpaint']}, 16:45:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:45:49 INFO - 'ts_paint', 16:45:49 INFO - 'tpaint', 16:45:49 INFO - 'sessionrestore', 16:45:49 INFO - 'sessionrestore_no_auto_restore', 16:45:49 INFO - 'tabpaint']}, 16:45:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:45:49 INFO - 'tests': ['a11yr', 16:45:49 INFO - 'ts_paint', 16:45:49 INFO - 'tpaint', 16:45:49 INFO - 'sessionrestore', 16:45:49 INFO - 'sessionrestore_no_auto_restore', 16:45:49 INFO - 'tabpaint']}, 16:45:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:45:49 INFO - 'tests': ['a11yr', 16:45:49 INFO - 'ts_paint', 16:45:49 INFO - 'tpaint', 16:45:49 INFO - 'sessionrestore', 16:45:49 INFO - 'sessionrestore_no_auto_restore', 16:45:49 INFO - 'tabpaint']}, 16:45:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:45:49 INFO - 'tests': ['tsvgx', 16:45:49 INFO - 'tsvgr_opacity', 16:45:49 INFO - 'tart', 16:45:49 INFO - 'tscrollx', 16:45:49 INFO - 'cart', 16:45:49 INFO - 'tsvg_static']}, 16:45:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:45:49 INFO - 'tsvgr_opacity', 16:45:49 INFO - 'tart', 16:45:49 INFO - 'tscrollx', 16:45:49 INFO - 'cart', 16:45:49 INFO - 'tsvg_static']}, 16:45:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:45:49 INFO - 'talos_options': ['--disable-e10s'], 16:45:49 INFO - 'tests': ['tp5o']}, 16:45:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:45:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:45:49 INFO - 'talos_options': ['--disable-e10s', 16:45:49 INFO - '--xperf_path', 16:45:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:49 INFO - 'tests': ['tp5n']}, 16:45:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:45:49 INFO - 'talos_options': ['--xperf_path', 16:45:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:49 INFO - 'tests': ['tp5n']}}, 16:45:49 INFO - 'talos.zip': {'path': '', 16:45:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:45:49 INFO - Running post-action listener: _resource_record_post_action 16:45:49 INFO - [mozharness: 2017-01-31 00:45:49.829631Z] Finished populate-webroot step (success) 16:45:49 INFO - [mozharness: 2017-01-31 00:45:49.829724Z] Running create-virtualenv step. 16:45:49 INFO - Running pre-action listener: _resource_record_pre_action 16:45:49 INFO - Running main action method: create_virtualenv 16:45:49 INFO - Creating virtualenv /builds/slave/test/build/venv 16:45:49 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 16:45:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:45:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:45:49 INFO - Using real prefix '/usr' 16:45:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:45:50 INFO - Installing distribute.............................................................................................................................................................................................done. 16:45:52 INFO - Installing pip.................done. 16:45:52 INFO - Return code: 0 16:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:45:52 INFO - Reading from file tmpfile_stdout 16:45:52 INFO - Output received: 16:45:52 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) 16:45:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:52 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x27fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b3f0>, '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 0x2b6bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c1a0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', '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 16:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 16:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:45:52 INFO - Using env: {'DISPLAY': ':0', 16:45:52 INFO - 'HOME': '/home/cltbld', 16:45:52 INFO - 'LANG': 'en_US.UTF-8', 16:45:52 INFO - 'LANGUAGE': 'en_US:en', 16:45:52 INFO - 'LOGNAME': 'cltbld', 16:45:52 INFO - 'MAIL': '/var/mail/cltbld', 16:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:52 INFO - 'MOZ_NO_REMOTE': '1', 16:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:52 INFO - 'NO_EM_RESTART': '1', 16:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:52 INFO - 'PWD': '/builds/slave/test', 16:45:52 INFO - 'SHELL': '/bin/bash', 16:45:52 INFO - 'SHLVL': '1', 16:45:52 INFO - 'TERM': 'linux', 16:45:52 INFO - 'TMOUT': '86400', 16:45:52 INFO - 'USER': 'cltbld', 16:45:52 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', 16:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:52 INFO - '_': '/tools/buildbot/bin/python'} 16:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:52 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 16:45:52 INFO - Cleaning up... 16:45:52 INFO - Return code: 0 16:45:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:52 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x27fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b3f0>, '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 0x2b6bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c1a0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', '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 16:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 16:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:45:52 INFO - Using env: {'DISPLAY': ':0', 16:45:52 INFO - 'HOME': '/home/cltbld', 16:45:52 INFO - 'LANG': 'en_US.UTF-8', 16:45:52 INFO - 'LANGUAGE': 'en_US:en', 16:45:52 INFO - 'LOGNAME': 'cltbld', 16:45:52 INFO - 'MAIL': '/var/mail/cltbld', 16:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:52 INFO - 'MOZ_NO_REMOTE': '1', 16:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:52 INFO - 'NO_EM_RESTART': '1', 16:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:52 INFO - 'PWD': '/builds/slave/test', 16:45:52 INFO - 'SHELL': '/bin/bash', 16:45:52 INFO - 'SHLVL': '1', 16:45:52 INFO - 'TERM': 'linux', 16:45:52 INFO - 'TMOUT': '86400', 16:45:52 INFO - 'USER': 'cltbld', 16:45:52 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', 16:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:52 INFO - '_': '/tools/buildbot/bin/python'} 16:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:53 INFO - Downloading/unpacking psutil>=3.1.1 16:45: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 16:45: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 16:45:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45: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 16:45: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 16:45:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:45:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:55 INFO - Installing collected packages: psutil 16:45:55 INFO - Running setup.py install for psutil 16:45:55 INFO - building 'psutil._psutil_linux' extension 16:45: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 16:45:55 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 16:45:55 INFO - building 'psutil._psutil_posix' extension 16:45:55 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 16:45:55 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 16:45:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:55 INFO - Successfully installed psutil 16:45:55 INFO - Cleaning up... 16:45:55 INFO - Return code: 0 16:45:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:55 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x27fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b3f0>, '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 0x2b6bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c1a0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', '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 16:45:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 16:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:45:55 INFO - Using env: {'DISPLAY': ':0', 16:45:55 INFO - 'HOME': '/home/cltbld', 16:45:55 INFO - 'LANG': 'en_US.UTF-8', 16:45:55 INFO - 'LANGUAGE': 'en_US:en', 16:45:55 INFO - 'LOGNAME': 'cltbld', 16:45:55 INFO - 'MAIL': '/var/mail/cltbld', 16:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:55 INFO - 'MOZ_NO_REMOTE': '1', 16:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:55 INFO - 'NO_EM_RESTART': '1', 16:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:55 INFO - 'PWD': '/builds/slave/test', 16:45:55 INFO - 'SHELL': '/bin/bash', 16:45:55 INFO - 'SHLVL': '1', 16:45:55 INFO - 'TERM': 'linux', 16:45:55 INFO - 'TMOUT': '86400', 16:45:55 INFO - 'USER': 'cltbld', 16:45:55 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', 16:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:55 INFO - '_': '/tools/buildbot/bin/python'} 16:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:45:57 INFO - Installing collected packages: mozsystemmonitor 16:45:57 INFO - Running setup.py install for mozsystemmonitor 16:45:58 INFO - Successfully installed mozsystemmonitor 16:45:58 INFO - Cleaning up... 16:45:58 INFO - Return code: 0 16:45:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x27fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b3f0>, '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 0x2b6bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c1a0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', '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 16:45:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 16:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:45:58 INFO - Using env: {'DISPLAY': ':0', 16:45:58 INFO - 'HOME': '/home/cltbld', 16:45:58 INFO - 'LANG': 'en_US.UTF-8', 16:45:58 INFO - 'LANGUAGE': 'en_US:en', 16:45:58 INFO - 'LOGNAME': 'cltbld', 16:45:58 INFO - 'MAIL': '/var/mail/cltbld', 16:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:58 INFO - 'MOZ_NO_REMOTE': '1', 16:45:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:58 INFO - 'NO_EM_RESTART': '1', 16:45:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:58 INFO - 'PWD': '/builds/slave/test', 16:45:58 INFO - 'SHELL': '/bin/bash', 16:45:58 INFO - 'SHLVL': '1', 16:45:58 INFO - 'TERM': 'linux', 16:45:58 INFO - 'TMOUT': '86400', 16:45:58 INFO - 'USER': 'cltbld', 16:45:58 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', 16:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:58 INFO - '_': '/tools/buildbot/bin/python'} 16:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:58 INFO - Downloading/unpacking jsonschema==2.5.1 16:45: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 16:45: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 16:45:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45: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 16:45: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 16:46:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:46:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:46: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 16:46: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 16:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46: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 16:46: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 16:46:00 INFO - Downloading functools32-3.2.3-2.tar.gz 16:46:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:46:00 INFO - warning: no files found matching '*.txt' 16:46:00 INFO - no previously-included directories found matching 'build' 16:46:00 INFO - no previously-included directories found matching 'dist' 16:46:00 INFO - no previously-included directories found matching '.git*' 16:46:00 INFO - Installing collected packages: jsonschema, functools32 16:46:00 INFO - Running setup.py install for functools32 16:46:00 INFO - warning: no files found matching '*.txt' 16:46:00 INFO - no previously-included directories found matching 'build' 16:46:00 INFO - no previously-included directories found matching 'dist' 16:46:00 INFO - no previously-included directories found matching '.git*' 16:46:00 INFO - Successfully installed jsonschema functools32 16:46:00 INFO - Cleaning up... 16:46:00 INFO - Return code: 0 16:46:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x27fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b3f0>, '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 0x2b6bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c1a0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', '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 16:46:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 16:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:46:00 INFO - Using env: {'DISPLAY': ':0', 16:46:00 INFO - 'HOME': '/home/cltbld', 16:46:00 INFO - 'LANG': 'en_US.UTF-8', 16:46:00 INFO - 'LANGUAGE': 'en_US:en', 16:46:00 INFO - 'LOGNAME': 'cltbld', 16:46:00 INFO - 'MAIL': '/var/mail/cltbld', 16:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:00 INFO - 'MOZ_NO_REMOTE': '1', 16:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:00 INFO - 'NO_EM_RESTART': '1', 16:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:00 INFO - 'PWD': '/builds/slave/test', 16:46:00 INFO - 'SHELL': '/bin/bash', 16:46:00 INFO - 'SHLVL': '1', 16:46:00 INFO - 'TERM': 'linux', 16:46:00 INFO - 'TMOUT': '86400', 16:46:00 INFO - 'USER': 'cltbld', 16:46:00 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', 16:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:00 INFO - '_': '/tools/buildbot/bin/python'} 16:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:46:01 INFO - Cleaning up... 16:46:01 INFO - Return code: 0 16:46:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x27fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b3f0>, '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 0x2b6bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c1a0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', '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 16:46:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 16:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:46:01 INFO - Using env: {'DISPLAY': ':0', 16:46:01 INFO - 'HOME': '/home/cltbld', 16:46:01 INFO - 'LANG': 'en_US.UTF-8', 16:46:01 INFO - 'LANGUAGE': 'en_US:en', 16:46:01 INFO - 'LOGNAME': 'cltbld', 16:46:01 INFO - 'MAIL': '/var/mail/cltbld', 16:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:01 INFO - 'MOZ_NO_REMOTE': '1', 16:46:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:01 INFO - 'NO_EM_RESTART': '1', 16:46:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:01 INFO - 'PWD': '/builds/slave/test', 16:46:01 INFO - 'SHELL': '/bin/bash', 16:46:01 INFO - 'SHLVL': '1', 16:46:01 INFO - 'TERM': 'linux', 16:46:01 INFO - 'TMOUT': '86400', 16:46:01 INFO - 'USER': 'cltbld', 16:46:01 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', 16:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:01 INFO - '_': '/tools/buildbot/bin/python'} 16:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:01 INFO - Downloading/unpacking blobuploader==1.2.4 16:46: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 16:46: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 16:46:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46: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 16:46: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 16:46:03 INFO - Downloading blobuploader-1.2.4.tar.gz 16:46:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:46:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:46:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:04 INFO - Downloading docopt-0.6.1.tar.gz 16:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:46:04 INFO - Installing collected packages: blobuploader, requests, docopt 16:46:04 INFO - Running setup.py install for blobuploader 16:46:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:46:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:46:04 INFO - Running setup.py install for requests 16:46:04 INFO - Running setup.py install for docopt 16:46:04 INFO - Successfully installed blobuploader requests docopt 16:46:04 INFO - Cleaning up... 16:46:04 INFO - Return code: 0 16:46:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:04 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x27fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b3f0>, '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 0x2b6bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c1a0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', '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 16:46:04 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 16:46:04 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:46:04 INFO - Using env: {'DISPLAY': ':0', 16:46:04 INFO - 'HOME': '/home/cltbld', 16:46:04 INFO - 'LANG': 'en_US.UTF-8', 16:46:04 INFO - 'LANGUAGE': 'en_US:en', 16:46:04 INFO - 'LOGNAME': 'cltbld', 16:46:04 INFO - 'MAIL': '/var/mail/cltbld', 16:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:04 INFO - 'MOZ_NO_REMOTE': '1', 16:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:04 INFO - 'NO_EM_RESTART': '1', 16:46:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:04 INFO - 'PWD': '/builds/slave/test', 16:46:04 INFO - 'SHELL': '/bin/bash', 16:46:04 INFO - 'SHLVL': '1', 16:46:04 INFO - 'TERM': 'linux', 16:46:04 INFO - 'TMOUT': '86400', 16:46:04 INFO - 'USER': 'cltbld', 16:46:04 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', 16:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:04 INFO - '_': '/tools/buildbot/bin/python'} 16:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:46:04 INFO - Running setup.py (path:/tmp/pip-kU6quR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:46:05 INFO - Running setup.py (path:/tmp/pip-YPA7SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:46:05 INFO - Running setup.py (path:/tmp/pip-hwdhhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:46:05 INFO - Running setup.py (path:/tmp/pip-lSDgku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:46:05 INFO - Running setup.py (path:/tmp/pip-jgLJ6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:46:05 INFO - Running setup.py (path:/tmp/pip-tL3fok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:46:05 INFO - Running setup.py (path:/tmp/pip-OBhe4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:46:05 INFO - Running setup.py (path:/tmp/pip-5alQS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:46:05 INFO - Running setup.py (path:/tmp/pip-toaeW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:46:05 INFO - Running setup.py (path:/tmp/pip-IUNlSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:46:05 INFO - Running setup.py (path:/tmp/pip-wqVTRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:46:05 INFO - Running setup.py (path:/tmp/pip-ULfxNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:46:05 INFO - Running setup.py (path:/tmp/pip-8pt9qY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:46:05 INFO - Running setup.py (path:/tmp/pip-exWRzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:46:05 INFO - Running setup.py (path:/tmp/pip-koD49_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:46:06 INFO - Running setup.py (path:/tmp/pip-eFVc24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:46:06 INFO - Running setup.py (path:/tmp/pip-0QusEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:46:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:46:06 INFO - Running setup.py install for manifestparser 16:46:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:46:06 INFO - Running setup.py install for mozcrash 16:46:06 INFO - Running setup.py install for mozdebug 16:46:06 INFO - Running setup.py install for mozdevice 16:46:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:46:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:46:06 INFO - Running setup.py install for mozfile 16:46:06 INFO - Running setup.py install for mozhttpd 16:46:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:46:06 INFO - Running setup.py install for mozinfo 16:46:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:46:06 INFO - Running setup.py install for mozInstall 16:46:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:46:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:46:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:46:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:46:06 INFO - Running setup.py install for mozleak 16:46:07 INFO - Running setup.py install for mozlog 16:46:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:46:07 INFO - Running setup.py install for moznetwork 16:46:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:46:07 INFO - Running setup.py install for mozprocess 16:46:07 INFO - Running setup.py install for mozprofile 16:46:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:46:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:46:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:46:07 INFO - Running setup.py install for mozrunner 16:46:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:46:07 INFO - Running setup.py install for mozscreenshot 16:46:07 INFO - Running setup.py install for moztest 16:46:07 INFO - Running setup.py install for mozversion 16:46:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:46:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:46:07 INFO - Cleaning up... 16:46:07 INFO - Return code: 0 16:46:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:07 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x27fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b3f0>, '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 0x2b6bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c1a0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', '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 16:46:07 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 16:46:07 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:46:07 INFO - Using env: {'DISPLAY': ':0', 16:46:07 INFO - 'HOME': '/home/cltbld', 16:46:07 INFO - 'LANG': 'en_US.UTF-8', 16:46:07 INFO - 'LANGUAGE': 'en_US:en', 16:46:07 INFO - 'LOGNAME': 'cltbld', 16:46:07 INFO - 'MAIL': '/var/mail/cltbld', 16:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:07 INFO - 'MOZ_NO_REMOTE': '1', 16:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:07 INFO - 'NO_EM_RESTART': '1', 16:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:07 INFO - 'PWD': '/builds/slave/test', 16:46:07 INFO - 'SHELL': '/bin/bash', 16:46:07 INFO - 'SHLVL': '1', 16:46:07 INFO - 'TERM': 'linux', 16:46:07 INFO - 'TMOUT': '86400', 16:46:07 INFO - 'USER': 'cltbld', 16:46:07 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', 16:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:07 INFO - '_': '/tools/buildbot/bin/python'} 16:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:46:08 INFO - Running setup.py (path:/tmp/pip-m_Bb_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:46:08 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)) 16:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:46:08 INFO - Running setup.py (path:/tmp/pip-WhRt0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:46:08 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)) 16:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:46:08 INFO - Running setup.py (path:/tmp/pip-1do9Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:46:08 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)) 16:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:46:08 INFO - Running setup.py (path:/tmp/pip-Zz6hJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 16:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:46:08 INFO - Running setup.py (path:/tmp/pip-JcsOAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:46:08 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)) 16:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:46:08 INFO - Running setup.py (path:/tmp/pip-ABqFCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:46:08 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)) 16:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:46:08 INFO - Running setup.py (path:/tmp/pip-stUy2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:46:08 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)) 16:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:46:08 INFO - Running setup.py (path:/tmp/pip-6Z4Vye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:46:08 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)) 16:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:46:08 INFO - Running setup.py (path:/tmp/pip-Hvs2UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:46:08 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)) 16:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:46:08 INFO - Running setup.py (path:/tmp/pip-rwD7cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:46:08 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)) 16:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:46:08 INFO - Running setup.py (path:/tmp/pip-1ZagAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:46:08 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)) 16:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:46:09 INFO - Running setup.py (path:/tmp/pip-qyQn2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 16:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:46:09 INFO - Running setup.py (path:/tmp/pip-1bynwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:46:09 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)) 16:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:46:09 INFO - Running setup.py (path:/tmp/pip-jm3jaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:46:09 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)) 16:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:46:09 INFO - Running setup.py (path:/tmp/pip-TQoqsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:46:09 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)) 16:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:46:09 INFO - Running setup.py (path:/tmp/pip-janoZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:46:09 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)) 16:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:46:09 INFO - Running setup.py (path:/tmp/pip-ULaNMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:46:09 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)) 16:46:09 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)) 16:46:09 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)) 16:46:09 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)) 16:46:09 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:46:09 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:46:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:46:09 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 16:46:09 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 16:46:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:09 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 16:46:09 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 16:46:11 INFO - Downloading blessings-1.6.tar.gz 16:46:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:46:11 INFO - Installing collected packages: blessings 16:46:11 INFO - Running setup.py install for blessings 16:46:11 INFO - Successfully installed blessings 16:46:11 INFO - Cleaning up... 16:46:11 INFO - Return code: 0 16:46:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:46:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:46:11 INFO - Reading from file tmpfile_stdout 16:46:11 INFO - Current package versions: 16:46:11 INFO - argparse == 1.2.1 16:46:11 INFO - blessings == 1.6 16:46:11 INFO - blobuploader == 1.2.4 16:46:11 INFO - docopt == 0.6.1 16:46:11 INFO - functools32 == 3.2.3-2 16:46:11 INFO - jsonschema == 2.5.1 16:46:11 INFO - manifestparser == 1.1 16:46:11 INFO - mozInstall == 1.12 16:46:11 INFO - mozcrash == 1.0 16:46:11 INFO - mozdebug == 0.1 16:46:11 INFO - mozdevice == 0.49 16:46:11 INFO - mozfile == 1.2 16:46:11 INFO - mozhttpd == 0.7 16:46:11 INFO - mozinfo == 0.9 16:46:11 INFO - mozleak == 0.1 16:46:11 INFO - mozlog == 3.4 16:46:11 INFO - moznetwork == 0.27 16:46:11 INFO - mozprocess == 0.24 16:46:11 INFO - mozprofile == 0.28 16:46:11 INFO - mozrunner == 6.13 16:46:11 INFO - mozscreenshot == 0.1 16:46:11 INFO - mozsystemmonitor == 0.3 16:46:11 INFO - moztest == 0.8 16:46:11 INFO - mozversion == 1.4 16:46:11 INFO - psutil == 3.1.1 16:46:11 INFO - requests == 1.2.3 16:46:11 INFO - wsgiref == 0.1.2 16:46:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:11 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x27fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b3f0>, '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 0x2b6bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c1a0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', '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 16:46:11 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 16:46:11 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:46:11 INFO - Using env: {'DISPLAY': ':0', 16:46:11 INFO - 'HOME': '/home/cltbld', 16:46:11 INFO - 'LANG': 'en_US.UTF-8', 16:46:11 INFO - 'LANGUAGE': 'en_US:en', 16:46:11 INFO - 'LOGNAME': 'cltbld', 16:46:11 INFO - 'MAIL': '/var/mail/cltbld', 16:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:11 INFO - 'MOZ_NO_REMOTE': '1', 16:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:11 INFO - 'NO_EM_RESTART': '1', 16:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:11 INFO - 'PWD': '/builds/slave/test', 16:46:11 INFO - 'SHELL': '/bin/bash', 16:46:11 INFO - 'SHLVL': '1', 16:46:11 INFO - 'TERM': 'linux', 16:46:11 INFO - 'TMOUT': '86400', 16:46:11 INFO - 'USER': 'cltbld', 16:46:11 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', 16:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:11 INFO - '_': '/tools/buildbot/bin/python'} 16:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:46:12 INFO - Cleaning up... 16:46:12 INFO - Return code: 0 16:46:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:46:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x27fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b3f0>, '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 0x2b6bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c1a0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', '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 16:46:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:46:12 INFO - Using env: {'DISPLAY': ':0', 16:46:12 INFO - 'HOME': '/home/cltbld', 16:46:12 INFO - 'LANG': 'en_US.UTF-8', 16:46:12 INFO - 'LANGUAGE': 'en_US:en', 16:46:12 INFO - 'LOGNAME': 'cltbld', 16:46:12 INFO - 'MAIL': '/var/mail/cltbld', 16:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:12 INFO - 'MOZ_NO_REMOTE': '1', 16:46:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:12 INFO - 'NO_EM_RESTART': '1', 16:46:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:12 INFO - 'PWD': '/builds/slave/test', 16:46:12 INFO - 'SHELL': '/bin/bash', 16:46:12 INFO - 'SHLVL': '1', 16:46:12 INFO - 'TERM': 'linux', 16:46:12 INFO - 'TMOUT': '86400', 16:46:12 INFO - 'USER': 'cltbld', 16:46:12 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', 16:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:12 INFO - '_': '/tools/buildbot/bin/python'} 16:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:46:12 INFO - Cleaning up... 16:46:12 INFO - Return code: 0 16:46:12 INFO - Running post-action listener: _resource_record_post_action 16:46:12 INFO - Running post-action listener: _start_resource_monitoring 16:46:12 INFO - Starting resource monitoring. 16:46:12 INFO - [mozharness: 2017-01-31 00:46:12.438290Z] Finished create-virtualenv step (success) 16:46:12 INFO - [mozharness: 2017-01-31 00:46:12.438757Z] Running install step. 16:46:12 INFO - Running pre-action listener: _resource_record_pre_action 16:46:12 INFO - Running main action method: install 16:46:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:46:12 INFO - Reading from file tmpfile_stdout 16:46:12 INFO - Detecting whether we're running mozinstall >=1.0... 16:46:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:46:12 INFO - Reading from file tmpfile_stdout 16:46:12 INFO - Output received: 16:46:12 INFO - Usage: mozinstall [options] installer 16:46:12 INFO - Options: 16:46:12 INFO - -h, --help show this help message and exit 16:46:12 INFO - -d DEST, --destination=DEST 16:46:12 INFO - Directory to install application into. [default: 16:46:12 INFO - "/builds/slave/test"] 16:46:12 INFO - --app=APP Application being installed. [default: firefox] 16:46:12 INFO - mkdir: /builds/slave/test/build/application 16:46:12 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'] 16:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:46:30 INFO - Reading from file tmpfile_stdout 16:46:30 INFO - Output received: 16:46:30 INFO - /builds/slave/test/build/application/firefox/firefox 16:46:30 INFO - Running post-action listener: _resource_record_post_action 16:46:30 INFO - [mozharness: 2017-01-31 00:46:30.235419Z] Finished install step (success) 16:46:30 INFO - [mozharness: 2017-01-31 00:46:30.235698Z] Running run-tests step. 16:46:30 INFO - Running pre-action listener: _resource_record_pre_action 16:46:30 INFO - Running main action method: run_tests 16:46:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:46:30 INFO - Python 2.7.3 16:46:30 INFO - Return code: 0 16:46:30 INFO - grabbing minidump binary from tooltool 16:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 16:46:30 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 0x2b6b3f0>, '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 0x2b6bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:46:30 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 16:46:30 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 16:46:30 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 16:46:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:46:30 INFO - Return code: 0 16:46:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:46:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:46:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:46:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:46:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:46:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:46:30 INFO - Using env: {'DISPLAY': ':0', 16:46:30 INFO - 'HOME': '/home/cltbld', 16:46:30 INFO - 'LANG': 'en_US.UTF-8', 16:46:30 INFO - 'LANGUAGE': 'en_US:en', 16:46:30 INFO - 'LOGNAME': 'cltbld', 16:46:30 INFO - 'MAIL': '/var/mail/cltbld', 16:46:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:46:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:30 INFO - 'MOZ_NO_REMOTE': '1', 16:46:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:30 INFO - 'NO_EM_RESTART': '1', 16:46:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:30 INFO - 'PWD': '/builds/slave/test', 16:46:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:46:30 INFO - 'SHELL': '/bin/bash', 16:46:30 INFO - 'SHLVL': '1', 16:46:30 INFO - 'TERM': 'linux', 16:46:30 INFO - 'TMOUT': '86400', 16:46:30 INFO - 'USER': 'cltbld', 16:46:30 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443', 16:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:30 INFO - '_': '/tools/buildbot/bin/python'} 16:46:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:46:30 INFO - mozversion application_buildid: 20170130234509 16:46:30 INFO - mozversion application_changeset: 1fe66bd0efba89df59d2046e8c91418eb5ae10b8 16:46:30 INFO - mozversion application_display_name: Nightly 16:46:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:46:30 INFO - mozversion application_name: Firefox 16:46:30 INFO - mozversion application_remotingname: firefox 16:46:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:46:30 INFO - mozversion application_vendor: Mozilla 16:46:30 INFO - mozversion application_version: 54.0a1 16:46:30 INFO - mozversion platform_buildid: 20170130234509 16:46:30 INFO - mozversion platform_changeset: 1fe66bd0efba89df59d2046e8c91418eb5ae10b8 16:46:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:46:30 INFO - mozversion platform_version: 54.0a1 16:46:30 INFO - using testdate: 1485823590 16:46:30 INFO - actual date: 1485823590 16:46:30 INFO - starting webserver on 'localhost:43518' 16:46:30 INFO - SUITE-START | Running 2 tests 16:46:30 INFO - TEST-START | dromaeo_css 16:46:30 INFO - operating with platform_type : linux_ 16:46:30 INFO - Initialising browser for dromaeo_css test... 16:46:30 INFO - TEST-INFO | started process 24113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8xGTRa/profile http://localhost:43518/getInfo.html) 16:46:33 INFO - PROCESS | 24113 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 16:46:34 INFO - PROCESS | 24113 | __metrics Screen width/height:1600/1200 16:46:34 INFO - PROCESS | 24113 | colorDepth:24 16:46:34 INFO - PROCESS | 24113 | Browser inner width/height: 1024/697 16:46:34 INFO - PROCESS | 24113 | __metrics 16:46:34 INFO - PROCESS | 24113 | 1485823594843 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 16:46:35 INFO - PROCESS | 24113 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:46:35 INFO - PROCESS | 24113 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:46:35 INFO - PROCESS | 24113 | console.error: PushService: 16:46:35 INFO - PROCESS | 24113 | stateChangeProcessEnqueue: Error transitioning state 16:46:35 INFO - PROCESS | 24113 | UnknownError 16:46:36 INFO - TEST-INFO | 24113: exit 0 16:46:36 INFO - Browser initialized. 16:46:36 INFO - Running cycle 1/1 for dromaeo_css test... 16:46:36 INFO - TEST-INFO | started process 24199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8xGTRa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:46:48 INFO - PROCESS | 24199 | RSS: Main: 153124864 16:46:48 INFO - PROCESS | 24199 | 16:49:49 INFO - PROCESS | 24199 | Cycle 1(1): loaded http://localhost:43518/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43518/tests/dromaeo/cssquery-ext.html) 16:49:51 INFO - PROCESS | 24199 | RSS: Main: 268980224 16:49:51 INFO - PROCESS | 24199 | 16:51:37 INFO - PROCESS | 24199 | ************************* 16:51:37 INFO - PROCESS | 24199 | A coding exception was thrown and uncaught in a Task. 16:51:37 INFO - PROCESS | 24199 | 16:51:37 ERROR - PROCESS | 24199 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:51:37 INFO - PROCESS | 24199 | Full stack: 16:51:37 INFO - PROCESS | 24199 | ************************* 16:52:53 INFO - PROCESS | 24199 | Cycle 1(1): loaded http://localhost:43518/tests/dromaeo/cssquery-ext.html (next: http://localhost:43518/tests/dromaeo/cssquery-jquery.html) 16:52:54 INFO - PROCESS | 24199 | RSS: Main: 244432896 16:52:54 INFO - PROCESS | 24199 | 16:55:56 INFO - PROCESS | 24199 | Cycle 1(1): loaded http://localhost:43518/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43518/tests/dromaeo/cssquery-mootools.html) 16:55:56 INFO - PROCESS | 24199 | RSS: Main: 185737216 16:55:56 INFO - PROCESS | 24199 | 16:58:58 INFO - PROCESS | 24199 | Cycle 1(1): loaded http://localhost:43518/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43518/tests/dromaeo/cssquery-prototype.html) 16:58:59 INFO - PROCESS | 24199 | RSS: Main: 240783360 16:58:59 INFO - PROCESS | 24199 | 17:02:02 INFO - PROCESS | 24199 | Cycle 1(1): loaded http://localhost:43518/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43518/tests/dromaeo/cssquery-yui.html) 17:02:02 INFO - PROCESS | 24199 | RSS: Main: 182845440 17:02:02 INFO - PROCESS | 24199 | 17:05:05 INFO - PROCESS | 24199 | Cycle 1(1): loaded http://localhost:43518/tests/dromaeo/cssquery-yui.html (next: http://localhost:43518/tests/dromaeo/cssquery-dojo.html) 17:05:05 INFO - PROCESS | 24199 | RSS: Main: 280150016 17:05:05 INFO - PROCESS | 24199 | 17:05:05 INFO - PROCESS | 24199 | __start_tp_report 17:05:05 INFO - PROCESS | 24199 | _x_x_mozilla_page_load 17:05:05 INFO - PROCESS | 24199 | _x_x_mozilla_page_load_details 17:05:05 INFO - PROCESS | 24199 | |i|pagename|runs| 17:05:05 INFO - PROCESS | 24199 | |0;dojo.html;3142.7485801135913;3186.792858464198;3217.967820321797;3222.5649537312456;3225.3549290141978;5337.733113344337;5349.732513374335;5372.54333381662;5459.454054594538;5459.890802183954;5358.410574836775;5441.83674489765;5473.480019398151;5482.780688772455;5507.201455788908;4798.4001999750035;4867.780949857265;4874.756262186894;4889.095517329288;4995.950850321418;4937.185364414867;4967.279744437054;4981.501849815026;4988.975055124719;4991.975040124794;4766.332713420124;4772.665913386064;4807.61539076873;4812.67651395869;4966.279889416032;4846.709197448165;4855.223164293696;4860.975695121537;4906.31311616374;4934.629902757271;4820.71075735457;4835.226363781813;4842.176829938883;4857.8299759508245;4871.488493708145;5209.088409528355;5246.265522826808;5268.736563171826;5424.384794166631;5492.5605951523785;5618.269624948731;5690.829275121753;5693.743781529841;5736.3403208631125;5752.194692743019;5691.430856914317;5700.087985922274;5714.542836573064;5724.112762521816;5733.283339582552;5334.946650533522;5343.171808369709;5345.144776835727;5345.518903298683;5409.83770486886;5929.970350148222;5956.672383018976;5985.431384018511;5994.250718660168;6049.455549000611;5746.712664366765;5774.2782152230975;5781.277340332458;5781.392953739797;5788.102844059177;5695.914561281584;5731.340895796953;5755.482006619424;5837.854053648693;5848.64908105515;5747.339056008613;5786.652800831964;5795.449432303924;5807.303123625107;5898.233229680114;5830.76676932918;5831.650100993954;5838.182654428383;5841.970790146022;5843.5909486336395;4482.551744825491;4487.371767952489;4499.977500112478;4508.053308805188;4543.704659197141;3955.624215699504;3980.0646847990697;3981.761094334291;4022.416749571296;4041.3937909313836;5511.173324001432;5512.2558454608115;5512.3385193777;5528.143137813645;5573.944260557342;5814.505767009767;5868.413158684098;5875.735591898375;5886.117082437583;5898.675572843535;5364.3830959440165;5426.050441172779;5433.157860531624;5433.864153396196;5496.917546236809;4975.800967961313;4976.576990955737;4977.925331120036;4990.825321113816;4992.350994370781;6016.187814644967;6018.127371531191;6024.969875150597;6034.39656034393;6036.0644100164545;5800.071988481823;5821.970890145522;5832.737526811219;5841.824745257649;5843;5964.761409543569;6021.518278537794;6031.125486804476;6040.942835003769;6045.063015232646;5746.856328591819;5756.280464941882;5761.39505351932;5764.423557644202;5764.769409223752;5811.4479124483105;5814.680192589279;5824.388439213822;5831;5854.385289544536;5749.080147176432;5751.769929202952;5752.7698892043845;5753.021986262429;5757.9424205757405;5624.971875140598;5698.059820129798;5741.91387129185;5753.338366087786;5759;5670.092785154356;5680.715964201856;5686.658800471985;5753.4246575343805;5754.68349240779;5756;5756.194132821324;5763;5770.394108618702;5790.507806836466;5594.104943209067;5601.5238704710555;5606.159076138611;5610.691411972218;5612.186232996274 17:05:05 INFO - PROCESS | 24199 | |1;ext.html;567.8637127089498;586.4663156527558;589.3576002157648;614.1739360560045;634.8984511871904;33730.49404258935;43157;45564.54435455644;45620.771896140475;49201.26198107031;45530;45725.77137114318;45851;46204.306935395914;46412;9045.638174473013;9244.907550924505;9248.861267081;9256.028117047681;9264.444133351986;8634.611442485104;8908.465492070463;10811.78376432471;11095.056920161756;11101.111911047097;11020.559177632886;11086.833697494543;11087.55649774008;11093;11094.167937404687;11089.2237543372;11141.888581114166;11144.777104457946;11154.274972126866;11168.385738784364;10833.079188269006;10839.566417343296;10859.619913303075;10927.672169834917;10928;44365.77817110926;44379;44639.330410043876;44785;44799.55200447986;4204.5375008749015;4225.577442255781;4274.166537525184;4285.807138678736;4370.737755734634;32500.83749581237;32764.344713105842;32773.6722632773;32798.50802237968;32838.6716132838;4231.513375961742;4341.45731783527;4423.668224883115;4529.071540334224;4580.7938642761155;314178;316220;316895;316915;317039;59628.10557841636;60207.39792602018;60458.697706511186;60647;60774;62968.3328500428;63162;63226;63368.395792505195;63396;17705.380311689285;17996.190171442315;17997.640047199246;18001.099945002697;18003.549911252325;12798.744025119631;13102.541411050568;13821.723565528633;13836.23900685452;13885.236312002937;16432;16938.576535586464;16962.268300973767;17495.912520437316;17573.912130439265;5732.570057245724;6375.027478566725;6580;6648.53460257787;6743.561668491532;924.2744445610164;933.9066093390743;946.4226821638795;948.7011591348703;950.7147855643279;29509;31699;31708;31951.360972780414;31979.680203198135;1033.3076838518211;1110.838928355384;1118.072000239799;1127.3405058040973;1134.9716257093473;15850.286737096858;16483.175841207893;16825.6634867302;16839.57901052459;16963.406280780113;483632;484933;485851;485857;485912;53432.46567534275;54716.45283547114;59124.01825753554;60245.698771505864;60303;1469.441612187362;1476.8301645310712;1487.620656732548;1508.5021942758863;1511.138650968937;30891.227719307197;32422.83788581042;32795.34409311848;33231.833840830644;33536.64023676906;53016.4698353027;53570;53652.73173634107;53671;53716.462835371145;387914;390592;391492;391509;391565.759081684;40222.59777402189;40706.796466017484;40766.980825478415;40840.3873941897;40874.38688419617;45582.54417455783;46592.7670361646;46881.53118468908;46896;47467.28799067948;38391.42412863865;38560.61439385683;38825;38837;40118.197636046534;37608.811955940044;38065.23869522649;38724.838254851275;39492.40761388639;39605.20789584135;38395.23209535849;38469.8459046229;38499;38515.6148438512;38721.80639096787;32625;34056.65943340535;34488.31023379569;34874.47688284729;35246.471302930986;25982.480350392507;26505;26529.60205596879;26614.201573952814;26887.462250755267 17:05:05 INFO - PROCESS | 24199 | |2;jquery.html;396.166070421762;428.88848899286194;430.8233624214072;434.48245897761444;448.5066426930375;17560.82439175608;20254.29109981151;22170.224042158527;22229;22534.661980070312;21208.151673933062;21520.677189842165;21914.452138696503;22342.88828555859;22675.886620566875;5971.37300583439;6066.908996365058;6077.5137988961;6112.449879510843;6205.472534834545;4440.800163992628;6004.5796794224425;6125.816225513219;6126.479249263795;6127.080937859335;4745.833895813647;6564.343565643445;6845.315468453165;6850.040994260808;6977.651117444133;6715.2613212546585;6804;6869.072675188835;6955.686994085253;6972.651367431634;6094.786682466137;6096.603720758137;6096.695165241765;6101.664408457533;6103.633781973096;21474.141034358607;25854.87072564644;25910.611340829902;25967.870160649265;26047.479050418886;2879.2226098953165;2881.5101432756273;2882.754965827907;2889.4654488919405;2894.276430892277;15168.435417676837;15406.844486663433;15798.526044218692;15814.525564233092;16174.838251617452;1907.8569107317007;1961.4900125967351;1980.7722111957166;2003.989980050105;2026.0882602828638;84511.15488845094;89238.5538072312;91374.99999999933;91997.5400122995;92683;10249.38503689781;11011.229213955106;11978.101642376856;11981.723472540189;12010.339431331186;15394.23028848553;16425.55063436668;16430.67138657244;16885.40901068457;17139.400120995706;8309.37679674027;8340.791480212922;8367.539785311867;8519.233269005696;8586.270167035871;7788.337991270692;7871.960640196877;7968.681252749825;7992.080910695228;8036.839263214703;7504.198992241932;7701.961490192513;7725.613719314012;7874.330681891989;7899.842003159904;2026.7365242518379;2032.1363420546209;2076.5431605046865;2131.1581925139485;2148.688440176166;1037.4605205293205;1068.9251752377259;1072.2387105155426;1088.8893328804575;1118.6196693124377;19350.612987740165;19373.450123990046;19803.20787168526;19961.101750421265;20017.499562511053;1069.556134204312;1077.6282182646974;1093.9726506837392;1096.8519249901321;1125.4091601909063;10038.849417258747;10859.29414588065;10994.230403871812;11057.11543076552;11106.944465277784;667088;678413;688515;691562;697031;97016.51491742497;97185;97216.51391742995;98202;101558;1025.8666373371414;1026.5431882812227;1032.2361452525076;1039.3140527252128;1049.895010498944;16213.59466013312;16623;17003.659926801643;17230.483085507454;17573.209205586034;43388.78305608452;43857.34213986729;44236.55763442325;44488.11023779442;44534.55465445304;57026.42973570377;57678;58246.70876645589;58260.4173958255;62277;11671.59149429766;12499.75000500003;12650.30423326726;12691.448707131722;13888.861111388756;13359.53241636538;13468.79796803029;13627.863721362659;13647.454101835816;13674.863251367757;6841.110655614738;9823.16503097216;11501.367424791717;11585.594504192313;11721.531138754695;11102.61140860066;11299.152563557602;11425.942870285595;11476.540938362372;11947.953271915605;11294.887051129712;11569.132315076571;11705.122115841516;11789.41052947332;12063.155579109378;13011.934940325238;13197.406116724962;13297.867021329663;13305.401256943655;13590.93204533971;11471;11535.307881527135;11606.825897611374;11673;11927.701807454536 17:05:05 INFO - PROCESS | 24199 | |3;mootools.html;1417.2134465371714;1439.0358459831912;1440.5894320118764;1449.6593300574357;1453.1353844462542;7974.800629984246;8392.664293428255;8447.746567602973;8457.746267611981;8462.280706139978;7372.262773722625;7599.620018999041;7970.601469926495;8232.588370581461;8241.835163296746;2316.5830150572933;2329.5457385809773;2330;2347.213683416058;2348.6829278047503;2262.3891549281684;2347.530493901218;2352.9411764705847;2357.8467399619058;2363.5745565798147;2073.9170433182653;2148.591767564166;2153.138744502196;2155.9461013474634;2303.1363238785457;2300.838941274103;2351.2240960483173;2351.494428697838;2354.399628094842;2356.0340260493117;2299.1952816514085;2343.9648405273933;2350.4241460842204;2392.1986134644917;2401.639754036891;8440.704575339834;8477.406581539295;8487.872681909776;8497.660093596249;8503.319734421231;5142.177251639757;5262.60530460217;5264.210368444726;5264.763085661154;5265.894682106336;3292.27569934614;3362.798232106057;3378.3243351329834;3442.7245820334315;3490.703290220334;1379.7654398752136;1422.5376752555358;1442.28606839614;1468.84577119402;1523.2992823301295;11356.091512678966;11420.42897855104;11445.885541144482;11445.942770286096;11461.541538338457;4405.559444055569;4671.392718946583;4708.599769019604;4726.8109275628585;4735.786889589976;9777.804443911224;9789;9801.166900813369;9804.460754658563;9820;5254.816081437131;5275.894482110336;5348.545373643206;5349.625526213128;5353.1167357386375;4815.6388270879825;4866.221404575251;4916.72957987307;4932.03825254072;4984.975075124674;3907.941380879289;3918.275119102975;3938.6849052076336;3994.720369574102;4031.4154447604933;1268.6194141757435;1288.884000439965;1308.908376413642;1312.6718320419895;1330.3547779327018;736.1240124252123;806.6128258435983;914.1955079530104;984.7538115471132;1008.5612758450097;5577.888442231133;5857.58996870215;5881.5000724938;5962.135490353874;6118.663473508911;1018.5823812236947;1031.118393773328;1049.1763965287214;1068.4016950507585;1073.588231475607;4040.6363427291685;4112.506499220112;4135.483064616923;4359.782010899506;4394.934075988863;9986.700398988041;10140.949295253624;10143.08712215904;10216.540255688511;10257.897421025844;10188.694339169837;10279.588816447258;10315.226358023177;10323.174146068297;10330.690079297634;7521.7743467696055;7707.344875685518;7801.726939557202;7941.285284324554;7943.563104029334;5698.772049118154;5714.942850571441;5742.856428589319;5846.766129354778;5998.4601385875485;9009.189172974464;9157.954210229173;9193.448393096436;9240.768980775534;9282.535873206447;9156.771080723036;9384.108509691569;9445.197158241626;9484.430934143973;9555.761105972128;7447.404207663482;7559.622018899143;7614.466987311057;7685.154632990479;7696.461247712607;8090.352771778362;8164.142765009588;8175.427720059776;8178.877316840371;8180.304674102768;7138.179109402485;7179.389751871149;7244.529105608119;7379.262073792793;7379.704811807467;7241.637918104179;7352.889706654511;7370.77887663371;7386.409087273113;7605.961970190335;6610.4711623071;6681.665916704048;6692.866142677217;6693.799186024427;6706.429953454011;5056.772445240046;5062.924056139234;5083.72039537829;5114.232865070269;5267.789288428573;4984.7258400788305;5042.117629414764;5076.18780995039;5076.82231121909;5126.4360920297995 17:05:05 INFO - PROCESS | 24199 | |4;prototype.html;397.5289282200591;402.7643828360409;409.896785026421;422.65975889409015;423.94912610486745;5013.122703526887;5161.974190129054;5283.867903302419;5292.655977361474;5334.626576139667;5080.415752188499;5166.095933211683;5183.300254465646;5184.7407629618465;5198.194279886624;4160.750354978696;4199.7690127043;4203.621674049335;4216.304309788881;4225.788710564475;3860.40163774614;4059.4316795648633;4210.97894510527;4215.768132752697;4237.7669228192435;4020.5778393268724;4030.717849750519;4030.9318030721884;4034.979825100885;4044.3822471011536;4008.959910400888;4016.6585840203616;4027.41602467642;4044.3326851069833;4065.146319272956;3633.818309084562;3635.0734110921253;3638.199596088856;3667.7799332039895;3673.8530458781615;5041.319421878036;5052.444231134572;5052.8484145475695;5065.822696205652;5138.794448222104;4700.764961751933;4704.694194877322;4705.6470764692785;4722.409698787652;4740.360051393087;5454;5476.644018138848;5478.424765399615;5490.478404551562;5506.449355064502;3923.2741942740686;4008.498937632796;4014.5383280922483;4025.6376926076796;4042.555318914917;5642.153676948449;5672.376038635788;5696.943030569724;5720.399358067426;5724.5688577855535;4110.650594699424;4138.627523522898;4150.398192262105;4151.107511884959;4156.147989662112;4035.3946907963455;4138.275801734684;4159.188958153191;4171.20747058058;4234.24278924243;4698.459677137173;4699.154152252628;4702.905941881143;4716.740579268173;4741.596964258008;5579.163125531203;5581.776728930879;5584.385717571064;5594.412586678422;5610.531366198859;1319.4392383237087;1339.4776037345443;1378.5312993582231;1409.9284543746621;1427.978580321296;939.1735272959752;977.4848984074656;977.8044391121804;992.503748125937;992.8609994600762;5111.028904508132;5117.667351622133;5132.307138536325;5141.71720555373;5163.277141200235;5426.782928682808;5466.797304592983;5469.917951230735;5474.698891561003;5538.6399884007415;4897.681650692693;5105.923411148836;5110;5143.742812859342;5226.555742761908;2889.19102651258;2894.9710502895123;2897.797154199186;2908.8910539858857;2936.309967157716;5625.38120806711;5673.914891276634;5675.858103547444;5677.460641239076;5681.3240094172315;5418.674879507243;5643.266375371176;5726.79737255181;5774.2782152230975;5791.88416231673;5824.592278540462;5847.181394604759;5855.531557475391;5858.53131749459;5861.677607731615;5570.303712035996;5631.746571404215;5662.207290979349;5691.630044047124;5701.7434215461235;5575.470330318613;5576.60963732551;5578.163275508706;5582.7766889323975;5608;5849.736761845642;5883.764649413975;5899.410058994066;5907.5231192201945;5925.970370148121;4063.2686116499312;4143.114882728291;4165.4168416422335;4167.937480937728;4176.812043458112;5473.425290344616;5676.602637815313;5679.630823996427;5691.715414229355;5712.514436272963;5365.175840214346;5483.341998960151;5484.489926446998;5497.202905578589;5523.066926575666;5473.644213126134;5501.14732216507;5520.889582208413;5537.6954267515675;5539.473749993744;5289.523942845162;5484.7806087757635;5487.722595122979;5535.142052981794;5547.44525547442;5546.306711661043;5547.7780888764;5552.888942221214;5566.944330556805;5572.3034620672415;5376.166694162411;5382.219578161066;5425.593080519056;5435.565154787687;5443.312573102351 17:05:05 INFO - PROCESS | 24199 | |5;yui.html;772.4008710688535;776.367260682544;811.5536454949776;860.131267419906;890.2166093837424;14758.33587488563;15383.692326153498;15775.368985240591;15823.84176158238;15902.602434939132;14633.048851824651;15018.849811501881;15336.386544538233;15487.690246195069;15501;741.3402072155773;757.7044952468542;759.4266328921684;759.5290919629837;761.6458346868704;764.1861417590277;765.3915137465729;765.9885101723451;767.1522967121334;767.2902565127263;791.1692722641233;802.9598520074002;803.5901690138013;803.9678412863478;805.1304591041661;797.6490344248512;798.7364169823974;799.2007992007992;799.3565180030073;800.1238643685184;579.8840231953626;580.1848402993759;580.2978396140675;582.618384957849;582.9154772557955;14175.85824141766;14517.637059073502;14521.128732276096;14567.49013784523;15225.847741522664;14709.632259193499;14961.177135257556;15207.61980950474;15329;15453.304601292968;12137.878621213764;12196.573119940847;12219.694507637292;12472.251664900044;12580.496780128784;3878.495795546561;3924.9018774530864;3931.7247792654525;3933.154371810046;3989.900252493682;73416;73457;73881.26118738852;75158.24841751567;76606;11820.586279480176;12045.819312710317;12115.939420303019;12281.263124212397;12285.877141228473;22529.549409012056;22548;22565;22599.322020339416;22727.431814204447;8205.548694821842;8222.342212622976;8259.545724985064;8265.173482651686;8509.361797865186;4393.275109606943;4461.353103799996;4554.134714404253;4601.5168407317415;4625.653076019312;3684.152644891636;3790.3556395412847;3795.6773674237998;3800.505934228588;3802.0304822270145;637.8947473666885;642.5116911147561;642.8907085795425;646.331047365974;664.0371461381017;750.4071783291248;756.7427074794597;773.153397030251;804.2279411764771;826.921442462965;9901.75245618851;10140.239482038876;10285.7428564285;10316.845247321296;10532;772.7527191298843;787.4566549081115;791.3155120820448;791.8614242507538;794.447858738183;4659.9767001165455;5103.795848166106;5126.92309615356;5161.66449180802;5176.171812510056;76986.61506692543;78438.6078069606;79021;79690.20309796827;80067;39572.20855582872;47592.286115708295;68064.6596767013;68616.6569167151;70663;50654.49345506571;56840.43159568434;56977.14534281989;57033;58692.70653646704;10481.580736770444;10819.18856085781;11051.447427628425;11088.223824332219;11195.552177912792;39331.21337573175;39350.60649393584;39473.40789888096;40145.39781903215;41158.794206029976;50202.49797501978;50244;50820;51609;53306;13367.197968121944;13397.92318775766;13548;13553;13669.453221871014;14836.703265934837;14846.777298340317;14953.476628317956;15235.3905843765;15859.286332114852;12757.872421275668;13083.803742944054;13246.735065298833;13712.862871371557;14286.571402857931;13581.32093395346;13841.377138029015;13915.652108697364;14102;14169.858301416854;11762.70593235176;13692.246926419142;13940.651483712989;14600.269986500845;14635.85364146345;11103.5558577656;11146.609868654557;11618.294590690784;11965.102617303563;12001.459934303151;9510.809783804147;10541.525631346454;10711.858987169651;10917.781644367227;10946.781064378827 17:05:05 INFO - PROCESS | 24199 | __end_tp_report 17:05:05 INFO - PROCESS | 24199 | __start_cc_report 17:05:05 INFO - PROCESS | 24199 | _x_x_mozilla_cycle_collect,1155 17:05:05 INFO - PROCESS | 24199 | __end_cc_report 17:05:05 INFO - PROCESS | 24199 | __startTimestamp1485824705517__endTimestamp 17:05:05 INFO - PROCESS | 24199 | 17:05:05 INFO - PROCESS | 24199 | ------- Summary: start ------- 17:05:05 INFO - PROCESS | 24199 | Number of tests: 6 17:05:05 INFO - PROCESS | 24199 | 17:05:05 INFO - PROCESS | 24199 | [#0] dojo.html Cycles:165 Average:5395.41 Median:5670.09 stddev:614.21 (10.8%) stddev-sans-first:590.13 17:05:05 INFO - PROCESS | 24199 | Values: 3142.7 3186.8 3218.0 3222.6 3225.4 5337.7 5349.7 5372.5 5459.5 5459.9 5358.4 5441.8 5473.5 5482.8 5507.2 4798.4 4867.8 4874.8 4889.1 4996.0 4937.2 4967.3 4981.5 4989.0 4992.0 4766.3 4772.7 4807.6 4812.7 4966.3 4846.7 4855.2 4861.0 4906.3 4934.6 4820.7 4835.2 4842.2 4857.8 4871.5 5209.1 5246.3 5268.7 5424.4 5492.6 5618.3 5690.8 5693.7 5736.3 5752.2 5691.4 5700.1 5714.5 5724.1 5733.3 5334.9 5343.2 5345.1 5345.5 5409.8 5930.0 5956.7 5985.4 5994.3 6049.5 5746.7 5774.3 5781.3 5781.4 5788.1 5695.9 5731.3 5755.5 5837.9 5848.6 5747.3 5786.7 5795.4 5807.3 5898.2 5830.8 5831.7 5838.2 5842.0 5843.6 4482.6 4487.4 4500.0 4508.1 4543.7 3955.6 3980.1 3981.8 4022.4 4041.4 5511.2 5512.3 5512.3 5528.1 5573.9 5814.5 5868.4 5875.7 5886.1 5898.7 5364.4 5426.1 5433.2 5433.9 5496.9 4975.8 4976.6 4977.9 4990.8 4992.4 6016.2 6018.1 6025.0 6034.4 6036.1 5800.1 5822.0 5832.7 5841.8 5843.0 5964.8 6021.5 6031.1 6040.9 6045.1 5746.9 5756.3 5761.4 5764.4 5764.8 5811.4 5814.7 5824.4 5831.0 5854.4 5749.1 5751.8 5752.8 5753.0 5757.9 5625.0 5698.1 5741.9 5753.3 5759.0 5670.1 5680.7 5686.7 5753.4 5754.7 5756.0 5756.2 5763.0 5770.4 5790.5 5594.1 5601.5 5606.2 5610.7 5612.2 17:05:05 INFO - PROCESS | 24199 | 17:05:05 INFO - PROCESS | 24199 | [#1] ext.html Cycles:180 Average:57180.23 Median:38831.00 stddev:106391.68 (274.0%) stddev-sans-first:106605.22 17:05:05 INFO - PROCESS | 24199 | Values: 567.9 586.5 589.4 614.2 634.9 33730.5 43157.0 45564.5 45620.8 49201.3 45530.0 45725.8 45851.0 46204.3 46412.0 9045.6 9244.9 9248.9 9256.0 9264.4 8634.6 8908.5 10811.8 11095.1 11101.1 11020.6 11086.8 11087.6 11093.0 11094.2 11089.2 11141.9 11144.8 11154.3 11168.4 10833.1 10839.6 10859.6 10927.7 10928.0 44365.8 44379.0 44639.3 44785.0 44799.6 4204.5 4225.6 4274.2 4285.8 4370.7 32500.8 32764.3 32773.7 32798.5 32838.7 4231.5 4341.5 4423.7 4529.1 4580.8 314178.0 316220.0 316895.0 316915.0 317039.0 59628.1 60207.4 60458.7 60647.0 60774.0 62968.3 63162.0 63226.0 63368.4 63396.0 17705.4 17996.2 17997.6 18001.1 18003.5 12798.7 13102.5 13821.7 13836.2 13885.2 16432.0 16938.6 16962.3 17495.9 17573.9 5732.6 6375.0 6580.0 6648.5 6743.6 924.3 933.9 946.4 948.7 950.7 29509.0 31699.0 31708.0 31951.4 31979.7 1033.3 1110.8 1118.1 1127.3 1135.0 15850.3 16483.2 16825.7 16839.6 16963.4 483632.0 484933.0 485851.0 485857.0 485912.0 53432.5 54716.5 59124.0 60245.7 60303.0 1469.4 1476.8 1487.6 1508.5 1511.1 30891.2 32422.8 32795.3 33231.8 33536.6 53016.5 53570.0 53652.7 53671.0 53716.5 387914.0 390592.0 391492.0 391509.0 391565.8 40222.6 40706.8 40767.0 40840.4 40874.4 45582.5 46592.8 46881.5 46896.0 47467.3 38391.4 38560.6 38825.0 38837.0 40118.2 37608.8 38065.2 38724.8 39492.4 39605.2 38395.2 38469.8 38499.0 38515.6 38721.8 32625.0 34056.7 34488.3 34874.5 35246.5 25982.5 26505.0 26529.6 26614.2 26887.5 17:05:05 INFO - PROCESS | 24199 | 17:05:05 INFO - PROCESS | 24199 | [#2] jquery.html Cycles:180 Average:35692.76 Median:11802.65 stddev:112166.14 (950.3%) stddev-sans-first:112449.48 17:05:05 INFO - PROCESS | 24199 | Values: 396.2 428.9 430.8 434.5 448.5 17560.8 20254.3 22170.2 22229.0 22534.7 21208.2 21520.7 21914.5 22342.9 22675.9 5971.4 6066.9 6077.5 6112.4 6205.5 4440.8 6004.6 6125.8 6126.5 6127.1 4745.8 6564.3 6845.3 6850.0 6977.7 6715.3 6804.0 6869.1 6955.7 6972.7 6094.8 6096.6 6096.7 6101.7 6103.6 21474.1 25854.9 25910.6 25967.9 26047.5 2879.2 2881.5 2882.8 2889.5 2894.3 15168.4 15406.8 15798.5 15814.5 16174.8 1907.9 1961.5 1980.8 2004.0 2026.1 84511.2 89238.6 91375.0 91997.5 92683.0 10249.4 11011.2 11978.1 11981.7 12010.3 15394.2 16425.6 16430.7 16885.4 17139.4 8309.4 8340.8 8367.5 8519.2 8586.3 7788.3 7872.0 7968.7 7992.1 8036.8 7504.2 7702.0 7725.6 7874.3 7899.8 2026.7 2032.1 2076.5 2131.2 2148.7 1037.5 1068.9 1072.2 1088.9 1118.6 19350.6 19373.5 19803.2 19961.1 20017.5 1069.6 1077.6 1094.0 1096.9 1125.4 10038.8 10859.3 10994.2 11057.1 11106.9 667088.0 678413.0 688515.0 691562.0 697031.0 97016.5 97185.0 97216.5 98202.0 101558.0 1025.9 1026.5 1032.2 1039.3 1049.9 16213.6 16623.0 17003.7 17230.5 17573.2 43388.8 43857.3 44236.6 44488.1 44534.6 57026.4 57678.0 58246.7 58260.4 62277.0 11671.6 12499.8 12650.3 12691.4 13888.9 13359.5 13468.8 13627.9 13647.5 13674.9 6841.1 9823.2 11501.4 11585.6 11721.5 11102.6 11299.2 11425.9 11476.5 11948.0 11294.9 11569.1 11705.1 11789.4 12063.2 13011.9 13197.4 13297.9 13305.4 13590.9 11471.0 11535.3 11606.8 11673.0 11927.7 17:05:05 INFO - PROCESS | 24199 | 17:05:05 INFO - PROCESS | 24199 | [#3] mootools.html Cycles:180 Average:5583.96 Median:5080.27 stddev:3023.57 (59.5%) stddev-sans-first:3015.83 17:05:05 INFO - PROCESS | 24199 | Values: 1417.2 1439.0 1440.6 1449.7 1453.1 7974.8 8392.7 8447.7 8457.7 8462.3 7372.3 7599.6 7970.6 8232.6 8241.8 2316.6 2329.5 2330.0 2347.2 2348.7 2262.4 2347.5 2352.9 2357.8 2363.6 2073.9 2148.6 2153.1 2155.9 2303.1 2300.8 2351.2 2351.5 2354.4 2356.0 2299.2 2344.0 2350.4 2392.2 2401.6 8440.7 8477.4 8487.9 8497.7 8503.3 5142.2 5262.6 5264.2 5264.8 5265.9 3292.3 3362.8 3378.3 3442.7 3490.7 1379.8 1422.5 1442.3 1468.8 1523.3 11356.1 11420.4 11445.9 11445.9 11461.5 4405.6 4671.4 4708.6 4726.8 4735.8 9777.8 9789.0 9801.2 9804.5 9820.0 5254.8 5275.9 5348.5 5349.6 5353.1 4815.6 4866.2 4916.7 4932.0 4985.0 3907.9 3918.3 3938.7 3994.7 4031.4 1268.6 1288.9 1308.9 1312.7 1330.4 736.1 806.6 914.2 984.8 1008.6 5577.9 5857.6 5881.5 5962.1 6118.7 1018.6 1031.1 1049.2 1068.4 1073.6 4040.6 4112.5 4135.5 4359.8 4394.9 9986.7 10140.9 10143.1 10216.5 10257.9 10188.7 10279.6 10315.2 10323.2 10330.7 7521.8 7707.3 7801.7 7941.3 7943.6 5698.8 5714.9 5742.9 5846.8 5998.5 9009.2 9158.0 9193.4 9240.8 9282.5 9156.8 9384.1 9445.2 9484.4 9555.8 7447.4 7559.6 7614.5 7685.2 7696.5 8090.4 8164.1 8175.4 8178.9 8180.3 7138.2 7179.4 7244.5 7379.3 7379.7 7241.6 7352.9 7370.8 7386.4 7606.0 6610.5 6681.7 6692.9 6693.8 6706.4 5056.8 5062.9 5083.7 5114.2 5267.8 4984.7 5042.1 5076.2 5076.8 5126.4 17:05:05 INFO - PROCESS | 24199 | 17:05:05 INFO - PROCESS | 24199 | [#4] prototype.html Cycles:180 Average:4635.20 Median:5212.38 stddev:1344.73 (25.8%) stddev-sans-first:1310.34 17:05:05 INFO - PROCESS | 24199 | Values: 397.5 402.8 409.9 422.7 423.9 5013.1 5162.0 5283.9 5292.7 5334.6 5080.4 5166.1 5183.3 5184.7 5198.2 4160.8 4199.8 4203.6 4216.3 4225.8 3860.4 4059.4 4211.0 4215.8 4237.8 4020.6 4030.7 4030.9 4035.0 4044.4 4009.0 4016.7 4027.4 4044.3 4065.1 3633.8 3635.1 3638.2 3667.8 3673.9 5041.3 5052.4 5052.8 5065.8 5138.8 4700.8 4704.7 4705.6 4722.4 4740.4 5454.0 5476.6 5478.4 5490.5 5506.4 3923.3 4008.5 4014.5 4025.6 4042.6 5642.2 5672.4 5696.9 5720.4 5724.6 4110.7 4138.6 4150.4 4151.1 4156.1 4035.4 4138.3 4159.2 4171.2 4234.2 4698.5 4699.2 4702.9 4716.7 4741.6 5579.2 5581.8 5584.4 5594.4 5610.5 1319.4 1339.5 1378.5 1409.9 1428.0 939.2 977.5 977.8 992.5 992.9 5111.0 5117.7 5132.3 5141.7 5163.3 5426.8 5466.8 5469.9 5474.7 5538.6 4897.7 5105.9 5110.0 5143.7 5226.6 2889.2 2895.0 2897.8 2908.9 2936.3 5625.4 5673.9 5675.9 5677.5 5681.3 5418.7 5643.3 5726.8 5774.3 5791.9 5824.6 5847.2 5855.5 5858.5 5861.7 5570.3 5631.7 5662.2 5691.6 5701.7 5575.5 5576.6 5578.2 5582.8 5608.0 5849.7 5883.8 5899.4 5907.5 5926.0 4063.3 4143.1 4165.4 4167.9 4176.8 5473.4 5676.6 5679.6 5691.7 5712.5 5365.2 5483.3 5484.5 5497.2 5523.1 5473.6 5501.1 5520.9 5537.7 5539.5 5289.5 5484.8 5487.7 5535.1 5547.4 5546.3 5547.8 5552.9 5566.9 5572.3 5376.2 5382.2 5425.6 5435.6 5443.3 17:05:05 INFO - PROCESS | 24199 | 17:05:05 INFO - PROCESS | 24199 | [#5] yui.html Cycles:180 Average:17005.15 Median:21781.05 stddev:20926.10 (96.1%) stddev-sans-first:20949.30 17:05:05 INFO - PROCESS | 24199 | Values: 772.4 776.4 811.6 860.1 890.2 14758.3 15383.7 15775.4 15823.8 15902.6 14633.0 15018.8 15336.4 15487.7 15501.0 741.3 757.7 759.4 759.5 761.6 764.2 765.4 766.0 767.2 767.3 791.2 803.0 803.6 804.0 805.1 797.6 798.7 799.2 799.4 800.1 579.9 580.2 580.3 582.6 582.9 14175.9 14517.6 14521.1 14567.5 15225.8 14709.6 14961.2 15207.6 15329.0 15453.3 12137.9 12196.6 12219.7 12472.3 12580.5 3878.5 3924.9 3931.7 3933.2 3989.9 73416.0 73457.0 73881.3 75158.2 76606.0 11820.6 12045.8 12115.9 12281.3 12285.9 22529.5 22548.0 22565.0 22599.3 22727.4 8205.5 8222.3 8259.5 8265.2 8509.4 4393.3 4461.4 4554.1 4601.5 4625.7 3684.2 3790.4 3795.7 3800.5 3802.0 637.9 642.5 642.9 646.3 664.0 750.4 756.7 773.2 804.2 826.9 9901.8 10140.2 10285.7 10316.8 10532.0 772.8 787.5 791.3 791.9 794.4 4660.0 5103.8 5126.9 5161.7 5176.2 76986.6 78438.6 79021.0 79690.2 80067.0 39572.2 47592.3 68064.7 68616.7 70663.0 50654.5 56840.4 56977.1 57033.0 58692.7 10481.6 10819.2 11051.4 11088.2 11195.6 39331.2 39350.6 39473.4 40145.4 41158.8 50202.5 50244.0 50820.0 51609.0 53306.0 13367.2 13397.9 13548.0 13553.0 13669.5 14836.7 14846.8 14953.5 15235.4 15859.3 12757.9 13083.8 13246.7 13712.9 14286.6 13581.3 13841.4 13915.7 14102.0 14169.9 11762.7 13692.2 13940.7 14600.3 14635.9 11103.6 11146.6 11618.3 11965.1 12001.5 9510.8 10541.5 10711.9 10917.8 10946.8 17:05:05 INFO - PROCESS | 24199 | -------- Summary: end -------- 17:05:05 INFO - PROCESS | 24199 | 17:05:06 INFO - TEST-INFO | 24199: exit 0 17:05:06 INFO - TEST-OK | dromaeo_css | took 1115795ms 17:05:06 INFO - TEST-START | kraken 17:05:06 INFO - operating with platform_type : linux_ 17:05:06 INFO - Initialising browser for kraken test... 17:05:06 INFO - TEST-INFO | started process 24503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjZXi4X/profile http://localhost:43518/getInfo.html) 17:05:09 INFO - PROCESS | 24503 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:05:09 INFO - PROCESS | 24503 | __metrics Screen width/height:1600/1200 17:05:09 INFO - PROCESS | 24503 | colorDepth:24 17:05:09 INFO - PROCESS | 24503 | Browser inner width/height: 1024/697 17:05:09 INFO - PROCESS | 24503 | __metrics 17:05:10 INFO - PROCESS | 24503 | 1485824710596 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 17:05:10 INFO - PROCESS | 24503 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:05:10 INFO - PROCESS | 24503 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:05:11 INFO - PROCESS | 24503 | console.error: PushService: 17:05:11 INFO - PROCESS | 24503 | stateChangeProcessEnqueue: Error transitioning state 17:05:11 INFO - PROCESS | 24503 | UnknownError 17:05:11 INFO - TEST-INFO | 24503: exit 0 17:05:11 INFO - Browser initialized. 17:05:11 INFO - Running cycle 1/1 for kraken test... 17:05:11 INFO - TEST-INFO | started process 24588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjZXi4X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:23 INFO - PROCESS | 24588 | RSS: Main: 148709376 17:05:23 INFO - PROCESS | 24588 | 17:05:26 INFO - PROCESS | 24588 | Cycle 1(1): loaded http://localhost:43518/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43518/tests/kraken/driver.html?testName=audio-beat-detection) 17:05:27 INFO - PROCESS | 24588 | RSS: Main: 205307904 17:05:27 INFO - PROCESS | 24588 | 17:05:29 INFO - PROCESS | 24588 | Cycle 1(1): loaded http://localhost:43518/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43518/tests/kraken/driver.html?testName=audio-dft) 17:05:30 INFO - PROCESS | 24588 | RSS: Main: 184369152 17:05:30 INFO - PROCESS | 24588 | 17:05:33 INFO - PROCESS | 24588 | Cycle 1(1): loaded http://localhost:43518/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43518/tests/kraken/driver.html?testName=audio-fft) 17:05:34 INFO - PROCESS | 24588 | RSS: Main: 265019392 17:05:34 INFO - PROCESS | 24588 | 17:05:36 INFO - PROCESS | 24588 | Cycle 1(1): loaded http://localhost:43518/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43518/tests/kraken/driver.html?testName=audio-oscillator) 17:05:36 INFO - PROCESS | 24588 | RSS: Main: 175165440 17:05:36 INFO - PROCESS | 24588 | 17:05:38 INFO - PROCESS | 24588 | Cycle 1(1): loaded http://localhost:43518/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43518/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:05:39 INFO - PROCESS | 24588 | RSS: Main: 181080064 17:05:39 INFO - PROCESS | 24588 | 17:05:42 INFO - PROCESS | 24588 | Cycle 1(1): loaded http://localhost:43518/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43518/tests/kraken/driver.html?testName=imaging-darkroom) 17:05:43 INFO - PROCESS | 24588 | RSS: Main: 220131328 17:05:43 INFO - PROCESS | 24588 | 17:05:46 INFO - PROCESS | 24588 | Cycle 1(1): loaded http://localhost:43518/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43518/tests/kraken/driver.html?testName=imaging-desaturate) 17:05:46 INFO - PROCESS | 24588 | RSS: Main: 219541504 17:05:46 INFO - PROCESS | 24588 | 17:05:49 INFO - PROCESS | 24588 | Cycle 1(1): loaded http://localhost:43518/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43518/tests/kraken/driver.html?testName=json-parse-financial) 17:05:50 INFO - PROCESS | 24588 | RSS: Main: 218357760 17:05:50 INFO - PROCESS | 24588 | 17:05:51 INFO - PROCESS | 24588 | Cycle 1(1): loaded http://localhost:43518/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43518/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:05:52 INFO - PROCESS | 24588 | RSS: Main: 180576256 17:05:52 INFO - PROCESS | 24588 | 17:05:54 INFO - PROCESS | 24588 | Cycle 1(1): loaded http://localhost:43518/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43518/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:05:54 INFO - PROCESS | 24588 | RSS: Main: 188747776 17:05:54 INFO - PROCESS | 24588 | 17:05:57 INFO - PROCESS | 24588 | Cycle 1(1): loaded http://localhost:43518/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43518/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:05:57 INFO - PROCESS | 24588 | RSS: Main: 196583424 17:05:57 INFO - PROCESS | 24588 | 17:06:00 INFO - PROCESS | 24588 | Cycle 1(1): loaded http://localhost:43518/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:06:00 INFO - PROCESS | 24588 | RSS: Main: 206438400 17:06:00 INFO - PROCESS | 24588 | 17:06:03 INFO - PROCESS | 24588 | Cycle 1(1): loaded http://localhost:43518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:06:04 INFO - PROCESS | 24588 | RSS: Main: 202825728 17:06:04 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | Cycle 1(1): loaded http://localhost:43518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43518/tests/kraken/driver.html?testName=ai-astar) 17:06:06 INFO - PROCESS | 24588 | RSS: Main: 255336448 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | __start_tp_report 17:06:06 INFO - PROCESS | 24588 | _x_x_mozilla_page_load 17:06:06 INFO - PROCESS | 24588 | _x_x_mozilla_page_load_details 17:06:06 INFO - PROCESS | 24588 | |i|pagename|runs| 17:06:06 INFO - PROCESS | 24588 | |0;ai-astar;112;112;112;112;114;114;113;112;111;112 17:06:06 INFO - PROCESS | 24588 | |1;audio-beat-detection;157;120;119;169;132;120;120;119;145;126 17:06:06 INFO - PROCESS | 24588 | |2;audio-dft;162;160;160;160;162;162;161;165;161;161 17:06:06 INFO - PROCESS | 24588 | |3;audio-fft;75;76;76;121;76;76;76;74;102;76 17:06:06 INFO - PROCESS | 24588 | |4;audio-oscillator;84;83;107;84;84;83;96;84;83;107 17:06:06 INFO - PROCESS | 24588 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;117;116;117 17:06:06 INFO - PROCESS | 24588 | |6;imaging-darkroom;146;148;147;150;147;148;147;147;146;147 17:06:06 INFO - PROCESS | 24588 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;96 17:06:06 INFO - PROCESS | 24588 | |8;json-parse-financial;55;53;53;55;56;54;55;61;53;55 17:06:06 INFO - PROCESS | 24588 | |9;json-stringify-tinderbox;67;68;67;67;67;67;67;68;67;67 17:06:06 INFO - PROCESS | 24588 | |10;stanford-crypto-aes;83;83;82;83;90;84;84;88;81;87 17:06:06 INFO - PROCESS | 24588 | |11;stanford-crypto-ccm;130;130;126;126;126;126;124;124;164;137 17:06:06 INFO - PROCESS | 24588 | |12;stanford-crypto-pbkdf2;172;168;168;170;167;169;166;169;167;167 17:06:06 INFO - PROCESS | 24588 | |13;stanford-crypto-sha256-iterative;63;63;64;62;64;62;63;65;62;63 17:06:06 INFO - PROCESS | 24588 | __end_tp_report 17:06:06 INFO - PROCESS | 24588 | __start_cc_report 17:06:06 INFO - PROCESS | 24588 | _x_x_mozilla_cycle_collect,1583 17:06:06 INFO - PROCESS | 24588 | __end_cc_report 17:06:06 INFO - PROCESS | 24588 | __startTimestamp1485824766299__endTimestamp 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | ------- Summary: start ------- 17:06:06 INFO - PROCESS | 24588 | Number of tests: 14 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:0.97 (0.9%) stddev-sans-first:1.01 17:06:06 INFO - PROCESS | 24588 | Values: 112.0 112.0 112.0 112.0 114.0 114.0 113.0 112.0 111.0 112.0 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:129.00 stddev:18.15 (14.1%) stddev-sans-first:16.99 17:06:06 INFO - PROCESS | 24588 | Values: 157.0 120.0 119.0 169.0 132.0 120.0 120.0 119.0 145.0 126.0 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.51 (0.9%) stddev-sans-first:1.58 17:06:06 INFO - PROCESS | 24588 | Values: 162.0 160.0 160.0 160.0 162.0 162.0 161.0 165.0 161.0 161.0 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:15.79 (20.8%) stddev-sans-first:16.49 17:06:06 INFO - PROCESS | 24588 | Values: 75.0 76.0 76.0 121.0 76.0 76.0 76.0 74.0 102.0 76.0 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:84.00 stddev:10.01 (11.9%) stddev-sans-first:10.42 17:06:06 INFO - PROCESS | 24588 | Values: 84.0 83.0 107.0 84.0 84.0 83.0 96.0 84.0 83.0 107.0 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 17:06:06 INFO - PROCESS | 24588 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 116.0 117.0 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.16 (0.8%) stddev-sans-first:1.13 17:06:06 INFO - PROCESS | 24588 | Values: 146.0 148.0 147.0 150.0 147.0 148.0 147.0 147.0 146.0 147.0 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:06:06 INFO - PROCESS | 24588 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:2.36 (4.3%) stddev-sans-first:2.50 17:06:06 INFO - PROCESS | 24588 | Values: 55.0 53.0 53.0 55.0 56.0 54.0 55.0 61.0 53.0 55.0 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 17:06:06 INFO - PROCESS | 24588 | Values: 67.0 68.0 67.0 67.0 67.0 67.0 67.0 68.0 67.0 67.0 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:2.88 (3.4%) stddev-sans-first:3.00 17:06:06 INFO - PROCESS | 24588 | Values: 83.0 83.0 82.0 83.0 90.0 84.0 84.0 88.0 81.0 87.0 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:128.00 stddev:12.13 (9.5%) stddev-sans-first:12.86 17:06:06 INFO - PROCESS | 24588 | Values: 130.0 130.0 126.0 126.0 126.0 126.0 124.0 124.0 164.0 137.0 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:168.50 stddev:1.77 (1.0%) stddev-sans-first:1.27 17:06:06 INFO - PROCESS | 24588 | Values: 172.0 168.0 168.0 170.0 167.0 169.0 166.0 169.0 167.0 167.0 17:06:06 INFO - PROCESS | 24588 | 17:06:06 INFO - PROCESS | 24588 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 17:06:06 INFO - PROCESS | 24588 | Values: 63.0 63.0 64.0 62.0 64.0 62.0 63.0 65.0 62.0 63.0 17:06:06 INFO - PROCESS | 24588 | -------- Summary: end -------- 17:06:06 INFO - PROCESS | 24588 | 17:06:07 INFO - TEST-INFO | 24588: exit 0 17:06:07 INFO - TEST-OK | kraken | took 61140ms 17:06:07 INFO - SUITE-END | took 1176s 17:06:07 INFO - Completed test suite (00:19:36) 17:06:07 INFO - javascript benchmark 17:06:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7350.241891261175, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3142.7485801135913, 3186.792858464198, 3217.967820321797, 3222.5649537312456, 3225.3549290141978, 5337.733113344337, 5349.732513374335, 5372.54333381662, 5459.454054594538, 5459.890802183954, 5358.410574836775, 5441.83674489765, 5473.480019398151, 5482.780688772455, 5507.201455788908, 4798.4001999750035, 4867.780949857265, 4874.756262186894, 4889.095517329288, 4995.950850321418, 4937.185364414867, 4967.279744437054, 4981.501849815026, 4988.975055124719, 4991.975040124794, 4766.332713420124, 4772.665913386064, 4807.61539076873, 4812.67651395869, 4966.279889416032, 4846.709197448165, 4855.223164293696, 4860.975695121537, 4906.31311616374, 4934.629902757271, 4820.71075735457, 4835.226363781813, 4842.176829938883, 4857.8299759508245, 4871.488493708145, 5209.088409528355, 5246.265522826808, 5268.736563171826, 5424.384794166631, 5492.5605951523785, 5618.269624948731, 5690.829275121753, 5693.743781529841, 5736.3403208631125, 5752.194692743019, 5691.430856914317, 5700.087985922274, 5714.542836573064, 5724.112762521816, 5733.283339582552, 5334.946650533522, 5343.171808369709, 5345.144776835727, 5345.518903298683, 5409.83770486886, 5929.970350148222, 5956.672383018976, 5985.431384018511, 5994.250718660168, 6049.455549000611, 5746.712664366765, 5774.2782152230975, 5781.277340332458, 5781.392953739797, 5788.102844059177, 5695.914561281584, 5731.340895796953, 5755.482006619424, 5837.854053648693, 5848.64908105515, 5747.339056008613, 5786.652800831964, 5795.449432303924, 5807.303123625107, 5898.233229680114, 5830.76676932918, 5831.650100993954, 5838.182654428383, 5841.970790146022, 5843.5909486336395, 4482.551744825491, 4487.371767952489, 4499.977500112478, 4508.053308805188, 4543.704659197141, 3955.624215699504, 3980.0646847990697, 3981.761094334291, 4022.416749571296, 4041.3937909313836, 5511.173324001432, 5512.2558454608115, 5512.3385193777, 5528.143137813645, 5573.944260557342, 5814.505767009767, 5868.413158684098, 5875.735591898375, 5886.117082437583, 5898.675572843535, 5364.3830959440165, 5426.050441172779, 5433.157860531624, 5433.864153396196, 5496.917546236809, 4975.800967961313, 4976.576990955737, 4977.925331120036, 4990.825321113816, 4992.350994370781, 6016.187814644967, 6018.127371531191, 6024.969875150597, 6034.39656034393, 6036.0644100164545, 5800.071988481823, 5821.970890145522, 5832.737526811219, 5841.824745257649, 5843.0, 5964.761409543569, 6021.518278537794, 6031.125486804476, 6040.942835003769, 6045.063015232646, 5746.856328591819, 5756.280464941882, 5761.39505351932, 5764.423557644202, 5764.769409223752, 5811.4479124483105, 5814.680192589279, 5824.388439213822, 5831.0, 5854.385289544536, 5749.080147176432, 5751.769929202952, 5752.7698892043845, 5753.021986262429, 5757.9424205757405, 5624.971875140598, 5698.059820129798, 5741.91387129185, 5753.338366087786, 5759.0, 5670.092785154356, 5680.715964201856, 5686.658800471985, 5753.4246575343805, 5754.68349240779, 5756.0, 5756.194132821324, 5763.0, 5770.394108618702, 5790.507806836466, 5594.104943209067, 5601.5238704710555, 5606.159076138611, 5610.691411972218, 5612.186232996274], "value": 5354.357986395336, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.8637127089498, 586.4663156527558, 589.3576002157648, 614.1739360560045, 634.8984511871904, 33730.49404258935, 43157.0, 45564.54435455644, 45620.771896140475, 49201.26198107031, 45530.0, 45725.77137114318, 45851.0, 46204.306935395914, 46412.0, 9045.638174473013, 9244.907550924505, 9248.861267081, 9256.028117047681, 9264.444133351986, 8634.611442485104, 8908.465492070463, 10811.78376432471, 11095.056920161756, 11101.111911047097, 11020.559177632886, 11086.833697494543, 11087.55649774008, 11093.0, 11094.167937404687, 11089.2237543372, 11141.888581114166, 11144.777104457946, 11154.274972126866, 11168.385738784364, 10833.079188269006, 10839.566417343296, 10859.619913303075, 10927.672169834917, 10928.0, 44365.77817110926, 44379.0, 44639.330410043876, 44785.0, 44799.55200447986, 4204.5375008749015, 4225.577442255781, 4274.166537525184, 4285.807138678736, 4370.737755734634, 32500.83749581237, 32764.344713105842, 32773.6722632773, 32798.50802237968, 32838.6716132838, 4231.513375961742, 4341.45731783527, 4423.668224883115, 4529.071540334224, 4580.7938642761155, 314178.0, 316220.0, 316895.0, 316915.0, 317039.0, 59628.10557841636, 60207.39792602018, 60458.697706511186, 60647.0, 60774.0, 62968.3328500428, 63162.0, 63226.0, 63368.395792505195, 63396.0, 17705.380311689285, 17996.190171442315, 17997.640047199246, 18001.099945002697, 18003.549911252325, 12798.744025119631, 13102.541411050568, 13821.723565528633, 13836.23900685452, 13885.236312002937, 16432.0, 16938.576535586464, 16962.268300973767, 17495.912520437316, 17573.912130439265, 5732.570057245724, 6375.027478566725, 6580.0, 6648.53460257787, 6743.561668491532, 924.2744445610164, 933.9066093390743, 946.4226821638795, 948.7011591348703, 950.7147855643279, 29509.0, 31699.0, 31708.0, 31951.360972780414, 31979.680203198135, 1033.3076838518211, 1110.838928355384, 1118.072000239799, 1127.3405058040973, 1134.9716257093473, 15850.286737096858, 16483.175841207893, 16825.6634867302, 16839.57901052459, 16963.406280780113, 483632.0, 484933.0, 485851.0, 485857.0, 485912.0, 53432.46567534275, 54716.45283547114, 59124.01825753554, 60245.698771505864, 60303.0, 1469.441612187362, 1476.8301645310712, 1487.620656732548, 1508.5021942758863, 1511.138650968937, 30891.227719307197, 32422.83788581042, 32795.34409311848, 33231.833840830644, 33536.64023676906, 53016.4698353027, 53570.0, 53652.73173634107, 53671.0, 53716.462835371145, 387914.0, 390592.0, 391492.0, 391509.0, 391565.759081684, 40222.59777402189, 40706.796466017484, 40766.980825478415, 40840.3873941897, 40874.38688419617, 45582.54417455783, 46592.7670361646, 46881.53118468908, 46896.0, 47467.28799067948, 38391.42412863865, 38560.61439385683, 38825.0, 38837.0, 40118.197636046534, 37608.811955940044, 38065.23869522649, 38724.838254851275, 39492.40761388639, 39605.20789584135, 38395.23209535849, 38469.8459046229, 38499.0, 38515.6148438512, 38721.80639096787, 32625.0, 34056.65943340535, 34488.31023379569, 34874.47688284729, 35246.471302930986, 25982.480350392507, 26505.0, 26529.60205596879, 26614.201573952814, 26887.462250755267], "value": 20611.869552605174, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.166070421762, 428.88848899286194, 430.8233624214072, 434.48245897761444, 448.5066426930375, 17560.82439175608, 20254.29109981151, 22170.224042158527, 22229.0, 22534.661980070312, 21208.151673933062, 21520.677189842165, 21914.452138696503, 22342.88828555859, 22675.886620566875, 5971.37300583439, 6066.908996365058, 6077.5137988961, 6112.449879510843, 6205.472534834545, 4440.800163992628, 6004.5796794224425, 6125.816225513219, 6126.479249263795, 6127.080937859335, 4745.833895813647, 6564.343565643445, 6845.315468453165, 6850.040994260808, 6977.651117444133, 6715.2613212546585, 6804.0, 6869.072675188835, 6955.686994085253, 6972.651367431634, 6094.786682466137, 6096.603720758137, 6096.695165241765, 6101.664408457533, 6103.633781973096, 21474.141034358607, 25854.87072564644, 25910.611340829902, 25967.870160649265, 26047.479050418886, 2879.2226098953165, 2881.5101432756273, 2882.754965827907, 2889.4654488919405, 2894.276430892277, 15168.435417676837, 15406.844486663433, 15798.526044218692, 15814.525564233092, 16174.838251617452, 1907.8569107317007, 1961.4900125967351, 1980.7722111957166, 2003.989980050105, 2026.0882602828638, 84511.15488845094, 89238.5538072312, 91374.99999999933, 91997.5400122995, 92683.0, 10249.38503689781, 11011.229213955106, 11978.101642376856, 11981.723472540189, 12010.339431331186, 15394.23028848553, 16425.55063436668, 16430.67138657244, 16885.40901068457, 17139.400120995706, 8309.37679674027, 8340.791480212922, 8367.539785311867, 8519.233269005696, 8586.270167035871, 7788.337991270692, 7871.960640196877, 7968.681252749825, 7992.080910695228, 8036.839263214703, 7504.198992241932, 7701.961490192513, 7725.613719314012, 7874.330681891989, 7899.842003159904, 2026.7365242518379, 2032.1363420546209, 2076.5431605046865, 2131.1581925139485, 2148.688440176166, 1037.4605205293205, 1068.9251752377259, 1072.2387105155426, 1088.8893328804575, 1118.6196693124377, 19350.612987740165, 19373.450123990046, 19803.20787168526, 19961.101750421265, 20017.499562511053, 1069.556134204312, 1077.6282182646974, 1093.9726506837392, 1096.8519249901321, 1125.4091601909063, 10038.849417258747, 10859.29414588065, 10994.230403871812, 11057.11543076552, 11106.944465277784, 667088.0, 678413.0, 688515.0, 691562.0, 697031.0, 97016.51491742497, 97185.0, 97216.51391742995, 98202.0, 101558.0, 1025.8666373371414, 1026.5431882812227, 1032.2361452525076, 1039.3140527252128, 1049.895010498944, 16213.59466013312, 16623.0, 17003.659926801643, 17230.483085507454, 17573.209205586034, 43388.78305608452, 43857.34213986729, 44236.55763442325, 44488.11023779442, 44534.55465445304, 57026.42973570377, 57678.0, 58246.70876645589, 58260.4173958255, 62277.0, 11671.59149429766, 12499.75000500003, 12650.30423326726, 12691.448707131722, 13888.861111388756, 13359.53241636538, 13468.79796803029, 13627.863721362659, 13647.454101835816, 13674.863251367757, 6841.110655614738, 9823.16503097216, 11501.367424791717, 11585.594504192313, 11721.531138754695, 11102.61140860066, 11299.152563557602, 11425.942870285595, 11476.540938362372, 11947.953271915605, 11294.887051129712, 11569.132315076571, 11705.122115841516, 11789.41052947332, 12063.155579109378, 13011.934940325238, 13197.406116724962, 13297.867021329663, 13305.401256943655, 13590.93204533971, 11471.0, 11535.307881527135, 11606.825897611374, 11673.0, 11927.701807454536], "value": 10211.377750654734, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.2134465371714, 1439.0358459831912, 1440.5894320118764, 1449.6593300574357, 1453.1353844462542, 7974.800629984246, 8392.664293428255, 8447.746567602973, 8457.746267611981, 8462.280706139978, 7372.262773722625, 7599.620018999041, 7970.601469926495, 8232.588370581461, 8241.835163296746, 2316.5830150572933, 2329.5457385809773, 2330.0, 2347.213683416058, 2348.6829278047503, 2262.3891549281684, 2347.530493901218, 2352.9411764705847, 2357.8467399619058, 2363.5745565798147, 2073.9170433182653, 2148.591767564166, 2153.138744502196, 2155.9461013474634, 2303.1363238785457, 2300.838941274103, 2351.2240960483173, 2351.494428697838, 2354.399628094842, 2356.0340260493117, 2299.1952816514085, 2343.9648405273933, 2350.4241460842204, 2392.1986134644917, 2401.639754036891, 8440.704575339834, 8477.406581539295, 8487.872681909776, 8497.660093596249, 8503.319734421231, 5142.177251639757, 5262.60530460217, 5264.210368444726, 5264.763085661154, 5265.894682106336, 3292.27569934614, 3362.798232106057, 3378.3243351329834, 3442.7245820334315, 3490.703290220334, 1379.7654398752136, 1422.5376752555358, 1442.28606839614, 1468.84577119402, 1523.2992823301295, 11356.091512678966, 11420.42897855104, 11445.885541144482, 11445.942770286096, 11461.541538338457, 4405.559444055569, 4671.392718946583, 4708.599769019604, 4726.8109275628585, 4735.786889589976, 9777.804443911224, 9789.0, 9801.166900813369, 9804.460754658563, 9820.0, 5254.816081437131, 5275.894482110336, 5348.545373643206, 5349.625526213128, 5353.1167357386375, 4815.6388270879825, 4866.221404575251, 4916.72957987307, 4932.03825254072, 4984.975075124674, 3907.941380879289, 3918.275119102975, 3938.6849052076336, 3994.720369574102, 4031.4154447604933, 1268.6194141757435, 1288.884000439965, 1308.908376413642, 1312.6718320419895, 1330.3547779327018, 736.1240124252123, 806.6128258435983, 914.1955079530104, 984.7538115471132, 1008.5612758450097, 5577.888442231133, 5857.58996870215, 5881.5000724938, 5962.135490353874, 6118.663473508911, 1018.5823812236947, 1031.118393773328, 1049.1763965287214, 1068.4016950507585, 1073.588231475607, 4040.6363427291685, 4112.506499220112, 4135.483064616923, 4359.782010899506, 4394.934075988863, 9986.700398988041, 10140.949295253624, 10143.08712215904, 10216.540255688511, 10257.897421025844, 10188.694339169837, 10279.588816447258, 10315.226358023177, 10323.174146068297, 10330.690079297634, 7521.7743467696055, 7707.344875685518, 7801.726939557202, 7941.285284324554, 7943.563104029334, 5698.772049118154, 5714.942850571441, 5742.856428589319, 5846.766129354778, 5998.4601385875485, 9009.189172974464, 9157.954210229173, 9193.448393096436, 9240.768980775534, 9282.535873206447, 9156.771080723036, 9384.108509691569, 9445.197158241626, 9484.430934143973, 9555.761105972128, 7447.404207663482, 7559.622018899143, 7614.466987311057, 7685.154632990479, 7696.461247712607, 8090.352771778362, 8164.142765009588, 8175.427720059776, 8178.877316840371, 8180.304674102768, 7138.179109402485, 7179.389751871149, 7244.529105608119, 7379.262073792793, 7379.704811807467, 7241.637918104179, 7352.889706654511, 7370.77887663371, 7386.409087273113, 7605.961970190335, 6610.4711623071, 6681.665916704048, 6692.866142677217, 6693.799186024427, 6706.429953454011, 5056.772445240046, 5062.924056139234, 5083.72039537829, 5114.232865070269, 5267.789288428573, 4984.7258400788305, 5042.117629414764, 5076.18780995039, 5076.82231121909, 5126.4360920297995], "value": 4556.034002334998, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.5289282200591, 402.7643828360409, 409.896785026421, 422.65975889409015, 423.94912610486745, 5013.122703526887, 5161.974190129054, 5283.867903302419, 5292.655977361474, 5334.626576139667, 5080.415752188499, 5166.095933211683, 5183.300254465646, 5184.7407629618465, 5198.194279886624, 4160.750354978696, 4199.7690127043, 4203.621674049335, 4216.304309788881, 4225.788710564475, 3860.40163774614, 4059.4316795648633, 4210.97894510527, 4215.768132752697, 4237.7669228192435, 4020.5778393268724, 4030.717849750519, 4030.9318030721884, 4034.979825100885, 4044.3822471011536, 4008.959910400888, 4016.6585840203616, 4027.41602467642, 4044.3326851069833, 4065.146319272956, 3633.818309084562, 3635.0734110921253, 3638.199596088856, 3667.7799332039895, 3673.8530458781615, 5041.319421878036, 5052.444231134572, 5052.8484145475695, 5065.822696205652, 5138.794448222104, 4700.764961751933, 4704.694194877322, 4705.6470764692785, 4722.409698787652, 4740.360051393087, 5454.0, 5476.644018138848, 5478.424765399615, 5490.478404551562, 5506.449355064502, 3923.2741942740686, 4008.498937632796, 4014.5383280922483, 4025.6376926076796, 4042.555318914917, 5642.153676948449, 5672.376038635788, 5696.943030569724, 5720.399358067426, 5724.5688577855535, 4110.650594699424, 4138.627523522898, 4150.398192262105, 4151.107511884959, 4156.147989662112, 4035.3946907963455, 4138.275801734684, 4159.188958153191, 4171.20747058058, 4234.24278924243, 4698.459677137173, 4699.154152252628, 4702.905941881143, 4716.740579268173, 4741.596964258008, 5579.163125531203, 5581.776728930879, 5584.385717571064, 5594.412586678422, 5610.531366198859, 1319.4392383237087, 1339.4776037345443, 1378.5312993582231, 1409.9284543746621, 1427.978580321296, 939.1735272959752, 977.4848984074656, 977.8044391121804, 992.503748125937, 992.8609994600762, 5111.028904508132, 5117.667351622133, 5132.307138536325, 5141.71720555373, 5163.277141200235, 5426.782928682808, 5466.797304592983, 5469.917951230735, 5474.698891561003, 5538.6399884007415, 4897.681650692693, 5105.923411148836, 5110.0, 5143.742812859342, 5226.555742761908, 2889.19102651258, 2894.9710502895123, 2897.797154199186, 2908.8910539858857, 2936.309967157716, 5625.38120806711, 5673.914891276634, 5675.858103547444, 5677.460641239076, 5681.3240094172315, 5418.674879507243, 5643.266375371176, 5726.79737255181, 5774.2782152230975, 5791.88416231673, 5824.592278540462, 5847.181394604759, 5855.531557475391, 5858.53131749459, 5861.677607731615, 5570.303712035996, 5631.746571404215, 5662.207290979349, 5691.630044047124, 5701.7434215461235, 5575.470330318613, 5576.60963732551, 5578.163275508706, 5582.7766889323975, 5608.0, 5849.736761845642, 5883.764649413975, 5899.410058994066, 5907.5231192201945, 5925.970370148121, 4063.2686116499312, 4143.114882728291, 4165.4168416422335, 4167.937480937728, 4176.812043458112, 5473.425290344616, 5676.602637815313, 5679.630823996427, 5691.715414229355, 5712.514436272963, 5365.175840214346, 5483.341998960151, 5484.489926446998, 5497.202905578589, 5523.066926575666, 5473.644213126134, 5501.14732216507, 5520.889582208413, 5537.6954267515675, 5539.473749993744, 5289.523942845162, 5484.7806087757635, 5487.722595122979, 5535.142052981794, 5547.44525547442, 5546.306711661043, 5547.7780888764, 5552.888942221214, 5566.944330556805, 5572.3034620672415, 5376.166694162411, 5382.219578161066, 5425.593080519056, 5435.565154787687, 5443.312573102351], "value": 4228.572692046188, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.4008710688535, 776.367260682544, 811.5536454949776, 860.131267419906, 890.2166093837424, 14758.33587488563, 15383.692326153498, 15775.368985240591, 15823.84176158238, 15902.602434939132, 14633.048851824651, 15018.849811501881, 15336.386544538233, 15487.690246195069, 15501.0, 741.3402072155773, 757.7044952468542, 759.4266328921684, 759.5290919629837, 761.6458346868704, 764.1861417590277, 765.3915137465729, 765.9885101723451, 767.1522967121334, 767.2902565127263, 791.1692722641233, 802.9598520074002, 803.5901690138013, 803.9678412863478, 805.1304591041661, 797.6490344248512, 798.7364169823974, 799.2007992007992, 799.3565180030073, 800.1238643685184, 579.8840231953626, 580.1848402993759, 580.2978396140675, 582.618384957849, 582.9154772557955, 14175.85824141766, 14517.637059073502, 14521.128732276096, 14567.49013784523, 15225.847741522664, 14709.632259193499, 14961.177135257556, 15207.61980950474, 15329.0, 15453.304601292968, 12137.878621213764, 12196.573119940847, 12219.694507637292, 12472.251664900044, 12580.496780128784, 3878.495795546561, 3924.9018774530864, 3931.7247792654525, 3933.154371810046, 3989.900252493682, 73416.0, 73457.0, 73881.26118738852, 75158.24841751567, 76606.0, 11820.586279480176, 12045.819312710317, 12115.939420303019, 12281.263124212397, 12285.877141228473, 22529.549409012056, 22548.0, 22565.0, 22599.322020339416, 22727.431814204447, 8205.548694821842, 8222.342212622976, 8259.545724985064, 8265.173482651686, 8509.361797865186, 4393.275109606943, 4461.353103799996, 4554.134714404253, 4601.5168407317415, 4625.653076019312, 3684.152644891636, 3790.3556395412847, 3795.6773674237998, 3800.505934228588, 3802.0304822270145, 637.8947473666885, 642.5116911147561, 642.8907085795425, 646.331047365974, 664.0371461381017, 750.4071783291248, 756.7427074794597, 773.153397030251, 804.2279411764771, 826.921442462965, 9901.75245618851, 10140.239482038876, 10285.7428564285, 10316.845247321296, 10532.0, 772.7527191298843, 787.4566549081115, 791.3155120820448, 791.8614242507538, 794.447858738183, 4659.9767001165455, 5103.795848166106, 5126.92309615356, 5161.66449180802, 5176.171812510056, 76986.61506692543, 78438.6078069606, 79021.0, 79690.20309796827, 80067.0, 39572.20855582872, 47592.286115708295, 68064.6596767013, 68616.6569167151, 70663.0, 50654.49345506571, 56840.43159568434, 56977.14534281989, 57033.0, 58692.70653646704, 10481.580736770444, 10819.18856085781, 11051.447427628425, 11088.223824332219, 11195.552177912792, 39331.21337573175, 39350.60649393584, 39473.40789888096, 40145.39781903215, 41158.794206029976, 50202.49797501978, 50244.0, 50820.0, 51609.0, 53306.0, 13367.197968121944, 13397.92318775766, 13548.0, 13553.0, 13669.453221871014, 14836.703265934837, 14846.777298340317, 14953.476628317956, 15235.3905843765, 15859.286332114852, 12757.872421275668, 13083.803742944054, 13246.735065298833, 13712.862871371557, 14286.571402857931, 13581.32093395346, 13841.377138029015, 13915.652108697364, 14102.0, 14169.858301416854, 11762.70593235176, 13692.246926419142, 13940.651483712989, 14600.269986500845, 14635.85364146345, 11103.5558577656, 11146.609868654557, 11618.294590690784, 11965.102617303563, 12001.459934303151, 9510.809783804147, 10541.525631346454, 10711.858987169651, 10917.781644367227, 10946.781064378827], "value": 7262.26157547796, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 112.0, 112.0, 114.0, 114.0, 113.0, 112.0, 111.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 120.0, 119.0, 169.0, 132.0, 120.0, 120.0, 119.0, 145.0, 126.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 160.0, 162.0, 162.0, 161.0, 165.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 121.0, 76.0, 76.0, 76.0, 74.0, 102.0, 76.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 107.0, 84.0, 84.0, 83.0, 96.0, 84.0, 83.0, 107.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 150.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 55.0, 56.0, 54.0, 55.0, 61.0, 53.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 83.0, 90.0, 84.0, 84.0, 88.0, 81.0, 87.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 130.0, 126.0, 126.0, 126.0, 126.0, 124.0, 124.0, 164.0, 137.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 168.0, 170.0, 167.0, 169.0, 166.0, 169.0, 167.0, 167.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 62.0, 64.0, 62.0, 63.0, 65.0, 62.0, 63.0], "value": 63.1, "unit": "score"}]}]} 17:06:07 INFO - Return code: 0 17:06:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:06:07 ERROR - # TBPL SUCCESS # 17:06:07 INFO - Running post-action listener: _resource_record_post_action 17:06:07 INFO - [mozharness: 2017-01-31 01:06:07.600622Z] Finished run-tests step (success) 17:06:07 INFO - Running post-run listener: _resource_record_post_run 17:06:07 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 414539776; Read time: 0; Write time: 283344 17:06:07 INFO - TinderboxPrint: CPU usage
13.1% 17:06:07 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:06:07 INFO - TinderboxPrint: I/O write bytes / time
414,539,776 / 283,344 17:06:07 INFO - TinderboxPrint: CPU idle
8,292.2 (86.9%) 17:06:07 INFO - TinderboxPrint: CPU user
1,199.4 (12.6%) 17:06:07 INFO - TinderboxPrint: Swap in / out
0 / 0 17:06:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105693184; Read time: 0; Write time: 89340 17:06:07 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 295899136; Read time: 0; Write time: 190164 17:06:08 INFO - Running post-run listener: _upload_blobber_files 17:06:08 INFO - Blob upload gear active. 17:06:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:06:08 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 17:06:08 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:06:08 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:06:08 INFO - (blobuploader) - INFO - Open directory for files ... 17:06:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:06:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:06:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:09 INFO - (blobuploader) - INFO - Done attempting. 17:06:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:06:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:06:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:10 INFO - (blobuploader) - INFO - Done attempting. 17:06:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:06:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:06:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:11 INFO - (blobuploader) - INFO - Done attempting. 17:06:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:06:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:06:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:14 INFO - (blobuploader) - INFO - Done attempting. 17:06:14 INFO - (blobuploader) - INFO - Iteration through files over. 17:06:14 INFO - Return code: 0 17:06:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:06:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:06:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/029f02baf8ae851ac0b5751254fe00645dd235a09f11dc4c22b0e4789a052ae10920e289560db8115da3da12405ba0e3363fcd2ae724982b67a7da26471ad25a", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99a2839daf1ced3fd1107b0fdb930f186f2ba28c5bf36ff3b2d0b7df2cc713a44611ce7548d207010a35322d7dcb4f751b0ea08f868e57db8fed726075a42245", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e726feba1b7a00a967717428c313f2940bf85a83dbfd047aaecfe74c72ed14a87f60ab074d731772ec8ad51c90488e9fad9a815cb8be4abb6ff39ed372c4fc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19e57d67f80655918184e39bbf125e27f0f337b1646b7fca3d3f32f0bdfcff649bc62cc14ecdc4cea064d2fe97fbce6f28f6da3ba2bbf15ea9165152c7201ee0"} 17:06:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:06:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:06:14 INFO - Contents: 17:06:14 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/029f02baf8ae851ac0b5751254fe00645dd235a09f11dc4c22b0e4789a052ae10920e289560db8115da3da12405ba0e3363fcd2ae724982b67a7da26471ad25a", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99a2839daf1ced3fd1107b0fdb930f186f2ba28c5bf36ff3b2d0b7df2cc713a44611ce7548d207010a35322d7dcb4f751b0ea08f868e57db8fed726075a42245", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e726feba1b7a00a967717428c313f2940bf85a83dbfd047aaecfe74c72ed14a87f60ab074d731772ec8ad51c90488e9fad9a815cb8be4abb6ff39ed372c4fc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19e57d67f80655918184e39bbf125e27f0f337b1646b7fca3d3f32f0bdfcff649bc62cc14ecdc4cea064d2fe97fbce6f28f6da3ba2bbf15ea9165152c7201ee0"} 17:06:14 INFO - Running post-run listener: copy_logs_to_upload_dir 17:06:14 INFO - Copying logs to upload dir... 17:06:14 INFO - mkdir: /builds/slave/test/build/upload/logs 17:06:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.644771 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-01-30 17:06:13.633545) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 17:06:13.637564) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443 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/sha512/029f02baf8ae851ac0b5751254fe00645dd235a09f11dc4c22b0e4789a052ae10920e289560db8115da3da12405ba0e3363fcd2ae724982b67a7da26471ad25a", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99a2839daf1ced3fd1107b0fdb930f186f2ba28c5bf36ff3b2d0b7df2cc713a44611ce7548d207010a35322d7dcb4f751b0ea08f868e57db8fed726075a42245", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e726feba1b7a00a967717428c313f2940bf85a83dbfd047aaecfe74c72ed14a87f60ab074d731772ec8ad51c90488e9fad9a815cb8be4abb6ff39ed372c4fc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19e57d67f80655918184e39bbf125e27f0f337b1646b7fca3d3f32f0bdfcff649bc62cc14ecdc4cea064d2fe97fbce6f28f6da3ba2bbf15ea9165152c7201ee0"} build_url:https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/aCgRT0ZuSUyqCqXxdTPWgw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/029f02baf8ae851ac0b5751254fe00645dd235a09f11dc4c22b0e4789a052ae10920e289560db8115da3da12405ba0e3363fcd2ae724982b67a7da26471ad25a", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99a2839daf1ced3fd1107b0fdb930f186f2ba28c5bf36ff3b2d0b7df2cc713a44611ce7548d207010a35322d7dcb4f751b0ea08f868e57db8fed726075a42245", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e726feba1b7a00a967717428c313f2940bf85a83dbfd047aaecfe74c72ed14a87f60ab074d731772ec8ad51c90488e9fad9a815cb8be4abb6ff39ed372c4fc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19e57d67f80655918184e39bbf125e27f0f337b1646b7fca3d3f32f0bdfcff649bc62cc14ecdc4cea064d2fe97fbce6f28f6da3ba2bbf15ea9165152c7201ee0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 17:06:13.663312) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 17:06:13.663693) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1485823530.255281-476061443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 17:06:13.745067) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 17:06:13.745377) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 17:06:13.745683) ========= ========= Total master_lag: 0.15 =========