builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1468641357.79 results: success (0) buildid: 20160715193041 builduid: fc0e7d37d47a465fb1bac20f6592f77c revision: 0d82d5d030afa2e8f48dd68e86eb75efd0947a5c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 20:55:57.786740) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 20:55:57.787099) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 20:55:57.787378) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 20:55:57.804148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 20:55:57.804420) ========= 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=31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 20:55:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.6M=0s 2016-07-15 20:55:58 (39.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111684 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 20:55:57.929523) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 20:55:57.929855) ========= 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=31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022474 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 20:55:57.981987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 20:55:57.982294) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0d82d5d030afa2e8f48dd68e86eb75efd0947a5c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0d82d5d030afa2e8f48dd68e86eb75efd0947a5c --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=31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 20:55:58,498 truncating revision to first 12 chars 2016-07-15 20:55:58,498 Setting DEBUG logging. 2016-07-15 20:55:58,498 attempt 1/10 2016-07-15 20:55:58,498 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0d82d5d030af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 20:55:58,788 unpacking tar archive at: mozilla-central-0d82d5d030af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656839 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 20:55:58.653003) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 20:55:58.653267) ========= script_repo_revision: 0d82d5d030afa2e8f48dd68e86eb75efd0947a5c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 20:55:58.653631) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 20:55:58.653890) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 20:55:58.662711) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-15 20:55:58.662971) ========= /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=31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:55:59 INFO - MultiFileLogger online at 20160715 20:55:59 in /builds/slave/test 20:55:59 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 20:55:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:55:59 INFO - {'append_to_log': False, 20:55:59 INFO - 'base_work_dir': '/builds/slave/test', 20:55:59 INFO - 'blob_upload_branch': 'Firefox', 20:55:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:55:59 INFO - 'branch': 'Firefox', 20:55:59 INFO - 'buildbot_json_path': 'buildprops.json', 20:55:59 INFO - 'config_files': ('talos/linux_config.py',), 20:55:59 INFO - 'default_actions': ('clobber', 20:55:59 INFO - 'read-buildbot-config', 20:55:59 INFO - 'download-and-extract', 20:55:59 INFO - 'populate-webroot', 20:55:59 INFO - 'create-virtualenv', 20:55:59 INFO - 'install', 20:55:59 INFO - 'run-tests'), 20:55:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:55:59 INFO - 'download_minidump_stackwalk': True, 20:55:59 INFO - 'download_symbols': 'ondemand', 20:55:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:55:59 INFO - 'tooltool.py': '/tools/tooltool.py', 20:55:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:55:59 INFO - '/tools/misc-python/virtualenv.py')}, 20:55:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:55:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:55:59 INFO - 'installer_path': 'installer.exe', 20:55:59 INFO - 'log_level': 'info', 20:55:59 INFO - 'log_name': 'talos', 20:55:59 INFO - 'log_to_console': True, 20:55:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:55:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:55:59 INFO - 'opt_config_files': (), 20:55:59 INFO - 'pip_index': False, 20:55:59 INFO - 'sps_profile': False, 20:55:59 INFO - 'sps_profile_interval': 0, 20:55:59 INFO - 'suite': 'dromaeojs', 20:55:59 INFO - 'system_bits': '32', 20:55:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:55:59 INFO - 'title': 'talos-linux64-ix-014', 20:55:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:55:59 INFO - 'use_talos_json': True, 20:55:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:55:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:55:59 INFO - 'work_dir': 'build'} 20:55:59 INFO - ##### 20:55:59 INFO - ##### Running clobber step. 20:55:59 INFO - ##### 20:55:59 INFO - Running pre-action listener: _resource_record_pre_action 20:55:59 INFO - Running main action method: clobber 20:55:59 INFO - rmtree: /builds/slave/test/build 20:55:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:55:59 INFO - Running post-action listener: _resource_record_post_action 20:55:59 INFO - ##### 20:55:59 INFO - ##### Finished clobber step (success) 20:55:59 INFO - ##### 20:55:59 INFO - ##### 20:55:59 INFO - ##### Running read-buildbot-config step. 20:55:59 INFO - ##### 20:55:59 INFO - Running pre-action listener: _resource_record_pre_action 20:55:59 INFO - Running main action method: read_buildbot_config 20:55:59 INFO - Using buildbot properties: 20:55:59 INFO - { 20:55:59 INFO - "project": "", 20:55:59 INFO - "product": "firefox", 20:55:59 INFO - "script_repo_revision": "production", 20:55:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:55:59 INFO - "repository": "", 20:55:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 20:55:59 INFO - "buildid": "20160715193041", 20:55:59 INFO - "pgo_build": "True", 20:55:59 INFO - "basedir": "/builds/slave/test", 20:55:59 INFO - "buildnumber": 796, 20:55:59 INFO - "slavename": "talos-linux64-ix-014", 20:55:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:55:59 INFO - "platform": "ubuntu64_hw", 20:55:59 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 20:55:59 INFO - "branch": "mozilla-central", 20:55:59 INFO - "repo_path": "mozilla-central", 20:55:59 INFO - "revision": "0d82d5d030afa2e8f48dd68e86eb75efd0947a5c", 20:55:59 INFO - "stage_platform": "linux64-pgo", 20:55:59 INFO - "builduid": "fc0e7d37d47a465fb1bac20f6592f77c", 20:55:59 INFO - "slavebuilddir": "test" 20:55:59 INFO - } 20:55:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:55:59 INFO - Running post-action listener: _resource_record_post_action 20:55:59 INFO - ##### 20:55:59 INFO - ##### Finished read-buildbot-config step (success) 20:55:59 INFO - ##### 20:55:59 INFO - ##### 20:55:59 INFO - ##### Running download-and-extract step. 20:55:59 INFO - ##### 20:55:59 INFO - Running pre-action listener: _resource_record_pre_action 20:55:59 INFO - Running main action method: download_and_extract 20:55:59 INFO - mkdir: /builds/slave/test/build/tests 20:55:59 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:59 INFO - https://queue.taskcluster.net/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:55:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:55:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:55:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:55:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:56:12 INFO - Downloaded 1361 bytes. 20:56:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:56:12 INFO - Using the following test package requirements: 20:56:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:56:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:56:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:56:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:12 INFO - u'jsshell-linux-x86_64.zip'], 20:56:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:56:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:56:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:56:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:56:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:56:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:56:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:12 INFO - https://queue.taskcluster.net/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:56:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:56:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:56:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:56:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:56:19 INFO - Downloaded 24326514 bytes. 20:56:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:56:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:56:20 INFO - Return code: 0 20:56:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:56:20 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:20 INFO - https://queue.taskcluster.net/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:56:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:56:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:56:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:56:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:56:25 INFO - Downloaded 24326514 bytes. 20:56:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:56:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:56:26 INFO - Return code: 0 20:56:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:26 INFO - https://queue.taskcluster.net/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:56:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:56:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:56:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:56:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:56:27 INFO - Downloaded 14403317 bytes. 20:56:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:56:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:56:28 INFO - Return code: 0 20:56:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:28 INFO - https://queue.taskcluster.net/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:56:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:56:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:56:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:56:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:56:29 INFO - Downloaded 60819532 bytes. 20:56:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:56:29 INFO - mkdir: /builds/slave/test/properties 20:56:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:56:29 INFO - Writing to file /builds/slave/test/properties/build_url 20:56:29 INFO - Contents: 20:56:29 INFO - build_url:https://queue.taskcluster.net/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:56:30 INFO - Running post-action listener: _resource_record_post_action 20:56:30 INFO - Running post-action listener: set_extra_try_arguments 20:56:30 INFO - ##### 20:56:30 INFO - ##### Finished download-and-extract step (success) 20:56:30 INFO - ##### 20:56:30 INFO - ##### 20:56:30 INFO - ##### Running populate-webroot step. 20:56:30 INFO - ##### 20:56:30 INFO - Running pre-action listener: _resource_record_pre_action 20:56:30 INFO - Running main action method: populate_webroot 20:56:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:56:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:56:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:56:30 INFO - '--tppagecycles', 20:56:30 INFO - '7'], 20:56:30 INFO - 'tests': ['tsvgm']}}, 20:56:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:56:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:56:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:56:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:56:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:56:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:56:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:30 INFO - 'talos_options': ['--disable-e10s'], 20:56:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:56:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:56:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:30 INFO - 'talos_options': ['--disable-e10s'], 20:56:30 INFO - 'tests': ['damp', 'tps']}, 20:56:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:30 INFO - 'tests': ['damp', 'tps']}, 20:56:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:56:30 INFO - 'tests': ['dromaeo_dom']}, 20:56:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:56:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:56:30 INFO - 'tests': ['basic_compositor_video']}, 20:56:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:56:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:56:30 INFO - 'tests': ['a11yr', 20:56:30 INFO - 'ts_paint', 20:56:30 INFO - 'tpaint', 20:56:30 INFO - 'sessionrestore', 20:56:30 INFO - 'sessionrestore_no_auto_restore', 20:56:30 INFO - 'tabpaint']}, 20:56:30 INFO - 'other-e10s': {'tests': ['a11yr', 20:56:30 INFO - 'ts_paint', 20:56:30 INFO - 'tpaint', 20:56:30 INFO - 'sessionrestore', 20:56:30 INFO - 'sessionrestore_no_auto_restore', 20:56:30 INFO - 'tabpaint']}, 20:56:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:56:30 INFO - 'ts_paint', 20:56:30 INFO - 'tpaint', 20:56:30 INFO - 'sessionrestore', 20:56:30 INFO - 'sessionrestore_no_auto_restore', 20:56:30 INFO - 'tabpaint']}, 20:56:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:56:30 INFO - 'ts_paint', 20:56:30 INFO - 'tpaint', 20:56:30 INFO - 'sessionrestore', 20:56:30 INFO - 'sessionrestore_no_auto_restore', 20:56:30 INFO - 'tabpaint']}, 20:56:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:56:30 INFO - 'tests': ['a11yr', 20:56:30 INFO - 'ts_paint', 20:56:30 INFO - 'tpaint', 20:56:30 INFO - 'sessionrestore', 20:56:30 INFO - 'sessionrestore_no_auto_restore', 20:56:30 INFO - 'tabpaint']}, 20:56:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:56:30 INFO - 'tests': ['a11yr', 20:56:30 INFO - 'ts_paint', 20:56:30 INFO - 'tpaint', 20:56:30 INFO - 'sessionrestore', 20:56:30 INFO - 'sessionrestore_no_auto_restore', 20:56:30 INFO - 'tabpaint']}, 20:56:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:56:30 INFO - 'tests': ['tsvgx', 20:56:30 INFO - 'tsvgr_opacity', 20:56:30 INFO - 'tart', 20:56:30 INFO - 'tscrollx', 20:56:30 INFO - 'cart']}, 20:56:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:56:30 INFO - 'tsvgr_opacity', 20:56:30 INFO - 'tart', 20:56:30 INFO - 'tscrollx', 20:56:30 INFO - 'cart']}, 20:56:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:30 INFO - 'talos_options': ['--disable-e10s'], 20:56:30 INFO - 'tests': ['tp5o']}, 20:56:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:30 INFO - 'tests': ['tp5o']}, 20:56:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:30 INFO - 'talos_options': ['--disable-e10s', 20:56:30 INFO - '--xperf_path', 20:56:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:56:30 INFO - 'tests': ['tp5n']}, 20:56:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:30 INFO - 'talos_options': ['--xperf_path', 20:56:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:56:30 INFO - 'tests': ['tp5n']}}, 20:56:30 INFO - 'talos.zip': {'path': '', 20:56:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:56:30 INFO - Running post-action listener: _resource_record_post_action 20:56:30 INFO - ##### 20:56:30 INFO - ##### Finished populate-webroot step (success) 20:56:30 INFO - ##### 20:56:30 INFO - ##### 20:56:30 INFO - ##### Running create-virtualenv step. 20:56:30 INFO - ##### 20:56:30 INFO - Running pre-action listener: _resource_record_pre_action 20:56:30 INFO - Running main action method: create_virtualenv 20:56:30 INFO - Creating virtualenv /builds/slave/test/build/venv 20:56:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:56:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:56:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:56:30 INFO - Using real prefix '/usr' 20:56:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:56:30 INFO - Installing distribute.............................................................................................................................................................................................done. 20:56:32 INFO - Installing pip.................done. 20:56:32 INFO - Return code: 0 20:56:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:56:32 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:32 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:32 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 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', '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 20:56:32 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 20:56:32 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 20:56:32 INFO - Using env: {'DISPLAY': ':0', 20:56:32 INFO - 'HOME': '/home/cltbld', 20:56:32 INFO - 'LANG': 'en_US.UTF-8', 20:56:32 INFO - 'LANGUAGE': 'en_US:en', 20:56:32 INFO - 'LOGNAME': 'cltbld', 20:56:32 INFO - 'MAIL': '/var/mail/cltbld', 20:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:32 INFO - 'MOZ_NO_REMOTE': '1', 20:56:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:32 INFO - 'NO_EM_RESTART': '1', 20:56:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:32 INFO - 'PWD': '/builds/slave/test', 20:56:32 INFO - 'SHELL': '/bin/bash', 20:56:32 INFO - 'SHLVL': '1', 20:56:32 INFO - 'TERM': 'linux', 20:56:32 INFO - 'TMOUT': '86400', 20:56:32 INFO - 'USER': 'cltbld', 20:56:32 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', 20:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:32 INFO - '_': '/tools/buildbot/bin/python'} 20:56:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:56:33 INFO - Cleaning up... 20:56:33 INFO - Return code: 0 20:56:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:56:33 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:33 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', '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 20:56:33 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 20:56:33 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 20:56:33 INFO - Using env: {'DISPLAY': ':0', 20:56:33 INFO - 'HOME': '/home/cltbld', 20:56:33 INFO - 'LANG': 'en_US.UTF-8', 20:56:33 INFO - 'LANGUAGE': 'en_US:en', 20:56:33 INFO - 'LOGNAME': 'cltbld', 20:56:33 INFO - 'MAIL': '/var/mail/cltbld', 20:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:33 INFO - 'MOZ_NO_REMOTE': '1', 20:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:33 INFO - 'NO_EM_RESTART': '1', 20:56:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:33 INFO - 'PWD': '/builds/slave/test', 20:56:33 INFO - 'SHELL': '/bin/bash', 20:56:33 INFO - 'SHLVL': '1', 20:56:33 INFO - 'TERM': 'linux', 20:56:33 INFO - 'TMOUT': '86400', 20:56:33 INFO - 'USER': 'cltbld', 20:56:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', 20:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:33 INFO - '_': '/tools/buildbot/bin/python'} 20:56:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:33 INFO - Downloading/unpacking psutil>=3.1.1 20:56:33 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 20:56:33 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 20:56:33 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 20:56:33 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 20:56:33 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 20:56:33 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 20:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:56:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:56:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:56:35 INFO - Installing collected packages: psutil 20:56:35 INFO - Running setup.py install for psutil 20:56:35 INFO - building 'psutil._psutil_linux' extension 20:56:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:56:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:56:35 INFO - building 'psutil._psutil_posix' extension 20:56:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:56:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:56:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:56:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:56:35 INFO - Successfully installed psutil 20:56:35 INFO - Cleaning up... 20:56:35 INFO - Return code: 0 20:56:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', '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 20:56:35 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 20:56:35 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 20:56:35 INFO - Using env: {'DISPLAY': ':0', 20:56:35 INFO - 'HOME': '/home/cltbld', 20:56:35 INFO - 'LANG': 'en_US.UTF-8', 20:56:35 INFO - 'LANGUAGE': 'en_US:en', 20:56:35 INFO - 'LOGNAME': 'cltbld', 20:56:35 INFO - 'MAIL': '/var/mail/cltbld', 20:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:35 INFO - 'MOZ_NO_REMOTE': '1', 20:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:35 INFO - 'NO_EM_RESTART': '1', 20:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:35 INFO - 'PWD': '/builds/slave/test', 20:56:35 INFO - 'SHELL': '/bin/bash', 20:56:35 INFO - 'SHLVL': '1', 20:56:35 INFO - 'TERM': 'linux', 20:56:35 INFO - 'TMOUT': '86400', 20:56:35 INFO - 'USER': 'cltbld', 20:56:35 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', 20:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:35 INFO - '_': '/tools/buildbot/bin/python'} 20:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:56:36 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 20:56:36 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 20:56:36 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 20:56:36 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 20:56:36 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 20:56:36 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 20:56:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:56:38 INFO - Installing collected packages: mozsystemmonitor 20:56:38 INFO - Running setup.py install for mozsystemmonitor 20:56:38 INFO - Successfully installed mozsystemmonitor 20:56:38 INFO - Cleaning up... 20:56:38 INFO - Return code: 0 20:56:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:56:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', '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 20:56:38 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 20:56:38 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 20:56:38 INFO - Using env: {'DISPLAY': ':0', 20:56:38 INFO - 'HOME': '/home/cltbld', 20:56:38 INFO - 'LANG': 'en_US.UTF-8', 20:56:38 INFO - 'LANGUAGE': 'en_US:en', 20:56:38 INFO - 'LOGNAME': 'cltbld', 20:56:38 INFO - 'MAIL': '/var/mail/cltbld', 20:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:38 INFO - 'MOZ_NO_REMOTE': '1', 20:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:38 INFO - 'NO_EM_RESTART': '1', 20:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:38 INFO - 'PWD': '/builds/slave/test', 20:56:38 INFO - 'SHELL': '/bin/bash', 20:56:38 INFO - 'SHLVL': '1', 20:56:38 INFO - 'TERM': 'linux', 20:56:38 INFO - 'TMOUT': '86400', 20:56:38 INFO - 'USER': 'cltbld', 20:56:38 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', 20:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:38 INFO - '_': '/tools/buildbot/bin/python'} 20:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:38 INFO - Downloading/unpacking jsonschema==2.5.1 20:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:38 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 20:56:38 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 20:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:56:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:40 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 20:56:40 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 20:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:40 INFO - Downloading functools32-3.2.3-2.tar.gz 20:56:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:56:40 INFO - warning: no files found matching '*.txt' 20:56:40 INFO - no previously-included directories found matching 'build' 20:56:40 INFO - no previously-included directories found matching 'dist' 20:56:40 INFO - no previously-included directories found matching '.git*' 20:56:40 INFO - Installing collected packages: jsonschema, functools32 20:56:40 INFO - Running setup.py install for functools32 20:56:40 INFO - warning: no files found matching '*.txt' 20:56:40 INFO - no previously-included directories found matching 'build' 20:56:40 INFO - no previously-included directories found matching 'dist' 20:56:40 INFO - no previously-included directories found matching '.git*' 20:56:40 INFO - Successfully installed jsonschema functools32 20:56:40 INFO - Cleaning up... 20:56:40 INFO - Return code: 0 20:56:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:56:40 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:40 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:40 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 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', '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 20:56:40 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 20:56:40 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 20:56:40 INFO - Using env: {'DISPLAY': ':0', 20:56:40 INFO - 'HOME': '/home/cltbld', 20:56:40 INFO - 'LANG': 'en_US.UTF-8', 20:56:40 INFO - 'LANGUAGE': 'en_US:en', 20:56:40 INFO - 'LOGNAME': 'cltbld', 20:56:40 INFO - 'MAIL': '/var/mail/cltbld', 20:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:40 INFO - 'MOZ_NO_REMOTE': '1', 20:56:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:40 INFO - 'NO_EM_RESTART': '1', 20:56:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:40 INFO - 'PWD': '/builds/slave/test', 20:56:40 INFO - 'SHELL': '/bin/bash', 20:56:40 INFO - 'SHLVL': '1', 20:56:40 INFO - 'TERM': 'linux', 20:56:40 INFO - 'TMOUT': '86400', 20:56:40 INFO - 'USER': 'cltbld', 20:56:40 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', 20:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:40 INFO - '_': '/tools/buildbot/bin/python'} 20:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:40 INFO - Downloading/unpacking blobuploader==1.2.4 20:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:40 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 20:56:40 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 20:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:42 INFO - Downloading blobuploader-1.2.4.tar.gz 20:56:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:56:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:42 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 20:56:42 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 20:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:56:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:43 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 20:56:43 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 20:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:43 INFO - Downloading docopt-0.6.1.tar.gz 20:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:56:43 INFO - Installing collected packages: blobuploader, requests, docopt 20:56:43 INFO - Running setup.py install for blobuploader 20:56:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:56:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:56:43 INFO - Running setup.py install for requests 20:56:44 INFO - Running setup.py install for docopt 20:56:44 INFO - Successfully installed blobuploader requests docopt 20:56:44 INFO - Cleaning up... 20:56:44 INFO - Return code: 0 20:56:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:44 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 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', '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 20:56:44 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 20:56:44 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 20:56:44 INFO - Using env: {'DISPLAY': ':0', 20:56:44 INFO - 'HOME': '/home/cltbld', 20:56:44 INFO - 'LANG': 'en_US.UTF-8', 20:56:44 INFO - 'LANGUAGE': 'en_US:en', 20:56:44 INFO - 'LOGNAME': 'cltbld', 20:56:44 INFO - 'MAIL': '/var/mail/cltbld', 20:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:44 INFO - 'MOZ_NO_REMOTE': '1', 20:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:44 INFO - 'NO_EM_RESTART': '1', 20:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:44 INFO - 'PWD': '/builds/slave/test', 20:56:44 INFO - 'SHELL': '/bin/bash', 20:56:44 INFO - 'SHLVL': '1', 20:56:44 INFO - 'TERM': 'linux', 20:56:44 INFO - 'TMOUT': '86400', 20:56:44 INFO - 'USER': 'cltbld', 20:56:44 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', 20:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:44 INFO - '_': '/tools/buildbot/bin/python'} 20:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:56:44 INFO - Running setup.py (path:/tmp/pip-tQDxvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:56:44 INFO - Running setup.py (path:/tmp/pip-TEqTc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:56:44 INFO - Running setup.py (path:/tmp/pip-VUI87M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:56:44 INFO - Running setup.py (path:/tmp/pip-xghARs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:56:44 INFO - Running setup.py (path:/tmp/pip-MmhZEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:56:44 INFO - Running setup.py (path:/tmp/pip-gf3YxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:56:44 INFO - Running setup.py (path:/tmp/pip-gadgRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:56:45 INFO - Running setup.py (path:/tmp/pip-W3KSS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:56:45 INFO - Running setup.py (path:/tmp/pip-LUEbY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:56:45 INFO - Running setup.py (path:/tmp/pip-ik8wt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:56:45 INFO - Running setup.py (path:/tmp/pip-VUxuzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:56:45 INFO - Running setup.py (path:/tmp/pip-SkBeYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:56:45 INFO - Running setup.py (path:/tmp/pip-G3nAAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:56:45 INFO - Running setup.py (path:/tmp/pip-kCJ7ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:45 INFO - Running setup.py (path:/tmp/pip-M3lz_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:56:45 INFO - Running setup.py (path:/tmp/pip-Aoi7iZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:56:45 INFO - Running setup.py (path:/tmp/pip-lAoMwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:56:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:56:45 INFO - Running setup.py install for manifestparser 20:56:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:56:45 INFO - Running setup.py install for mozcrash 20:56:45 INFO - Running setup.py install for mozdebug 20:56:46 INFO - Running setup.py install for mozdevice 20:56:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:56:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:56:46 INFO - Running setup.py install for mozfile 20:56:46 INFO - Running setup.py install for mozhttpd 20:56:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:56:46 INFO - Running setup.py install for mozinfo 20:56:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:56:46 INFO - Running setup.py install for mozInstall 20:56:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:56:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:56:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:56:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:56:46 INFO - Running setup.py install for mozleak 20:56:46 INFO - Running setup.py install for mozlog 20:56:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:56:46 INFO - Running setup.py install for moznetwork 20:56:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:56:46 INFO - Running setup.py install for mozprocess 20:56:46 INFO - Running setup.py install for mozprofile 20:56:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:56:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:56:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:56:47 INFO - Running setup.py install for mozrunner 20:56:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:56:47 INFO - Running setup.py install for mozscreenshot 20:56:47 INFO - Running setup.py install for moztest 20:56:47 INFO - Running setup.py install for mozversion 20:56:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:56:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:56:47 INFO - Cleaning up... 20:56:47 INFO - Return code: 0 20:56:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:47 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 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', '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 20:56:47 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 20:56:47 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 20:56:47 INFO - Using env: {'DISPLAY': ':0', 20:56:47 INFO - 'HOME': '/home/cltbld', 20:56:47 INFO - 'LANG': 'en_US.UTF-8', 20:56:47 INFO - 'LANGUAGE': 'en_US:en', 20:56:47 INFO - 'LOGNAME': 'cltbld', 20:56:47 INFO - 'MAIL': '/var/mail/cltbld', 20:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:47 INFO - 'MOZ_NO_REMOTE': '1', 20:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:47 INFO - 'NO_EM_RESTART': '1', 20:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:47 INFO - 'PWD': '/builds/slave/test', 20:56:47 INFO - 'SHELL': '/bin/bash', 20:56:47 INFO - 'SHLVL': '1', 20:56:47 INFO - 'TERM': 'linux', 20:56:47 INFO - 'TMOUT': '86400', 20:56:47 INFO - 'USER': 'cltbld', 20:56:47 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', 20:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:47 INFO - '_': '/tools/buildbot/bin/python'} 20:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:56:47 INFO - Running setup.py (path:/tmp/pip-3mk6e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:56:47 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)) 20:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:56:47 INFO - Running setup.py (path:/tmp/pip-OmZXfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 20:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:56:47 INFO - Running setup.py (path:/tmp/pip-yNpeeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:56:47 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)) 20:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:56:47 INFO - Running setup.py (path:/tmp/pip-8c9r9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 20:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:56:48 INFO - Running setup.py (path:/tmp/pip-fusaCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:56:48 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)) 20:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:56:48 INFO - Running setup.py (path:/tmp/pip-wcuFWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:56:48 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)) 20:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:56:48 INFO - Running setup.py (path:/tmp/pip-tH3sJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:56:48 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)) 20:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:56:48 INFO - Running setup.py (path:/tmp/pip-Kh0x34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:56:48 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)) 20:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:56:48 INFO - Running setup.py (path:/tmp/pip-TVJ3Sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:56:48 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)) 20:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:56:48 INFO - Running setup.py (path:/tmp/pip-Bc9Bv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 20:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:56:48 INFO - Running setup.py (path:/tmp/pip-QSxg9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:56:48 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)) 20:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:56:48 INFO - Running setup.py (path:/tmp/pip-nX0bkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 20:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:56:48 INFO - Running setup.py (path:/tmp/pip-heGJNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:56:48 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)) 20:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:56:48 INFO - Running setup.py (path:/tmp/pip-RGKynw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 20:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:48 INFO - Running setup.py (path:/tmp/pip-toWryj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:48 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)) 20:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:56:48 INFO - Running setup.py (path:/tmp/pip-us61FL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 20:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:56:48 INFO - Running setup.py (path:/tmp/pip-kxkp0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:56:48 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)) 20:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:56:48 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)) 20:56:48 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:56:48 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:56:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:48 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 20:56:48 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 20:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:51 INFO - Downloading blessings-1.6.tar.gz 20:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:56:51 INFO - Installing collected packages: blessings 20:56:51 INFO - Running setup.py install for blessings 20:56:51 INFO - Successfully installed blessings 20:56:51 INFO - Cleaning up... 20:56:51 INFO - Return code: 0 20:56:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:56:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:56:51 INFO - Reading from file tmpfile_stdout 20:56:51 INFO - Current package versions: 20:56:51 INFO - argparse == 1.2.1 20:56:51 INFO - blessings == 1.6 20:56:51 INFO - blobuploader == 1.2.4 20:56:51 INFO - docopt == 0.6.1 20:56:51 INFO - functools32 == 3.2.3-2 20:56:51 INFO - jsonschema == 2.5.1 20:56:51 INFO - manifestparser == 1.1 20:56:51 INFO - mozInstall == 1.12 20:56:51 INFO - mozcrash == 0.17 20:56:51 INFO - mozdebug == 0.1 20:56:51 INFO - mozdevice == 0.48 20:56:51 INFO - mozfile == 1.2 20:56:51 INFO - mozhttpd == 0.7 20:56:51 INFO - mozinfo == 0.9 20:56:51 INFO - mozleak == 0.1 20:56:51 INFO - mozlog == 3.2 20:56:51 INFO - moznetwork == 0.27 20:56:51 INFO - mozprocess == 0.23 20:56:51 INFO - mozprofile == 0.28 20:56:51 INFO - mozrunner == 6.12 20:56:51 INFO - mozscreenshot == 0.1 20:56:51 INFO - mozsystemmonitor == 0.3 20:56:51 INFO - moztest == 0.7 20:56:51 INFO - mozversion == 1.4 20:56:51 INFO - psutil == 3.1.1 20:56:51 INFO - requests == 1.2.3 20:56:51 INFO - wsgiref == 0.1.2 20:56:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:51 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 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', '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 20:56:51 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 20:56:51 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 20:56:51 INFO - Using env: {'DISPLAY': ':0', 20:56:51 INFO - 'HOME': '/home/cltbld', 20:56:51 INFO - 'LANG': 'en_US.UTF-8', 20:56:51 INFO - 'LANGUAGE': 'en_US:en', 20:56:51 INFO - 'LOGNAME': 'cltbld', 20:56:51 INFO - 'MAIL': '/var/mail/cltbld', 20:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:51 INFO - 'MOZ_NO_REMOTE': '1', 20:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:51 INFO - 'NO_EM_RESTART': '1', 20:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:51 INFO - 'PWD': '/builds/slave/test', 20:56:51 INFO - 'SHELL': '/bin/bash', 20:56:51 INFO - 'SHLVL': '1', 20:56:51 INFO - 'TERM': 'linux', 20:56:51 INFO - 'TMOUT': '86400', 20:56:51 INFO - 'USER': 'cltbld', 20:56:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', 20:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:51 INFO - '_': '/tools/buildbot/bin/python'} 20:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:52 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)) 20:56:52 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)) 20:56:52 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)) 20:56:52 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)) 20:56:52 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)) 20:56:52 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)) 20:56:52 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)) 20:56:52 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)) 20:56:52 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)) 20:56:52 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)) 20:56:52 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)) 20:56:52 INFO - Cleaning up... 20:56:52 INFO - Return code: 0 20:56:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', '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 20:56: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', 'jsonschema'] in /builds/slave/test/build 20:56: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 jsonschema 20:56:52 INFO - Using env: {'DISPLAY': ':0', 20:56:52 INFO - 'HOME': '/home/cltbld', 20:56:52 INFO - 'LANG': 'en_US.UTF-8', 20:56:52 INFO - 'LANGUAGE': 'en_US:en', 20:56:52 INFO - 'LOGNAME': 'cltbld', 20:56:52 INFO - 'MAIL': '/var/mail/cltbld', 20:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:52 INFO - 'MOZ_NO_REMOTE': '1', 20:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:52 INFO - 'NO_EM_RESTART': '1', 20:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:52 INFO - 'PWD': '/builds/slave/test', 20:56:52 INFO - 'SHELL': '/bin/bash', 20:56:52 INFO - 'SHLVL': '1', 20:56:52 INFO - 'TERM': 'linux', 20:56:52 INFO - 'TMOUT': '86400', 20:56:52 INFO - 'USER': 'cltbld', 20:56:52 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', 20:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:52 INFO - '_': '/tools/buildbot/bin/python'} 20:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:56:52 INFO - Cleaning up... 20:56:52 INFO - Return code: 0 20:56:52 INFO - Running post-action listener: _resource_record_post_action 20:56:52 INFO - Running post-action listener: _start_resource_monitoring 20:56:52 INFO - Starting resource monitoring. 20:56:52 INFO - ##### 20:56:52 INFO - ##### Finished create-virtualenv step (success) 20:56:52 INFO - ##### 20:56:52 INFO - ##### 20:56:52 INFO - ##### Running install step. 20:56:52 INFO - ##### 20:56:52 INFO - Running pre-action listener: _resource_record_pre_action 20:56:52 INFO - Running main action method: install 20:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:56:52 INFO - Reading from file tmpfile_stdout 20:56:52 INFO - Detecting whether we're running mozinstall >=1.0... 20:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:56:52 INFO - Reading from file tmpfile_stdout 20:56:52 INFO - Output received: 20:56:52 INFO - Usage: mozinstall [options] installer 20:56:52 INFO - Options: 20:56:52 INFO - -h, --help show this help message and exit 20:56:52 INFO - -d DEST, --destination=DEST 20:56:52 INFO - Directory to install application into. [default: 20:56:52 INFO - "/builds/slave/test"] 20:56:52 INFO - --app=APP Application being installed. [default: firefox] 20:56:52 INFO - mkdir: /builds/slave/test/build/application 20:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:57:09 INFO - Reading from file tmpfile_stdout 20:57:09 INFO - Output received: 20:57:09 INFO - /builds/slave/test/build/application/firefox/firefox 20:57:09 INFO - Running post-action listener: _resource_record_post_action 20:57:09 INFO - ##### 20:57:09 INFO - ##### Finished install step (success) 20:57:09 INFO - ##### 20:57:09 INFO - ##### 20:57:09 INFO - ##### Running run-tests step. 20:57:09 INFO - ##### 20:57:09 INFO - Running pre-action listener: _resource_record_pre_action 20:57:09 INFO - Running main action method: run_tests 20:57:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:57:09 INFO - Python 2.7.3 20:57:09 INFO - Return code: 0 20:57:09 INFO - grabbing minidump binary from tooltool 20:57:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:57:09 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 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:57:09 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 20:57:09 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 20:57:09 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 20:57:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:57:09 INFO - Return code: 0 20:57:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:57:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:57:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:57:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:57:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:57:09 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/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 20:57:09 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/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 20:57:09 INFO - Using env: {'DISPLAY': ':0', 20:57:09 INFO - 'HOME': '/home/cltbld', 20:57:09 INFO - 'LANG': 'en_US.UTF-8', 20:57:09 INFO - 'LANGUAGE': 'en_US:en', 20:57:09 INFO - 'LOGNAME': 'cltbld', 20:57:09 INFO - 'MAIL': '/var/mail/cltbld', 20:57:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:57:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:09 INFO - 'MOZ_NO_REMOTE': '1', 20:57:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:09 INFO - 'NO_EM_RESTART': '1', 20:57:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:09 INFO - 'PWD': '/builds/slave/test', 20:57:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:57:09 INFO - 'SHELL': '/bin/bash', 20:57:09 INFO - 'SHLVL': '1', 20:57:09 INFO - 'TERM': 'linux', 20:57:09 INFO - 'TMOUT': '86400', 20:57:09 INFO - 'USER': 'cltbld', 20:57:09 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980', 20:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:09 INFO - '_': '/tools/buildbot/bin/python'} 20:57:09 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/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 20:57:10 INFO - mozversion application_buildid: 20160715193041 20:57:10 INFO - mozversion application_changeset: 0d82d5d030afa2e8f48dd68e86eb75efd0947a5c 20:57:10 INFO - mozversion application_display_name: Nightly 20:57:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:57:10 INFO - mozversion application_name: Firefox 20:57:10 INFO - mozversion application_remotingname: firefox 20:57:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:57:10 INFO - mozversion application_vendor: Mozilla 20:57:10 INFO - mozversion application_version: 50.0a1 20:57:10 INFO - mozversion platform_buildid: 20160715193041 20:57:10 INFO - mozversion platform_changeset: 0d82d5d030afa2e8f48dd68e86eb75efd0947a5c 20:57:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:57:10 INFO - mozversion platform_version: 50.0a1 20:57:10 INFO - using testdate: 1468641430 20:57:10 INFO - actual date: 1468641430 20:57:10 INFO - starting webserver on 'localhost:37518' 20:57:10 INFO - SUITE-START | Running 2 tests 20:57:10 INFO - TEST-START | dromaeo_css 20:57:10 INFO - operating with platform_type : linux_ 20:57:10 INFO - Initialising browser for dromaeo_css test... 20:57:10 INFO - TEST-INFO | started process 26208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpogCu5j/profile http://localhost:37518/getInfo.html) 20:57:13 INFO - PROCESS | 26208 | __metrics Screen width/height:1600/1200 20:57:13 INFO - PROCESS | 26208 | colorDepth:24 20:57:13 INFO - PROCESS | 26208 | Browser inner width/height: 1024/697 20:57:13 INFO - PROCESS | 26208 | __metrics 20:57:15 INFO - PROCESS | 26208 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:57:15 INFO - PROCESS | 26208 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:57:15 INFO - PROCESS | 26208 | console.error: PushService: 20:57:15 INFO - PROCESS | 26208 | stateChangeProcessEnqueue: Error transitioning state 20:57:15 INFO - PROCESS | 26208 | UnknownError 20:57:16 INFO - TEST-INFO | 26208: exit 0 20:57:16 INFO - Browser initialized. 20:57:16 INFO - Running cycle 1/1 for dromaeo_css test... 20:57:16 INFO - TEST-INFO | started process 26294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpogCu5j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:57:27 INFO - PROCESS | 26294 | RSS: Main: 157454336 20:57:27 INFO - PROCESS | 26294 | 20:58:19 INFO - PROCESS | 26294 | 1468641499168 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:00:26 INFO - PROCESS | 26294 | Cycle 1(1): loaded http://localhost:37518/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37518/tests/dromaeo/cssquery-ext.html) 21:00:27 INFO - PROCESS | 26294 | RSS: Main: 254693376 21:00:27 INFO - PROCESS | 26294 | 21:03:30 INFO - PROCESS | 26294 | Cycle 1(1): loaded http://localhost:37518/tests/dromaeo/cssquery-ext.html (next: http://localhost:37518/tests/dromaeo/cssquery-jquery.html) 21:03:30 INFO - PROCESS | 26294 | RSS: Main: 239378432 21:03:30 INFO - PROCESS | 26294 | 21:06:32 INFO - PROCESS | 26294 | Cycle 1(1): loaded http://localhost:37518/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37518/tests/dromaeo/cssquery-mootools.html) 21:06:33 INFO - PROCESS | 26294 | RSS: Main: 241057792 21:06:33 INFO - PROCESS | 26294 | 21:09:35 INFO - PROCESS | 26294 | Cycle 1(1): loaded http://localhost:37518/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37518/tests/dromaeo/cssquery-prototype.html) 21:09:35 INFO - PROCESS | 26294 | RSS: Main: 235679744 21:09:35 INFO - PROCESS | 26294 | 21:12:38 INFO - PROCESS | 26294 | Cycle 1(1): loaded http://localhost:37518/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37518/tests/dromaeo/cssquery-yui.html) 21:12:39 INFO - PROCESS | 26294 | RSS: Main: 203522048 21:12:39 INFO - PROCESS | 26294 | 21:15:42 INFO - PROCESS | 26294 | Cycle 1(1): loaded http://localhost:37518/tests/dromaeo/cssquery-yui.html (next: http://localhost:37518/tests/dromaeo/cssquery-dojo.html) 21:15:42 INFO - PROCESS | 26294 | RSS: Main: 277520384 21:15:42 INFO - PROCESS | 26294 | 21:15:42 INFO - PROCESS | 26294 | __start_tp_report 21:15:42 INFO - PROCESS | 26294 | _x_x_mozilla_page_load 21:15:42 INFO - PROCESS | 26294 | _x_x_mozilla_page_load_details 21:15:42 INFO - PROCESS | 26294 | |i|pagename|runs| 21:15:42 INFO - PROCESS | 26294 | |0;dojo.html;3018.3812318474716;3033.9848300758495;3054.2364408897784;3065.5554944533055;3096.5819614352054;5274.235235890794;5313.521783039526;5354.170103633934;5411.621186516945;5439.184122381645;5326.041312563737;5354.598405119612;5359.866003349918;5385.35375754909;5391.973040134803;4840.975795121037;4894.902101957959;4914.361133052698;4928.310036594861;5081.085404627165;4984.4018717753925;4993.550580447759;5028.899422011557;5052.0906236877345;5061.54446099851;4755.619550435974;4799.712017278939;4810.182269014258;4853.417589889201;4858.562729354339;4862.027594481118;4864.100141473803;4921.18800397934;4937.037277730844;4955.60355171589;4731.313959475857;4885.413750349945;4901.460839307673;4916.1888288432365;4945.579625731817;5271.182966640177;5368.785248590052;5381.7578208980685;5415.918761218545;5430.375506816687;5727.656340619576;5753.626014309057;5770.682612456313;5796.797112101099;5801.564882633819;5598.1602759585985;5694.174344720034;5739.713014349308;5753.395893431171;5788.04497257952;5377.865553361158;5459.672419654873;5463.972680136574;5470.753816078286;5470.835874923719;5941.465268125889;5956.8808623828145;5959.28488581373;5960.016597261403;5961.582689211714;5503.064479038573;5531.170324451365;5565.471280228372;5724.141378793214;5737.340205876378;5693.68684722336;5742.684152371576;5743.253377060955;5744.253247077937;5747.913781293284;5619.7471113799975;5664.065429204217;5665.490105890407;5666.320041594952;5679.886402271932;5480.616356854982;5659;5691.943080569225;5746.683932383759;5750.5112065474905;4387.122575484916;4390.714603550823;4391.626711729475;4392.121575684812;4426.26966550522;3898.688104951597;3918.5101862267215;3921.3333733265413;3948.170884114311;3963.286608410456;5210.47895210476;5314.415414304423;5344.251804747339;5369.979703856255;5396.649217800909;5733.741981610838;5746.0519014363;5750.108733146285;5760.94239057604;5802.6808525531505;5395.190721391823;5415;5415.53967912724;5419.376771671308;5419.674819510842;4674.322223277673;4768.356271903318;4788.473267940523;4800.375951126401;4872.78072486739;5920.31916329619;5928.110783382527;5928.992071347795;5931.792387266425;5948.940510594839;5745.3105627324985;5756.136579513107;5759.51044161251;5768.077107662753;5772.740226689725;5707.343655479673;5849.707514624337;5851.824445266649;5903.085021821625;5943.851403714942;5655.632383895034;5685.971570142123;5687.601867869375;5692.31692196939;5696.1455781633085;5518.751656175402;5770.3364113125845;5771.884562308815;5778.133280008033;5791.594588378773;5466.1527463243265;5521.420250873601;5528.253685752372;5535.418781027934;5539.169124631338;5507.228987941771;5524.889502209853;5527.226188333556;5530.695811730394;5542.307211598551;5394.919076213939;5439.428859969805;5455.645383050089;5458.263134476795;5515.834524964097;5587.6088673794075;5612.102063669957;5668.291463567054;5671.432856714296;5674.4325567444575;5447.918281225706;5466.234727138124;5483.369412517452;5488.945110549003;5496.780128794963 21:15:42 INFO - PROCESS | 26294 | |1;ext.html;591.9822405327839;600.9819705408838;611.2237458427794;616.1804799616508;622.5424313129848;33926.83036584817;36739.081522961904;36752.63247367529;47070.76464617672;47878.76060619692;45161;45578.772106139426;45599.31601025987;45632.771836140775;45688.77155614226;8918.19736223738;9079.727608171732;9096;9098.135677110664;9099.181073703365;8957.283417326631;9015.819683606323;9047.95476022619;9055.275577953747;9059.637614495412;9075.863862042042;9114.134157255083;9118.680846170351;9125.315601329894;9125.908740912571;8997.775055623597;9008.054154313768;9039.864402033974;9041.3671043027;9045.819083618324;8910.688125915562;8984.416012959136;8984.685536006275;8986;8986.415882967585;37028;37161.62838371609;37211.627883721085;37281.44077838834;37324;3358.714509266715;3380.9830950845335;3389.474631432132;3437.2781715839706;3519.771214871025;33008.504872426936;33283.6671633283;34071.31857362839;34088.65911340904;34164;4449.917243304674;4491.595756381941;4511.954880451219;4695.765211739399;4699.929501057487;345699.27150364337;346131;346526;347575;348036;59729.402705973254;60666.393336066954;61136;61262.69368653218;61294.38705612887;61025.38974610197;61256.38743612596;61890;62131.06803397953;62163.06755398673;17053.48839534816;17252.223649935782;17270.05014724177;17273.309067637405;17292.567685807957;13201.20792752438;13241.73516529664;13257.072004959753;13270.469181232836;13274.137181083199;16923.238454269587;17843.28626854937;17863;18012.459626211235;18065.7290140648;6632.734690612418;6653.667316634149;6693.665316734144;6760.966195169091;6839.487038472134;945.6831961293044;947.772534591693;1086.918481113904;1088.4992903264429;1166.7433164703752;31816.840915795274;32023.839880800446;32159.678403216138;32351.19122021921;32389.35221295608;899.1772528136681;986.8371718666483;991.306085739985;1011.8801111671038;1123.2642619084513;16450.424235151953;16823.915880420518;16838.24227909747;16968.74546881798;16995.74506382405;536435;540365;541752;542093.0534862522;543717;60704.69647651733;60776.69611652002;60820.695896520236;60912.69543652253;60924;1238.294172321768;1357.3077730357588;1375.6010756880391;1399.1605036977733;1404.810350602676;32138.83930580332;33659.66340336565;33812.323753525285;33970.66029339675;34360;56248.71875640596;58246.4175358241;58355.416445836694;61924;62299.377006229355;491550;498129;498286;498916;499581;24599.631005534575;25304.240872773848;25853.482930341663;27949.441011180068;29920.401591968475;48009.27986080282;48506.5149348502;48534.514654853;48883.51116488932;50211;40552.391714124904;40733.1853362937;41624.79187604043;41843.7907810459;41918;40158.79920600495;41441.1711765769;41453.58546414618;41624.1675166501;41656.58343416648;41139.588604113575;41180;42314.15371692611;42617.1476570473;45044.77477612591;34503.82748086344;36741.44887826738;37185.62814371822;37994;38308.80588658758;28256.717432825408;28559.857200713865;28920.13239602815;29101.7089829099;29114.41771164607 21:15:42 INFO - PROCESS | 26294 | |2;jquery.html;375.42559883378425;379.5843551311314;385.70300868331367;390.85147643895317;405.691674327511;18404.907975460137;19408.90295548524;20425.591488170227;20471.488212794688;20497.99999999998;18303;19067.618647627038;19228.13473393697;19488.512787180327;19550.217991280333;5445.1832225166145;5501.477359650837;5649.322081350244;5659.462351076641;5664.971675141639;5555.611107222496;5591.7483713233005;5623.381428042912;5654.434556544354;5660.773569057254;5405.756740946647;5425.83722488324;5500.944990550103;5634.830955071355;5647.7458514366745;5468.043092458804;5481.616286859921;5486.588505862076;5492.945070549284;5497.835064948058;4808.374911261549;4825.7587120644175;4861.73260470674;4915.901681966377;4923.655344125913;23143.305700828834;23330.883345583334;23565.764342356528;23638.527229455485;23696;2490.1906880263805;2491.352248415425;2506.248125562324;2529.8229123961146;2574.00900653248;14120.364583593762;14190.787138192936;14343.928280358636;14496.347664355024;14681.650935850214;1927.1831371475555;1929.488685498344;1988.3745834723852;1998.840533750875;2020.454477291138;61501;81038.59480702618;82376.58811705903;82576.17423825744;82825;9660.792400949882;9894.109530142321;10112.241581881388;10135.64525241613;10388.688339349832;13863;13917.23455209953;13930.512432065032;13959.232242226572;13963.092398994237;8015.998000249969;8072.798180045545;8075.434719569691;8129.1464396238725;8264.132266112092;8143.6742530298125;8227.876581851277;8303.459111679073;8367;8406.663733450716;6541.411272985454;6549.803505894735;6605.735770569124;6609.570377925419;6622.63575503352;1700.542715775717;1708.5728567858037;1753.8947663140252;1792.8834625749284;1796.1288774944142;980.8528720691811;1016.0347669713801;1049.1606714628267;1121.4056550028497;1121.6354684727496;18234.54413639643;20142;20197.192112315635;20214.797852021587;20263.594728105356;1023.8924912884189;1046.5970601318395;1051.600391851107;1092.639428988432;1094.9124070074374;10798.892011079946;11462.770744585228;11479.426028698532;11526.94236528812;11582.536698531965;445932;458981;481995;482122;483145;57989.71005145032;75496.81449094316;79218;82697.58651206705;84356;991.306085739985;1012.3116280929039;1036.108946306176;1044.6239353832614;1045.362328979322;13988.790168147689;16877;17080.74378884293;17335.82664173342;18562.44312670622;40226;43938;44191.33712994243;44475.77762111169;44616;58192.709036454544;58926.116108259266;59228.70385648044;59246;59430;8123.431359804993;8286.212809783061;8346.457480264005;8416.705415310435;8517.701880434155;9595.23238140933;12333.506659733868;12953.287569183785;13132.540361087316;13277.66805829862;10537.525811338355;11387.886121139014;11704.473298701409;11718.531258749554;12154.635360939186;10879.619213327496;11163.051140653135;11203.551857925591;11218.831717524406;11565.768684626428;11555.084766934677;11742.823857642314;12203.511859525519;12452.813207802072;12483.188592741442;8501.787455313419;8502.44734092282;8617.353698472765;8665.523396213268;8837.734867953972;11062.502187401748;11371;11808.527658893549;11856.288622682667;12166.57416990401 21:15:42 INFO - PROCESS | 26294 | |3;mootools.html;1504.7667611520214;1530.5178868656371;1701.5831121375256;1768.4782989018238;1828.4514645606323;8902.421342612726;9358.29812764042;9416.482093484856;9424.623015079405;9468.384555003928;8040.8391832163325;8785.428947118433;9035.81928361434;9049.592768325425;9210.032946540618;2303.0442366417915;2325.476767727265;2328.0571368595747;2332.568474832153;2334.708161479815;2310.341552657493;2322.1408079010707;2347.9765202348012;2348.753380895007;2355.1403737635724;2024.4635171679442;2098.842586805988;2241.3051953894346;2309.2033248529315;2315.4674424882287;2319.373769082347;2321.872297023663;2337.55586438577;2339.6724458575814;2363.279199844047;2297.127091705158;2297.150054479853;2298.8735619540917;2303.1133013789813;2306.1006207579057;8810.33922455812;8882.289416846701;8898.4660920345;8902.73291801247;8973.28213742899;4993;5063.139266324733;5067.366579177603;5073.923891141636;5082.618803589746;3193.4730769423018;3243.172990887332;3274.590676165479;3299.3236386540943;3341.3150304187825;1015.5836107196014;1017.9338343007681;1033.194108595297;1033.3696445168441;1060.2790102730216;12019.21875078126;12044.638660840188;12052.939735301268;12080.456379462858;12099.213551119148;4267.701260911768;4269.18885411777;4443.511213766483;4444.933326000112;4503.729776213438;10108.24188185889;10196.949015254877;10277.17782577392;10290.279680422298;10299.897001030044;5015.6489045767175;5054.393472783216;5054.418741844662;5055.368078990126;5057.31726216956;4577.771111444415;4598.494165641777;4630.953690463052;4633.72197668141;4715.905681886343;3988.202359528106;3996.200759848042;4041.9595804041583;4050.473438453041;4100.323446631332;1137.1244142010771;1194.8028575285155;1224.2960297828783;1227.6808029912108;1234.3766397969148;916.935814492979;977.3695966101825;979.911807937289;1004.7437903334749;1007.1727435744143;6089.604175728564;6118.449339559461;6275.905861412082;6318.747250109944;6391.9243202507305;1005.4721271332609;1015.2588610314511;1022.9181665466745;1030.6501177315731;1039.2673165418362;4029.5567487576345;4102.118044620421;4258.403823464718;4339.7396156230725;4340.370646256275;11453.541858325574;11592.826107608393;11793.941030294794;11833;11842.111841611913;10495.737606559744;11687.590934317259;11693.532258709556;11711.941440292743;11721.238119522204;8231.42380033392;8561.44350617208;8587.742367728979;8733.30133589324;8754.212120909022;6038.486728628116;6163.537734670007;6275.403836635513;6298.71655775482;6313.96843015782;10616.469176541297;10730.83903741429;10863.891361086287;10875;10886.673399797703;10689.679309620724;10860.131189504662;10920.508577114208;11169.72075698114;11191.048760855418;8104.554249516334;8104.594770261346;8143.6742530298125;8151.673933042849;8163.83672326562;8255.752327430188;8562.828743425222;8830.337724670548;8902.42134261271;8912.242459390765;6243.625382477066;7994.440389172702;8197.221263979913;8323.583820808813;8380.413371063967;7810.843783124419;7943.721969731032;7993.12075671664;8065.556394398364;8250.54621995796;6880.208775990825;6919.238883722887;6941.097657304518;6952.270011648907;6956.165260168812;4731.858044258678;4748.287756836502;4754.358161648133;4795.328653988514;4853.466118727008;5146.0737067326745;5173.1464308388695;5212.635115542027;5278.3637072507645;5382.757775900016 21:15:42 INFO - PROCESS | 26294 | |4;prototype.html;304.1908523327947;315.8120918053758;320.98716051357945;323.7765941500366;326.4760060103534;5090.287359769626;5154.896902061956;5318.122509785885;5334.359876814783;5344.679319240843;5117.539421452068;5233.8953220935555;5244.501772331632;5258.8685282867855;5269.209618557218;4111.814968326433;4124.19554702802;4125.525564560069;4132;4136.931534232884;3852.8266228019666;3891.1633998690277;4082.9387559186634;4147.108371700084;4150.750954942698;4098.733582317155;4106.178764247147;4112.6298633123015;4116.300228961084;4124.57702092779;4066.3900414938;4088.1823635272917;4094.426780250782;4106.548279689232;4115.34154535276;3418.6923176914197;3625.7099432045375;3627.3289441453417;3634.3276493848457;3636.6181550937035;5119.129747942859;5138.3577052868395;5148.330717006766;5152.433232344439;5172.715500647463;4627.838025669085;4633.9536604634195;4651.372064771246;4665.603423708955;4681.859544213679;5327.440618735054;5343.679379237219;5448.237246785453;5480.177973304037;5488.121900495941;3873.12854607711;3882.864099756495;3889.0666240102455;3891.2606604745006;3897.9670387347373;5675.694590244226;5686.071673088321;5692.857678558028;5708.71456427177;5753.971230143822;3953.8418463261723;3960.2277555876326;3961.74248673841;3981.2634662587516;3992.401139828991;3821.8471261149243;4015.0765323975647;4035.8183881725395;4048.352263637804;4066.4916885389325;4659.673822832369;4663.48701642819;4663.580277775017;4664.673472856867;4669.7431641260055;5434.8913021739345;5465.180222966507;5540.722963851791;5553.861153471195;5557.110862262019;1281.8013207952781;1304.6999190186311;1385.9514916977857;1388.1116085705157;1393.2824595333411;912.1425859692001;926.4302453990747;937.9624815007323;940.7365937537501;941.3786900645541;5264.184051472028;5265.236540701577;5265.447128051576;5270.472952704776;5277.604179686539;5569.526590239875;5578.191162281447;5585.58108141891;5593.748281327269;5596.300462442195;5052.191649336089;5203.609729270244;5234.712090835041;5254.0805359062015;5355.892882142335;3000.324926891432;3005.2269161195;3019.290466740314;3027.848607569613;3029.6515900671266;5828.94171058284;5851.268591426072;5851.444112809277;5854.2389489366105;5860.794872179454;5592.916106258409;5783.797567085132;5805.36141024487;5814.622049566765;5834.883302333929;5779.88440231193;5809.912851307149;5819.185314055951;5846.590738648254;5846.970765146147;5452.918206226989;5636.746346414503;5650.869826034727;5685.971570142123;5697.4302569742695;5529.281193444826;5560.221568980427;5564.638298510584;5586.888262234814;5601.271834661468;5824.184614153937;5835.67903765297;5852.488506895828;5853.590248682552;5870.442307980735;3583.4087375582735;3727.8881633551036;3859.324618191861;3944.822482988215;3962.4942521841517;5529.695866727207;5555.611107222618;5563.471470210324;5619.353774316006;5654.15187721845;5469.371022332482;5476.17857321405;5486.478784515464;5495.422980586981;5511.925174591077;5258.342707161605;5478.835634930959;5575.553955683455;5576;5592.384837667934;5475.808346707846;5499.102809530706;5513.5037846594;5518.779248830002;5527;5259.47405259471;5548.361938377138;5566.610337276352;5569.220309156641;5597.440255974533;5467.753951072132;5480.766347854785;5488.051741631663;5509.201165831012;5509.421510741315 21:15:42 INFO - PROCESS | 26294 | |5;yui.html;786.9370450363972;808.8220591469875;809.0816922792633;821.5070957425545;860.384824850232;14384.784228236571;15553;15691.05853648779;15715.214239288047;15737.52787416378;13255.204687718744;13445.529406470776;13491.730165396686;13499.730005399912;13518.121322114055;671.214678825775;788.684526189523;797.338209286291;819.5902048975512;820.335528222139;821.0557858462756;830.9210624990646;832.2218725491655;833.945793523422;835.0772396501869;868.3964644572025;876.583622779178;878.8110556230409;880.8062226310202;881.7575166829109;693.7329128285621;826.9710560130367;846.1031306814796;868.7567481105301;871.4074429388014;619.5693992675093;620.0853740732383;620.3238470067603;620.3548309757847;620.3734228429274;14261.857381426156;14313.78529322061;14323.713525729427;14328.068675536057;14340;13103.541376051888;13143.211407315495;13156.802647960289;13254.403551840094;13708.45166193351;12825.807612885814;12882.742345153138;12984.28586427746;12986.155899866573;13296.933515332457;4416.977915110436;4446.088551846864;4465.82136714531;4497.347884556721;4552.863414097583;75631.24368756296;76090;76304.61847690726;78444.60777696132;78810.60594697105;11163.162762792661;11188.888111118948;11265.71835704114;11545.076393888468;11602.303861768321;21573.352799416043;21575;21731.13075476963;21883.890580546995;21900.89049554742;7900.84198316042;8359.791005224917;8681.869771953427;8918.241949434241;9316.44101353921;4684.110019096361;4893.339399181136;4917.754112294371;4950.108980383494;5110.28456016158;3424.7088997435;3549.1836877518317;3552.5914519830035;3553.8400771965325;3558.2705545363137;610.9327973922865;619.6375120554526;620.4044117647019;638.1002786071709;638.3743930947604;631.4001698386551;666.4068978609042;701.6526819224415;741.4142827166586;764.9158592554815;9390.906090939003;9441.575129119206;10004.19966402686;10069.043440873105;10168.084872361524;705.7247673407376;719.6078137415121;725.7097161135588;765.1583258415809;767.6430459836203;4581.748003859753;4798.424189097331;4879.585235255043;4901.705897646081;4911.45973942866;68524;69502;80668;117791.41104294424;118233;93181;96842.51578742202;97143;97443;98738.50630746801;84250;84770;85903.57048214719;88502.55748721215;88779.55610222036;8883.156100170474;8965;9061.456312621263;9141.177294043568;9243.907560924574;51008.48991510186;51790.74104629603;52460.213096802814;53244.73377633242;53298.73350633222;68875;73797.26202737904;73877.6306118466;74416.62791686007;74845.6257718708;11547.249428787438;11654.592089276835;11728.824067639163;12154.513819447124;12594.055445841781;13044.54344097952;13174.816808733516;13388.598342049754;13411.731765364442;13689.24709140967;12640.6839829005;12857.421416036488;12953;12959.287239201934;13042.282674452617;11743.88256117428;12218.694532636755;12219;12248.510059597873;12516.374181290717;10946;11506.252093613888;11512.42437878086;11537.538498460304;11884.46519906589;9720.708378748648;10061.195104391485;10074.972622356969;10117.241206909659;10486.423246721504;9755.146522160767;10157.492125393554;10157.746056348355;10231.744206394602;10330.535125919501 21:15:42 INFO - PROCESS | 26294 | __end_tp_report 21:15:42 INFO - PROCESS | 26294 | __start_cc_report 21:15:42 INFO - PROCESS | 26294 | _x_x_mozilla_cycle_collect,860 21:15:42 INFO - PROCESS | 26294 | __end_cc_report 21:15:42 INFO - PROCESS | 26294 | __startTimestamp1468642542459__endTimestamp 21:15:42 INFO - PROCESS | 26294 | 21:15:42 INFO - PROCESS | 26294 | ------- Summary: start ------- 21:15:42 INFO - PROCESS | 26294 | Number of tests: 6 21:15:42 INFO - PROCESS | 26294 | 21:15:42 INFO - PROCESS | 26294 | [#0] dojo.html Cycles:165 Average:5316.44 Median:5480.62 stddev:604.97 (11.0%) stddev-sans-first:579.34 21:15:42 INFO - PROCESS | 26294 | Values: 3018.4 3034.0 3054.2 3065.6 3096.6 5274.2 5313.5 5354.2 5411.6 5439.2 5326.0 5354.6 5359.9 5385.4 5392.0 4841.0 4894.9 4914.4 4928.3 5081.1 4984.4 4993.6 5028.9 5052.1 5061.5 4755.6 4799.7 4810.2 4853.4 4858.6 4862.0 4864.1 4921.2 4937.0 4955.6 4731.3 4885.4 4901.5 4916.2 4945.6 5271.2 5368.8 5381.8 5415.9 5430.4 5727.7 5753.6 5770.7 5796.8 5801.6 5598.2 5694.2 5739.7 5753.4 5788.0 5377.9 5459.7 5464.0 5470.8 5470.8 5941.5 5956.9 5959.3 5960.0 5961.6 5503.1 5531.2 5565.5 5724.1 5737.3 5693.7 5742.7 5743.3 5744.3 5747.9 5619.7 5664.1 5665.5 5666.3 5679.9 5480.6 5659.0 5691.9 5746.7 5750.5 4387.1 4390.7 4391.6 4392.1 4426.3 3898.7 3918.5 3921.3 3948.2 3963.3 5210.5 5314.4 5344.3 5370.0 5396.6 5733.7 5746.1 5750.1 5760.9 5802.7 5395.2 5415.0 5415.5 5419.4 5419.7 4674.3 4768.4 4788.5 4800.4 4872.8 5920.3 5928.1 5929.0 5931.8 5948.9 5745.3 5756.1 5759.5 5768.1 5772.7 5707.3 5849.7 5851.8 5903.1 5943.9 5655.6 5686.0 5687.6 5692.3 5696.1 5518.8 5770.3 5771.9 5778.1 5791.6 5466.2 5521.4 5528.3 5535.4 5539.2 5507.2 5524.9 5527.2 5530.7 5542.3 5394.9 5439.4 5455.6 5458.3 5515.8 5587.6 5612.1 5668.3 5671.4 5674.4 5447.9 5466.2 5483.4 5488.9 5496.8 21:15:42 INFO - PROCESS | 26294 | 21:15:42 INFO - PROCESS | 26294 | [#1] ext.html Cycles:180 Average:62379.88 Median:42465.65 stddev:124542.17 (293.3%) stddev-sans-first:124805.14 21:15:42 INFO - PROCESS | 26294 | Values: 592.0 601.0 611.2 616.2 622.5 33926.8 36739.1 36752.6 47070.8 47878.8 45161.0 45578.8 45599.3 45632.8 45688.8 8918.2 9079.7 9096.0 9098.1 9099.2 8957.3 9015.8 9048.0 9055.3 9059.6 9075.9 9114.1 9118.7 9125.3 9125.9 8997.8 9008.1 9039.9 9041.4 9045.8 8910.7 8984.4 8984.7 8986.0 8986.4 37028.0 37161.6 37211.6 37281.4 37324.0 3358.7 3381.0 3389.5 3437.3 3519.8 33008.5 33283.7 34071.3 34088.7 34164.0 4449.9 4491.6 4512.0 4695.8 4699.9 345699.3 346131.0 346526.0 347575.0 348036.0 59729.4 60666.4 61136.0 61262.7 61294.4 61025.4 61256.4 61890.0 62131.1 62163.1 17053.5 17252.2 17270.1 17273.3 17292.6 13201.2 13241.7 13257.1 13270.5 13274.1 16923.2 17843.3 17863.0 18012.5 18065.7 6632.7 6653.7 6693.7 6761.0 6839.5 945.7 947.8 1086.9 1088.5 1166.7 31816.8 32023.8 32159.7 32351.2 32389.4 899.2 986.8 991.3 1011.9 1123.3 16450.4 16823.9 16838.2 16968.7 16995.7 536435.0 540365.0 541752.0 542093.1 543717.0 60704.7 60776.7 60820.7 60912.7 60924.0 1238.3 1357.3 1375.6 1399.2 1404.8 32138.8 33659.7 33812.3 33970.7 34360.0 56248.7 58246.4 58355.4 61924.0 62299.4 491550.0 498129.0 498286.0 498916.0 499581.0 24599.6 25304.2 25853.5 27949.4 29920.4 48009.3 48506.5 48534.5 48883.5 50211.0 40552.4 40733.2 41624.8 41843.8 41918.0 40158.8 41441.2 41453.6 41624.2 41656.6 41139.6 41180.0 42314.2 42617.1 45044.8 34503.8 36741.4 37185.6 37994.0 38308.8 28256.7 28559.9 28920.1 29101.7 29114.4 21:15:42 INFO - PROCESS | 26294 | 21:15:42 INFO - PROCESS | 26294 | [#2] jquery.html Cycles:180 Average:28088.24 Median:2490.77 stddev:77375.54 (3106.5%) stddev-sans-first:77564.62 21:15:42 INFO - PROCESS | 26294 | Values: 375.4 379.6 385.7 390.9 405.7 18404.9 19408.9 20425.6 20471.5 20498.0 18303.0 19067.6 19228.1 19488.5 19550.2 5445.2 5501.5 5649.3 5659.5 5665.0 5555.6 5591.7 5623.4 5654.4 5660.8 5405.8 5425.8 5500.9 5634.8 5647.7 5468.0 5481.6 5486.6 5492.9 5497.8 4808.4 4825.8 4861.7 4915.9 4923.7 23143.3 23330.9 23565.8 23638.5 23696.0 2490.2 2491.4 2506.2 2529.8 2574.0 14120.4 14190.8 14343.9 14496.3 14681.7 1927.2 1929.5 1988.4 1998.8 2020.5 61501.0 81038.6 82376.6 82576.2 82825.0 9660.8 9894.1 10112.2 10135.6 10388.7 13863.0 13917.2 13930.5 13959.2 13963.1 8016.0 8072.8 8075.4 8129.1 8264.1 8143.7 8227.9 8303.5 8367.0 8406.7 6541.4 6549.8 6605.7 6609.6 6622.6 1700.5 1708.6 1753.9 1792.9 1796.1 980.9 1016.0 1049.2 1121.4 1121.6 18234.5 20142.0 20197.2 20214.8 20263.6 1023.9 1046.6 1051.6 1092.6 1094.9 10798.9 11462.8 11479.4 11526.9 11582.5 445932.0 458981.0 481995.0 482122.0 483145.0 57989.7 75496.8 79218.0 82697.6 84356.0 991.3 1012.3 1036.1 1044.6 1045.4 13988.8 16877.0 17080.7 17335.8 18562.4 40226.0 43938.0 44191.3 44475.8 44616.0 58192.7 58926.1 59228.7 59246.0 59430.0 8123.4 8286.2 8346.5 8416.7 8517.7 9595.2 12333.5 12953.3 13132.5 13277.7 10537.5 11387.9 11704.5 11718.5 12154.6 10879.6 11163.1 11203.6 11218.8 11565.8 11555.1 11742.8 12203.5 12452.8 12483.2 8501.8 8502.4 8617.4 8665.5 8837.7 11062.5 11371.0 11808.5 11856.3 12166.6 21:15:42 INFO - PROCESS | 26294 | 21:15:42 INFO - PROCESS | 26294 | [#3] mootools.html Cycles:180 Average:5914.81 Median:4268.45 stddev:3456.51 (81.0%) stddev-sans-first:3450.32 21:15:42 INFO - PROCESS | 26294 | Values: 1504.8 1530.5 1701.6 1768.5 1828.5 8902.4 9358.3 9416.5 9424.6 9468.4 8040.8 8785.4 9035.8 9049.6 9210.0 2303.0 2325.5 2328.1 2332.6 2334.7 2310.3 2322.1 2348.0 2348.8 2355.1 2024.5 2098.8 2241.3 2309.2 2315.5 2319.4 2321.9 2337.6 2339.7 2363.3 2297.1 2297.2 2298.9 2303.1 2306.1 8810.3 8882.3 8898.5 8902.7 8973.3 4993.0 5063.1 5067.4 5073.9 5082.6 3193.5 3243.2 3274.6 3299.3 3341.3 1015.6 1017.9 1033.2 1033.4 1060.3 12019.2 12044.6 12052.9 12080.5 12099.2 4267.7 4269.2 4443.5 4444.9 4503.7 10108.2 10196.9 10277.2 10290.3 10299.9 5015.6 5054.4 5054.4 5055.4 5057.3 4577.8 4598.5 4631.0 4633.7 4715.9 3988.2 3996.2 4042.0 4050.5 4100.3 1137.1 1194.8 1224.3 1227.7 1234.4 916.9 977.4 979.9 1004.7 1007.2 6089.6 6118.4 6275.9 6318.7 6391.9 1005.5 1015.3 1022.9 1030.7 1039.3 4029.6 4102.1 4258.4 4339.7 4340.4 11453.5 11592.8 11793.9 11833.0 11842.1 10495.7 11687.6 11693.5 11711.9 11721.2 8231.4 8561.4 8587.7 8733.3 8754.2 6038.5 6163.5 6275.4 6298.7 6314.0 10616.5 10730.8 10863.9 10875.0 10886.7 10689.7 10860.1 10920.5 11169.7 11191.0 8104.6 8104.6 8143.7 8151.7 8163.8 8255.8 8562.8 8830.3 8902.4 8912.2 6243.6 7994.4 8197.2 8323.6 8380.4 7810.8 7943.7 7993.1 8065.6 8250.5 6880.2 6919.2 6941.1 6952.3 6956.2 4731.9 4748.3 4754.4 4795.3 4853.5 5146.1 5173.1 5212.6 5278.4 5382.8 21:15:42 INFO - PROCESS | 26294 | 21:15:42 INFO - PROCESS | 26294 | [#4] prototype.html Cycles:180 Average:4622.90 Median:5269.84 stddev:1373.33 (26.1%) stddev-sans-first:1338.38 21:15:42 INFO - PROCESS | 26294 | Values: 304.2 315.8 321.0 323.8 326.5 5090.3 5154.9 5318.1 5334.4 5344.7 5117.5 5233.9 5244.5 5258.9 5269.2 4111.8 4124.2 4125.5 4132.0 4136.9 3852.8 3891.2 4082.9 4147.1 4150.8 4098.7 4106.2 4112.6 4116.3 4124.6 4066.4 4088.2 4094.4 4106.5 4115.3 3418.7 3625.7 3627.3 3634.3 3636.6 5119.1 5138.4 5148.3 5152.4 5172.7 4627.8 4634.0 4651.4 4665.6 4681.9 5327.4 5343.7 5448.2 5480.2 5488.1 3873.1 3882.9 3889.1 3891.3 3898.0 5675.7 5686.1 5692.9 5708.7 5754.0 3953.8 3960.2 3961.7 3981.3 3992.4 3821.8 4015.1 4035.8 4048.4 4066.5 4659.7 4663.5 4663.6 4664.7 4669.7 5434.9 5465.2 5540.7 5553.9 5557.1 1281.8 1304.7 1386.0 1388.1 1393.3 912.1 926.4 938.0 940.7 941.4 5264.2 5265.2 5265.4 5270.5 5277.6 5569.5 5578.2 5585.6 5593.7 5596.3 5052.2 5203.6 5234.7 5254.1 5355.9 3000.3 3005.2 3019.3 3027.8 3029.7 5828.9 5851.3 5851.4 5854.2 5860.8 5592.9 5783.8 5805.4 5814.6 5834.9 5779.9 5809.9 5819.2 5846.6 5847.0 5452.9 5636.7 5650.9 5686.0 5697.4 5529.3 5560.2 5564.6 5586.9 5601.3 5824.2 5835.7 5852.5 5853.6 5870.4 3583.4 3727.9 3859.3 3944.8 3962.5 5529.7 5555.6 5563.5 5619.4 5654.2 5469.4 5476.2 5486.5 5495.4 5511.9 5258.3 5478.8 5575.6 5576.0 5592.4 5475.8 5499.1 5513.5 5518.8 5527.0 5259.5 5548.4 5566.6 5569.2 5597.4 5467.8 5480.8 5488.1 5509.2 5509.4 21:15:42 INFO - PROCESS | 26294 | 21:15:42 INFO - PROCESS | 26294 | [#5] yui.html Cycles:180 Average:19812.81 Median:4933.93 stddev:28160.12 (570.7%) stddev-sans-first:28202.88 21:15:42 INFO - PROCESS | 26294 | Values: 786.9 808.8 809.1 821.5 860.4 14384.8 15553.0 15691.1 15715.2 15737.5 13255.2 13445.5 13491.7 13499.7 13518.1 671.2 788.7 797.3 819.6 820.3 821.1 830.9 832.2 833.9 835.1 868.4 876.6 878.8 880.8 881.8 693.7 827.0 846.1 868.8 871.4 619.6 620.1 620.3 620.4 620.4 14261.9 14313.8 14323.7 14328.1 14340.0 13103.5 13143.2 13156.8 13254.4 13708.5 12825.8 12882.7 12984.3 12986.2 13296.9 4417.0 4446.1 4465.8 4497.3 4552.9 75631.2 76090.0 76304.6 78444.6 78810.6 11163.2 11188.9 11265.7 11545.1 11602.3 21573.4 21575.0 21731.1 21883.9 21900.9 7900.8 8359.8 8681.9 8918.2 9316.4 4684.1 4893.3 4917.8 4950.1 5110.3 3424.7 3549.2 3552.6 3553.8 3558.3 610.9 619.6 620.4 638.1 638.4 631.4 666.4 701.7 741.4 764.9 9390.9 9441.6 10004.2 10069.0 10168.1 705.7 719.6 725.7 765.2 767.6 4581.7 4798.4 4879.6 4901.7 4911.5 68524.0 69502.0 80668.0 117791.4 118233.0 93181.0 96842.5 97143.0 97443.0 98738.5 84250.0 84770.0 85903.6 88502.6 88779.6 8883.2 8965.0 9061.5 9141.2 9243.9 51008.5 51790.7 52460.2 53244.7 53298.7 68875.0 73797.3 73877.6 74416.6 74845.6 11547.2 11654.6 11728.8 12154.5 12594.1 13044.5 13174.8 13388.6 13411.7 13689.2 12640.7 12857.4 12953.0 12959.3 13042.3 11743.9 12218.7 12219.0 12248.5 12516.4 10946.0 11506.3 11512.4 11537.5 11884.5 9720.7 10061.2 10075.0 10117.2 10486.4 9755.1 10157.5 10157.7 10231.7 10330.5 21:15:42 INFO - PROCESS | 26294 | -------- Summary: end -------- 21:15:42 INFO - PROCESS | 26294 | 21:15:43 INFO - TEST-INFO | 26294: exit 0 21:15:43 INFO - TEST-OK | dromaeo_css | took 1113063ms 21:15:43 INFO - TEST-START | kraken 21:15:43 INFO - operating with platform_type : linux_ 21:15:43 INFO - Initialising browser for kraken test... 21:15:43 INFO - TEST-INFO | started process 26487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLoxsgr/profile http://localhost:37518/getInfo.html) 21:15:46 INFO - PROCESS | 26487 | __metrics Screen width/height:1600/1200 21:15:46 INFO - PROCESS | 26487 | colorDepth:24 21:15:46 INFO - PROCESS | 26487 | Browser inner width/height: 1024/697 21:15:46 INFO - PROCESS | 26487 | __metrics 21:15:47 INFO - PROCESS | 26487 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:15:47 INFO - PROCESS | 26487 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:15:48 INFO - TEST-INFO | 26487: exit 0 21:15:48 INFO - Browser initialized. 21:15:48 INFO - Running cycle 1/1 for kraken test... 21:15:48 INFO - TEST-INFO | started process 26573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLoxsgr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:16:00 INFO - PROCESS | 26573 | RSS: Main: 157179904 21:16:00 INFO - PROCESS | 26573 | 21:16:02 INFO - PROCESS | 26573 | Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37518/tests/kraken/driver.html?testName=audio-beat-detection) 21:16:03 INFO - PROCESS | 26573 | RSS: Main: 217260032 21:16:03 INFO - PROCESS | 26573 | 21:16:06 INFO - PROCESS | 26573 | Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37518/tests/kraken/driver.html?testName=audio-dft) 21:16:07 INFO - PROCESS | 26573 | RSS: Main: 204767232 21:16:07 INFO - PROCESS | 26573 | 21:16:10 INFO - PROCESS | 26573 | Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37518/tests/kraken/driver.html?testName=audio-fft) 21:16:10 INFO - PROCESS | 26573 | RSS: Main: 269524992 21:16:10 INFO - PROCESS | 26573 | 21:16:12 INFO - PROCESS | 26573 | Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37518/tests/kraken/driver.html?testName=audio-oscillator) 21:16:13 INFO - PROCESS | 26573 | RSS: Main: 180469760 21:16:13 INFO - PROCESS | 26573 | 21:16:15 INFO - PROCESS | 26573 | Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37518/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:16:16 INFO - PROCESS | 26573 | RSS: Main: 185167872 21:16:16 INFO - PROCESS | 26573 | 21:16:19 INFO - PROCESS | 26573 | Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37518/tests/kraken/driver.html?testName=imaging-darkroom) 21:16:19 INFO - PROCESS | 26573 | RSS: Main: 219131904 21:16:19 INFO - PROCESS | 26573 | 21:16:23 INFO - PROCESS | 26573 | Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37518/tests/kraken/driver.html?testName=imaging-desaturate) 21:16:23 INFO - PROCESS | 26573 | RSS: Main: 221134848 21:16:23 INFO - PROCESS | 26573 | 21:16:26 INFO - PROCESS | 26573 | Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37518/tests/kraken/driver.html?testName=json-parse-financial) 21:16:27 INFO - PROCESS | 26573 | RSS: Main: 221569024 21:16:27 INFO - PROCESS | 26573 | 21:16:28 INFO - PROCESS | 26573 | Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37518/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:16:29 INFO - PROCESS | 26573 | RSS: Main: 208953344 21:16:29 INFO - PROCESS | 26573 | 21:16:30 INFO - PROCESS | 26573 | Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:16:31 INFO - PROCESS | 26573 | RSS: Main: 214151168 21:16:31 INFO - PROCESS | 26573 | 21:16:33 INFO - PROCESS | 26573 | Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:16:34 INFO - PROCESS | 26573 | RSS: Main: 212803584 21:16:34 INFO - PROCESS | 26573 | 21:16:36 INFO - PROCESS | 26573 | Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:16:37 INFO - PROCESS | 26573 | RSS: Main: 222511104 21:16:37 INFO - PROCESS | 26573 | 21:16:40 INFO - PROCESS | 26573 | Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:16:40 INFO - PROCESS | 26573 | RSS: Main: 223637504 21:16:40 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37518/tests/kraken/driver.html?testName=ai-astar) 21:16:42 INFO - PROCESS | 26573 | RSS: Main: 265506816 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | __start_tp_report 21:16:42 INFO - PROCESS | 26573 | _x_x_mozilla_page_load 21:16:42 INFO - PROCESS | 26573 | _x_x_mozilla_page_load_details 21:16:42 INFO - PROCESS | 26573 | |i|pagename|runs| 21:16:42 INFO - PROCESS | 26573 | |0;ai-astar;103;110;113;112;111;112;111;112;110;111 21:16:42 INFO - PROCESS | 26573 | |1;audio-beat-detection;148;124;118;170;122;120;140;117;160;116 21:16:42 INFO - PROCESS | 26573 | |2;audio-dft;162;159;169;161;160;161;161;161;160;162 21:16:42 INFO - PROCESS | 26573 | |3;audio-fft;75;75;74;110;75;76;75;74;98;74 21:16:42 INFO - PROCESS | 26573 | |4;audio-oscillator;84;84;117;84;84;84;120;85;84;123 21:16:42 INFO - PROCESS | 26573 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;117;117 21:16:42 INFO - PROCESS | 26573 | |6;imaging-darkroom;145;144;145;145;146;145;145;146;145;146 21:16:42 INFO - PROCESS | 26573 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;94;94 21:16:42 INFO - PROCESS | 26573 | |8;json-parse-financial;50;51;52;49;48;51;50;50;50;50 21:16:42 INFO - PROCESS | 26573 | |9;json-stringify-tinderbox;63;63;63;63;65;63;63;64;64;63 21:16:42 INFO - PROCESS | 26573 | |10;stanford-crypto-aes;75;75;76;84;81;75;80;77;74;81 21:16:42 INFO - PROCESS | 26573 | |11;stanford-crypto-ccm;129;129;119;134;120;126;120;117;188;119 21:16:42 INFO - PROCESS | 26573 | |12;stanford-crypto-pbkdf2;155;162;156;161;167;156;156;158;154;154 21:16:42 INFO - PROCESS | 26573 | |13;stanford-crypto-sha256-iterative;67;61;62;61;62;62;70;62;61;64 21:16:42 INFO - PROCESS | 26573 | __end_tp_report 21:16:42 INFO - PROCESS | 26573 | __start_cc_report 21:16:42 INFO - PROCESS | 26573 | _x_x_mozilla_cycle_collect,1634 21:16:42 INFO - PROCESS | 26573 | __end_cc_report 21:16:42 INFO - PROCESS | 26573 | __startTimestamp1468642602569__endTimestamp 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | ------- Summary: start ------- 21:16:42 INFO - PROCESS | 26573 | Number of tests: 14 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:2.80 (2.5%) stddev-sans-first:1.00 21:16:42 INFO - PROCESS | 26573 | Values: 103.0 110.0 113.0 112.0 111.0 112.0 111.0 112.0 110.0 111.0 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:132.00 stddev:19.75 (15.0%) stddev-sans-first:20.24 21:16:42 INFO - PROCESS | 26573 | Values: 148.0 124.0 118.0 170.0 122.0 120.0 140.0 117.0 160.0 116.0 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.00 stddev:2.76 (1.7%) stddev-sans-first:2.92 21:16:42 INFO - PROCESS | 26573 | Values: 162.0 159.0 169.0 161.0 160.0 161.0 161.0 161.0 160.0 162.0 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:12.67 (16.9%) stddev-sans-first:13.27 21:16:42 INFO - PROCESS | 26573 | Values: 75.0 75.0 74.0 110.0 75.0 76.0 75.0 74.0 98.0 74.0 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.00 stddev:17.38 (20.7%) stddev-sans-first:17.98 21:16:42 INFO - PROCESS | 26573 | Values: 84.0 84.0 117.0 84.0 84.0 84.0 120.0 85.0 84.0 123.0 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:16:42 INFO - PROCESS | 26573 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 21:16:42 INFO - PROCESS | 26573 | Values: 145.0 144.0 145.0 145.0 146.0 145.0 145.0 146.0 145.0 146.0 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 21:16:42 INFO - PROCESS | 26573 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:50.00 stddev:1.10 (2.2%) stddev-sans-first:1.17 21:16:42 INFO - PROCESS | 26573 | Values: 50.0 51.0 52.0 49.0 48.0 51.0 50.0 50.0 50.0 50.0 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 21:16:42 INFO - PROCESS | 26573 | Values: 63.0 63.0 63.0 63.0 65.0 63.0 63.0 64.0 64.0 63.0 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:78.50 stddev:3.43 (4.4%) stddev-sans-first:3.48 21:16:42 INFO - PROCESS | 26573 | Values: 75.0 75.0 76.0 84.0 81.0 75.0 80.0 77.0 74.0 81.0 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:127.50 stddev:21.11 (16.6%) stddev-sans-first:22.38 21:16:42 INFO - PROCESS | 26573 | Values: 129.0 129.0 119.0 134.0 120.0 126.0 120.0 117.0 188.0 119.0 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.90 Median:157.00 stddev:4.20 (2.7%) stddev-sans-first:4.32 21:16:42 INFO - PROCESS | 26573 | Values: 155.0 162.0 156.0 161.0 167.0 156.0 156.0 158.0 154.0 154.0 21:16:42 INFO - PROCESS | 26573 | 21:16:42 INFO - PROCESS | 26573 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:62.00 stddev:3.01 (4.9%) stddev-sans-first:2.86 21:16:42 INFO - PROCESS | 26573 | Values: 67.0 61.0 62.0 61.0 62.0 62.0 70.0 62.0 61.0 64.0 21:16:42 INFO - PROCESS | 26573 | -------- Summary: end -------- 21:16:42 INFO - PROCESS | 26573 | 21:16:43 INFO - TEST-INFO | 26573: exit 0 21:16:43 INFO - TEST-OK | kraken | took 60362ms 21:16:43 INFO - SUITE-END | took 1173s 21:16:43 INFO - Completed test suite (00:19:33) 21:16:43 INFO - javascript benchmark 21:16:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3018.3812318474716, 3033.9848300758495, 3054.2364408897784, 3065.5554944533055, 3096.5819614352054, 5274.235235890794, 5313.521783039526, 5354.170103633934, 5411.621186516945, 5439.184122381645, 5326.041312563737, 5354.598405119612, 5359.866003349918, 5385.35375754909, 5391.973040134803, 4840.975795121037, 4894.902101957959, 4914.361133052698, 4928.310036594861, 5081.085404627165, 4984.4018717753925, 4993.550580447759, 5028.899422011557, 5052.0906236877345, 5061.54446099851, 4755.619550435974, 4799.712017278939, 4810.182269014258, 4853.417589889201, 4858.562729354339, 4862.027594481118, 4864.100141473803, 4921.18800397934, 4937.037277730844, 4955.60355171589, 4731.313959475857, 4885.413750349945, 4901.460839307673, 4916.1888288432365, 4945.579625731817, 5271.182966640177, 5368.785248590052, 5381.7578208980685, 5415.918761218545, 5430.375506816687, 5727.656340619576, 5753.626014309057, 5770.682612456313, 5796.797112101099, 5801.564882633819, 5598.1602759585985, 5694.174344720034, 5739.713014349308, 5753.395893431171, 5788.04497257952, 5377.865553361158, 5459.672419654873, 5463.972680136574, 5470.753816078286, 5470.835874923719, 5941.465268125889, 5956.8808623828145, 5959.28488581373, 5960.016597261403, 5961.582689211714, 5503.064479038573, 5531.170324451365, 5565.471280228372, 5724.141378793214, 5737.340205876378, 5693.68684722336, 5742.684152371576, 5743.253377060955, 5744.253247077937, 5747.913781293284, 5619.7471113799975, 5664.065429204217, 5665.490105890407, 5666.320041594952, 5679.886402271932, 5480.616356854982, 5659.0, 5691.943080569225, 5746.683932383759, 5750.5112065474905, 4387.122575484916, 4390.714603550823, 4391.626711729475, 4392.121575684812, 4426.26966550522, 3898.688104951597, 3918.5101862267215, 3921.3333733265413, 3948.170884114311, 3963.286608410456, 5210.47895210476, 5314.415414304423, 5344.251804747339, 5369.979703856255, 5396.649217800909, 5733.741981610838, 5746.0519014363, 5750.108733146285, 5760.94239057604, 5802.6808525531505, 5395.190721391823, 5415.0, 5415.53967912724, 5419.376771671308, 5419.674819510842, 4674.322223277673, 4768.356271903318, 4788.473267940523, 4800.375951126401, 4872.78072486739, 5920.31916329619, 5928.110783382527, 5928.992071347795, 5931.792387266425, 5948.940510594839, 5745.3105627324985, 5756.136579513107, 5759.51044161251, 5768.077107662753, 5772.740226689725, 5707.343655479673, 5849.707514624337, 5851.824445266649, 5903.085021821625, 5943.851403714942, 5655.632383895034, 5685.971570142123, 5687.601867869375, 5692.31692196939, 5696.1455781633085, 5518.751656175402, 5770.3364113125845, 5771.884562308815, 5778.133280008033, 5791.594588378773, 5466.1527463243265, 5521.420250873601, 5528.253685752372, 5535.418781027934, 5539.169124631338, 5507.228987941771, 5524.889502209853, 5527.226188333556, 5530.695811730394, 5542.307211598551, 5394.919076213939, 5439.428859969805, 5455.645383050089, 5458.263134476795, 5515.834524964097, 5587.6088673794075, 5612.102063669957, 5668.291463567054, 5671.432856714296, 5674.4325567444575, 5447.918281225706, 5466.234727138124, 5483.369412517452, 5488.945110549003, 5496.780128794963], "value": 5275.21119086301, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.9822405327839, 600.9819705408838, 611.2237458427794, 616.1804799616508, 622.5424313129848, 33926.83036584817, 36739.081522961904, 36752.63247367529, 47070.76464617672, 47878.76060619692, 45161.0, 45578.772106139426, 45599.31601025987, 45632.771836140775, 45688.77155614226, 8918.19736223738, 9079.727608171732, 9096.0, 9098.135677110664, 9099.181073703365, 8957.283417326631, 9015.819683606323, 9047.95476022619, 9055.275577953747, 9059.637614495412, 9075.863862042042, 9114.134157255083, 9118.680846170351, 9125.315601329894, 9125.908740912571, 8997.775055623597, 9008.054154313768, 9039.864402033974, 9041.3671043027, 9045.819083618324, 8910.688125915562, 8984.416012959136, 8984.685536006275, 8986.0, 8986.415882967585, 37028.0, 37161.62838371609, 37211.627883721085, 37281.44077838834, 37324.0, 3358.714509266715, 3380.9830950845335, 3389.474631432132, 3437.2781715839706, 3519.771214871025, 33008.504872426936, 33283.6671633283, 34071.31857362839, 34088.65911340904, 34164.0, 4449.917243304674, 4491.595756381941, 4511.954880451219, 4695.765211739399, 4699.929501057487, 345699.27150364337, 346131.0, 346526.0, 347575.0, 348036.0, 59729.402705973254, 60666.393336066954, 61136.0, 61262.69368653218, 61294.38705612887, 61025.38974610197, 61256.38743612596, 61890.0, 62131.06803397953, 62163.06755398673, 17053.48839534816, 17252.223649935782, 17270.05014724177, 17273.309067637405, 17292.567685807957, 13201.20792752438, 13241.73516529664, 13257.072004959753, 13270.469181232836, 13274.137181083199, 16923.238454269587, 17843.28626854937, 17863.0, 18012.459626211235, 18065.7290140648, 6632.734690612418, 6653.667316634149, 6693.665316734144, 6760.966195169091, 6839.487038472134, 945.6831961293044, 947.772534591693, 1086.918481113904, 1088.4992903264429, 1166.7433164703752, 31816.840915795274, 32023.839880800446, 32159.678403216138, 32351.19122021921, 32389.35221295608, 899.1772528136681, 986.8371718666483, 991.306085739985, 1011.8801111671038, 1123.2642619084513, 16450.424235151953, 16823.915880420518, 16838.24227909747, 16968.74546881798, 16995.74506382405, 536435.0, 540365.0, 541752.0, 542093.0534862522, 543717.0, 60704.69647651733, 60776.69611652002, 60820.695896520236, 60912.69543652253, 60924.0, 1238.294172321768, 1357.3077730357588, 1375.6010756880391, 1399.1605036977733, 1404.810350602676, 32138.83930580332, 33659.66340336565, 33812.323753525285, 33970.66029339675, 34360.0, 56248.71875640596, 58246.4175358241, 58355.416445836694, 61924.0, 62299.377006229355, 491550.0, 498129.0, 498286.0, 498916.0, 499581.0, 24599.631005534575, 25304.240872773848, 25853.482930341663, 27949.441011180068, 29920.401591968475, 48009.27986080282, 48506.5149348502, 48534.514654853, 48883.51116488932, 50211.0, 40552.391714124904, 40733.1853362937, 41624.79187604043, 41843.7907810459, 41918.0, 40158.79920600495, 41441.1711765769, 41453.58546414618, 41624.1675166501, 41656.58343416648, 41139.588604113575, 41180.0, 42314.15371692611, 42617.1476570473, 45044.77477612591, 34503.82748086344, 36741.44887826738, 37185.62814371822, 37994.0, 38308.80588658758, 28256.717432825408, 28559.857200713865, 28920.13239602815, 29101.7089829099, 29114.41771164607], "value": 20307.095546101973, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.42559883378425, 379.5843551311314, 385.70300868331367, 390.85147643895317, 405.691674327511, 18404.907975460137, 19408.90295548524, 20425.591488170227, 20471.488212794688, 20497.99999999998, 18303.0, 19067.618647627038, 19228.13473393697, 19488.512787180327, 19550.217991280333, 5445.1832225166145, 5501.477359650837, 5649.322081350244, 5659.462351076641, 5664.971675141639, 5555.611107222496, 5591.7483713233005, 5623.381428042912, 5654.434556544354, 5660.773569057254, 5405.756740946647, 5425.83722488324, 5500.944990550103, 5634.830955071355, 5647.7458514366745, 5468.043092458804, 5481.616286859921, 5486.588505862076, 5492.945070549284, 5497.835064948058, 4808.374911261549, 4825.7587120644175, 4861.73260470674, 4915.901681966377, 4923.655344125913, 23143.305700828834, 23330.883345583334, 23565.764342356528, 23638.527229455485, 23696.0, 2490.1906880263805, 2491.352248415425, 2506.248125562324, 2529.8229123961146, 2574.00900653248, 14120.364583593762, 14190.787138192936, 14343.928280358636, 14496.347664355024, 14681.650935850214, 1927.1831371475555, 1929.488685498344, 1988.3745834723852, 1998.840533750875, 2020.454477291138, 61501.0, 81038.59480702618, 82376.58811705903, 82576.17423825744, 82825.0, 9660.792400949882, 9894.109530142321, 10112.241581881388, 10135.64525241613, 10388.688339349832, 13863.0, 13917.23455209953, 13930.512432065032, 13959.232242226572, 13963.092398994237, 8015.998000249969, 8072.798180045545, 8075.434719569691, 8129.1464396238725, 8264.132266112092, 8143.6742530298125, 8227.876581851277, 8303.459111679073, 8367.0, 8406.663733450716, 6541.411272985454, 6549.803505894735, 6605.735770569124, 6609.570377925419, 6622.63575503352, 1700.542715775717, 1708.5728567858037, 1753.8947663140252, 1792.8834625749284, 1796.1288774944142, 980.8528720691811, 1016.0347669713801, 1049.1606714628267, 1121.4056550028497, 1121.6354684727496, 18234.54413639643, 20142.0, 20197.192112315635, 20214.797852021587, 20263.594728105356, 1023.8924912884189, 1046.5970601318395, 1051.600391851107, 1092.639428988432, 1094.9124070074374, 10798.892011079946, 11462.770744585228, 11479.426028698532, 11526.94236528812, 11582.536698531965, 445932.0, 458981.0, 481995.0, 482122.0, 483145.0, 57989.71005145032, 75496.81449094316, 79218.0, 82697.58651206705, 84356.0, 991.306085739985, 1012.3116280929039, 1036.108946306176, 1044.6239353832614, 1045.362328979322, 13988.790168147689, 16877.0, 17080.74378884293, 17335.82664173342, 18562.44312670622, 40226.0, 43938.0, 44191.33712994243, 44475.77762111169, 44616.0, 58192.709036454544, 58926.116108259266, 59228.70385648044, 59246.0, 59430.0, 8123.431359804993, 8286.212809783061, 8346.457480264005, 8416.705415310435, 8517.701880434155, 9595.23238140933, 12333.506659733868, 12953.287569183785, 13132.540361087316, 13277.66805829862, 10537.525811338355, 11387.886121139014, 11704.473298701409, 11718.531258749554, 12154.635360939186, 10879.619213327496, 11163.051140653135, 11203.551857925591, 11218.831717524406, 11565.768684626428, 11555.084766934677, 11742.823857642314, 12203.511859525519, 12452.813207802072, 12483.188592741442, 8501.787455313419, 8502.44734092282, 8617.353698472765, 8665.523396213268, 8837.734867953972, 11062.502187401748, 11371.0, 11808.527658893549, 11856.288622682667, 12166.57416990401], "value": 9256.368886068292, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.7667611520214, 1530.5178868656371, 1701.5831121375256, 1768.4782989018238, 1828.4514645606323, 8902.421342612726, 9358.29812764042, 9416.482093484856, 9424.623015079405, 9468.384555003928, 8040.8391832163325, 8785.428947118433, 9035.81928361434, 9049.592768325425, 9210.032946540618, 2303.0442366417915, 2325.476767727265, 2328.0571368595747, 2332.568474832153, 2334.708161479815, 2310.341552657493, 2322.1408079010707, 2347.9765202348012, 2348.753380895007, 2355.1403737635724, 2024.4635171679442, 2098.842586805988, 2241.3051953894346, 2309.2033248529315, 2315.4674424882287, 2319.373769082347, 2321.872297023663, 2337.55586438577, 2339.6724458575814, 2363.279199844047, 2297.127091705158, 2297.150054479853, 2298.8735619540917, 2303.1133013789813, 2306.1006207579057, 8810.33922455812, 8882.289416846701, 8898.4660920345, 8902.73291801247, 8973.28213742899, 4993.0, 5063.139266324733, 5067.366579177603, 5073.923891141636, 5082.618803589746, 3193.4730769423018, 3243.172990887332, 3274.590676165479, 3299.3236386540943, 3341.3150304187825, 1015.5836107196014, 1017.9338343007681, 1033.194108595297, 1033.3696445168441, 1060.2790102730216, 12019.21875078126, 12044.638660840188, 12052.939735301268, 12080.456379462858, 12099.213551119148, 4267.701260911768, 4269.18885411777, 4443.511213766483, 4444.933326000112, 4503.729776213438, 10108.24188185889, 10196.949015254877, 10277.17782577392, 10290.279680422298, 10299.897001030044, 5015.6489045767175, 5054.393472783216, 5054.418741844662, 5055.368078990126, 5057.31726216956, 4577.771111444415, 4598.494165641777, 4630.953690463052, 4633.72197668141, 4715.905681886343, 3988.202359528106, 3996.200759848042, 4041.9595804041583, 4050.473438453041, 4100.323446631332, 1137.1244142010771, 1194.8028575285155, 1224.2960297828783, 1227.6808029912108, 1234.3766397969148, 916.935814492979, 977.3695966101825, 979.911807937289, 1004.7437903334749, 1007.1727435744143, 6089.604175728564, 6118.449339559461, 6275.905861412082, 6318.747250109944, 6391.9243202507305, 1005.4721271332609, 1015.2588610314511, 1022.9181665466745, 1030.6501177315731, 1039.2673165418362, 4029.5567487576345, 4102.118044620421, 4258.403823464718, 4339.7396156230725, 4340.370646256275, 11453.541858325574, 11592.826107608393, 11793.941030294794, 11833.0, 11842.111841611913, 10495.737606559744, 11687.590934317259, 11693.532258709556, 11711.941440292743, 11721.238119522204, 8231.42380033392, 8561.44350617208, 8587.742367728979, 8733.30133589324, 8754.212120909022, 6038.486728628116, 6163.537734670007, 6275.403836635513, 6298.71655775482, 6313.96843015782, 10616.469176541297, 10730.83903741429, 10863.891361086287, 10875.0, 10886.673399797703, 10689.679309620724, 10860.131189504662, 10920.508577114208, 11169.72075698114, 11191.048760855418, 8104.554249516334, 8104.594770261346, 8143.6742530298125, 8151.673933042849, 8163.83672326562, 8255.752327430188, 8562.828743425222, 8830.337724670548, 8902.42134261271, 8912.242459390765, 6243.625382477066, 7994.440389172702, 8197.221263979913, 8323.583820808813, 8380.413371063967, 7810.843783124419, 7943.721969731032, 7993.12075671664, 8065.556394398364, 8250.54621995796, 6880.208775990825, 6919.238883722887, 6941.097657304518, 6952.270011648907, 6956.165260168812, 4731.858044258678, 4748.287756836502, 4754.358161648133, 4795.328653988514, 4853.466118727008, 5146.0737067326745, 5173.1464308388695, 5212.635115542027, 5278.3637072507645, 5382.757775900016], "value": 4685.803591034908, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.1908523327947, 315.8120918053758, 320.98716051357945, 323.7765941500366, 326.4760060103534, 5090.287359769626, 5154.896902061956, 5318.122509785885, 5334.359876814783, 5344.679319240843, 5117.539421452068, 5233.8953220935555, 5244.501772331632, 5258.8685282867855, 5269.209618557218, 4111.814968326433, 4124.19554702802, 4125.525564560069, 4132.0, 4136.931534232884, 3852.8266228019666, 3891.1633998690277, 4082.9387559186634, 4147.108371700084, 4150.750954942698, 4098.733582317155, 4106.178764247147, 4112.6298633123015, 4116.300228961084, 4124.57702092779, 4066.3900414938, 4088.1823635272917, 4094.426780250782, 4106.548279689232, 4115.34154535276, 3418.6923176914197, 3625.7099432045375, 3627.3289441453417, 3634.3276493848457, 3636.6181550937035, 5119.129747942859, 5138.3577052868395, 5148.330717006766, 5152.433232344439, 5172.715500647463, 4627.838025669085, 4633.9536604634195, 4651.372064771246, 4665.603423708955, 4681.859544213679, 5327.440618735054, 5343.679379237219, 5448.237246785453, 5480.177973304037, 5488.121900495941, 3873.12854607711, 3882.864099756495, 3889.0666240102455, 3891.2606604745006, 3897.9670387347373, 5675.694590244226, 5686.071673088321, 5692.857678558028, 5708.71456427177, 5753.971230143822, 3953.8418463261723, 3960.2277555876326, 3961.74248673841, 3981.2634662587516, 3992.401139828991, 3821.8471261149243, 4015.0765323975647, 4035.8183881725395, 4048.352263637804, 4066.4916885389325, 4659.673822832369, 4663.48701642819, 4663.580277775017, 4664.673472856867, 4669.7431641260055, 5434.8913021739345, 5465.180222966507, 5540.722963851791, 5553.861153471195, 5557.110862262019, 1281.8013207952781, 1304.6999190186311, 1385.9514916977857, 1388.1116085705157, 1393.2824595333411, 912.1425859692001, 926.4302453990747, 937.9624815007323, 940.7365937537501, 941.3786900645541, 5264.184051472028, 5265.236540701577, 5265.447128051576, 5270.472952704776, 5277.604179686539, 5569.526590239875, 5578.191162281447, 5585.58108141891, 5593.748281327269, 5596.300462442195, 5052.191649336089, 5203.609729270244, 5234.712090835041, 5254.0805359062015, 5355.892882142335, 3000.324926891432, 3005.2269161195, 3019.290466740314, 3027.848607569613, 3029.6515900671266, 5828.94171058284, 5851.268591426072, 5851.444112809277, 5854.2389489366105, 5860.794872179454, 5592.916106258409, 5783.797567085132, 5805.36141024487, 5814.622049566765, 5834.883302333929, 5779.88440231193, 5809.912851307149, 5819.185314055951, 5846.590738648254, 5846.970765146147, 5452.918206226989, 5636.746346414503, 5650.869826034727, 5685.971570142123, 5697.4302569742695, 5529.281193444826, 5560.221568980427, 5564.638298510584, 5586.888262234814, 5601.271834661468, 5824.184614153937, 5835.67903765297, 5852.488506895828, 5853.590248682552, 5870.442307980735, 3583.4087375582735, 3727.8881633551036, 3859.324618191861, 3944.822482988215, 3962.4942521841517, 5529.695866727207, 5555.611107222618, 5563.471470210324, 5619.353774316006, 5654.15187721845, 5469.371022332482, 5476.17857321405, 5486.478784515464, 5495.422980586981, 5511.925174591077, 5258.342707161605, 5478.835634930959, 5575.553955683455, 5576.0, 5592.384837667934, 5475.808346707846, 5499.102809530706, 5513.5037846594, 5518.779248830002, 5527.0, 5259.47405259471, 5548.361938377138, 5566.610337276352, 5569.220309156641, 5597.440255974533, 5467.753951072132, 5480.766347854785, 5488.051741631663, 5509.201165831012, 5509.421510741315], "value": 4180.427175425123, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.9370450363972, 808.8220591469875, 809.0816922792633, 821.5070957425545, 860.384824850232, 14384.784228236571, 15553.0, 15691.05853648779, 15715.214239288047, 15737.52787416378, 13255.204687718744, 13445.529406470776, 13491.730165396686, 13499.730005399912, 13518.121322114055, 671.214678825775, 788.684526189523, 797.338209286291, 819.5902048975512, 820.335528222139, 821.0557858462756, 830.9210624990646, 832.2218725491655, 833.945793523422, 835.0772396501869, 868.3964644572025, 876.583622779178, 878.8110556230409, 880.8062226310202, 881.7575166829109, 693.7329128285621, 826.9710560130367, 846.1031306814796, 868.7567481105301, 871.4074429388014, 619.5693992675093, 620.0853740732383, 620.3238470067603, 620.3548309757847, 620.3734228429274, 14261.857381426156, 14313.78529322061, 14323.713525729427, 14328.068675536057, 14340.0, 13103.541376051888, 13143.211407315495, 13156.802647960289, 13254.403551840094, 13708.45166193351, 12825.807612885814, 12882.742345153138, 12984.28586427746, 12986.155899866573, 13296.933515332457, 4416.977915110436, 4446.088551846864, 4465.82136714531, 4497.347884556721, 4552.863414097583, 75631.24368756296, 76090.0, 76304.61847690726, 78444.60777696132, 78810.60594697105, 11163.162762792661, 11188.888111118948, 11265.71835704114, 11545.076393888468, 11602.303861768321, 21573.352799416043, 21575.0, 21731.13075476963, 21883.890580546995, 21900.89049554742, 7900.84198316042, 8359.791005224917, 8681.869771953427, 8918.241949434241, 9316.44101353921, 4684.110019096361, 4893.339399181136, 4917.754112294371, 4950.108980383494, 5110.28456016158, 3424.7088997435, 3549.1836877518317, 3552.5914519830035, 3553.8400771965325, 3558.2705545363137, 610.9327973922865, 619.6375120554526, 620.4044117647019, 638.1002786071709, 638.3743930947604, 631.4001698386551, 666.4068978609042, 701.6526819224415, 741.4142827166586, 764.9158592554815, 9390.906090939003, 9441.575129119206, 10004.19966402686, 10069.043440873105, 10168.084872361524, 705.7247673407376, 719.6078137415121, 725.7097161135588, 765.1583258415809, 767.6430459836203, 4581.748003859753, 4798.424189097331, 4879.585235255043, 4901.705897646081, 4911.45973942866, 68524.0, 69502.0, 80668.0, 117791.41104294424, 118233.0, 93181.0, 96842.51578742202, 97143.0, 97443.0, 98738.50630746801, 84250.0, 84770.0, 85903.57048214719, 88502.55748721215, 88779.55610222036, 8883.156100170474, 8965.0, 9061.456312621263, 9141.177294043568, 9243.907560924574, 51008.48991510186, 51790.74104629603, 52460.213096802814, 53244.73377633242, 53298.73350633222, 68875.0, 73797.26202737904, 73877.6306118466, 74416.62791686007, 74845.6257718708, 11547.249428787438, 11654.592089276835, 11728.824067639163, 12154.513819447124, 12594.055445841781, 13044.54344097952, 13174.816808733516, 13388.598342049754, 13411.731765364442, 13689.24709140967, 12640.6839829005, 12857.421416036488, 12953.0, 12959.287239201934, 13042.282674452617, 11743.88256117428, 12218.694532636755, 12219.0, 12248.510059597873, 12516.374181290717, 10946.0, 11506.252093613888, 11512.42437878086, 11537.538498460304, 11884.46519906589, 9720.708378748648, 10061.195104391485, 10074.972622356969, 10117.241206909659, 10486.423246721504, 9755.146522160767, 10157.492125393554, 10157.746056348355, 10231.744206394602, 10330.535125919501], "value": 7386.752115350806, "unit": "score"}], "name": "dromaeo_css", "value": 7235.5587255844885, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 113.0, 112.0, 111.0, 112.0, 111.0, 112.0, 110.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 124.0, 118.0, 170.0, 122.0, 120.0, 140.0, 117.0, 160.0, 116.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 169.0, 161.0, 160.0, 161.0, 161.0, 161.0, 160.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 110.0, 75.0, 76.0, 75.0, 74.0, 98.0, 74.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 117.0, 84.0, 84.0, 84.0, 120.0, 85.0, 84.0, 123.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 52.0, 49.0, 48.0, 51.0, 50.0, 50.0, 50.0, 50.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 65.0, 63.0, 63.0, 64.0, 64.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 84.0, 81.0, 75.0, 80.0, 77.0, 74.0, 81.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 119.0, 134.0, 120.0, 126.0, 120.0, 117.0, 188.0, 119.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 162.0, 156.0, 161.0, 167.0, 156.0, 156.0, 158.0, 154.0, 154.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 61.0, 62.0, 61.0, 62.0, 62.0, 70.0, 62.0, 61.0, 64.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1480.3, "alertThreshold": 2.0}]} 21:16:43 INFO - Return code: 0 21:16:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:16:43 INFO - # TBPL SUCCESS # 21:16:43 INFO - Running post-action listener: _resource_record_post_action 21:16:43 INFO - ##### 21:16:43 INFO - ##### Finished run-tests step (success) 21:16:43 INFO - ##### 21:16:43 INFO - Running post-run listener: _resource_record_post_run 21:16:43 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 555761664; Read time: 0; Write time: 436412 21:16:43 INFO - TinderboxPrint: CPU usage
13.0% 21:16:43 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:16:43 INFO - TinderboxPrint: I/O write bytes / time
555,761,664 / 436,412 21:16:43 INFO - TinderboxPrint: CPU idle
8,270.6 (87.0%) 21:16:43 INFO - TinderboxPrint: CPU user
1,192.9 (12.5%) 21:16:43 INFO - TinderboxPrint: Swap in / out
0 / 0 21:16:43 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 256884736; Read time: 0; Write time: 232724 21:16:43 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 298262528; Read time: 0; Write time: 203688 21:16:44 INFO - Running post-run listener: _upload_blobber_files 21:16:44 INFO - Blob upload gear active. 21:16:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:16:44 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 21:16:44 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'] 21:16:44 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 21:16:44 INFO - (blobuploader) - INFO - Open directory for files ... 21:16:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:16:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:16:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:16:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:16:45 INFO - (blobuploader) - INFO - Done attempting. 21:16:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:16:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:16:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:16:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:16:48 INFO - (blobuploader) - INFO - Done attempting. 21:16:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:16:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:16:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:16:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:16:49 INFO - (blobuploader) - INFO - Done attempting. 21:16:49 INFO - (blobuploader) - INFO - Iteration through files over. 21:16:49 INFO - Return code: 0 21:16:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:16:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:16:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe84cf7ccfc3a1588ba887032fd9aab2e7933f4296b63454a7e1117cfadac7d07c0de91d95db0d030b396a00423383ca556ae47ddd317e1e7bb926fea6810fd8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f255c5df9bf20692a20f0b39097227770b160c07ec54460cf1bdb15b703328aba6b3f55aa7c70ee4ab58c1d0e4c90cb30c7fcd06f3076fb6b4a03e25d5c63f5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1db8e2478adaddb8048219293000132fa0c12a10b8edbe66186b8d2049424314249bf5dc683bb4eb9b34721846ac8cad6865a1f47068657a62c616412f32e1cd"} 21:16:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:16:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:16:49 INFO - Contents: 21:16:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe84cf7ccfc3a1588ba887032fd9aab2e7933f4296b63454a7e1117cfadac7d07c0de91d95db0d030b396a00423383ca556ae47ddd317e1e7bb926fea6810fd8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f255c5df9bf20692a20f0b39097227770b160c07ec54460cf1bdb15b703328aba6b3f55aa7c70ee4ab58c1d0e4c90cb30c7fcd06f3076fb6b4a03e25d5c63f5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1db8e2478adaddb8048219293000132fa0c12a10b8edbe66186b8d2049424314249bf5dc683bb4eb9b34721846ac8cad6865a1f47068657a62c616412f32e1cd"} 21:16:49 INFO - Running post-run listener: copy_logs_to_upload_dir 21:16:49 INFO - Copying logs to upload dir... 21:16:49 INFO - mkdir: /builds/slave/test/build/upload/logs 21:16:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.679093 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-15 21:16:49.355205) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 21:16:49.358707) ========= 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=31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe84cf7ccfc3a1588ba887032fd9aab2e7933f4296b63454a7e1117cfadac7d07c0de91d95db0d030b396a00423383ca556ae47ddd317e1e7bb926fea6810fd8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f255c5df9bf20692a20f0b39097227770b160c07ec54460cf1bdb15b703328aba6b3f55aa7c70ee4ab58c1d0e4c90cb30c7fcd06f3076fb6b4a03e25d5c63f5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1db8e2478adaddb8048219293000132fa0c12a10b8edbe66186b8d2049424314249bf5dc683bb4eb9b34721846ac8cad6865a1f47068657a62c616412f32e1cd"} build_url:https://queue.taskcluster.net/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/SCg5BjL0QLW3JSy3hIu_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe84cf7ccfc3a1588ba887032fd9aab2e7933f4296b63454a7e1117cfadac7d07c0de91d95db0d030b396a00423383ca556ae47ddd317e1e7bb926fea6810fd8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f255c5df9bf20692a20f0b39097227770b160c07ec54460cf1bdb15b703328aba6b3f55aa7c70ee4ab58c1d0e4c90cb30c7fcd06f3076fb6b4a03e25d5c63f5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1db8e2478adaddb8048219293000132fa0c12a10b8edbe66186b8d2049424314249bf5dc683bb4eb9b34721846ac8cad6865a1f47068657a62c616412f32e1cd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 21:16:49.383356) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 21:16:49.383643) ========= 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=31acecf42b6a79ec49471d4a000001bb-1468639538.140531-1026546980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 21:16:49.465641) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 21:16:49.465915) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 21:16:49.466165) ========= ========= Total master_lag: 0.16 =========