builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1467262740.74 results: success (0) buildid: 20160629183001 builduid: ebdc124328364bb6b8bc0a794fb64b6e revision: 0edb9df3c97ff7d205a99f8af607f99a858f140b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 21:59:00.737705) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 21:59:00.738365) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 21:59:00.738721) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 21:59:00.826065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 21:59:00.826372) ========= 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=db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 21:59:01-- 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% 50.2K=0.2s 2016-06-29 21:59:01 (50.2 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.324993 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 21:59:01.173669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 21:59:01.174015) ========= 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=db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021441 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 21:59:01.226556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 21:59:01.227298) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0edb9df3c97ff7d205a99f8af607f99a858f140b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 0edb9df3c97ff7d205a99f8af607f99a858f140b --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=db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 21:59:01,559 truncating revision to first 12 chars 2016-06-29 21:59:01,560 Setting DEBUG logging. 2016-06-29 21:59:01,560 attempt 1/10 2016-06-29 21:59:01,560 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0edb9df3c97f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 21:59:01,887 unpacking tar archive at: autoland-0edb9df3c97f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712933 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 21:59:01.956415) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 21:59:01.956833) ========= script_repo_revision: 0edb9df3c97ff7d205a99f8af607f99a858f140b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 21:59:01.957346) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 21:59:01.957736) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 21:59:01.968073) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-29 21:59:01.968436) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:59:02 INFO - MultiFileLogger online at 20160629 21:59:02 in /builds/slave/test 21:59:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:59:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:59:02 INFO - {'append_to_log': False, 21:59:02 INFO - 'base_work_dir': '/builds/slave/test', 21:59:02 INFO - 'blob_upload_branch': 'Autoland', 21:59:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:59:02 INFO - 'branch': 'Autoland', 21:59:02 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:02 INFO - 'config_files': ('talos/linux_config.py',), 21:59:02 INFO - 'default_actions': ('clobber', 21:59:02 INFO - 'read-buildbot-config', 21:59:02 INFO - 'download-and-extract', 21:59:02 INFO - 'populate-webroot', 21:59:02 INFO - 'create-virtualenv', 21:59:02 INFO - 'install', 21:59:02 INFO - 'run-tests'), 21:59:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:02 INFO - 'download_minidump_stackwalk': True, 21:59:02 INFO - 'download_symbols': 'ondemand', 21:59:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:02 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:02 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:02 INFO - 'installer_path': 'installer.exe', 21:59:02 INFO - 'log_level': 'info', 21:59:02 INFO - 'log_name': 'talos', 21:59:02 INFO - 'log_to_console': True, 21:59:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:59:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:59:02 INFO - 'opt_config_files': (), 21:59:02 INFO - 'pip_index': False, 21:59:02 INFO - 'sps_profile': False, 21:59:02 INFO - 'sps_profile_interval': 0, 21:59:02 INFO - 'suite': 'dromaeojs', 21:59:02 INFO - 'system_bits': '32', 21:59:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:02 INFO - 'title': 'talos-linux64-ix-049', 21:59:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:02 INFO - 'use_talos_json': True, 21:59:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:59:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:02 INFO - 'work_dir': 'build'} 21:59:02 INFO - ##### 21:59:02 INFO - ##### Running clobber step. 21:59:02 INFO - ##### 21:59:02 INFO - Running pre-action listener: _resource_record_pre_action 21:59:02 INFO - Running main action method: clobber 21:59:02 INFO - rmtree: /builds/slave/test/build 21:59:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:59:03 INFO - Running post-action listener: _resource_record_post_action 21:59:03 INFO - ##### 21:59:03 INFO - ##### Finished clobber step (success) 21:59:03 INFO - ##### 21:59:03 INFO - ##### 21:59:03 INFO - ##### Running read-buildbot-config step. 21:59:03 INFO - ##### 21:59:03 INFO - Running pre-action listener: _resource_record_pre_action 21:59:03 INFO - Running main action method: read_buildbot_config 21:59:03 INFO - Using buildbot properties: 21:59:03 INFO - { 21:59:03 INFO - "project": "", 21:59:03 INFO - "product": "firefox", 21:59:03 INFO - "script_repo_revision": "production", 21:59:03 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 21:59:03 INFO - "repository": "", 21:59:03 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 21:59:03 INFO - "buildid": "20160629183001", 21:59:03 INFO - "pgo_build": "True", 21:59:03 INFO - "basedir": "/builds/slave/test", 21:59:03 INFO - "buildnumber": 4, 21:59:03 INFO - "slavename": "talos-linux64-ix-049", 21:59:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:59:03 INFO - "platform": "ubuntu64_hw", 21:59:03 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 21:59:03 INFO - "branch": "autoland", 21:59:03 INFO - "repo_path": "integration/autoland", 21:59:03 INFO - "revision": "0edb9df3c97ff7d205a99f8af607f99a858f140b", 21:59:03 INFO - "stage_platform": "linux64-pgo", 21:59:03 INFO - "builduid": "ebdc124328364bb6b8bc0a794fb64b6e", 21:59:03 INFO - "slavebuilddir": "test" 21:59:03 INFO - } 21:59:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 21:59:03 INFO - Running post-action listener: _resource_record_post_action 21:59:03 INFO - ##### 21:59:03 INFO - ##### Finished read-buildbot-config step (success) 21:59:03 INFO - ##### 21:59:03 INFO - ##### 21:59:03 INFO - ##### Running download-and-extract step. 21:59:03 INFO - ##### 21:59:03 INFO - Running pre-action listener: _resource_record_pre_action 21:59:03 INFO - Running main action method: download_and_extract 21:59:03 INFO - mkdir: /builds/slave/test/build/tests 21:59:03 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')]} 21:59:03 INFO - https://queue.taskcluster.net/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:59:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:59:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:59:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/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 21:59:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/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 21:59:05 INFO - Downloaded 1361 bytes. 21:59:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:59:05 INFO - Using the following test package requirements: 21:59:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:59:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:59:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:05 INFO - u'jsshell-linux-x86_64.zip'], 21:59:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:59:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:59:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:59:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:59:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:59:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:59:05 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')]} 21:59:05 INFO - https://queue.taskcluster.net/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:59:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:59:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/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 21:59:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/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 21:59:08 INFO - Downloaded 24267521 bytes. 21:59:08 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'] 21:59:08 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 21:59:09 INFO - Return code: 0 21:59:09 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 21:59: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')]} 21:59:09 INFO - https://queue.taskcluster.net/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:59:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:59:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/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 21:59:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/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 21:59:18 INFO - Downloaded 24267521 bytes. 21:59:18 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'] 21:59:18 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 21:59:20 INFO - Return code: 0 21:59: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')]} 21:59:20 INFO - https://queue.taskcluster.net/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:59:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/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 21:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/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 21:59:21 INFO - Downloaded 14405245 bytes. 21:59:21 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'] 21:59:21 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 21:59:21 INFO - Return code: 0 21:59:21 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')]} 21:59:21 INFO - https://queue.taskcluster.net/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:59:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:59:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:59:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/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 21:59:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/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 21:59:25 INFO - Downloaded 60341886 bytes. 21:59:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:59:25 INFO - mkdir: /builds/slave/test/properties 21:59:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:59:25 INFO - Writing to file /builds/slave/test/properties/build_url 21:59:25 INFO - Contents: 21:59:25 INFO - build_url:https://queue.taskcluster.net/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:59:26 INFO - Running post-action listener: _resource_record_post_action 21:59:26 INFO - Running post-action listener: set_extra_try_arguments 21:59:26 INFO - ##### 21:59:26 INFO - ##### Finished download-and-extract step (success) 21:59:26 INFO - ##### 21:59:26 INFO - ##### 21:59:26 INFO - ##### Running populate-webroot step. 21:59:26 INFO - ##### 21:59:26 INFO - Running pre-action listener: _resource_record_pre_action 21:59:26 INFO - Running main action method: populate_webroot 21:59:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:26 INFO - '--tppagecycles', 21:59:26 INFO - '7'], 21:59:26 INFO - 'tests': ['tsvgm']}}, 21:59:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:59:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:59:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:59:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:59:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:59:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:26 INFO - 'talos_options': ['--disable-e10s'], 21:59:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:26 INFO - 'talos_options': ['--disable-e10s'], 21:59:26 INFO - 'tests': ['damp', 'tps']}, 21:59:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:26 INFO - 'tests': ['damp', 'tps']}, 21:59:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:59:26 INFO - 'tests': ['dromaeo_dom']}, 21:59:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:59:26 INFO - 'tests': ['basic_compositor_video']}, 21:59:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:59:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:59:26 INFO - 'tests': ['a11yr', 21:59:26 INFO - 'ts_paint', 21:59:26 INFO - 'tpaint', 21:59:26 INFO - 'sessionrestore', 21:59:26 INFO - 'sessionrestore_no_auto_restore', 21:59:26 INFO - 'tabpaint']}, 21:59:26 INFO - 'other-e10s': {'tests': ['a11yr', 21:59:26 INFO - 'ts_paint', 21:59:26 INFO - 'tpaint', 21:59:26 INFO - 'sessionrestore', 21:59:26 INFO - 'sessionrestore_no_auto_restore', 21:59:26 INFO - 'tabpaint']}, 21:59:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:59:26 INFO - 'ts_paint', 21:59:26 INFO - 'tpaint', 21:59:26 INFO - 'sessionrestore', 21:59:26 INFO - 'sessionrestore_no_auto_restore', 21:59:26 INFO - 'tabpaint']}, 21:59:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:59:26 INFO - 'ts_paint', 21:59:26 INFO - 'tpaint', 21:59:26 INFO - 'sessionrestore', 21:59:26 INFO - 'sessionrestore_no_auto_restore', 21:59:26 INFO - 'tabpaint']}, 21:59:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:59:26 INFO - 'tests': ['a11yr', 21:59:26 INFO - 'ts_paint', 21:59:26 INFO - 'tpaint', 21:59:26 INFO - 'sessionrestore', 21:59:26 INFO - 'sessionrestore_no_auto_restore', 21:59:26 INFO - 'tabpaint']}, 21:59:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:59:26 INFO - 'tests': ['a11yr', 21:59:26 INFO - 'ts_paint', 21:59:26 INFO - 'tpaint', 21:59:26 INFO - 'sessionrestore', 21:59:26 INFO - 'sessionrestore_no_auto_restore', 21:59:26 INFO - 'tabpaint']}, 21:59:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:59:26 INFO - 'tests': ['tsvgx', 21:59:26 INFO - 'tsvgr_opacity', 21:59:26 INFO - 'tart', 21:59:26 INFO - 'tscrollx', 21:59:26 INFO - 'cart']}, 21:59:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:59:26 INFO - 'tsvgr_opacity', 21:59:26 INFO - 'tart', 21:59:26 INFO - 'tscrollx', 21:59:26 INFO - 'cart']}, 21:59:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:26 INFO - 'talos_options': ['--disable-e10s'], 21:59:26 INFO - 'tests': ['tp5o']}, 21:59:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:26 INFO - 'tests': ['tp5o']}, 21:59:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:26 INFO - 'talos_options': ['--disable-e10s', 21:59:26 INFO - '--xperf_path', 21:59:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:26 INFO - 'tests': ['tp5n']}, 21:59:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:26 INFO - 'talos_options': ['--xperf_path', 21:59:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:26 INFO - 'tests': ['tp5n']}}, 21:59:26 INFO - 'talos.zip': {'path': '', 21:59:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:26 INFO - Running post-action listener: _resource_record_post_action 21:59:26 INFO - ##### 21:59:26 INFO - ##### Finished populate-webroot step (success) 21:59:26 INFO - ##### 21:59:26 INFO - ##### 21:59:26 INFO - ##### Running create-virtualenv step. 21:59:26 INFO - ##### 21:59:26 INFO - Running pre-action listener: _resource_record_pre_action 21:59:26 INFO - Running main action method: create_virtualenv 21:59:26 INFO - Creating virtualenv /builds/slave/test/build/venv 21:59:26 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 21:59:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:59:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:26 INFO - Using real prefix '/usr' 21:59:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:59:26 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:28 INFO - Installing pip.................done. 21:59:28 INFO - Return code: 0 21:59:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:28 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 0x1559030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18183b0>, '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 0x18192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1819740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', '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 21:59:28 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 21:59:28 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 21:59:28 INFO - Using env: {'DISPLAY': ':0', 21:59:28 INFO - 'HOME': '/home/cltbld', 21:59:28 INFO - 'LANG': 'en_US.UTF-8', 21:59:28 INFO - 'LANGUAGE': 'en_US:en', 21:59:28 INFO - 'LOGNAME': 'cltbld', 21:59:28 INFO - 'MAIL': '/var/mail/cltbld', 21:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:28 INFO - 'MOZ_NO_REMOTE': '1', 21:59:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:28 INFO - 'NO_EM_RESTART': '1', 21:59:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:28 INFO - 'PWD': '/builds/slave/test', 21:59:28 INFO - 'SHELL': '/bin/bash', 21:59:28 INFO - 'SHLVL': '1', 21:59:28 INFO - 'TERM': 'linux', 21:59:28 INFO - 'TMOUT': '86400', 21:59:28 INFO - 'USER': 'cltbld', 21:59:28 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', 21:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:28 INFO - '_': '/tools/buildbot/bin/python'} 21:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:29 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 21:59:29 INFO - Cleaning up... 21:59:29 INFO - Return code: 0 21:59:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:59:29 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')]} 21:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:29 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')]} 21:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:29 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 0x1559030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18183b0>, '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 0x18192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1819740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', '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 21:59:29 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 21:59:29 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 21:59:29 INFO - Using env: {'DISPLAY': ':0', 21:59:29 INFO - 'HOME': '/home/cltbld', 21:59:29 INFO - 'LANG': 'en_US.UTF-8', 21:59:29 INFO - 'LANGUAGE': 'en_US:en', 21:59:29 INFO - 'LOGNAME': 'cltbld', 21:59:29 INFO - 'MAIL': '/var/mail/cltbld', 21:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:29 INFO - 'MOZ_NO_REMOTE': '1', 21:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:29 INFO - 'NO_EM_RESTART': '1', 21:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:29 INFO - 'PWD': '/builds/slave/test', 21:59:29 INFO - 'SHELL': '/bin/bash', 21:59:29 INFO - 'SHLVL': '1', 21:59:29 INFO - 'TERM': 'linux', 21:59:29 INFO - 'TMOUT': '86400', 21:59:29 INFO - 'USER': 'cltbld', 21:59:29 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', 21:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:29 INFO - '_': '/tools/buildbot/bin/python'} 21:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:29 INFO - Downloading/unpacking psutil>=3.1.1 21:59:29 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 21:59:29 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 21:59:29 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 21:59:29 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 21:59:29 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 21:59:29 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 21:59:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:59:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:31 INFO - Installing collected packages: psutil 21:59:31 INFO - Running setup.py install for psutil 21:59:31 INFO - building 'psutil._psutil_linux' extension 21:59:31 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 21:59:31 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 21:59:31 INFO - building 'psutil._psutil_posix' extension 21:59:31 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 21:59:31 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 21:59:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:31 INFO - Successfully installed psutil 21:59:31 INFO - Cleaning up... 21:59:31 INFO - Return code: 0 21:59:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:59:31 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')]} 21:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:31 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')]} 21:59:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:31 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 0x1559030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18183b0>, '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 0x18192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1819740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', '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 21:59:31 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 21:59:31 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 21:59:31 INFO - Using env: {'DISPLAY': ':0', 21:59:31 INFO - 'HOME': '/home/cltbld', 21:59:31 INFO - 'LANG': 'en_US.UTF-8', 21:59:31 INFO - 'LANGUAGE': 'en_US:en', 21:59:31 INFO - 'LOGNAME': 'cltbld', 21:59:31 INFO - 'MAIL': '/var/mail/cltbld', 21:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:31 INFO - 'MOZ_NO_REMOTE': '1', 21:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:31 INFO - 'NO_EM_RESTART': '1', 21:59:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:31 INFO - 'PWD': '/builds/slave/test', 21:59:31 INFO - 'SHELL': '/bin/bash', 21:59:31 INFO - 'SHLVL': '1', 21:59:31 INFO - 'TERM': 'linux', 21:59:31 INFO - 'TMOUT': '86400', 21:59:31 INFO - 'USER': 'cltbld', 21:59:31 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', 21:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:31 INFO - '_': '/tools/buildbot/bin/python'} 21:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:59:32 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 21:59:32 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 21:59:32 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 21:59:32 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 21:59:32 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 21:59:32 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 21:59:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:59:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:59:34 INFO - Installing collected packages: mozsystemmonitor 21:59:34 INFO - Running setup.py install for mozsystemmonitor 21:59:34 INFO - Successfully installed mozsystemmonitor 21:59:34 INFO - Cleaning up... 21:59:34 INFO - Return code: 0 21:59:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:59:34 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')]} 21:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:34 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')]} 21:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:34 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 0x1559030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18183b0>, '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 0x18192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1819740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', '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 21:59:34 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 21:59:34 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 21:59:34 INFO - Using env: {'DISPLAY': ':0', 21:59:34 INFO - 'HOME': '/home/cltbld', 21:59:34 INFO - 'LANG': 'en_US.UTF-8', 21:59:34 INFO - 'LANGUAGE': 'en_US:en', 21:59:34 INFO - 'LOGNAME': 'cltbld', 21:59:34 INFO - 'MAIL': '/var/mail/cltbld', 21:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:34 INFO - 'MOZ_NO_REMOTE': '1', 21:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:34 INFO - 'NO_EM_RESTART': '1', 21:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:34 INFO - 'PWD': '/builds/slave/test', 21:59:34 INFO - 'SHELL': '/bin/bash', 21:59:34 INFO - 'SHLVL': '1', 21:59:34 INFO - 'TERM': 'linux', 21:59:34 INFO - 'TMOUT': '86400', 21:59:34 INFO - 'USER': 'cltbld', 21:59:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', 21:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:34 INFO - '_': '/tools/buildbot/bin/python'} 21:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:34 INFO - Downloading/unpacking jsonschema==2.5.1 21:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:34 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 21:59:34 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 21:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:59:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59:36 INFO - Downloading functools32-3.2.3-2.tar.gz 21:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:59:36 INFO - warning: no files found matching '*.txt' 21:59:36 INFO - no previously-included directories found matching 'build' 21:59:36 INFO - no previously-included directories found matching 'dist' 21:59:36 INFO - no previously-included directories found matching '.git*' 21:59:36 INFO - Installing collected packages: jsonschema, functools32 21:59:36 INFO - Running setup.py install for functools32 21:59:36 INFO - warning: no files found matching '*.txt' 21:59:36 INFO - no previously-included directories found matching 'build' 21:59:36 INFO - no previously-included directories found matching 'dist' 21:59:36 INFO - no previously-included directories found matching '.git*' 21:59:36 INFO - Successfully installed jsonschema functools32 21:59:36 INFO - Cleaning up... 21:59:36 INFO - Return code: 0 21:59:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:59:36 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')]} 21:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:36 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')]} 21:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:36 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 0x1559030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18183b0>, '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 0x18192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1819740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', '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 21:59:36 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 21:59:36 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 21:59:36 INFO - Using env: {'DISPLAY': ':0', 21:59:36 INFO - 'HOME': '/home/cltbld', 21:59:36 INFO - 'LANG': 'en_US.UTF-8', 21:59:36 INFO - 'LANGUAGE': 'en_US:en', 21:59:36 INFO - 'LOGNAME': 'cltbld', 21:59:36 INFO - 'MAIL': '/var/mail/cltbld', 21:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:36 INFO - 'MOZ_NO_REMOTE': '1', 21:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:36 INFO - 'NO_EM_RESTART': '1', 21:59:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:36 INFO - 'PWD': '/builds/slave/test', 21:59:36 INFO - 'SHELL': '/bin/bash', 21:59:36 INFO - 'SHLVL': '1', 21:59:36 INFO - 'TERM': 'linux', 21:59:36 INFO - 'TMOUT': '86400', 21:59:36 INFO - 'USER': 'cltbld', 21:59:36 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', 21:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:36 INFO - '_': '/tools/buildbot/bin/python'} 21:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:36 INFO - Downloading/unpacking blobuploader==1.2.4 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59:38 INFO - Downloading blobuploader-1.2.4.tar.gz 21:59:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:59:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:59:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:39 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 21:59:39 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 21:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:39 INFO - Downloading docopt-0.6.1.tar.gz 21:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:59:39 INFO - Installing collected packages: blobuploader, requests, docopt 21:59:39 INFO - Running setup.py install for blobuploader 21:59:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:59:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:59:39 INFO - Running setup.py install for requests 21:59:40 INFO - Running setup.py install for docopt 21:59:40 INFO - Successfully installed blobuploader requests docopt 21:59:40 INFO - Cleaning up... 21:59:40 INFO - Return code: 0 21:59:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:40 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 0x1559030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18183b0>, '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 0x18192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1819740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', '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 21:59:40 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 21:59:40 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 21:59:40 INFO - Using env: {'DISPLAY': ':0', 21:59:40 INFO - 'HOME': '/home/cltbld', 21:59:40 INFO - 'LANG': 'en_US.UTF-8', 21:59:40 INFO - 'LANGUAGE': 'en_US:en', 21:59:40 INFO - 'LOGNAME': 'cltbld', 21:59:40 INFO - 'MAIL': '/var/mail/cltbld', 21:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:40 INFO - 'MOZ_NO_REMOTE': '1', 21:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:40 INFO - 'NO_EM_RESTART': '1', 21:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:40 INFO - 'PWD': '/builds/slave/test', 21:59:40 INFO - 'SHELL': '/bin/bash', 21:59:40 INFO - 'SHLVL': '1', 21:59:40 INFO - 'TERM': 'linux', 21:59:40 INFO - 'TMOUT': '86400', 21:59:40 INFO - 'USER': 'cltbld', 21:59:40 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', 21:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:40 INFO - '_': '/tools/buildbot/bin/python'} 21:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:59:40 INFO - Running setup.py (path:/tmp/pip-yx_xpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:59:40 INFO - Running setup.py (path:/tmp/pip-WPErEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:59:40 INFO - Running setup.py (path:/tmp/pip-Gk76NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:59:40 INFO - Running setup.py (path:/tmp/pip-hN_4cL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:59:40 INFO - Running setup.py (path:/tmp/pip-JiadJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:59:40 INFO - Running setup.py (path:/tmp/pip-ieGSUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:59:40 INFO - Running setup.py (path:/tmp/pip-wKZxIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:59:40 INFO - Running setup.py (path:/tmp/pip-FbtkQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:59:41 INFO - Running setup.py (path:/tmp/pip-ZNIdLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:59:41 INFO - Running setup.py (path:/tmp/pip-Bw_Epj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:59:41 INFO - Running setup.py (path:/tmp/pip-Gv2t5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:59:41 INFO - Running setup.py (path:/tmp/pip-yziEnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:59:41 INFO - Running setup.py (path:/tmp/pip-BSq0FJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:59:41 INFO - Running setup.py (path:/tmp/pip-ppPZBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:41 INFO - Running setup.py (path:/tmp/pip-C1_qI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:59:41 INFO - Running setup.py (path:/tmp/pip-eM5_4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:59:41 INFO - Running setup.py (path:/tmp/pip-LUlNya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:59:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:59:41 INFO - Running setup.py install for manifestparser 21:59:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:59:41 INFO - Running setup.py install for mozcrash 21:59:41 INFO - Running setup.py install for mozdebug 21:59:41 INFO - Running setup.py install for mozdevice 21:59:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Running setup.py install for mozfile 21:59:42 INFO - Running setup.py install for mozhttpd 21:59:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Running setup.py install for mozinfo 21:59:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Running setup.py install for mozInstall 21:59:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Running setup.py install for mozleak 21:59:42 INFO - Running setup.py install for mozlog 21:59:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Running setup.py install for moznetwork 21:59:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Running setup.py install for mozprocess 21:59:42 INFO - Running setup.py install for mozprofile 21:59:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:59:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:59:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:59:43 INFO - Running setup.py install for mozrunner 21:59:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:59:43 INFO - Running setup.py install for mozscreenshot 21:59:43 INFO - Running setup.py install for moztest 21:59:43 INFO - Running setup.py install for mozversion 21:59:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:59:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:59:43 INFO - Cleaning up... 21:59:43 INFO - Return code: 0 21:59:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59:43 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')]} 21:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:43 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')]} 21:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:43 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 0x1559030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18183b0>, '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 0x18192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1819740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', '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 21:59:43 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 21:59:43 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 21:59:43 INFO - Using env: {'DISPLAY': ':0', 21:59:43 INFO - 'HOME': '/home/cltbld', 21:59:43 INFO - 'LANG': 'en_US.UTF-8', 21:59:43 INFO - 'LANGUAGE': 'en_US:en', 21:59:43 INFO - 'LOGNAME': 'cltbld', 21:59:43 INFO - 'MAIL': '/var/mail/cltbld', 21:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:43 INFO - 'MOZ_NO_REMOTE': '1', 21:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:43 INFO - 'NO_EM_RESTART': '1', 21:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:43 INFO - 'PWD': '/builds/slave/test', 21:59:43 INFO - 'SHELL': '/bin/bash', 21:59:43 INFO - 'SHLVL': '1', 21:59:43 INFO - 'TERM': 'linux', 21:59:43 INFO - 'TMOUT': '86400', 21:59:43 INFO - 'USER': 'cltbld', 21:59:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', 21:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:43 INFO - '_': '/tools/buildbot/bin/python'} 21:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:59:43 INFO - Running setup.py (path:/tmp/pip-hViD5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:59:43 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)) 21:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:59:43 INFO - Running setup.py (path:/tmp/pip-KMmUKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:59:43 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)) 21:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:59:43 INFO - Running setup.py (path:/tmp/pip-ZOIX16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:59:43 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)) 21:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:59:43 INFO - Running setup.py (path:/tmp/pip-qWfaJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:59:43 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)) 21:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:59:43 INFO - Running setup.py (path:/tmp/pip-sQ22Yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:59:44 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)) 21:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:59:44 INFO - Running setup.py (path:/tmp/pip-cQnMQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:59:44 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)) 21:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:59:44 INFO - Running setup.py (path:/tmp/pip-rSDi2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:59:44 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)) 21:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:59:44 INFO - Running setup.py (path:/tmp/pip-sY3Kfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:59:44 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)) 21:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:59:44 INFO - Running setup.py (path:/tmp/pip-y5_k5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:59:44 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)) 21:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:59:44 INFO - Running setup.py (path:/tmp/pip-CYY6pI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:59:44 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)) 21:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:59:44 INFO - Running setup.py (path:/tmp/pip-f6AKhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:59:44 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)) 21:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:59:44 INFO - Running setup.py (path:/tmp/pip-3fMvLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 21:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:59:44 INFO - Running setup.py (path:/tmp/pip-LoegAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:59:44 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)) 21:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:59:44 INFO - Running setup.py (path:/tmp/pip-Can_kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 21:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:44 INFO - Running setup.py (path:/tmp/pip-E03MNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:44 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)) 21:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:59:44 INFO - Running setup.py (path:/tmp/pip-pI7x3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:59:44 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)) 21:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:59:44 INFO - Running setup.py (path:/tmp/pip-DUhssL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:59:44 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)) 21:59:44 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)) 21:59:44 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)) 21:59:44 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)) 21:59:44 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)) 21:59:44 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)) 21:59:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:59:44 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 21:59:44 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 21:59:44 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 21:59:44 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 21:59:44 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 21:59:44 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 21:59:46 INFO - Downloading blessings-1.6.tar.gz 21:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:59:46 INFO - Installing collected packages: blessings 21:59:46 INFO - Running setup.py install for blessings 21:59:46 INFO - Successfully installed blessings 21:59:46 INFO - Cleaning up... 21:59:47 INFO - Return code: 0 21:59:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:59:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:59:47 INFO - Reading from file tmpfile_stdout 21:59:47 INFO - Current package versions: 21:59:47 INFO - argparse == 1.2.1 21:59:47 INFO - blessings == 1.6 21:59:47 INFO - blobuploader == 1.2.4 21:59:47 INFO - docopt == 0.6.1 21:59:47 INFO - functools32 == 3.2.3-2 21:59:47 INFO - jsonschema == 2.5.1 21:59:47 INFO - manifestparser == 1.1 21:59:47 INFO - mozInstall == 1.12 21:59:47 INFO - mozcrash == 0.17 21:59:47 INFO - mozdebug == 0.1 21:59:47 INFO - mozdevice == 0.48 21:59:47 INFO - mozfile == 1.2 21:59:47 INFO - mozhttpd == 0.7 21:59:47 INFO - mozinfo == 0.9 21:59:47 INFO - mozleak == 0.1 21:59:47 INFO - mozlog == 3.2 21:59:47 INFO - moznetwork == 0.27 21:59:47 INFO - mozprocess == 0.22 21:59:47 INFO - mozprofile == 0.28 21:59:47 INFO - mozrunner == 6.11 21:59:47 INFO - mozscreenshot == 0.1 21:59:47 INFO - mozsystemmonitor == 0.3 21:59:47 INFO - moztest == 0.7 21:59:47 INFO - mozversion == 1.4 21:59:47 INFO - psutil == 3.1.1 21:59:47 INFO - requests == 1.2.3 21:59:47 INFO - wsgiref == 0.1.2 21:59:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1559030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18183b0>, '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 0x18192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1819740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', '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 21:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 21:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.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 21:59:47 INFO - Using env: {'DISPLAY': ':0', 21:59:47 INFO - 'HOME': '/home/cltbld', 21:59:47 INFO - 'LANG': 'en_US.UTF-8', 21:59:47 INFO - 'LANGUAGE': 'en_US:en', 21:59:47 INFO - 'LOGNAME': 'cltbld', 21:59:47 INFO - 'MAIL': '/var/mail/cltbld', 21:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:47 INFO - 'MOZ_NO_REMOTE': '1', 21:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:47 INFO - 'NO_EM_RESTART': '1', 21:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:47 INFO - 'PWD': '/builds/slave/test', 21:59:47 INFO - 'SHELL': '/bin/bash', 21:59:47 INFO - 'SHLVL': '1', 21:59:47 INFO - 'TERM': 'linux', 21:59:47 INFO - 'TMOUT': '86400', 21:59:47 INFO - 'USER': 'cltbld', 21:59:47 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', 21:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:47 INFO - '_': '/tools/buildbot/bin/python'} 21:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:47 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)) 21:59:47 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)) 21:59:47 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)) 21:59:47 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)) 21:59:47 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)) 21:59:47 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)) 21:59:47 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)) 21:59:47 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)) 21:59:47 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)) 21:59:47 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)) 21:59:47 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)) 21:59:47 INFO - Cleaning up... 21:59:47 INFO - Return code: 0 21:59:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:47 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 0x1559030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18183b0>, '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 0x18192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1819740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', '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 21:59:47 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 21:59:47 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 21:59:47 INFO - Using env: {'DISPLAY': ':0', 21:59:47 INFO - 'HOME': '/home/cltbld', 21:59:47 INFO - 'LANG': 'en_US.UTF-8', 21:59:47 INFO - 'LANGUAGE': 'en_US:en', 21:59:47 INFO - 'LOGNAME': 'cltbld', 21:59:47 INFO - 'MAIL': '/var/mail/cltbld', 21:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:47 INFO - 'MOZ_NO_REMOTE': '1', 21:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:47 INFO - 'NO_EM_RESTART': '1', 21:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:47 INFO - 'PWD': '/builds/slave/test', 21:59:47 INFO - 'SHELL': '/bin/bash', 21:59:47 INFO - 'SHLVL': '1', 21:59:47 INFO - 'TERM': 'linux', 21:59:47 INFO - 'TMOUT': '86400', 21:59:47 INFO - 'USER': 'cltbld', 21:59:47 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', 21:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:47 INFO - '_': '/tools/buildbot/bin/python'} 21:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:59:47 INFO - Cleaning up... 21:59:47 INFO - Return code: 0 21:59:47 INFO - Running post-action listener: _resource_record_post_action 21:59:47 INFO - Running post-action listener: _start_resource_monitoring 21:59:47 INFO - Starting resource monitoring. 21:59:47 INFO - ##### 21:59:47 INFO - ##### Finished create-virtualenv step (success) 21:59:47 INFO - ##### 21:59:47 INFO - ##### 21:59:47 INFO - ##### Running install step. 21:59:47 INFO - ##### 21:59:47 INFO - Running pre-action listener: _resource_record_pre_action 21:59:47 INFO - Running main action method: install 21:59:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:59:47 INFO - Reading from file tmpfile_stdout 21:59:47 INFO - Detecting whether we're running mozinstall >=1.0... 21:59:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:59:47 INFO - Reading from file tmpfile_stdout 21:59:47 INFO - Output received: 21:59:47 INFO - Usage: mozinstall [options] installer 21:59:47 INFO - Options: 21:59:47 INFO - -h, --help show this help message and exit 21:59:47 INFO - -d DEST, --destination=DEST 21:59:47 INFO - Directory to install application into. [default: 21:59:47 INFO - "/builds/slave/test"] 21:59:47 INFO - --app=APP Application being installed. [default: firefox] 21:59:47 INFO - mkdir: /builds/slave/test/build/application 21:59:47 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'] 21:59:47 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 22:00:05 INFO - Reading from file tmpfile_stdout 22:00:05 INFO - Output received: 22:00:05 INFO - /builds/slave/test/build/application/firefox/firefox 22:00:05 INFO - Running post-action listener: _resource_record_post_action 22:00:05 INFO - ##### 22:00:05 INFO - ##### Finished install step (success) 22:00:05 INFO - ##### 22:00:05 INFO - ##### 22:00:05 INFO - ##### Running run-tests step. 22:00:05 INFO - ##### 22:00:05 INFO - Running pre-action listener: _resource_record_pre_action 22:00:05 INFO - Running main action method: run_tests 22:00:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:00:05 INFO - Python 2.7.3 22:00:05 INFO - Return code: 0 22:00:05 INFO - grabbing minidump binary from tooltool 22:00:05 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')]} 22:00:05 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 0x18183b0>, '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 0x18192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1819740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:00:05 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 22:00:05 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 22:00:05 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 22:00:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:05 INFO - Return code: 0 22:00:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:00:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:00:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:00:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:00:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:00:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 22:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 22:00:05 INFO - Using env: {'DISPLAY': ':0', 22:00:05 INFO - 'HOME': '/home/cltbld', 22:00:05 INFO - 'LANG': 'en_US.UTF-8', 22:00:05 INFO - 'LANGUAGE': 'en_US:en', 22:00:05 INFO - 'LOGNAME': 'cltbld', 22:00:05 INFO - 'MAIL': '/var/mail/cltbld', 22:00:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:00:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:05 INFO - 'MOZ_NO_REMOTE': '1', 22:00:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:05 INFO - 'NO_EM_RESTART': '1', 22:00:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:05 INFO - 'PWD': '/builds/slave/test', 22:00:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:00:05 INFO - 'SHELL': '/bin/bash', 22:00:05 INFO - 'SHLVL': '1', 22:00:05 INFO - 'TERM': 'linux', 22:00:05 INFO - 'TMOUT': '86400', 22:00:05 INFO - 'USER': 'cltbld', 22:00:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164', 22:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:05 INFO - '_': '/tools/buildbot/bin/python'} 22:00:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 22:00:05 INFO - mozversion application_buildid: 20160629183001 22:00:05 INFO - mozversion application_changeset: 0edb9df3c97ff7d205a99f8af607f99a858f140b 22:00:05 INFO - mozversion application_display_name: Nightly 22:00:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:05 INFO - mozversion application_name: Firefox 22:00:05 INFO - mozversion application_remotingname: firefox 22:00:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 22:00:05 INFO - mozversion application_vendor: Mozilla 22:00:05 INFO - mozversion application_version: 50.0a1 22:00:05 INFO - mozversion platform_buildid: 20160629183001 22:00:05 INFO - mozversion platform_changeset: 0edb9df3c97ff7d205a99f8af607f99a858f140b 22:00:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 22:00:05 INFO - mozversion platform_version: 50.0a1 22:00:05 INFO - using testdate: 1467262805 22:00:05 INFO - actual date: 1467262805 22:00:05 INFO - starting webserver on 'localhost:45315' 22:00:05 INFO - SUITE-START | Running 2 tests 22:00:05 INFO - TEST-START | dromaeo_css 22:00:05 INFO - operating with platform_type : linux_ 22:00:05 INFO - Initialising browser for dromaeo_css test... 22:00:05 INFO - TEST-INFO | started process 20943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn0sLTu/profile http://localhost:45315/getInfo.html) 22:00:09 INFO - PROCESS | 20943 | __metrics Screen width/height:1600/1200 22:00:09 INFO - PROCESS | 20943 | colorDepth:24 22:00:09 INFO - PROCESS | 20943 | Browser inner width/height: 1024/697 22:00:09 INFO - PROCESS | 20943 | __metrics 22:00:10 INFO - PROCESS | 20943 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:00:11 INFO - TEST-INFO | 20943: exit 0 22:00:11 INFO - Browser initialized. 22:00:11 INFO - Running cycle 1/1 for dromaeo_css test... 22:00:11 INFO - TEST-INFO | started process 21026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn0sLTu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:23 INFO - PROCESS | 21026 | RSS: Main: 157351936 22:00:23 INFO - PROCESS | 21026 | 22:01:14 INFO - PROCESS | 21026 | 1467262874511 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] 22:03:22 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:45315/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45315/tests/dromaeo/cssquery-ext.html) 22:03:23 INFO - PROCESS | 21026 | RSS: Main: 259026944 22:03:23 INFO - PROCESS | 21026 | 22:06:26 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:45315/tests/dromaeo/cssquery-ext.html (next: http://localhost:45315/tests/dromaeo/cssquery-jquery.html) 22:06:26 INFO - PROCESS | 21026 | RSS: Main: 240287744 22:06:26 INFO - PROCESS | 21026 | 22:09:28 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:45315/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45315/tests/dromaeo/cssquery-mootools.html) 22:09:29 INFO - PROCESS | 21026 | RSS: Main: 239570944 22:09:29 INFO - PROCESS | 21026 | 22:12:31 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:45315/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45315/tests/dromaeo/cssquery-prototype.html) 22:12:31 INFO - PROCESS | 21026 | RSS: Main: 236945408 22:12:31 INFO - PROCESS | 21026 | 22:15:34 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:45315/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45315/tests/dromaeo/cssquery-yui.html) 22:15:35 INFO - PROCESS | 21026 | RSS: Main: 211664896 22:15:35 INFO - PROCESS | 21026 | 22:18:37 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:45315/tests/dromaeo/cssquery-yui.html (next: http://localhost:45315/tests/dromaeo/cssquery-dojo.html) 22:18:37 INFO - PROCESS | 21026 | RSS: Main: 280215552 22:18:37 INFO - PROCESS | 21026 | 22:18:37 INFO - PROCESS | 21026 | __start_tp_report 22:18:37 INFO - PROCESS | 21026 | _x_x_mozilla_page_load 22:18:37 INFO - PROCESS | 21026 | _x_x_mozilla_page_load_details 22:18:37 INFO - PROCESS | 21026 | |i|pagename|runs| 22:18:37 INFO - PROCESS | 21026 | |0;dojo.html;3094;3094.5048792193247;3130.4834702274125;3167.1132083016764;3172.7144556989865;5189.896202075956;5227.660202086861;5339.305890234269;5441.945580544193;5471.425500322463;5293.550048245894;5367.1680889462195;5389.056915039862;5416.702081385522;5416.8104116355935;4867.8783030424165;4885.804567817292;4978.054169707762;5043.949560504403;5044.873878153039;4971.975140124312;4979.377577802775;5024.4724303948105;5041.218611115283;5047.01583191276;4734.195186818232;4876.195427754416;4960.553550180465;4983.202687570008;4988.226824842155;4974.925376119361;4980.651354405193;4985.825496107619;4996.925046124311;5030.899382012376;4810.759462026919;4819.614430845524;4894.192458244385;4954.826581069681;5016.673916195436;5298.973505132488;5391.487808658171;5422.511973922326;5423.7830486780485;5427.891442171174;5773.480386765212;5781.624194427349;5784.88430231393;5788.913166302509;5792.015357389254;5562.805301814417;5660.575456840712;5672.149177623348;5882.000059989812;5892.823215303548;5387.326584176978;5415;5420.376656684492;5421.1326187810155;5425.565954723652;5890.6171098879295;5915.763369465173;5916.319623243296;5916.8462149881225;5920.141579471038;5482.424345443751;5592.161175823578;5642.069058605366;5673.971630141906;5709.172170035322;5720.942790572124;5764.855878602984;5766.94233057664;5770.480656740913;5771.480566748929;5697.515711164515;5700.657960522382;5703.800366987136;5705;5739.311282646109;5608.887822243532;5647.463490968434;5650.29371328584;5672.943270567242;5683;4147.834086636561;4149.045719484536;4150.232207041707;4156.085661154601;4186.937195942063;3678.503402040744;3703.666669999713;3741.8129093545213;3756.6619004289746;3784.981075094662;5317.361916570037;5441.156620723794;5480.04099282624;5494.340679118532;5514.696691681996;5821.301443826768;5830.154627578977;5841;5843.5325173985975;5859.033259512133;5276.287701160371;5513.669179849222;5518.061929471999;5520.558355331564;5525.254090697705;4846.466888642247;4891.413030436299;4911.63162762787;4919.65562410635;4922.704637721748;6006.039033754491;6013.398660134039;6025.608335458269;6027.30685971119;6030.698465076816;5641.435856414326;5810.767569297181;5815.069588865761;5817.563682723728;5824.592278540462;5869.090291004901;5944.3164036136395;5951.047832346977;5951.880962380815;5957.314908785545;5607.243022191952;5639.6334238274385;5647.20939068539;5655.660660360391;5659.971700141473;5579.246801681721;5704;5793.536517078539;5802.6808525531505;5807.157962095557;5589.1336842787805;5600.27196464457;5609;5617.129344951539;5650.802221922213;5590.133529302964;5592.5525957922455;5593.0771422716425;5603.215549822947;5613.915791263053;5370.489803468664;5522.475364840334;5531.751071201886;5565.387807341108;5593.300837395325;5750.856228594319;5768.134779783066;5773.595848290579;5823.097419899922;5823.94176058234;5544.306961629796;5557.666540007613;5559.360673522597;5560.916586251128;5565.749541270734 22:18:37 INFO - PROCESS | 21026 | |1;ext.html;587.7061469265367;605.131636102193;609.9939000609994;619.6901549225387;623.8596315828939;33536.4969525457;43873.78063109684;45074.09851802962;45103;45199.774001130034;45653.31520027202;45987.31019034717;46018;46048.769756151254;46115.308270375885;8062.7581172564915;8880.689175878846;9029.413088149282;9037.774055648628;10528.578856845717;10386.63646772363;10745.355278683304;10782.406967616778;10788.5684572617;10788.676339709822;10799.136069114491;10803.891961080406;10848.077913377332;10857.23999320048;10858.131349492021;8214.63034163461;10567.735806604896;10743.086837618812;10807.945960270226;10814;10708.625198118028;10773;10777.676669699922;10783.83824242637;10784.191185661028;36113.81943090294;43090.35364469535;43293.56706432927;43403.78298108489;43476.78261608672;3499.5800503939436;3572.821358932043;3581.391163502211;3628.76413033152;3653.1049892776173;33159.83420082884;33564.83217583921;33582.32835343279;33658.158546036546;34510.309793804234;4484.977575112136;4491.079328737601;4495.9325610115875;4508.842190523316;4543.31850222466;350405;351133.24433377926;352174;354180;355649;36507.452388214195;37360.43959340612;61277.69361153166;61556;61588.69205653943;38775.22449550993;38789.806050969564;38915.416268755995;38941;38971.220575588326;15266.389344426321;15343.539693809204;15424.071991001125;15480.84519154794;15492.60566549016;12422.875771242172;12583.748325033448;12619.684507887192;12622.116451848466;12625.05312101596;8893.244074253631;8990.100989900957;8995.640174393082;9047.547622618975;9112.726618201465;3212.951805722916;3284.704376606069;3381.9492707609406;3389.932201355959;3491.6682915123024;933.2627224492575;1034.270839058462;1042.744527590745;1053.4100903494068;1115.2360632966445;32811.83594082014;33388.499172512435;33482;33560.16099597481;33645.15887102842;1151.5508951508918;1161.506359797083;1176.6528873982195;1191.9165658404002;1229.1518851992096;17222.311107555557;17399.47801565955;17659.646807064044;17711.114444277733;17753.822461775475;588700;593038;594984;595809;598392;60618.696906515186;61269.08096378558;61348.38651613516;61379.38620613826;61405.69297153575;1260.6785269756153;1340.2829486224823;1375.9243241621607;1378.2281922123443;1410.7954346619888;32549;33904.49143262902;34025.65974340324;34304;34459.655403446646;51164.232536512725;51698.48301516937;51703.48296516987;52190.21714674359;52279.73860130675;403786;404002;406497;406857;409205;26563.867180664747;28692.282692932844;29041.128766137048;29258.7074129256;31080.378392432478;48153.5184648149;48981.51018489769;49523.77178688234;49874.750626246634;50114;40122.39816402698;41125.588744112174;41343.58656413398;42241.36637950494;42883.7855810719;41373.37939930963;42073;42249.577504225796;42452.787736061124;42604.573954260064;41215.175696485305;41893.1621367577;42380.788096059325;42609.220215274676;44556.549389783875;37771.2445751078;38840.805795971966;38909.221815564095;39168.804155979036;39290.60709392984;28663.713362866103;28957.85521072381;29322.266943326587;29507;29580.260493486974 22:18:37 INFO - PROCESS | 21026 | |2;jquery.html;406.99186016279657;420.0884081543051;422.45503300742047;426.88687497813083;432.19611522568016;18706.15822287997;20229.089690963887;20393.388198354056;20696.48258793531;20847.583048339024;19190.712139317886;19997;20263.49341266469;20712.067956941937;20762.48093797652;5812.883742325162;5983.2820061592665;6032.457078862902;6039.365866584011;6040.244969378828;4180.435641188446;5914.9112763308585;5925.05199168131;6330.746770129189;6630.834229144261;6678.165229346332;6695.866082678343;6719.798406047802;6730.932690673079;6733.124693789825;6370.8088757337355;6646.136002319716;6651.368120028614;6656.434203092743;6656.70044847983;3888.9805550972346;5436.864078398072;5738.6556806591325;5747.3677895431465;5874.32445268791;23590.174343898052;24009.639855402183;24108.517829643486;24401.389965250833;24515.264542063767;2219.533897881447;2339.3332900123555;2496.8501889886666;2508.059477695864;3102.4260511805387;9922.206223502102;10141.290109692325;10207.285490015702;10304.896951030469;10368.222383321281;1859.172668162668;1885.198790514026;1902.8858268503934;1907.4849790556611;2007.237249845064;82473.58763206206;82632.76050859242;84188;84252.57873710593;85906;11646.41767911601;11785.233959792586;11799.823002654966;11886.167968242313;11913.22564033335;16136.35454581827;16246.106464144586;16250.187490625422;16261.349546018027;16289.674206515803;7704.152543220242;7755.030621172354;7818.569978651229;7898.447108702336;8056.073551541648;7314.195438501761;7339.229380915034;7339.8532029360185;7424.888626670604;7436.442266830009;5070.366204224472;5099.59203263738;5102.132637451642;5173.224016397495;5173.611979101583;1826.8191330047348;1991;2049.764277108122;2108.81020708137;2109.1457959526415;931.3806318797923;1009.3439264478149;1026.0867827633413;1029.902159294866;1088.7223757941833;19397.709034364496;20024.89987550082;20109.899450502653;20132.597348052957;20429.897850510653;993.6472552243994;1020.2297265564451;1028.321307936758;1052.1372474570778;1059.1685526861377;10056.899431005597;11330.433478326051;11409.942950285196;11414.828777568344;11416.94291528537;365645;366154;366365;456821;461967;100892.49553752184;101984;103783.48108259561;105318;107640;994.5126887824914;1038.2628333882876;1041.4948749856314;1042.5777560088177;1057.2070946789909;17792.199351028976;18221;18380.816191837912;18453.16960736797;18456.446306610822;45836;46678;46926.53073469221;47564.762176188895;48448.5155148444;63468.365316346244;63983.3601663996;64833.35166648273;64936;66083.66958165179;8475.576221188792;8574.3997920145;8609.311255099452;8839.734807955772;8847.292216622784;9800.950995244979;13877.86122138806;14097.929510352382;14439.78340324917;14539.273036348352;12243.75512489763;12400.255984640951;12410.689732756753;12474.339810662681;12498.312592807482;5918.911216331845;9880.291507294929;11896.048316134515;12210.145289829981;12380.504779809067;6629.337066293332;11818.822717659414;12268.141230113806;12397.318147501974;12603.369831508571;8677.132286771272;8715.64907439348;8746.606402712021;8805.955970220108;9519.714408567754;9201.723948281562;12537.435815388511;12592.685182870502;12683.302418367079;12694.301813400352 22:18:37 INFO - PROCESS | 21026 | |3;mootools.html;1359.442628522306;1505.1195050895226;1509.501864384753;1672.8327167283273;1798.6312805874798;8757.781055473617;9138.131877471638;9145.588448519817;9433.24534037277;9439.480828554426;9204.309676774235;9433.056694330564;9434.81130377392;9435.339526233167;9476.28927830412;2087.7390326209224;2403.146882856591;2442.6458163566363;2458.1027924807404;2522.8864701088496;2480.7395223501544;2501.862397568133;2510.410053637394;2512.7612876776675;2513.4721708441157;2482.8758562071916;2497.2882728422405;2498.562751518486;2501.6372625969316;2503.824732268742;2078.5738923520644;2373.7744914233035;2415.903363865443;2418.274517644717;2443.9755602443925;2318.2465698648007;2330.8951097200497;2332.9650055249185;2337.8597284163006;2353.270486149282;9341.159295663423;9353.064693530592;9410.858837117381;9413.152816246502;9427;5459.153831156177;5523.4752698493985;5567.610267281292;5568.49883510482;5575.749091290902;3681.4661874028384;3765.8681946131755;3813.8283777229813;3819.8281077351585;3839.4816699745734;1264.576366917084;1265.7278685082658;1285.517930775959;1289.3037759609892;1335.105479328852;13535.32323383827;13634.863651363557;13654.385552650154;13670.52153174644;13712.314384280746;4954;5012.724300163453;5150.098732721834;5160.922586161136;5179.7928082877015;11211.495482703134;11218.326900386002;11224.438778061065;11230;11244.212905096729;4948.208286674115;5680.318361796611;5683.687397193112;5687.061634830289;5688.317401911797;4913.877153071202;5076.695398276115;5088.821891233789;5133.974330128325;5138.306328645585;4280.807363668642;4323.697341186087;4355.236129367611;4413.073254616503;4420.359047938031;1249.7000719827176;1324.5297919238724;1325.072449285504;1387.6808334083016;1412.7245187188605;939.0797018921359;949.8005418862116;956.8469044952914;965.4834663455018;970.1995853420956;5690.4025077367105;5694.402087780806;6037.607555508878;6244.781432649836;6261.686915654199;954.7326748510428;958.8465845464692;967.8354679704468;993.4784238274964;993.9950300248597;3968.047668559525;4046.1705350403095;4049.2913740095364;4099.569545197771;4122.443470131494;11838.644840654793;12175.756484870253;12254.81617775734;12293.508259669514;12340.81488777669;12135.939320303341;12156.33140177281;12161.635150945485;12171.452284647212;12188.512459501699;8362.080171181165;8570.185832345916;8689.217970382695;8710.782230444289;8715.912840871637;5972.104184372205;6137.508999280136;6147.508199344131;6151.200343955257;6197.318294987638;10892.836607450736;10996.780064398827;11217.046551043253;11262.436878156223;11262.774744505228;11121.721956951142;11337;11372.658820235407;11545.36500492481;11577.07383409342;8500.829983400174;8503.319734421108;8540;8582.485050896967;8678.696245631372;9125.224355929555;9185.357025008185;9225.354225204172;9232.861507077534;9240.95379523098;8285.585720714062;8328.708495202638;8345.582720864053;8505.532195729294;8636.26591739684;8078.272955433804;8229.423940324119;8238.917610824055;8349.248567628943;8359;7270.9636451817405;7528.473006889465;7549.471536992358;7564.773056808304;7718.729844455417;5132.769025393941;5220.9216861746345;5267.236250743697;5323.0684630190335;5342.198670199501;5514.5864060196445;5530.5022547969265;5540.80607178763;5558.833235002957;5559.467259041846 22:18:37 INFO - PROCESS | 21026 | |4;prototype.html;341.23222748815164;344.86377880737103;352.964050511748;355.82208895552225;358.53748664223156;5343.679379237248;5349.9732501337485;5376.758045887935;5388.595855310848;5420.268263784388;5273.657212281209;5295.841124766263;5326.547243484309;5375.247465354853;5394.757235924383;4171.541130475645;4217.177650358181;4257.361395790641;4271.70098093132;4285.400043993851;4196.916061678765;4238.724482908617;4242.8727138185905;4254;4254.383114448403;3996.7601943883315;4217.924429270532;4227.133437645275;4251.341042138458;4259.701820872525;4092.242935057009;4191.7484950903045;4206.768627725474;4225.767582782961;4227.513835908879;3743.288775132716;3758.3047136279874;3763.153290509641;3771.3211621908044;3777.527809023872;4952.727599981999;4999.925001124986;5248.396434410015;5253.266422080743;5254.4220135785035;4827.6930302742385;4830.73430961297;4834.806607735686;4836.709797412132;4861.562459378673;5582.8325150245555;5587.916181257244;5603.803866864681;5628.521575666074;5633.211350410946;3892.299386110499;4099.97950010251;4103.363978583325;4118.382242663594;4136.503619565671;5704.401037891044;5781.161731548944;5821.592488525805;5827.3298570664065;5851.531877449794;4161.708680392343;4184.288670925889;4185;4194.979025104916;4212.220739163265;4174.039970806671;4215.156968606291;4253.425787518708;4282.678799090018;4284.121755040209;4764.166270902579;4780.521947805261;4820.276958456189;4825.227963525819;4831.299461578052;5641.971790141023;5645.576581756384;5679.914801277984;5704.573856535866;5725.570582206351;1389.7012142389435;1423.4590855474853;1439.7480440923007;1445.3929349673163;1460.5034288342015;910.5583791860943;915.6428992692855;919.8298314811781;929.3494553812359;935.5415846235431;4791.425028996543;4801.783919723621;4807.966287248259;4818.494058123846;4835.323054772335;5022.89954200914;5036.841526448864;5053.545180933734;5065.797368105308;5067.493250674903;4810.01778897086;5189.065968125698;5200.947990520046;5450.754716037788;5453.745638503166;3026.424979253935;3027.8031927924612;3034.7117023882697;3035.6509001465115;3042.558828969787;5646.296259588915;5868.794592189253;5876.6180198286975;5892.764289428461;5898.233229680114;5772.365039845614;5801.94198058014;5804.506616937523;5810.477057064884;5813.622114562624;5892.440218179266;5892.558058145656;5895.823125306248;5902.20320256777;5915.822525324334;5456.972715136399;5736.397678243891;5825.242718446575;5826.650400975955;5831.70841457917;5750.30996280449;5760.481556659921;5769.394213607511;5771.538276937918;5787.450192231731;5740.971295143498;5956.225690660186;5963.254593175853;5966.463018328372;5972.760214919405;4056.492938382702;4063.780865740325;4070.633642972028;4078.347464405681;4082.693797965224;5753.324704012654;5767.365589785037;5779.36426993022;5794.18881356602;5797.826065218051;5426.945730542802;5634.633748806478;5658.688772117408;5661.961693790315;5669;5557.694326812064;5599.272094627672;5605.663660180402;5643;5646.153077038477;5503.532199763065;5517.117261238182;5534.7786088556;5552.222688823649;5564.944350556604;5519.130052372663;5669.716514174357;5671.043489995945;5673.574481913955;5683.431656834284;5482.150266708666;5514.365847927379;5518.33779946409;5559.2217089606675;5561.138023606348 22:18:37 INFO - PROCESS | 21026 | |5;yui.html;741.2254194366886;754.773567929621;764.7629234937167;788.6569342336085;850.1031411860489;15503.302351394186;16328.673426531492;16616.418425355114;16964.91517542412;17020.574485637866;14586.051906626088;14753.704925901475;14764.557063288119;14766.409343626243;14780.334884930204;663.5521023309271;790.1269097647104;791.6595863778588;804.5172896262225;817.0971076959963;782.2216894190288;809.4172196018857;811.8051667599763;815.963281652327;816.6529225079347;857.901341345747;865.11758006833;870.9346798990069;871.8430682477151;872.5506364222431;691.8754624167648;817.5094943034192;843.8987321521457;858.7767180533075;862.9827403451927;619.1919544993781;619.6065498408498;620.8789286089169;620.9968950155265;621.5090078837712;15388.230588470531;15401.22993850303;15426.46007389736;15438.614034649112;15444.45944391941;14520.564383068524;14696.779548306784;14804.555863324118;14830.258487075711;15026.849731502654;13196.86803131966;13316.201027938354;13541.729165416735;13632.727345453135;13883.37524811386;4516.525764794682;4532.954670453286;4559.589636932692;4574.6340292776495;4640.466346370143;75414.24585754127;75496.62251688761;75672.86490702699;76084.61957690232;76157.23842761612;11648.475818588015;11680.299182049104;11737.530498779954;11740.88259117415;11972.791835551563;21677.458063548223;21724;21736;21737.23919662804;21761;7653.425993050543;7664.501807382502;7701.499402538817;7731;7734.1492435832015;4496.887577810516;4586.472555656075;4641.466231383367;4660.906781864343;4745.406824146981;3424.6404127566248;3525.065857547752;3537.5754909411035;3538.239278555123;3538.522299489536;538.2303306272069;632.5414074795829;646.612032780328;652.8628987912497;667.1593791822241;626.3423405424377;741.5773009384599;757.7648433054087;759.4835511851883;781.6404453951133;9873.60505579783;9882.505874706236;10048.748781280381;10234.181265498743;10263.281570290157;747.9626018699043;764.6788348893479;776.2133939158335;784.7567254151231;788.2354116506979;4231.957680423218;5096.541311282002;5158.664686795346;5165.070287348313;5192.558632516203;112412.43793781142;116594.41702791431;117661;118035.40982295206;120816;98193;100113.49943250237;100271.49864250778;100974.49512752389;100981.49509252554;88936.555317223;89871;92740;93285.53357233171;93995;10137.695869123938;10246.129079028366;10248.077673009167;10257.794844103226;10267.58929642806;46266.30600540927;47958.76020619875;49508;49530.75234623804;49690.751546242034;69958.65020674864;70757.64621176862;80780.59609701914;82300;82769.58615206885;12595;12729.681757956125;13141.671458213621;13447.663808404868;13641.181529108286;16003.839961600235;16121.838781612034;16296.674066518366;16404.015759054495;17246;14288.357023934155;15076.773848392502;15312.770308445159;15357.846421535642;15570.844291557392;14107.788383174466;14124.940629452627;14125.293735312987;15045.623859403602;15693.529194124194;14505;14868.702625947204;15025.924870375578;15047.398104075713;15151.545453636409;11796.29222246668;12177.147599667938;12200.206986546202;12209.572664956684;12553.686157846127;10628;11542.365169915734;11645.359505227294;12271.69320766988;12530.436130374337 22:18:37 INFO - PROCESS | 21026 | __end_tp_report 22:18:37 INFO - PROCESS | 21026 | __start_cc_report 22:18:37 INFO - PROCESS | 21026 | _x_x_mozilla_cycle_collect,822 22:18:37 INFO - PROCESS | 21026 | __end_cc_report 22:18:37 INFO - PROCESS | 21026 | __startTimestamp1467263917897__endTimestamp 22:18:37 INFO - PROCESS | 21026 | 22:18:37 INFO - PROCESS | 21026 | ------- Summary: start ------- 22:18:37 INFO - PROCESS | 21026 | Number of tests: 6 22:18:37 INFO - PROCESS | 21026 | 22:18:37 INFO - PROCESS | 21026 | [#0] dojo.html Cycles:165 Average:5343.57 Median:5560.92 stddev:630.53 (11.3%) stddev-sans-first:607.27 22:18:37 INFO - PROCESS | 21026 | Values: 3094.0 3094.5 3130.5 3167.1 3172.7 5189.9 5227.7 5339.3 5441.9 5471.4 5293.6 5367.2 5389.1 5416.7 5416.8 4867.9 4885.8 4978.1 5043.9 5044.9 4972.0 4979.4 5024.5 5041.2 5047.0 4734.2 4876.2 4960.6 4983.2 4988.2 4974.9 4980.7 4985.8 4996.9 5030.9 4810.8 4819.6 4894.2 4954.8 5016.7 5299.0 5391.5 5422.5 5423.8 5427.9 5773.5 5781.6 5784.9 5788.9 5792.0 5562.8 5660.6 5672.1 5882.0 5892.8 5387.3 5415.0 5420.4 5421.1 5425.6 5890.6 5915.8 5916.3 5916.8 5920.1 5482.4 5592.2 5642.1 5674.0 5709.2 5720.9 5764.9 5766.9 5770.5 5771.5 5697.5 5700.7 5703.8 5705.0 5739.3 5608.9 5647.5 5650.3 5672.9 5683.0 4147.8 4149.0 4150.2 4156.1 4186.9 3678.5 3703.7 3741.8 3756.7 3785.0 5317.4 5441.2 5480.0 5494.3 5514.7 5821.3 5830.2 5841.0 5843.5 5859.0 5276.3 5513.7 5518.1 5520.6 5525.3 4846.5 4891.4 4911.6 4919.7 4922.7 6006.0 6013.4 6025.6 6027.3 6030.7 5641.4 5810.8 5815.1 5817.6 5824.6 5869.1 5944.3 5951.0 5951.9 5957.3 5607.2 5639.6 5647.2 5655.7 5660.0 5579.2 5704.0 5793.5 5802.7 5807.2 5589.1 5600.3 5609.0 5617.1 5650.8 5590.1 5592.6 5593.1 5603.2 5613.9 5370.5 5522.5 5531.8 5565.4 5593.3 5750.9 5768.1 5773.6 5823.1 5823.9 5544.3 5557.7 5559.4 5560.9 5565.7 22:18:37 INFO - PROCESS | 21026 | 22:18:37 INFO - PROCESS | 21026 | [#1] ext.html Cycles:180 Average:60614.04 Median:20080.28 stddev:123074.63 (612.9%) stddev-sans-first:123337.37 22:18:37 INFO - PROCESS | 21026 | Values: 587.7 605.1 610.0 619.7 623.9 33536.5 43873.8 45074.1 45103.0 45199.8 45653.3 45987.3 46018.0 46048.8 46115.3 8062.8 8880.7 9029.4 9037.8 10528.6 10386.6 10745.4 10782.4 10788.6 10788.7 10799.1 10803.9 10848.1 10857.2 10858.1 8214.6 10567.7 10743.1 10807.9 10814.0 10708.6 10773.0 10777.7 10783.8 10784.2 36113.8 43090.4 43293.6 43403.8 43476.8 3499.6 3572.8 3581.4 3628.8 3653.1 33159.8 33564.8 33582.3 33658.2 34510.3 4485.0 4491.1 4495.9 4508.8 4543.3 350405.0 351133.2 352174.0 354180.0 355649.0 36507.5 37360.4 61277.7 61556.0 61588.7 38775.2 38789.8 38915.4 38941.0 38971.2 15266.4 15343.5 15424.1 15480.8 15492.6 12422.9 12583.7 12619.7 12622.1 12625.1 8893.2 8990.1 8995.6 9047.5 9112.7 3213.0 3284.7 3381.9 3389.9 3491.7 933.3 1034.3 1042.7 1053.4 1115.2 32811.8 33388.5 33482.0 33560.2 33645.2 1151.6 1161.5 1176.7 1191.9 1229.2 17222.3 17399.5 17659.6 17711.1 17753.8 588700.0 593038.0 594984.0 595809.0 598392.0 60618.7 61269.1 61348.4 61379.4 61405.7 1260.7 1340.3 1375.9 1378.2 1410.8 32549.0 33904.5 34025.7 34304.0 34459.7 51164.2 51698.5 51703.5 52190.2 52279.7 403786.0 404002.0 406497.0 406857.0 409205.0 26563.9 28692.3 29041.1 29258.7 31080.4 48153.5 48981.5 49523.8 49874.8 50114.0 40122.4 41125.6 41343.6 42241.4 42883.8 41373.4 42073.0 42249.6 42452.8 42604.6 41215.2 41893.2 42380.8 42609.2 44556.5 37771.2 38840.8 38909.2 39168.8 39290.6 28663.7 28957.9 29322.3 29507.0 29580.3 22:18:37 INFO - PROCESS | 21026 | 22:18:37 INFO - PROCESS | 21026 | [#2] jquery.html Cycles:180 Average:27574.19 Median:24254.95 stddev:68028.85 (280.5%) stddev-sans-first:68189.11 22:18:37 INFO - PROCESS | 21026 | Values: 407.0 420.1 422.5 426.9 432.2 18706.2 20229.1 20393.4 20696.5 20847.6 19190.7 19997.0 20263.5 20712.1 20762.5 5812.9 5983.3 6032.5 6039.4 6040.2 4180.4 5914.9 5925.1 6330.7 6630.8 6678.2 6695.9 6719.8 6730.9 6733.1 6370.8 6646.1 6651.4 6656.4 6656.7 3889.0 5436.9 5738.7 5747.4 5874.3 23590.2 24009.6 24108.5 24401.4 24515.3 2219.5 2339.3 2496.9 2508.1 3102.4 9922.2 10141.3 10207.3 10304.9 10368.2 1859.2 1885.2 1902.9 1907.5 2007.2 82473.6 82632.8 84188.0 84252.6 85906.0 11646.4 11785.2 11799.8 11886.2 11913.2 16136.4 16246.1 16250.2 16261.3 16289.7 7704.2 7755.0 7818.6 7898.4 8056.1 7314.2 7339.2 7339.9 7424.9 7436.4 5070.4 5099.6 5102.1 5173.2 5173.6 1826.8 1991.0 2049.8 2108.8 2109.1 931.4 1009.3 1026.1 1029.9 1088.7 19397.7 20024.9 20109.9 20132.6 20429.9 993.6 1020.2 1028.3 1052.1 1059.2 10056.9 11330.4 11409.9 11414.8 11416.9 365645.0 366154.0 366365.0 456821.0 461967.0 100892.5 101984.0 103783.5 105318.0 107640.0 994.5 1038.3 1041.5 1042.6 1057.2 17792.2 18221.0 18380.8 18453.2 18456.4 45836.0 46678.0 46926.5 47564.8 48448.5 63468.4 63983.4 64833.4 64936.0 66083.7 8475.6 8574.4 8609.3 8839.7 8847.3 9801.0 13877.9 14097.9 14439.8 14539.3 12243.8 12400.3 12410.7 12474.3 12498.3 5918.9 9880.3 11896.0 12210.1 12380.5 6629.3 11818.8 12268.1 12397.3 12603.4 8677.1 8715.6 8746.6 8806.0 9519.7 9201.7 12537.4 12592.7 12683.3 12694.3 22:18:37 INFO - PROCESS | 21026 | 22:18:37 INFO - PROCESS | 21026 | [#3] mootools.html Cycles:180 Average:6244.48 Median:5110.80 stddev:3655.87 (71.5%) stddev-sans-first:3647.69 22:18:37 INFO - PROCESS | 21026 | Values: 1359.4 1505.1 1509.5 1672.8 1798.6 8757.8 9138.1 9145.6 9433.2 9439.5 9204.3 9433.1 9434.8 9435.3 9476.3 2087.7 2403.1 2442.6 2458.1 2522.9 2480.7 2501.9 2510.4 2512.8 2513.5 2482.9 2497.3 2498.6 2501.6 2503.8 2078.6 2373.8 2415.9 2418.3 2444.0 2318.2 2330.9 2333.0 2337.9 2353.3 9341.2 9353.1 9410.9 9413.2 9427.0 5459.2 5523.5 5567.6 5568.5 5575.7 3681.5 3765.9 3813.8 3819.8 3839.5 1264.6 1265.7 1285.5 1289.3 1335.1 13535.3 13634.9 13654.4 13670.5 13712.3 4954.0 5012.7 5150.1 5160.9 5179.8 11211.5 11218.3 11224.4 11230.0 11244.2 4948.2 5680.3 5683.7 5687.1 5688.3 4913.9 5076.7 5088.8 5134.0 5138.3 4280.8 4323.7 4355.2 4413.1 4420.4 1249.7 1324.5 1325.1 1387.7 1412.7 939.1 949.8 956.8 965.5 970.2 5690.4 5694.4 6037.6 6244.8 6261.7 954.7 958.8 967.8 993.5 994.0 3968.0 4046.2 4049.3 4099.6 4122.4 11838.6 12175.8 12254.8 12293.5 12340.8 12135.9 12156.3 12161.6 12171.5 12188.5 8362.1 8570.2 8689.2 8710.8 8715.9 5972.1 6137.5 6147.5 6151.2 6197.3 10892.8 10996.8 11217.0 11262.4 11262.8 11121.7 11337.0 11372.7 11545.4 11577.1 8500.8 8503.3 8540.0 8582.5 8678.7 9125.2 9185.4 9225.4 9232.9 9241.0 8285.6 8328.7 8345.6 8505.5 8636.3 8078.3 8229.4 8238.9 8349.2 8359.0 7271.0 7528.5 7549.5 7564.8 7718.7 5132.8 5220.9 5267.2 5323.1 5342.2 5514.6 5530.5 5540.8 5558.8 5559.5 22:18:37 INFO - PROCESS | 21026 | 22:18:37 INFO - PROCESS | 21026 | [#4] prototype.html Cycles:180 Average:4701.41 Median:5335.11 stddev:1369.12 (25.7%) stddev-sans-first:1333.28 22:18:37 INFO - PROCESS | 21026 | Values: 341.2 344.9 353.0 355.8 358.5 5343.7 5350.0 5376.8 5388.6 5420.3 5273.7 5295.8 5326.5 5375.2 5394.8 4171.5 4217.2 4257.4 4271.7 4285.4 4196.9 4238.7 4242.9 4254.0 4254.4 3996.8 4217.9 4227.1 4251.3 4259.7 4092.2 4191.7 4206.8 4225.8 4227.5 3743.3 3758.3 3763.2 3771.3 3777.5 4952.7 4999.9 5248.4 5253.3 5254.4 4827.7 4830.7 4834.8 4836.7 4861.6 5582.8 5587.9 5603.8 5628.5 5633.2 3892.3 4100.0 4103.4 4118.4 4136.5 5704.4 5781.2 5821.6 5827.3 5851.5 4161.7 4184.3 4185.0 4195.0 4212.2 4174.0 4215.2 4253.4 4282.7 4284.1 4764.2 4780.5 4820.3 4825.2 4831.3 5642.0 5645.6 5679.9 5704.6 5725.6 1389.7 1423.5 1439.7 1445.4 1460.5 910.6 915.6 919.8 929.3 935.5 4791.4 4801.8 4808.0 4818.5 4835.3 5022.9 5036.8 5053.5 5065.8 5067.5 4810.0 5189.1 5200.9 5450.8 5453.7 3026.4 3027.8 3034.7 3035.7 3042.6 5646.3 5868.8 5876.6 5892.8 5898.2 5772.4 5801.9 5804.5 5810.5 5813.6 5892.4 5892.6 5895.8 5902.2 5915.8 5457.0 5736.4 5825.2 5826.7 5831.7 5750.3 5760.5 5769.4 5771.5 5787.5 5741.0 5956.2 5963.3 5966.5 5972.8 4056.5 4063.8 4070.6 4078.3 4082.7 5753.3 5767.4 5779.4 5794.2 5797.8 5426.9 5634.6 5658.7 5662.0 5669.0 5557.7 5599.3 5605.7 5643.0 5646.2 5503.5 5517.1 5534.8 5552.2 5564.9 5519.1 5669.7 5671.0 5673.6 5683.4 5482.2 5514.4 5518.3 5559.2 5561.1 22:18:37 INFO - PROCESS | 21026 | 22:18:37 INFO - PROCESS | 21026 | [#5] yui.html Cycles:180 Average:21378.08 Median:3538.38 stddev:30503.42 (862.1%) stddev-sans-first:30549.63 22:18:37 INFO - PROCESS | 21026 | Values: 741.2 754.8 764.8 788.7 850.1 15503.3 16328.7 16616.4 16964.9 17020.6 14586.1 14753.7 14764.6 14766.4 14780.3 663.6 790.1 791.7 804.5 817.1 782.2 809.4 811.8 816.0 816.7 857.9 865.1 870.9 871.8 872.6 691.9 817.5 843.9 858.8 863.0 619.2 619.6 620.9 621.0 621.5 15388.2 15401.2 15426.5 15438.6 15444.5 14520.6 14696.8 14804.6 14830.3 15026.8 13196.9 13316.2 13541.7 13632.7 13883.4 4516.5 4533.0 4559.6 4574.6 4640.5 75414.2 75496.6 75672.9 76084.6 76157.2 11648.5 11680.3 11737.5 11740.9 11972.8 21677.5 21724.0 21736.0 21737.2 21761.0 7653.4 7664.5 7701.5 7731.0 7734.1 4496.9 4586.5 4641.5 4660.9 4745.4 3424.6 3525.1 3537.6 3538.2 3538.5 538.2 632.5 646.6 652.9 667.2 626.3 741.6 757.8 759.5 781.6 9873.6 9882.5 10048.7 10234.2 10263.3 748.0 764.7 776.2 784.8 788.2 4232.0 5096.5 5158.7 5165.1 5192.6 112412.4 116594.4 117661.0 118035.4 120816.0 98193.0 100113.5 100271.5 100974.5 100981.5 88936.6 89871.0 92740.0 93285.5 93995.0 10137.7 10246.1 10248.1 10257.8 10267.6 46266.3 47958.8 49508.0 49530.8 49690.8 69958.7 70757.6 80780.6 82300.0 82769.6 12595.0 12729.7 13141.7 13447.7 13641.2 16003.8 16121.8 16296.7 16404.0 17246.0 14288.4 15076.8 15312.8 15357.8 15570.8 14107.8 14124.9 14125.3 15045.6 15693.5 14505.0 14868.7 15025.9 15047.4 15151.5 11796.3 12177.1 12200.2 12209.6 12553.7 10628.0 11542.4 11645.4 12271.7 12530.4 22:18:37 INFO - PROCESS | 21026 | -------- Summary: end -------- 22:18:37 INFO - PROCESS | 21026 | 22:18:38 INFO - TEST-INFO | 21026: exit 0 22:18:38 INFO - TEST-OK | dromaeo_css | took 1113156ms 22:18:38 INFO - TEST-START | kraken 22:18:38 INFO - operating with platform_type : linux_ 22:18:38 INFO - Initialising browser for kraken test... 22:18:38 INFO - TEST-INFO | started process 21215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzpQ0nK/profile http://localhost:45315/getInfo.html) 22:18:42 INFO - PROCESS | 21215 | __metrics Screen width/height:1600/1200 22:18:42 INFO - PROCESS | 21215 | colorDepth:24 22:18:42 INFO - PROCESS | 21215 | Browser inner width/height: 1024/697 22:18:42 INFO - PROCESS | 21215 | __metrics 22:18:43 INFO - PROCESS | 21215 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:18:44 INFO - TEST-INFO | 21215: exit 0 22:18:44 INFO - Browser initialized. 22:18:44 INFO - Running cycle 1/1 for kraken test... 22:18:44 INFO - TEST-INFO | started process 21296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzpQ0nK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:18:56 INFO - PROCESS | 21296 | RSS: Main: 156794880 22:18:56 INFO - PROCESS | 21296 | 22:18:58 INFO - PROCESS | 21296 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45315/tests/kraken/driver.html?testName=audio-beat-detection) 22:18:59 INFO - PROCESS | 21296 | RSS: Main: 215310336 22:18:59 INFO - PROCESS | 21296 | 22:19:02 INFO - PROCESS | 21296 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45315/tests/kraken/driver.html?testName=audio-dft) 22:19:02 INFO - PROCESS | 21296 | RSS: Main: 203616256 22:19:02 INFO - PROCESS | 21296 | 22:19:06 INFO - PROCESS | 21296 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45315/tests/kraken/driver.html?testName=audio-fft) 22:19:06 INFO - PROCESS | 21296 | RSS: Main: 269074432 22:19:06 INFO - PROCESS | 21296 | 22:19:08 INFO - PROCESS | 21296 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45315/tests/kraken/driver.html?testName=audio-oscillator) 22:19:09 INFO - PROCESS | 21296 | RSS: Main: 180367360 22:19:09 INFO - PROCESS | 21296 | 22:19:11 INFO - PROCESS | 21296 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45315/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:12 INFO - PROCESS | 21296 | RSS: Main: 184635392 22:19:12 INFO - PROCESS | 21296 | 22:19:15 INFO - PROCESS | 21296 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45315/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:15 INFO - PROCESS | 21296 | RSS: Main: 220434432 22:19:15 INFO - PROCESS | 21296 | 22:19:19 INFO - PROCESS | 21296 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45315/tests/kraken/driver.html?testName=imaging-desaturate) 22:19:19 INFO - PROCESS | 21296 | RSS: Main: 220749824 22:19:19 INFO - PROCESS | 21296 | 22:19:22 INFO - PROCESS | 21296 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45315/tests/kraken/driver.html?testName=json-parse-financial) 22:19:23 INFO - PROCESS | 21296 | RSS: Main: 221310976 22:19:23 INFO - PROCESS | 21296 | 22:19:24 INFO - PROCESS | 21296 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45315/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:19:25 INFO - PROCESS | 21296 | RSS: Main: 208281600 22:19:25 INFO - PROCESS | 21296 | 22:19:26 INFO - PROCESS | 21296 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:19:27 INFO - PROCESS | 21296 | RSS: Main: 210518016 22:19:27 INFO - PROCESS | 21296 | 22:19:29 INFO - PROCESS | 21296 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:19:30 INFO - PROCESS | 21296 | RSS: Main: 209231872 22:19:30 INFO - PROCESS | 21296 | 22:19:32 INFO - PROCESS | 21296 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:19:33 INFO - PROCESS | 21296 | RSS: Main: 224976896 22:19:33 INFO - PROCESS | 21296 | 22:19:36 INFO - PROCESS | 21296 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:19:36 INFO - PROCESS | 21296 | RSS: Main: 223813632 22:19:36 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45315/tests/kraken/driver.html?testName=ai-astar) 22:19:38 INFO - PROCESS | 21296 | RSS: Main: 266657792 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | __start_tp_report 22:19:38 INFO - PROCESS | 21296 | _x_x_mozilla_page_load 22:19:38 INFO - PROCESS | 21296 | _x_x_mozilla_page_load_details 22:19:38 INFO - PROCESS | 21296 | |i|pagename|runs| 22:19:38 INFO - PROCESS | 21296 | |0;ai-astar;101;112;110;110;112;110;110;113;111;112 22:19:38 INFO - PROCESS | 21296 | |1;audio-beat-detection;148;117;119;175;118;128;156;118;154;118 22:19:38 INFO - PROCESS | 21296 | |2;audio-dft;161;161;161;161;160;160;161;163;160;160 22:19:38 INFO - PROCESS | 21296 | |3;audio-fft;74;75;75;123;76;76;73;74;97;75 22:19:38 INFO - PROCESS | 21296 | |4;audio-oscillator;84;84;109;84;84;86;122;83;83;136 22:19:38 INFO - PROCESS | 21296 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;117;118;117 22:19:38 INFO - PROCESS | 21296 | |6;imaging-darkroom;147;147;146;146;146;148;145;145;145;146 22:19:38 INFO - PROCESS | 21296 | |7;imaging-desaturate;96;95;95;95;95;95;96;94;95;95 22:19:38 INFO - PROCESS | 21296 | |8;json-parse-financial;52;52;52;52;52;52;52;52;53;52 22:19:38 INFO - PROCESS | 21296 | |9;json-stringify-tinderbox;59;60;61;60;60;60;61;61;61;61 22:19:38 INFO - PROCESS | 21296 | |10;stanford-crypto-aes;74;74;81;75;74;75;74;76;79;78 22:19:38 INFO - PROCESS | 21296 | |11;stanford-crypto-ccm;118;116;117;138;136;119;128;117;156;128 22:19:38 INFO - PROCESS | 21296 | |12;stanford-crypto-pbkdf2;159;157;156;160;155;157;162;160;162;165 22:19:38 INFO - PROCESS | 21296 | |13;stanford-crypto-sha256-iterative;63;65;62;62;63;63;62;65;61;60 22:19:38 INFO - PROCESS | 21296 | __end_tp_report 22:19:38 INFO - PROCESS | 21296 | __start_cc_report 22:19:38 INFO - PROCESS | 21296 | _x_x_mozilla_cycle_collect,1618 22:19:38 INFO - PROCESS | 21296 | __end_cc_report 22:19:38 INFO - PROCESS | 21296 | __startTimestamp1467263978509__endTimestamp 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | ------- Summary: start ------- 22:19:38 INFO - PROCESS | 21296 | Number of tests: 14 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.50 stddev:3.38 (3.0%) stddev-sans-first:1.17 22:19:38 INFO - PROCESS | 21296 | Values: 101.0 112.0 110.0 110.0 112.0 110.0 110.0 113.0 111.0 112.0 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:138.00 stddev:21.26 (15.4%) stddev-sans-first:22.03 22:19:38 INFO - PROCESS | 21296 | Values: 148.0 117.0 119.0 175.0 118.0 128.0 156.0 118.0 154.0 118.0 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 22:19:38 INFO - PROCESS | 21296 | Values: 161.0 161.0 161.0 161.0 160.0 160.0 161.0 163.0 160.0 160.0 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:16.10 (21.5%) stddev-sans-first:16.83 22:19:38 INFO - PROCESS | 21296 | Values: 74.0 75.0 75.0 123.0 76.0 76.0 73.0 74.0 97.0 75.0 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.00 stddev:19.60 (23.3%) stddev-sans-first:20.34 22:19:38 INFO - PROCESS | 21296 | Values: 84.0 84.0 109.0 84.0 84.0 86.0 122.0 83.0 83.0 136.0 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:19:38 INFO - PROCESS | 21296 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 22:19:38 INFO - PROCESS | 21296 | Values: 147.0 147.0 146.0 146.0 146.0 148.0 145.0 145.0 145.0 146.0 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 22:19:38 INFO - PROCESS | 21296 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 22:19:38 INFO - PROCESS | 21296 | Values: 52.0 52.0 52.0 52.0 52.0 52.0 52.0 52.0 53.0 52.0 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 22:19:38 INFO - PROCESS | 21296 | Values: 59.0 60.0 61.0 60.0 60.0 60.0 61.0 61.0 61.0 61.0 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:75.50 stddev:2.49 (3.3%) stddev-sans-first:2.54 22:19:38 INFO - PROCESS | 21296 | Values: 74.0 74.0 81.0 75.0 74.0 75.0 74.0 76.0 79.0 78.0 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:128.00 stddev:12.95 (10.1%) stddev-sans-first:13.29 22:19:38 INFO - PROCESS | 21296 | Values: 118.0 116.0 117.0 138.0 136.0 119.0 128.0 117.0 156.0 128.0 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:160.00 stddev:3.13 (2.0%) stddev-sans-first:3.32 22:19:38 INFO - PROCESS | 21296 | Values: 159.0 157.0 156.0 160.0 155.0 157.0 162.0 160.0 162.0 165.0 22:19:38 INFO - PROCESS | 21296 | 22:19:38 INFO - PROCESS | 21296 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.58 (2.5%) stddev-sans-first:1.67 22:19:38 INFO - PROCESS | 21296 | Values: 63.0 65.0 62.0 62.0 63.0 63.0 62.0 65.0 61.0 60.0 22:19:38 INFO - PROCESS | 21296 | -------- Summary: end -------- 22:19:38 INFO - PROCESS | 21296 | 22:19:39 INFO - TEST-INFO | 21296: exit 0 22:19:39 INFO - TEST-OK | kraken | took 60808ms 22:19:39 INFO - SUITE-END | took 1173s 22:19:39 INFO - Completed test suite (00:19:34) 22:19:39 INFO - javascript benchmark 22:19:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.0, 3094.5048792193247, 3130.4834702274125, 3167.1132083016764, 3172.7144556989865, 5189.896202075956, 5227.660202086861, 5339.305890234269, 5441.945580544193, 5471.425500322463, 5293.550048245894, 5367.1680889462195, 5389.056915039862, 5416.702081385522, 5416.8104116355935, 4867.8783030424165, 4885.804567817292, 4978.054169707762, 5043.949560504403, 5044.873878153039, 4971.975140124312, 4979.377577802775, 5024.4724303948105, 5041.218611115283, 5047.01583191276, 4734.195186818232, 4876.195427754416, 4960.553550180465, 4983.202687570008, 4988.226824842155, 4974.925376119361, 4980.651354405193, 4985.825496107619, 4996.925046124311, 5030.899382012376, 4810.759462026919, 4819.614430845524, 4894.192458244385, 4954.826581069681, 5016.673916195436, 5298.973505132488, 5391.487808658171, 5422.511973922326, 5423.7830486780485, 5427.891442171174, 5773.480386765212, 5781.624194427349, 5784.88430231393, 5788.913166302509, 5792.015357389254, 5562.805301814417, 5660.575456840712, 5672.149177623348, 5882.000059989812, 5892.823215303548, 5387.326584176978, 5415.0, 5420.376656684492, 5421.1326187810155, 5425.565954723652, 5890.6171098879295, 5915.763369465173, 5916.319623243296, 5916.8462149881225, 5920.141579471038, 5482.424345443751, 5592.161175823578, 5642.069058605366, 5673.971630141906, 5709.172170035322, 5720.942790572124, 5764.855878602984, 5766.94233057664, 5770.480656740913, 5771.480566748929, 5697.515711164515, 5700.657960522382, 5703.800366987136, 5705.0, 5739.311282646109, 5608.887822243532, 5647.463490968434, 5650.29371328584, 5672.943270567242, 5683.0, 4147.834086636561, 4149.045719484536, 4150.232207041707, 4156.085661154601, 4186.937195942063, 3678.503402040744, 3703.666669999713, 3741.8129093545213, 3756.6619004289746, 3784.981075094662, 5317.361916570037, 5441.156620723794, 5480.04099282624, 5494.340679118532, 5514.696691681996, 5821.301443826768, 5830.154627578977, 5841.0, 5843.5325173985975, 5859.033259512133, 5276.287701160371, 5513.669179849222, 5518.061929471999, 5520.558355331564, 5525.254090697705, 4846.466888642247, 4891.413030436299, 4911.63162762787, 4919.65562410635, 4922.704637721748, 6006.039033754491, 6013.398660134039, 6025.608335458269, 6027.30685971119, 6030.698465076816, 5641.435856414326, 5810.767569297181, 5815.069588865761, 5817.563682723728, 5824.592278540462, 5869.090291004901, 5944.3164036136395, 5951.047832346977, 5951.880962380815, 5957.314908785545, 5607.243022191952, 5639.6334238274385, 5647.20939068539, 5655.660660360391, 5659.971700141473, 5579.246801681721, 5704.0, 5793.536517078539, 5802.6808525531505, 5807.157962095557, 5589.1336842787805, 5600.27196464457, 5609.0, 5617.129344951539, 5650.802221922213, 5590.133529302964, 5592.5525957922455, 5593.0771422716425, 5603.215549822947, 5613.915791263053, 5370.489803468664, 5522.475364840334, 5531.751071201886, 5565.387807341108, 5593.300837395325, 5750.856228594319, 5768.134779783066, 5773.595848290579, 5823.097419899922, 5823.94176058234, 5544.306961629796, 5557.666540007613, 5559.360673522597, 5560.916586251128, 5565.749541270734], "value": 5299.174211960903, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.7061469265367, 605.131636102193, 609.9939000609994, 619.6901549225387, 623.8596315828939, 33536.4969525457, 43873.78063109684, 45074.09851802962, 45103.0, 45199.774001130034, 45653.31520027202, 45987.31019034717, 46018.0, 46048.769756151254, 46115.308270375885, 8062.7581172564915, 8880.689175878846, 9029.413088149282, 9037.774055648628, 10528.578856845717, 10386.63646772363, 10745.355278683304, 10782.406967616778, 10788.5684572617, 10788.676339709822, 10799.136069114491, 10803.891961080406, 10848.077913377332, 10857.23999320048, 10858.131349492021, 8214.63034163461, 10567.735806604896, 10743.086837618812, 10807.945960270226, 10814.0, 10708.625198118028, 10773.0, 10777.676669699922, 10783.83824242637, 10784.191185661028, 36113.81943090294, 43090.35364469535, 43293.56706432927, 43403.78298108489, 43476.78261608672, 3499.5800503939436, 3572.821358932043, 3581.391163502211, 3628.76413033152, 3653.1049892776173, 33159.83420082884, 33564.83217583921, 33582.32835343279, 33658.158546036546, 34510.309793804234, 4484.977575112136, 4491.079328737601, 4495.9325610115875, 4508.842190523316, 4543.31850222466, 350405.0, 351133.24433377926, 352174.0, 354180.0, 355649.0, 36507.452388214195, 37360.43959340612, 61277.69361153166, 61556.0, 61588.69205653943, 38775.22449550993, 38789.806050969564, 38915.416268755995, 38941.0, 38971.220575588326, 15266.389344426321, 15343.539693809204, 15424.071991001125, 15480.84519154794, 15492.60566549016, 12422.875771242172, 12583.748325033448, 12619.684507887192, 12622.116451848466, 12625.05312101596, 8893.244074253631, 8990.100989900957, 8995.640174393082, 9047.547622618975, 9112.726618201465, 3212.951805722916, 3284.704376606069, 3381.9492707609406, 3389.932201355959, 3491.6682915123024, 933.2627224492575, 1034.270839058462, 1042.744527590745, 1053.4100903494068, 1115.2360632966445, 32811.83594082014, 33388.499172512435, 33482.0, 33560.16099597481, 33645.15887102842, 1151.5508951508918, 1161.506359797083, 1176.6528873982195, 1191.9165658404002, 1229.1518851992096, 17222.311107555557, 17399.47801565955, 17659.646807064044, 17711.114444277733, 17753.822461775475, 588700.0, 593038.0, 594984.0, 595809.0, 598392.0, 60618.696906515186, 61269.08096378558, 61348.38651613516, 61379.38620613826, 61405.69297153575, 1260.6785269756153, 1340.2829486224823, 1375.9243241621607, 1378.2281922123443, 1410.7954346619888, 32549.0, 33904.49143262902, 34025.65974340324, 34304.0, 34459.655403446646, 51164.232536512725, 51698.48301516937, 51703.48296516987, 52190.21714674359, 52279.73860130675, 403786.0, 404002.0, 406497.0, 406857.0, 409205.0, 26563.867180664747, 28692.282692932844, 29041.128766137048, 29258.7074129256, 31080.378392432478, 48153.5184648149, 48981.51018489769, 49523.77178688234, 49874.750626246634, 50114.0, 40122.39816402698, 41125.588744112174, 41343.58656413398, 42241.36637950494, 42883.7855810719, 41373.37939930963, 42073.0, 42249.577504225796, 42452.787736061124, 42604.573954260064, 41215.175696485305, 41893.1621367577, 42380.788096059325, 42609.220215274676, 44556.549389783875, 37771.2445751078, 38840.805795971966, 38909.221815564095, 39168.804155979036, 39290.60709392984, 28663.713362866103, 28957.85521072381, 29322.266943326587, 29507.0, 29580.260493486974], "value": 19698.595748210806, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.99186016279657, 420.0884081543051, 422.45503300742047, 426.88687497813083, 432.19611522568016, 18706.15822287997, 20229.089690963887, 20393.388198354056, 20696.48258793531, 20847.583048339024, 19190.712139317886, 19997.0, 20263.49341266469, 20712.067956941937, 20762.48093797652, 5812.883742325162, 5983.2820061592665, 6032.457078862902, 6039.365866584011, 6040.244969378828, 4180.435641188446, 5914.9112763308585, 5925.05199168131, 6330.746770129189, 6630.834229144261, 6678.165229346332, 6695.866082678343, 6719.798406047802, 6730.932690673079, 6733.124693789825, 6370.8088757337355, 6646.136002319716, 6651.368120028614, 6656.434203092743, 6656.70044847983, 3888.9805550972346, 5436.864078398072, 5738.6556806591325, 5747.3677895431465, 5874.32445268791, 23590.174343898052, 24009.639855402183, 24108.517829643486, 24401.389965250833, 24515.264542063767, 2219.533897881447, 2339.3332900123555, 2496.8501889886666, 2508.059477695864, 3102.4260511805387, 9922.206223502102, 10141.290109692325, 10207.285490015702, 10304.896951030469, 10368.222383321281, 1859.172668162668, 1885.198790514026, 1902.8858268503934, 1907.4849790556611, 2007.237249845064, 82473.58763206206, 82632.76050859242, 84188.0, 84252.57873710593, 85906.0, 11646.41767911601, 11785.233959792586, 11799.823002654966, 11886.167968242313, 11913.22564033335, 16136.35454581827, 16246.106464144586, 16250.187490625422, 16261.349546018027, 16289.674206515803, 7704.152543220242, 7755.030621172354, 7818.569978651229, 7898.447108702336, 8056.073551541648, 7314.195438501761, 7339.229380915034, 7339.8532029360185, 7424.888626670604, 7436.442266830009, 5070.366204224472, 5099.59203263738, 5102.132637451642, 5173.224016397495, 5173.611979101583, 1826.8191330047348, 1991.0, 2049.764277108122, 2108.81020708137, 2109.1457959526415, 931.3806318797923, 1009.3439264478149, 1026.0867827633413, 1029.902159294866, 1088.7223757941833, 19397.709034364496, 20024.89987550082, 20109.899450502653, 20132.597348052957, 20429.897850510653, 993.6472552243994, 1020.2297265564451, 1028.321307936758, 1052.1372474570778, 1059.1685526861377, 10056.899431005597, 11330.433478326051, 11409.942950285196, 11414.828777568344, 11416.94291528537, 365645.0, 366154.0, 366365.0, 456821.0, 461967.0, 100892.49553752184, 101984.0, 103783.48108259561, 105318.0, 107640.0, 994.5126887824914, 1038.2628333882876, 1041.4948749856314, 1042.5777560088177, 1057.2070946789909, 17792.199351028976, 18221.0, 18380.816191837912, 18453.16960736797, 18456.446306610822, 45836.0, 46678.0, 46926.53073469221, 47564.762176188895, 48448.5155148444, 63468.365316346244, 63983.3601663996, 64833.35166648273, 64936.0, 66083.66958165179, 8475.576221188792, 8574.3997920145, 8609.311255099452, 8839.734807955772, 8847.292216622784, 9800.950995244979, 13877.86122138806, 14097.929510352382, 14439.78340324917, 14539.273036348352, 12243.75512489763, 12400.255984640951, 12410.689732756753, 12474.339810662681, 12498.312592807482, 5918.911216331845, 9880.291507294929, 11896.048316134515, 12210.145289829981, 12380.504779809067, 6629.337066293332, 11818.822717659414, 12268.141230113806, 12397.318147501974, 12603.369831508571, 8677.132286771272, 8715.64907439348, 8746.606402712021, 8805.955970220108, 9519.714408567754, 9201.723948281562, 12537.435815388511, 12592.685182870502, 12683.302418367079, 12694.301813400352], "value": 9507.06857634612, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.442628522306, 1505.1195050895226, 1509.501864384753, 1672.8327167283273, 1798.6312805874798, 8757.781055473617, 9138.131877471638, 9145.588448519817, 9433.24534037277, 9439.480828554426, 9204.309676774235, 9433.056694330564, 9434.81130377392, 9435.339526233167, 9476.28927830412, 2087.7390326209224, 2403.146882856591, 2442.6458163566363, 2458.1027924807404, 2522.8864701088496, 2480.7395223501544, 2501.862397568133, 2510.410053637394, 2512.7612876776675, 2513.4721708441157, 2482.8758562071916, 2497.2882728422405, 2498.562751518486, 2501.6372625969316, 2503.824732268742, 2078.5738923520644, 2373.7744914233035, 2415.903363865443, 2418.274517644717, 2443.9755602443925, 2318.2465698648007, 2330.8951097200497, 2332.9650055249185, 2337.8597284163006, 2353.270486149282, 9341.159295663423, 9353.064693530592, 9410.858837117381, 9413.152816246502, 9427.0, 5459.153831156177, 5523.4752698493985, 5567.610267281292, 5568.49883510482, 5575.749091290902, 3681.4661874028384, 3765.8681946131755, 3813.8283777229813, 3819.8281077351585, 3839.4816699745734, 1264.576366917084, 1265.7278685082658, 1285.517930775959, 1289.3037759609892, 1335.105479328852, 13535.32323383827, 13634.863651363557, 13654.385552650154, 13670.52153174644, 13712.314384280746, 4954.0, 5012.724300163453, 5150.098732721834, 5160.922586161136, 5179.7928082877015, 11211.495482703134, 11218.326900386002, 11224.438778061065, 11230.0, 11244.212905096729, 4948.208286674115, 5680.318361796611, 5683.687397193112, 5687.061634830289, 5688.317401911797, 4913.877153071202, 5076.695398276115, 5088.821891233789, 5133.974330128325, 5138.306328645585, 4280.807363668642, 4323.697341186087, 4355.236129367611, 4413.073254616503, 4420.359047938031, 1249.7000719827176, 1324.5297919238724, 1325.072449285504, 1387.6808334083016, 1412.7245187188605, 939.0797018921359, 949.8005418862116, 956.8469044952914, 965.4834663455018, 970.1995853420956, 5690.4025077367105, 5694.402087780806, 6037.607555508878, 6244.781432649836, 6261.686915654199, 954.7326748510428, 958.8465845464692, 967.8354679704468, 993.4784238274964, 993.9950300248597, 3968.047668559525, 4046.1705350403095, 4049.2913740095364, 4099.569545197771, 4122.443470131494, 11838.644840654793, 12175.756484870253, 12254.81617775734, 12293.508259669514, 12340.81488777669, 12135.939320303341, 12156.33140177281, 12161.635150945485, 12171.452284647212, 12188.512459501699, 8362.080171181165, 8570.185832345916, 8689.217970382695, 8710.782230444289, 8715.912840871637, 5972.104184372205, 6137.508999280136, 6147.508199344131, 6151.200343955257, 6197.318294987638, 10892.836607450736, 10996.780064398827, 11217.046551043253, 11262.436878156223, 11262.774744505228, 11121.721956951142, 11337.0, 11372.658820235407, 11545.36500492481, 11577.07383409342, 8500.829983400174, 8503.319734421108, 8540.0, 8582.485050896967, 8678.696245631372, 9125.224355929555, 9185.357025008185, 9225.354225204172, 9232.861507077534, 9240.95379523098, 8285.585720714062, 8328.708495202638, 8345.582720864053, 8505.532195729294, 8636.26591739684, 8078.272955433804, 8229.423940324119, 8238.917610824055, 8349.248567628943, 8359.0, 7270.9636451817405, 7528.473006889465, 7549.471536992358, 7564.773056808304, 7718.729844455417, 5132.769025393941, 5220.9216861746345, 5267.236250743697, 5323.0684630190335, 5342.198670199501, 5514.5864060196445, 5530.5022547969265, 5540.80607178763, 5558.833235002957, 5559.467259041846], "value": 4943.139842912166, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.23222748815164, 344.86377880737103, 352.964050511748, 355.82208895552225, 358.53748664223156, 5343.679379237248, 5349.9732501337485, 5376.758045887935, 5388.595855310848, 5420.268263784388, 5273.657212281209, 5295.841124766263, 5326.547243484309, 5375.247465354853, 5394.757235924383, 4171.541130475645, 4217.177650358181, 4257.361395790641, 4271.70098093132, 4285.400043993851, 4196.916061678765, 4238.724482908617, 4242.8727138185905, 4254.0, 4254.383114448403, 3996.7601943883315, 4217.924429270532, 4227.133437645275, 4251.341042138458, 4259.701820872525, 4092.242935057009, 4191.7484950903045, 4206.768627725474, 4225.767582782961, 4227.513835908879, 3743.288775132716, 3758.3047136279874, 3763.153290509641, 3771.3211621908044, 3777.527809023872, 4952.727599981999, 4999.925001124986, 5248.396434410015, 5253.266422080743, 5254.4220135785035, 4827.6930302742385, 4830.73430961297, 4834.806607735686, 4836.709797412132, 4861.562459378673, 5582.8325150245555, 5587.916181257244, 5603.803866864681, 5628.521575666074, 5633.211350410946, 3892.299386110499, 4099.97950010251, 4103.363978583325, 4118.382242663594, 4136.503619565671, 5704.401037891044, 5781.161731548944, 5821.592488525805, 5827.3298570664065, 5851.531877449794, 4161.708680392343, 4184.288670925889, 4185.0, 4194.979025104916, 4212.220739163265, 4174.039970806671, 4215.156968606291, 4253.425787518708, 4282.678799090018, 4284.121755040209, 4764.166270902579, 4780.521947805261, 4820.276958456189, 4825.227963525819, 4831.299461578052, 5641.971790141023, 5645.576581756384, 5679.914801277984, 5704.573856535866, 5725.570582206351, 1389.7012142389435, 1423.4590855474853, 1439.7480440923007, 1445.3929349673163, 1460.5034288342015, 910.5583791860943, 915.6428992692855, 919.8298314811781, 929.3494553812359, 935.5415846235431, 4791.425028996543, 4801.783919723621, 4807.966287248259, 4818.494058123846, 4835.323054772335, 5022.89954200914, 5036.841526448864, 5053.545180933734, 5065.797368105308, 5067.493250674903, 4810.01778897086, 5189.065968125698, 5200.947990520046, 5450.754716037788, 5453.745638503166, 3026.424979253935, 3027.8031927924612, 3034.7117023882697, 3035.6509001465115, 3042.558828969787, 5646.296259588915, 5868.794592189253, 5876.6180198286975, 5892.764289428461, 5898.233229680114, 5772.365039845614, 5801.94198058014, 5804.506616937523, 5810.477057064884, 5813.622114562624, 5892.440218179266, 5892.558058145656, 5895.823125306248, 5902.20320256777, 5915.822525324334, 5456.972715136399, 5736.397678243891, 5825.242718446575, 5826.650400975955, 5831.70841457917, 5750.30996280449, 5760.481556659921, 5769.394213607511, 5771.538276937918, 5787.450192231731, 5740.971295143498, 5956.225690660186, 5963.254593175853, 5966.463018328372, 5972.760214919405, 4056.492938382702, 4063.780865740325, 4070.633642972028, 4078.347464405681, 4082.693797965224, 5753.324704012654, 5767.365589785037, 5779.36426993022, 5794.18881356602, 5797.826065218051, 5426.945730542802, 5634.633748806478, 5658.688772117408, 5661.961693790315, 5669.0, 5557.694326812064, 5599.272094627672, 5605.663660180402, 5643.0, 5646.153077038477, 5503.532199763065, 5517.117261238182, 5534.7786088556, 5552.222688823649, 5564.944350556604, 5519.130052372663, 5669.716514174357, 5671.043489995945, 5673.574481913955, 5683.431656834284, 5482.150266708666, 5514.365847927379, 5518.33779946409, 5559.2217089606675, 5561.138023606348], "value": 4267.317369155933, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.2254194366886, 754.773567929621, 764.7629234937167, 788.6569342336085, 850.1031411860489, 15503.302351394186, 16328.673426531492, 16616.418425355114, 16964.91517542412, 17020.574485637866, 14586.051906626088, 14753.704925901475, 14764.557063288119, 14766.409343626243, 14780.334884930204, 663.5521023309271, 790.1269097647104, 791.6595863778588, 804.5172896262225, 817.0971076959963, 782.2216894190288, 809.4172196018857, 811.8051667599763, 815.963281652327, 816.6529225079347, 857.901341345747, 865.11758006833, 870.9346798990069, 871.8430682477151, 872.5506364222431, 691.8754624167648, 817.5094943034192, 843.8987321521457, 858.7767180533075, 862.9827403451927, 619.1919544993781, 619.6065498408498, 620.8789286089169, 620.9968950155265, 621.5090078837712, 15388.230588470531, 15401.22993850303, 15426.46007389736, 15438.614034649112, 15444.45944391941, 14520.564383068524, 14696.779548306784, 14804.555863324118, 14830.258487075711, 15026.849731502654, 13196.86803131966, 13316.201027938354, 13541.729165416735, 13632.727345453135, 13883.37524811386, 4516.525764794682, 4532.954670453286, 4559.589636932692, 4574.6340292776495, 4640.466346370143, 75414.24585754127, 75496.62251688761, 75672.86490702699, 76084.61957690232, 76157.23842761612, 11648.475818588015, 11680.299182049104, 11737.530498779954, 11740.88259117415, 11972.791835551563, 21677.458063548223, 21724.0, 21736.0, 21737.23919662804, 21761.0, 7653.425993050543, 7664.501807382502, 7701.499402538817, 7731.0, 7734.1492435832015, 4496.887577810516, 4586.472555656075, 4641.466231383367, 4660.906781864343, 4745.406824146981, 3424.6404127566248, 3525.065857547752, 3537.5754909411035, 3538.239278555123, 3538.522299489536, 538.2303306272069, 632.5414074795829, 646.612032780328, 652.8628987912497, 667.1593791822241, 626.3423405424377, 741.5773009384599, 757.7648433054087, 759.4835511851883, 781.6404453951133, 9873.60505579783, 9882.505874706236, 10048.748781280381, 10234.181265498743, 10263.281570290157, 747.9626018699043, 764.6788348893479, 776.2133939158335, 784.7567254151231, 788.2354116506979, 4231.957680423218, 5096.541311282002, 5158.664686795346, 5165.070287348313, 5192.558632516203, 112412.43793781142, 116594.41702791431, 117661.0, 118035.40982295206, 120816.0, 98193.0, 100113.49943250237, 100271.49864250778, 100974.49512752389, 100981.49509252554, 88936.555317223, 89871.0, 92740.0, 93285.53357233171, 93995.0, 10137.695869123938, 10246.129079028366, 10248.077673009167, 10257.794844103226, 10267.58929642806, 46266.30600540927, 47958.76020619875, 49508.0, 49530.75234623804, 49690.751546242034, 69958.65020674864, 70757.64621176862, 80780.59609701914, 82300.0, 82769.58615206885, 12595.0, 12729.681757956125, 13141.671458213621, 13447.663808404868, 13641.181529108286, 16003.839961600235, 16121.838781612034, 16296.674066518366, 16404.015759054495, 17246.0, 14288.357023934155, 15076.773848392502, 15312.770308445159, 15357.846421535642, 15570.844291557392, 14107.788383174466, 14124.940629452627, 14125.293735312987, 15045.623859403602, 15693.529194124194, 14505.0, 14868.702625947204, 15025.924870375578, 15047.398104075713, 15151.545453636409, 11796.29222246668, 12177.147599667938, 12200.206986546202, 12209.572664956684, 12553.686157846127, 10628.0, 11542.365169915734, 11645.359505227294, 12271.69320766988, 12530.436130374337], "value": 7803.885276846171, "unit": "score"}], "name": "dromaeo_css", "value": 7393.786215456824, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 110.0, 110.0, 112.0, 110.0, 110.0, 113.0, 111.0, 112.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 119.0, 175.0, 118.0, 128.0, 156.0, 118.0, 154.0, 118.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 161.0, 163.0, 160.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 123.0, 76.0, 76.0, 73.0, 74.0, 97.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 109.0, 84.0, 84.0, 86.0, 122.0, 83.0, 83.0, 136.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 148.0, 145.0, 145.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 53.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 61.0, 60.0, 60.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 81.0, 75.0, 74.0, 75.0, 74.0, 76.0, 79.0, 78.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 138.0, 136.0, 119.0, 128.0, 117.0, 156.0, 128.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 156.0, 160.0, 155.0, 157.0, 162.0, 160.0, 162.0, 165.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 62.0, 62.0, 63.0, 63.0, 62.0, 65.0, 61.0, 60.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1479.3999999999999, "alertThreshold": 2.0}]} 22:19:39 INFO - Return code: 0 22:19:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:19:39 INFO - # TBPL SUCCESS # 22:19:39 INFO - Running post-action listener: _resource_record_post_action 22:19:39 INFO - ##### 22:19:39 INFO - ##### Finished run-tests step (success) 22:19:39 INFO - ##### 22:19:39 INFO - Running post-run listener: _resource_record_post_run 22:19:39 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 552108032; Read time: 0; Write time: 430100 22:19:39 INFO - TinderboxPrint: CPU usage
12.9% 22:19:39 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:19:39 INFO - TinderboxPrint: I/O write bytes / time
552,108,032 / 430,100 22:19:39 INFO - TinderboxPrint: CPU idle
8,281.5 (87.0%) 22:19:39 INFO - TinderboxPrint: CPU user
1,189.0 (12.5%) 22:19:39 INFO - TinderboxPrint: Swap in / out
0 / 0 22:19:39 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256327680; Read time: 0; Write time: 252984 22:19:39 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295780352; Read time: 0; Write time: 177116 22:19:40 INFO - Running post-run listener: _upload_blobber_files 22:19:40 INFO - Blob upload gear active. 22:19:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:19:40 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 22:19:40 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:19:40 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:19:40 INFO - (blobuploader) - INFO - Open directory for files ... 22:19:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:19:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:19:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:41 INFO - (blobuploader) - INFO - Done attempting. 22:19:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:19:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:19:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:42 INFO - (blobuploader) - INFO - Done attempting. 22:19:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:19:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:19:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:45 INFO - (blobuploader) - INFO - Done attempting. 22:19:45 INFO - (blobuploader) - INFO - Iteration through files over. 22:19:45 INFO - Return code: 0 22:19:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:19:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:19:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/be67b451dc4911decc34d8683cbb3c660164d347f1ae27c5a119530daf4d65c9d75e77fb0c7f1bd3638265fcb7c5c5e3dae9b1b6617ed971f5726a8499770d82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6502ffa21f486595d808d3f44f9245cdc0aa7e293353e85097fe81ad872c831368f886d88ee89955d719491116e00cd1dc4e4bb2419ea0eaa302a11676d22165", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/893fd702b050f60815bd4744ba9e493d21385e54bf2b43673068cfc2458e3292a3742a4fc990e2c3cdb8e3ebb1ca7a3e3f88c57d4c0706933fa5fa2be78d5000"} 22:19:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:19:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:19:45 INFO - Contents: 22:19:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/be67b451dc4911decc34d8683cbb3c660164d347f1ae27c5a119530daf4d65c9d75e77fb0c7f1bd3638265fcb7c5c5e3dae9b1b6617ed971f5726a8499770d82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6502ffa21f486595d808d3f44f9245cdc0aa7e293353e85097fe81ad872c831368f886d88ee89955d719491116e00cd1dc4e4bb2419ea0eaa302a11676d22165", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/893fd702b050f60815bd4744ba9e493d21385e54bf2b43673068cfc2458e3292a3742a4fc990e2c3cdb8e3ebb1ca7a3e3f88c57d4c0706933fa5fa2be78d5000"} 22:19:45 INFO - Running post-run listener: copy_logs_to_upload_dir 22:19:45 INFO - Copying logs to upload dir... 22:19:45 INFO - mkdir: /builds/slave/test/build/upload/logs 22:19:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.729606 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-29 22:19:45.710814) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 22:19:45.714066) ========= 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=db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/be67b451dc4911decc34d8683cbb3c660164d347f1ae27c5a119530daf4d65c9d75e77fb0c7f1bd3638265fcb7c5c5e3dae9b1b6617ed971f5726a8499770d82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6502ffa21f486595d808d3f44f9245cdc0aa7e293353e85097fe81ad872c831368f886d88ee89955d719491116e00cd1dc4e4bb2419ea0eaa302a11676d22165", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/893fd702b050f60815bd4744ba9e493d21385e54bf2b43673068cfc2458e3292a3742a4fc990e2c3cdb8e3ebb1ca7a3e3f88c57d4c0706933fa5fa2be78d5000"} build_url:https://queue.taskcluster.net/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/Xu1k9HyEQHmz_rEGDJHBCw/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/Autoland/sha512/be67b451dc4911decc34d8683cbb3c660164d347f1ae27c5a119530daf4d65c9d75e77fb0c7f1bd3638265fcb7c5c5e3dae9b1b6617ed971f5726a8499770d82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6502ffa21f486595d808d3f44f9245cdc0aa7e293353e85097fe81ad872c831368f886d88ee89955d719491116e00cd1dc4e4bb2419ea0eaa302a11676d22165", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/893fd702b050f60815bd4744ba9e493d21385e54bf2b43673068cfc2458e3292a3742a4fc990e2c3cdb8e3ebb1ca7a3e3f88c57d4c0706933fa5fa2be78d5000"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 22:19:45.740135) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 22:19:45.740468) ========= 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=db7e7c15f3ca076d53731445000001ba-1467256822.495729-141710164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004388 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 22:19:45.823462) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 22:19:45.823812) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 22:19:45.824139) ========= ========= Total master_lag: 0.18 =========