builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1468038153.39 results: success (0) buildid: 20160708183001 builduid: 71688b99c8fb4310b0cc17eb62da4297 revision: 64e752c0270c0dfebdf4004e8f7d19029807994d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 21:22:33.387772) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 21:22:33.388279) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 21:22:33.388613) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 21:22:33.407792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 21:22:33.408129) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 21:22:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-07-08 21:22:33 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.363381 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 21:22:33.787001) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 21:22:33.787377) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019603 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 21:22:33.837475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 21:22:33.837912) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 64e752c0270c0dfebdf4004e8f7d19029807994d --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 64e752c0270c0dfebdf4004e8f7d19029807994d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 21:22:34,031 truncating revision to first 12 chars 2016-07-08 21:22:34,031 Setting DEBUG logging. 2016-07-08 21:22:34,032 attempt 1/10 2016-07-08 21:22:34,032 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/64e752c0270c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 21:22:34,742 unpacking tar archive at: autoland-64e752c0270c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.104941 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 21:22:34.957343) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 21:22:34.957695) ========= script_repo_revision: 64e752c0270c0dfebdf4004e8f7d19029807994d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 21:22:34.958172) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 21:22:34.958481) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 21:22:34.969306) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-08 21:22:34.969625) ========= /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=31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:22:35 INFO - MultiFileLogger online at 20160708 21:22:35 in /builds/slave/test 21:22:35 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:22:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:22:35 INFO - {'append_to_log': False, 21:22:35 INFO - 'base_work_dir': '/builds/slave/test', 21:22:35 INFO - 'blob_upload_branch': 'Autoland', 21:22:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:22:35 INFO - 'branch': 'Autoland', 21:22:35 INFO - 'buildbot_json_path': 'buildprops.json', 21:22:35 INFO - 'config_files': ('talos/linux_config.py',), 21:22:35 INFO - 'default_actions': ('clobber', 21:22:35 INFO - 'read-buildbot-config', 21:22:35 INFO - 'download-and-extract', 21:22:35 INFO - 'populate-webroot', 21:22:35 INFO - 'create-virtualenv', 21:22:35 INFO - 'install', 21:22:35 INFO - 'run-tests'), 21:22:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:22:35 INFO - 'download_minidump_stackwalk': True, 21:22:35 INFO - 'download_symbols': 'ondemand', 21:22:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:22:35 INFO - 'tooltool.py': '/tools/tooltool.py', 21:22:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:22:35 INFO - '/tools/misc-python/virtualenv.py')}, 21:22:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:22:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:22:35 INFO - 'installer_path': 'installer.exe', 21:22:35 INFO - 'log_level': 'info', 21:22:35 INFO - 'log_name': 'talos', 21:22:35 INFO - 'log_to_console': True, 21:22:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:22:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:22:35 INFO - 'opt_config_files': (), 21:22:35 INFO - 'pip_index': False, 21:22:35 INFO - 'sps_profile': False, 21:22:35 INFO - 'sps_profile_interval': 0, 21:22:35 INFO - 'suite': 'dromaeojs', 21:22:35 INFO - 'system_bits': '32', 21:22:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:22:35 INFO - 'title': 'talos-linux64-ix-014', 21:22:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:22:35 INFO - 'use_talos_json': True, 21:22:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:22:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:22:35 INFO - 'work_dir': 'build'} 21:22:35 INFO - ##### 21:22:35 INFO - ##### Running clobber step. 21:22:35 INFO - ##### 21:22:35 INFO - Running pre-action listener: _resource_record_pre_action 21:22:35 INFO - Running main action method: clobber 21:22:35 INFO - rmtree: /builds/slave/test/build 21:22:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:22:36 INFO - Running post-action listener: _resource_record_post_action 21:22:36 INFO - ##### 21:22:36 INFO - ##### Finished clobber step (success) 21:22:36 INFO - ##### 21:22:36 INFO - ##### 21:22:36 INFO - ##### Running read-buildbot-config step. 21:22:36 INFO - ##### 21:22:36 INFO - Running pre-action listener: _resource_record_pre_action 21:22:36 INFO - Running main action method: read_buildbot_config 21:22:36 INFO - Using buildbot properties: 21:22:36 INFO - { 21:22:36 INFO - "project": "", 21:22:36 INFO - "product": "firefox", 21:22:36 INFO - "script_repo_revision": "production", 21:22:36 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 21:22:36 INFO - "repository": "", 21:22:36 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 21:22:36 INFO - "buildid": "20160708183001", 21:22:36 INFO - "pgo_build": "True", 21:22:36 INFO - "basedir": "/builds/slave/test", 21:22:36 INFO - "buildnumber": 13, 21:22:36 INFO - "slavename": "talos-linux64-ix-014", 21:22:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:22:36 INFO - "platform": "ubuntu64_hw", 21:22:36 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 21:22:36 INFO - "branch": "autoland", 21:22:36 INFO - "repo_path": "integration/autoland", 21:22:36 INFO - "revision": "64e752c0270c0dfebdf4004e8f7d19029807994d", 21:22:36 INFO - "stage_platform": "linux64-pgo", 21:22:36 INFO - "builduid": "71688b99c8fb4310b0cc17eb62da4297", 21:22:36 INFO - "slavebuilddir": "test" 21:22:36 INFO - } 21:22:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 21:22:36 INFO - Running post-action listener: _resource_record_post_action 21:22:36 INFO - ##### 21:22:36 INFO - ##### Finished read-buildbot-config step (success) 21:22:36 INFO - ##### 21:22:36 INFO - ##### 21:22:36 INFO - ##### Running download-and-extract step. 21:22:36 INFO - ##### 21:22:36 INFO - Running pre-action listener: _resource_record_pre_action 21:22:36 INFO - Running main action method: download_and_extract 21:22:36 INFO - mkdir: /builds/slave/test/build/tests 21:22: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:22:36 INFO - https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:22:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:22:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:22:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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:22:38 INFO - Downloaded 1361 bytes. 21:22:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:22:38 INFO - Using the following test package requirements: 21:22:38 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:22:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:22:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:22:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:38 INFO - u'jsshell-linux-x86_64.zip'], 21:22:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:22:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:22:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:22:38 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:22:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:22:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:22:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:22:38 INFO - https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:22:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:22:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:22:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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:22:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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:22:46 INFO - Downloaded 24303241 bytes. 21:22:46 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:22:46 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:22:47 INFO - Return code: 0 21:22:47 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:22: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:22:47 INFO - https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:22:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:22:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:22:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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:22:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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:22:48 INFO - Downloaded 24303241 bytes. 21:22:48 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:22:48 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:22:50 INFO - Return code: 0 21:22:50 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:22:50 INFO - https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:22:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:22:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:22:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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:22:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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:22:51 INFO - Downloaded 14403333 bytes. 21:22:51 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:22:51 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:22:51 INFO - Return code: 0 21:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:22:51 INFO - https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:22:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:22:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:22:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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:22:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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:22:52 INFO - Downloaded 60434003 bytes. 21:22:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:22:52 INFO - mkdir: /builds/slave/test/properties 21:22:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:22:52 INFO - Writing to file /builds/slave/test/properties/build_url 21:22:52 INFO - Contents: 21:22:52 INFO - build_url:https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:22:53 INFO - Running post-action listener: _resource_record_post_action 21:22:53 INFO - Running post-action listener: set_extra_try_arguments 21:22:53 INFO - ##### 21:22:53 INFO - ##### Finished download-and-extract step (success) 21:22:53 INFO - ##### 21:22:53 INFO - ##### 21:22:53 INFO - ##### Running populate-webroot step. 21:22:53 INFO - ##### 21:22:53 INFO - Running pre-action listener: _resource_record_pre_action 21:22:53 INFO - Running main action method: populate_webroot 21:22:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:22:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:22:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:22:53 INFO - '--tppagecycles', 21:22:53 INFO - '7'], 21:22:53 INFO - 'tests': ['tsvgm']}}, 21:22:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:22:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:22:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:22:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:22:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:22:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:22:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:53 INFO - 'talos_options': ['--disable-e10s'], 21:22:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:22:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:22:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:53 INFO - 'talos_options': ['--disable-e10s'], 21:22:53 INFO - 'tests': ['damp', 'tps']}, 21:22:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:53 INFO - 'tests': ['damp', 'tps']}, 21:22:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:22:53 INFO - 'tests': ['dromaeo_dom']}, 21:22:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:22:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:22:53 INFO - 'tests': ['basic_compositor_video']}, 21:22:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:22:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:22:53 INFO - 'tests': ['a11yr', 21:22:53 INFO - 'ts_paint', 21:22:53 INFO - 'tpaint', 21:22:53 INFO - 'sessionrestore', 21:22:53 INFO - 'sessionrestore_no_auto_restore', 21:22:53 INFO - 'tabpaint']}, 21:22:53 INFO - 'other-e10s': {'tests': ['a11yr', 21:22:53 INFO - 'ts_paint', 21:22:53 INFO - 'tpaint', 21:22:53 INFO - 'sessionrestore', 21:22:53 INFO - 'sessionrestore_no_auto_restore', 21:22:53 INFO - 'tabpaint']}, 21:22:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:22:53 INFO - 'ts_paint', 21:22:53 INFO - 'tpaint', 21:22:53 INFO - 'sessionrestore', 21:22:53 INFO - 'sessionrestore_no_auto_restore', 21:22:53 INFO - 'tabpaint']}, 21:22:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:22:53 INFO - 'ts_paint', 21:22:53 INFO - 'tpaint', 21:22:53 INFO - 'sessionrestore', 21:22:53 INFO - 'sessionrestore_no_auto_restore', 21:22:53 INFO - 'tabpaint']}, 21:22:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:22:53 INFO - 'tests': ['a11yr', 21:22:53 INFO - 'ts_paint', 21:22:53 INFO - 'tpaint', 21:22:53 INFO - 'sessionrestore', 21:22:53 INFO - 'sessionrestore_no_auto_restore', 21:22:53 INFO - 'tabpaint']}, 21:22:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:22:53 INFO - 'tests': ['a11yr', 21:22:53 INFO - 'ts_paint', 21:22:53 INFO - 'tpaint', 21:22:53 INFO - 'sessionrestore', 21:22:53 INFO - 'sessionrestore_no_auto_restore', 21:22:53 INFO - 'tabpaint']}, 21:22:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:22:53 INFO - 'tests': ['tsvgx', 21:22:53 INFO - 'tsvgr_opacity', 21:22:53 INFO - 'tart', 21:22:53 INFO - 'tscrollx', 21:22:53 INFO - 'cart']}, 21:22:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:22:53 INFO - 'tsvgr_opacity', 21:22:53 INFO - 'tart', 21:22:53 INFO - 'tscrollx', 21:22:53 INFO - 'cart']}, 21:22:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:53 INFO - 'talos_options': ['--disable-e10s'], 21:22:53 INFO - 'tests': ['tp5o']}, 21:22:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:53 INFO - 'tests': ['tp5o']}, 21:22:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:53 INFO - 'talos_options': ['--disable-e10s', 21:22:53 INFO - '--xperf_path', 21:22:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:22:53 INFO - 'tests': ['tp5n']}, 21:22:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:53 INFO - 'talos_options': ['--xperf_path', 21:22:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:22:53 INFO - 'tests': ['tp5n']}}, 21:22:53 INFO - 'talos.zip': {'path': '', 21:22:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:22:53 INFO - Running post-action listener: _resource_record_post_action 21:22:53 INFO - ##### 21:22:53 INFO - ##### Finished populate-webroot step (success) 21:22:53 INFO - ##### 21:22:53 INFO - ##### 21:22:53 INFO - ##### Running create-virtualenv step. 21:22:53 INFO - ##### 21:22:53 INFO - Running pre-action listener: _resource_record_pre_action 21:22:53 INFO - Running main action method: create_virtualenv 21:22:53 INFO - Creating virtualenv /builds/slave/test/build/venv 21:22:53 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:22:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:22:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:22:54 INFO - Using real prefix '/usr' 21:22:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:22:54 INFO - Installing distribute.............................................................................................................................................................................................done. 21:22:56 INFO - Installing pip.................done. 21:22:56 INFO - Return code: 0 21:22:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:22:56 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:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:56 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:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x24fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b93b0>, '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 0x27ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ba740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', '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:22:56 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:22:56 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:22:56 INFO - Using env: {'DISPLAY': ':0', 21:22:56 INFO - 'HOME': '/home/cltbld', 21:22:56 INFO - 'LANG': 'en_US.UTF-8', 21:22:56 INFO - 'LANGUAGE': 'en_US:en', 21:22:56 INFO - 'LOGNAME': 'cltbld', 21:22:56 INFO - 'MAIL': '/var/mail/cltbld', 21:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:56 INFO - 'MOZ_NO_REMOTE': '1', 21:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:22:56 INFO - 'NO_EM_RESTART': '1', 21:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:56 INFO - 'PWD': '/builds/slave/test', 21:22:56 INFO - 'SHELL': '/bin/bash', 21:22:56 INFO - 'SHLVL': '1', 21:22:56 INFO - 'TERM': 'linux', 21:22:56 INFO - 'TMOUT': '86400', 21:22:56 INFO - 'USER': 'cltbld', 21:22:56 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', 21:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:56 INFO - '_': '/tools/buildbot/bin/python'} 21:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:56 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:22:56 INFO - Cleaning up... 21:22:56 INFO - Return code: 0 21:22:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:22:56 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:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:56 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:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x24fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b93b0>, '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 0x27ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ba740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', '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:22:56 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:22:56 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:22:56 INFO - Using env: {'DISPLAY': ':0', 21:22:56 INFO - 'HOME': '/home/cltbld', 21:22:56 INFO - 'LANG': 'en_US.UTF-8', 21:22:56 INFO - 'LANGUAGE': 'en_US:en', 21:22:56 INFO - 'LOGNAME': 'cltbld', 21:22:56 INFO - 'MAIL': '/var/mail/cltbld', 21:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:56 INFO - 'MOZ_NO_REMOTE': '1', 21:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:22:56 INFO - 'NO_EM_RESTART': '1', 21:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:56 INFO - 'PWD': '/builds/slave/test', 21:22:56 INFO - 'SHELL': '/bin/bash', 21:22:56 INFO - 'SHLVL': '1', 21:22:56 INFO - 'TERM': 'linux', 21:22:56 INFO - 'TMOUT': '86400', 21:22:56 INFO - 'USER': 'cltbld', 21:22:56 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', 21:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:56 INFO - '_': '/tools/buildbot/bin/python'} 21:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:56 INFO - Downloading/unpacking psutil>=3.1.1 21:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:22:56 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:22:56 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:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:22:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:22:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:22:59 INFO - Installing collected packages: psutil 21:22:59 INFO - Running setup.py install for psutil 21:22:59 INFO - building 'psutil._psutil_linux' extension 21:22:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:22:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:22:59 INFO - building 'psutil._psutil_posix' extension 21:22:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:22:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:22:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:22:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:23:00 INFO - Successfully installed psutil 21:23:00 INFO - Cleaning up... 21:23:00 INFO - Return code: 0 21:23:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b93b0>, '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 0x27ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ba740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', '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:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:23:00 INFO - Using env: {'DISPLAY': ':0', 21:23:00 INFO - 'HOME': '/home/cltbld', 21:23:00 INFO - 'LANG': 'en_US.UTF-8', 21:23:00 INFO - 'LANGUAGE': 'en_US:en', 21:23:00 INFO - 'LOGNAME': 'cltbld', 21:23:00 INFO - 'MAIL': '/var/mail/cltbld', 21:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:00 INFO - 'MOZ_NO_REMOTE': '1', 21:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:00 INFO - 'NO_EM_RESTART': '1', 21:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:00 INFO - 'PWD': '/builds/slave/test', 21:23:00 INFO - 'SHELL': '/bin/bash', 21:23:00 INFO - 'SHLVL': '1', 21:23:00 INFO - 'TERM': 'linux', 21:23:00 INFO - 'TMOUT': '86400', 21:23:00 INFO - 'USER': 'cltbld', 21:23:00 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', 21:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:00 INFO - '_': '/tools/buildbot/bin/python'} 21:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:23:02 INFO - Installing collected packages: mozsystemmonitor 21:23:02 INFO - Running setup.py install for mozsystemmonitor 21:23:02 INFO - Successfully installed mozsystemmonitor 21:23:02 INFO - Cleaning up... 21:23:02 INFO - Return code: 0 21:23:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:23:02 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:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:02 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:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:02 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 0x24fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b93b0>, '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 0x27ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ba740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', '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:23:02 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:23:02 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:23:02 INFO - Using env: {'DISPLAY': ':0', 21:23:02 INFO - 'HOME': '/home/cltbld', 21:23:02 INFO - 'LANG': 'en_US.UTF-8', 21:23:02 INFO - 'LANGUAGE': 'en_US:en', 21:23:02 INFO - 'LOGNAME': 'cltbld', 21:23:02 INFO - 'MAIL': '/var/mail/cltbld', 21:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:02 INFO - 'MOZ_NO_REMOTE': '1', 21:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:02 INFO - 'NO_EM_RESTART': '1', 21:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:02 INFO - 'PWD': '/builds/slave/test', 21:23:02 INFO - 'SHELL': '/bin/bash', 21:23:02 INFO - 'SHLVL': '1', 21:23:02 INFO - 'TERM': 'linux', 21:23:02 INFO - 'TMOUT': '86400', 21:23:02 INFO - 'USER': 'cltbld', 21:23:02 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', 21:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:02 INFO - '_': '/tools/buildbot/bin/python'} 21:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:02 INFO - Downloading/unpacking jsonschema==2.5.1 21:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:02 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:23:02 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:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:23:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:04 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:23:04 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:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:05 INFO - Downloading functools32-3.2.3-2.tar.gz 21:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:23:05 INFO - warning: no files found matching '*.txt' 21:23:05 INFO - no previously-included directories found matching 'build' 21:23:05 INFO - no previously-included directories found matching 'dist' 21:23:05 INFO - no previously-included directories found matching '.git*' 21:23:05 INFO - Installing collected packages: jsonschema, functools32 21:23:05 INFO - Running setup.py install for functools32 21:23:05 INFO - warning: no files found matching '*.txt' 21:23:05 INFO - no previously-included directories found matching 'build' 21:23:05 INFO - no previously-included directories found matching 'dist' 21:23:05 INFO - no previously-included directories found matching '.git*' 21:23:05 INFO - Successfully installed jsonschema functools32 21:23:05 INFO - Cleaning up... 21:23:05 INFO - Return code: 0 21:23:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:23: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:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:05 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 0x24fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b93b0>, '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 0x27ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ba740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', '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:23:05 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:23:05 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:23:05 INFO - Using env: {'DISPLAY': ':0', 21:23:05 INFO - 'HOME': '/home/cltbld', 21:23:05 INFO - 'LANG': 'en_US.UTF-8', 21:23:05 INFO - 'LANGUAGE': 'en_US:en', 21:23:05 INFO - 'LOGNAME': 'cltbld', 21:23:05 INFO - 'MAIL': '/var/mail/cltbld', 21:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:05 INFO - 'MOZ_NO_REMOTE': '1', 21:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:05 INFO - 'NO_EM_RESTART': '1', 21:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:05 INFO - 'PWD': '/builds/slave/test', 21:23:05 INFO - 'SHELL': '/bin/bash', 21:23:05 INFO - 'SHLVL': '1', 21:23:05 INFO - 'TERM': 'linux', 21:23:05 INFO - 'TMOUT': '86400', 21:23:05 INFO - 'USER': 'cltbld', 21:23:05 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', 21:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:05 INFO - '_': '/tools/buildbot/bin/python'} 21:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:05 INFO - Downloading/unpacking blobuploader==1.2.4 21:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:05 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:23:05 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:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:07 INFO - Downloading blobuploader-1.2.4.tar.gz 21:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:23:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:07 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:23:07 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:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:23:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:07 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:23:07 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:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:08 INFO - Downloading docopt-0.6.1.tar.gz 21:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:23:08 INFO - Installing collected packages: blobuploader, requests, docopt 21:23:08 INFO - Running setup.py install for blobuploader 21:23:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:23:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:23:08 INFO - Running setup.py install for requests 21:23:08 INFO - Running setup.py install for docopt 21:23:08 INFO - Successfully installed blobuploader requests docopt 21:23:08 INFO - Cleaning up... 21:23:08 INFO - Return code: 0 21:23:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:08 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:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:08 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:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:08 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 0x24fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b93b0>, '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 0x27ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ba740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', '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:23:08 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:23:08 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:23:08 INFO - Using env: {'DISPLAY': ':0', 21:23:08 INFO - 'HOME': '/home/cltbld', 21:23:08 INFO - 'LANG': 'en_US.UTF-8', 21:23:08 INFO - 'LANGUAGE': 'en_US:en', 21:23:08 INFO - 'LOGNAME': 'cltbld', 21:23:08 INFO - 'MAIL': '/var/mail/cltbld', 21:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:08 INFO - 'MOZ_NO_REMOTE': '1', 21:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:08 INFO - 'NO_EM_RESTART': '1', 21:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:08 INFO - 'PWD': '/builds/slave/test', 21:23:08 INFO - 'SHELL': '/bin/bash', 21:23:08 INFO - 'SHLVL': '1', 21:23:08 INFO - 'TERM': 'linux', 21:23:08 INFO - 'TMOUT': '86400', 21:23:08 INFO - 'USER': 'cltbld', 21:23:08 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', 21:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:08 INFO - '_': '/tools/buildbot/bin/python'} 21:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:23:08 INFO - Running setup.py (path:/tmp/pip-S56q4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:23:09 INFO - Running setup.py (path:/tmp/pip-ta_Prg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:23:09 INFO - Running setup.py (path:/tmp/pip-pc2W85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:23:09 INFO - Running setup.py (path:/tmp/pip-bMisT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:23:09 INFO - Running setup.py (path:/tmp/pip-az4VoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:23:09 INFO - Running setup.py (path:/tmp/pip-pnJLKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:23:09 INFO - Running setup.py (path:/tmp/pip-Alc9XY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:23:09 INFO - Running setup.py (path:/tmp/pip-rzI1NU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:23:09 INFO - Running setup.py (path:/tmp/pip-RD3YOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:23:09 INFO - Running setup.py (path:/tmp/pip-SRhZjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:23:09 INFO - Running setup.py (path:/tmp/pip-Q08IIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:23:09 INFO - Running setup.py (path:/tmp/pip-tvPLka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:23:09 INFO - Running setup.py (path:/tmp/pip-DW_TaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:23:09 INFO - Running setup.py (path:/tmp/pip-3GHtC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:09 INFO - Running setup.py (path:/tmp/pip-mPUxoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:23:10 INFO - Running setup.py (path:/tmp/pip-JiGwSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:23:10 INFO - Running setup.py (path:/tmp/pip-EZnumG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:23:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:23:10 INFO - Running setup.py install for manifestparser 21:23:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:23:10 INFO - Running setup.py install for mozcrash 21:23:10 INFO - Running setup.py install for mozdebug 21:23:10 INFO - Running setup.py install for mozdevice 21:23:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:23:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:23:10 INFO - Running setup.py install for mozfile 21:23:10 INFO - Running setup.py install for mozhttpd 21:23:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:23:10 INFO - Running setup.py install for mozinfo 21:23:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:23:10 INFO - Running setup.py install for mozInstall 21:23:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:23:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:23:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:23:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:23:10 INFO - Running setup.py install for mozleak 21:23:11 INFO - Running setup.py install for mozlog 21:23:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:23:11 INFO - Running setup.py install for moznetwork 21:23:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:23:11 INFO - Running setup.py install for mozprocess 21:23:11 INFO - Running setup.py install for mozprofile 21:23:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:23:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:23:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:23:11 INFO - Running setup.py install for mozrunner 21:23:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:23:11 INFO - Running setup.py install for mozscreenshot 21:23:11 INFO - Running setup.py install for moztest 21:23:11 INFO - Running setup.py install for mozversion 21:23:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:23:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:23:11 INFO - Cleaning up... 21:23:11 INFO - Return code: 0 21:23:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:11 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 0x24fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b93b0>, '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 0x27ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ba740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', '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:23:11 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:23:11 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:23:11 INFO - Using env: {'DISPLAY': ':0', 21:23:11 INFO - 'HOME': '/home/cltbld', 21:23:11 INFO - 'LANG': 'en_US.UTF-8', 21:23:11 INFO - 'LANGUAGE': 'en_US:en', 21:23:11 INFO - 'LOGNAME': 'cltbld', 21:23:11 INFO - 'MAIL': '/var/mail/cltbld', 21:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:11 INFO - 'MOZ_NO_REMOTE': '1', 21:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:11 INFO - 'NO_EM_RESTART': '1', 21:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:11 INFO - 'PWD': '/builds/slave/test', 21:23:11 INFO - 'SHELL': '/bin/bash', 21:23:11 INFO - 'SHLVL': '1', 21:23:11 INFO - 'TERM': 'linux', 21:23:11 INFO - 'TMOUT': '86400', 21:23:11 INFO - 'USER': 'cltbld', 21:23:11 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', 21:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:11 INFO - '_': '/tools/buildbot/bin/python'} 21:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:23:12 INFO - Running setup.py (path:/tmp/pip-nEAMkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:23:12 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:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:23:12 INFO - Running setup.py (path:/tmp/pip-d4wWaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:23:12 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:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:23:12 INFO - Running setup.py (path:/tmp/pip-h56Ow_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:23:12 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:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:23:12 INFO - Running setup.py (path:/tmp/pip-Te9lFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:23:12 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:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:23:12 INFO - Running setup.py (path:/tmp/pip-bXR3ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:23:12 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:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:23:12 INFO - Running setup.py (path:/tmp/pip-FvFxGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:23:12 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:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:23:12 INFO - Running setup.py (path:/tmp/pip-ZeXPeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:23:12 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:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:23:12 INFO - Running setup.py (path:/tmp/pip-WcldZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:23:12 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:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:23:12 INFO - Running setup.py (path:/tmp/pip-1_mnqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:23:12 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:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:23:12 INFO - Running setup.py (path:/tmp/pip-H8xkS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:23:12 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:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:23:12 INFO - Running setup.py (path:/tmp/pip-yFfyJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:23:13 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:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:23:13 INFO - Running setup.py (path:/tmp/pip-t2R6dW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:23:13 INFO - Running setup.py (path:/tmp/pip-rXnx4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:23:13 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:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:23:13 INFO - Running setup.py (path:/tmp/pip-S3AT5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:13 INFO - Running setup.py (path:/tmp/pip-Bv_7u8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:13 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:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:23:13 INFO - Running setup.py (path:/tmp/pip-N7yKOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:23:13 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:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:23:13 INFO - Running setup.py (path:/tmp/pip-58kM0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:23:13 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:23:13 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:23:13 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:23:13 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:23:13 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:23:13 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:23:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:23:13 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:23:13 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:23:13 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:23:13 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:23:13 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:23:13 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:23:15 INFO - Downloading blessings-1.6.tar.gz 21:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:23:15 INFO - Installing collected packages: blessings 21:23:15 INFO - Running setup.py install for blessings 21:23:15 INFO - Successfully installed blessings 21:23:15 INFO - Cleaning up... 21:23:15 INFO - Return code: 0 21:23:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:23:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:15 INFO - Reading from file tmpfile_stdout 21:23:15 INFO - Current package versions: 21:23:15 INFO - argparse == 1.2.1 21:23:15 INFO - blessings == 1.6 21:23:15 INFO - blobuploader == 1.2.4 21:23:15 INFO - docopt == 0.6.1 21:23:15 INFO - functools32 == 3.2.3-2 21:23:15 INFO - jsonschema == 2.5.1 21:23:15 INFO - manifestparser == 1.1 21:23:15 INFO - mozInstall == 1.12 21:23:15 INFO - mozcrash == 0.17 21:23:15 INFO - mozdebug == 0.1 21:23:15 INFO - mozdevice == 0.48 21:23:15 INFO - mozfile == 1.2 21:23:15 INFO - mozhttpd == 0.7 21:23:15 INFO - mozinfo == 0.9 21:23:15 INFO - mozleak == 0.1 21:23:15 INFO - mozlog == 3.2 21:23:15 INFO - moznetwork == 0.27 21:23:15 INFO - mozprocess == 0.23 21:23:15 INFO - mozprofile == 0.28 21:23:15 INFO - mozrunner == 6.12 21:23:15 INFO - mozscreenshot == 0.1 21:23:15 INFO - mozsystemmonitor == 0.3 21:23:15 INFO - moztest == 0.7 21:23:15 INFO - mozversion == 1.4 21:23:15 INFO - psutil == 3.1.1 21:23:15 INFO - requests == 1.2.3 21:23:15 INFO - wsgiref == 0.1.2 21:23:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:15 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:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:15 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:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:15 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 0x24fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b93b0>, '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 0x27ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ba740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', '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:23:15 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:23:15 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:23:15 INFO - Using env: {'DISPLAY': ':0', 21:23:15 INFO - 'HOME': '/home/cltbld', 21:23:15 INFO - 'LANG': 'en_US.UTF-8', 21:23:15 INFO - 'LANGUAGE': 'en_US:en', 21:23:15 INFO - 'LOGNAME': 'cltbld', 21:23:15 INFO - 'MAIL': '/var/mail/cltbld', 21:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:15 INFO - 'MOZ_NO_REMOTE': '1', 21:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:15 INFO - 'NO_EM_RESTART': '1', 21:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:15 INFO - 'PWD': '/builds/slave/test', 21:23:15 INFO - 'SHELL': '/bin/bash', 21:23:15 INFO - 'SHLVL': '1', 21:23:15 INFO - 'TERM': 'linux', 21:23:15 INFO - 'TMOUT': '86400', 21:23:15 INFO - 'USER': 'cltbld', 21:23:15 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', 21:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:15 INFO - '_': '/tools/buildbot/bin/python'} 21:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:16 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:23:16 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:23:16 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:23:16 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:23:16 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:23:16 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:23:16 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:23:16 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:23:16 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:23:16 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:23:16 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:23:16 INFO - Cleaning up... 21:23:16 INFO - Return code: 0 21:23:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:23:16 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:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:16 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:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:16 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 0x24fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b93b0>, '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 0x27ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ba740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', '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:23:16 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:23:16 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:23:16 INFO - Using env: {'DISPLAY': ':0', 21:23:16 INFO - 'HOME': '/home/cltbld', 21:23:16 INFO - 'LANG': 'en_US.UTF-8', 21:23:16 INFO - 'LANGUAGE': 'en_US:en', 21:23:16 INFO - 'LOGNAME': 'cltbld', 21:23:16 INFO - 'MAIL': '/var/mail/cltbld', 21:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:16 INFO - 'MOZ_NO_REMOTE': '1', 21:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:16 INFO - 'NO_EM_RESTART': '1', 21:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:16 INFO - 'PWD': '/builds/slave/test', 21:23:16 INFO - 'SHELL': '/bin/bash', 21:23:16 INFO - 'SHLVL': '1', 21:23:16 INFO - 'TERM': 'linux', 21:23:16 INFO - 'TMOUT': '86400', 21:23:16 INFO - 'USER': 'cltbld', 21:23:16 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', 21:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:16 INFO - '_': '/tools/buildbot/bin/python'} 21:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:23:16 INFO - Cleaning up... 21:23:16 INFO - Return code: 0 21:23:16 INFO - Running post-action listener: _resource_record_post_action 21:23:16 INFO - Running post-action listener: _start_resource_monitoring 21:23:16 INFO - Starting resource monitoring. 21:23:16 INFO - ##### 21:23:16 INFO - ##### Finished create-virtualenv step (success) 21:23:16 INFO - ##### 21:23:16 INFO - ##### 21:23:16 INFO - ##### Running install step. 21:23:16 INFO - ##### 21:23:16 INFO - Running pre-action listener: _resource_record_pre_action 21:23:16 INFO - Running main action method: install 21:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:16 INFO - Reading from file tmpfile_stdout 21:23:16 INFO - Detecting whether we're running mozinstall >=1.0... 21:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:23:16 INFO - Reading from file tmpfile_stdout 21:23:16 INFO - Output received: 21:23:16 INFO - Usage: mozinstall [options] installer 21:23:16 INFO - Options: 21:23:16 INFO - -h, --help show this help message and exit 21:23:16 INFO - -d DEST, --destination=DEST 21:23:16 INFO - Directory to install application into. [default: 21:23:16 INFO - "/builds/slave/test"] 21:23:16 INFO - --app=APP Application being installed. [default: firefox] 21:23:16 INFO - mkdir: /builds/slave/test/build/application 21:23:16 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:23:16 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 21:23:33 INFO - Reading from file tmpfile_stdout 21:23:33 INFO - Output received: 21:23:33 INFO - /builds/slave/test/build/application/firefox/firefox 21:23:33 INFO - Running post-action listener: _resource_record_post_action 21:23:33 INFO - ##### 21:23:33 INFO - ##### Finished install step (success) 21:23:33 INFO - ##### 21:23:33 INFO - ##### 21:23:33 INFO - ##### Running run-tests step. 21:23:33 INFO - ##### 21:23:33 INFO - Running pre-action listener: _resource_record_pre_action 21:23:33 INFO - Running main action method: run_tests 21:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:23:33 INFO - Python 2.7.3 21:23:33 INFO - Return code: 0 21:23:33 INFO - grabbing minidump binary from tooltool 21:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:33 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 0x27b93b0>, '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 0x27ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ba740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:23:33 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 21:23:33 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 21:23:33 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 21:23:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:23:33 INFO - Return code: 0 21:23:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:23:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:23:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:23:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:23:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:23:33 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/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:23:33 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/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:23:33 INFO - Using env: {'DISPLAY': ':0', 21:23:33 INFO - 'HOME': '/home/cltbld', 21:23:33 INFO - 'LANG': 'en_US.UTF-8', 21:23:33 INFO - 'LANGUAGE': 'en_US:en', 21:23:33 INFO - 'LOGNAME': 'cltbld', 21:23:33 INFO - 'MAIL': '/var/mail/cltbld', 21:23:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:23:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:33 INFO - 'MOZ_NO_REMOTE': '1', 21:23:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:33 INFO - 'NO_EM_RESTART': '1', 21:23:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:33 INFO - 'PWD': '/builds/slave/test', 21:23:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:23:33 INFO - 'SHELL': '/bin/bash', 21:23:33 INFO - 'SHLVL': '1', 21:23:33 INFO - 'TERM': 'linux', 21:23:33 INFO - 'TMOUT': '86400', 21:23:33 INFO - 'USER': 'cltbld', 21:23:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659', 21:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:33 INFO - '_': '/tools/buildbot/bin/python'} 21:23:33 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/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:23:34 INFO - mozversion application_buildid: 20160708183001 21:23:34 INFO - mozversion application_changeset: 64e752c0270c0dfebdf4004e8f7d19029807994d 21:23:34 INFO - mozversion application_display_name: Nightly 21:23:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:23:34 INFO - mozversion application_name: Firefox 21:23:34 INFO - mozversion application_remotingname: firefox 21:23:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:23:34 INFO - mozversion application_vendor: Mozilla 21:23:34 INFO - mozversion application_version: 50.0a1 21:23:34 INFO - mozversion platform_buildid: 20160708183001 21:23:34 INFO - mozversion platform_changeset: 64e752c0270c0dfebdf4004e8f7d19029807994d 21:23:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:23:34 INFO - mozversion platform_version: 50.0a1 21:23:34 INFO - using testdate: 1468038214 21:23:34 INFO - actual date: 1468038214 21:23:34 INFO - starting webserver on 'localhost:40456' 21:23:34 INFO - SUITE-START | Running 2 tests 21:23:34 INFO - TEST-START | dromaeo_css 21:23:34 INFO - operating with platform_type : linux_ 21:23:34 INFO - Initialising browser for dromaeo_css test... 21:23:34 INFO - TEST-INFO | started process 23239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvzeDr0/profile http://localhost:40456/getInfo.html) 21:23:38 INFO - PROCESS | 23239 | __metrics Screen width/height:1600/1200 21:23:38 INFO - PROCESS | 23239 | colorDepth:24 21:23:38 INFO - PROCESS | 23239 | Browser inner width/height: 1024/697 21:23:38 INFO - PROCESS | 23239 | __metrics 21:23:39 INFO - PROCESS | 23239 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:23:39 INFO - PROCESS | 23239 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:23:40 INFO - TEST-INFO | 23239: exit 0 21:23:40 INFO - Browser initialized. 21:23:40 INFO - Running cycle 1/1 for dromaeo_css test... 21:23:40 INFO - TEST-INFO | started process 23323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvzeDr0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:23:52 INFO - PROCESS | 23323 | RSS: Main: 157511680 21:23:52 INFO - PROCESS | 23323 | 21:24:43 INFO - PROCESS | 23323 | 1468038283456 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:26:51 INFO - PROCESS | 23323 | Cycle 1(1): loaded http://localhost:40456/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40456/tests/dromaeo/cssquery-ext.html) 21:26:52 INFO - PROCESS | 23323 | RSS: Main: 253059072 21:26:52 INFO - PROCESS | 23323 | 21:29:54 INFO - PROCESS | 23323 | Cycle 1(1): loaded http://localhost:40456/tests/dromaeo/cssquery-ext.html (next: http://localhost:40456/tests/dromaeo/cssquery-jquery.html) 21:29:55 INFO - PROCESS | 23323 | RSS: Main: 239734784 21:29:55 INFO - PROCESS | 23323 | 21:32:57 INFO - PROCESS | 23323 | Cycle 1(1): loaded http://localhost:40456/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40456/tests/dromaeo/cssquery-mootools.html) 21:32:57 INFO - PROCESS | 23323 | RSS: Main: 236916736 21:32:57 INFO - PROCESS | 23323 | 21:35:59 INFO - PROCESS | 23323 | Cycle 1(1): loaded http://localhost:40456/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40456/tests/dromaeo/cssquery-prototype.html) 21:36:00 INFO - PROCESS | 23323 | RSS: Main: 237203456 21:36:00 INFO - PROCESS | 23323 | 21:39:03 INFO - PROCESS | 23323 | Cycle 1(1): loaded http://localhost:40456/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40456/tests/dromaeo/cssquery-yui.html) 21:39:03 INFO - PROCESS | 23323 | RSS: Main: 224657408 21:39:03 INFO - PROCESS | 23323 | 21:42:06 INFO - PROCESS | 23323 | Cycle 1(1): loaded http://localhost:40456/tests/dromaeo/cssquery-yui.html (next: http://localhost:40456/tests/dromaeo/cssquery-dojo.html) 21:42:06 INFO - PROCESS | 23323 | RSS: Main: 303972352 21:42:06 INFO - PROCESS | 23323 | 21:42:06 INFO - PROCESS | 23323 | __start_tp_report 21:42:06 INFO - PROCESS | 23323 | _x_x_mozilla_page_load 21:42:06 INFO - PROCESS | 23323 | _x_x_mozilla_page_load_details 21:42:06 INFO - PROCESS | 23323 | |i|pagename|runs| 21:42:06 INFO - PROCESS | 23323 | |0;dojo.html;2947.189522881206;2963.6591791943906;3005.504091824849;3045.3452507710845;3073.3085055862434;5245.4754524547525;5301.893962120765;5369.382521010085;5428.240046393508;5429.7828086876525;5356.758945847437;5386.1920711893235;5419.160030195316;5428.294321738178;5445.319335083114;4853.247746599265;4917.3361596184595;4937.629677774164;4955.083309587738;5001.6998980061135;4925.729084900329;4932.531409516108;4967.677100988442;4984.37695288089;4990.226514890198;4811.109944660249;4819.783109760034;4825.179719447685;4868.780904859272;4908.705477671351;4830.879228019293;4914.164592019365;4923.384576927884;4925.655204135712;4955.40535135786;4863.635227357927;4895.290182923456;4897.240927656219;4897.51024897511;4908.386451693538;5265.86835329116;5292.206169074631;5368.409474957752;5394.136938089926;5423.566114710814;5720.170575266605;5756.050251708463;5760.7695692172265;5781.797637082682;5789.623674461147;5644;5796.449337312949;5828.038373668382;5844.240248767633;5854.385289544622;5294.497022782868;5353.946460535384;5353.973230133864;5402.864928376744;5409.323834520685;5938.465538101505;5950.256217972754;5977.491913187428;5988.461038506555;5997.490213331916;5470;5534.142207957773;5747.597668163188;5749.396313387034;5756;5667.376588575254;5770.019096753562;5772.538196944234;5776.220210271644;5778.393268706809;5637.295338082739;5690.118031705092;5696.487316141567;5697.401772813795;5740.856478588069;5522.972385138049;5647.322321321468;5650.830475085754;5696.51579615729;5700.743466543932;4366.628836548929;4369.300911854088;4373.9125217495475;4409.382686423904;4414.668899832525;3845.0964023454467;3866.4007078902814;3872.0707030312524;3895.6299151580556;3900.278448487039;5289.550388216968;5379.327584051994;5398.6220964532895;5440.075187218183;5481.808136715196;5746.080627099727;5762.7694892203845;5771.7114144293455;5780.508656764138;5822.592418530662;5471.7264136793;5477.260569823103;5480.205370221295;5483.396826349099;5490.396056433869;4752.144613969519;4820.517948205152;4844.927326090112;4861.027794441055;4869.9269510957365;6003.579749417586;6006.729697163551;6010.068439391988;6013.1581578579035;6017.097435384728;5731.942680573141;5814.592978491634;5823.242978412779;5824.3593204748295;5827.446392592697;5844.064949608042;5883.970305196659;5956.344802071682;5960.821175364746;6001.759929602942;5627.43725627434;5662.150677398423;5673.092305231308;5676.17695434168;5678.574106942078;5612.691301978431;5737.540996720169;5751.9424805751405;5754;5761.164631128379;5603.10350343943;5670.319561652628;5681.517071049007;5684.346300175533;5685.232493613309;5621.072523033818;5633.8309850704545;5635.633683810539;5638.15427685834;5638.23883775685;5511.4213007633625;5538.750756215899;5606.355269143937;5678.488935995781;5681.034224181816;5649.350324712711;5657.8019769307875;5663;5722.971385143048;5731.140328950691;5534.667919924656;5539.9169012464035;5543.196236545759;5544.362398324244;5546.861328466821 21:42:06 INFO - PROCESS | 23323 | |1;ext.html;596.6479776931612;604.9939500604993;616.2266355723567;617.4350469320569;632.2444678609061;29087.85456072719;36472.08819779507;36802;37114.257714845684;37182.25635487289;44665.330020049725;45271.54728452714;45358;45425.77287113568;45445.54554454455;8543.530105844176;8675.219230269275;8684.609192586317;8690.304775617968;8699.217070463657;8775.56122193891;8879.44609693301;8883.77790555238;8884.156005179497;8886;8935.195832375084;8967.910320896774;8980.191782739552;8980.775480613005;8994.505302208376;8882.955585222066;8918.375713700043;8939.329550283723;8943.910560894374;8952;8812.295016398673;8873.822523549557;8874.46753194804;8879.689210877588;8882.86675699865;36495.27009459796;36599.63400365989;36626.63373366286;36661.633383666085;36839.81580092109;3115.6572776994512;3169.730572901306;3614.27714457107;3988.880333589997;4138.255114079465;26827.731722682915;28914.71085289141;28926;28946.565801512996;28970;4341.196878577442;4366.497852746943;4468.486124095738;4594.724316540985;4637.895093805166;402322;403538;404273;406233;406358;59895.401045989856;59958.70020649869;60342.69828650829;60497.39502604918;60596.39403605996;63151;63500;63951.36048639547;64071.67964160149;64105.35894640994;15638;15960.122193279249;15976.76034859478;15992.840071599368;16021;12700.87299126997;12777.872221277854;12785.808212876815;12788;12796.424160912782;18325.724731306113;19215.90392048031;19236.903815480833;19394.96352882955;19563.90218048929;6901.689423975933;7056.647167641598;7117.964410177916;7209.783706488814;7227.421806255487;972.3922548407245;1077.2459278505078;1088.1077516436446;1088.145805542661;1088.2762962629763;32425.18937026546;32733.07203135639;32907;32990;33458;985;1021.6475316015963;1033.0599154769275;1091.1761619977026;1127.6617014895498;16732.58168545796;16881.24034418454;17006.744898826528;17049.7442538362;17133.31466741341;574736;574807;576216;576758;580578;59348.406515934286;59647;59754;59961.40038599646;60034;1230.249547775856;1292.5088466382715;1350.9189448633113;1370.9725805483833;1372.540199033335;32478.512822307213;33730.49404258889;33856.49215261724;33952.429124578244;34014.149646259044;49460.50539494703;50300;50317.74841125918;50391;50439.74780126076;396638;405344;408009;409547;412899;22452;26690.733092668826;26995.190144295702;27440;28947.421051579273;48328;48346.758266208446;48812.2678159835;49377.259341109195;49709.25436118533;40388.394174087996;40580;41633.71679523324;42039.57960420479;42143.57856421397;41211.587884121975;41495.58504414917;41510.58489415188;41917;42611.7869410651;40204.597954020086;40881;41782.582174179086;42039.36940945827;42115.368269475366;33165.668343316254;36640;37608.247835042595;37610.62389376071;37765.81117094397;27674.44651107007;28110;28135.43729125447;28188.46303832665;28463.146105616866 21:42:06 INFO - PROCESS | 23323 | |2;jquery.html;377.4074702716735;380.8495644220533;384.7652931711657;393.4511356657463;397.90649197438614;15498.380064797395;15517.146556939391;18105.81894181058;20593.897030514847;20644;17965.64068718625;18455.538611534717;18507.16717747701;19788;19812.801871981275;5320.6275560710765;5416.91874621881;5439.700816455093;5457.754401051962;5465.672059676433;3973.2450834341525;5370.624056316059;5513.035218836688;5751.511121554673;5758.683272420015;5818;5826.854328641797;5841.503472204868;5851.180834683148;5855;5703.74333155009;5983.401659834025;5992.071228959497;5998.8500287492725;5999.850003749898;5595.048841696921;5787.88424231513;5790.942090579082;5798.536117110621;5835.474807267324;13955.232462214573;14302.64243393913;19489.830610163437;23484;23648.881755591283;2158.190678495564;2450.718167410735;2494.6756921600077;2725.0734750185034;2951.8081324713826;10073.798524029551;10203.33678310915;10632.46837658114;10646.25476216665;10678.62624808128;1890.905454727272;1932.5361913140885;1946.8539859510593;1978.6834106542883;2014.546726986431;79161.60419197925;83170.16829831745;84059.5797021017;84736.15263847282;84856.57571712101;10370.844437333446;10689.144868410509;10700.197485188643;10847.783044339069;11079.612213572647;14782.556523304318;14795.778063329059;14828.3327250274;14915.701685966436;14979.475718349806;7820.648070836826;8049.718259860877;8058.395620328499;8191.467554608931;8220.712275070344;7755.108162561265;7759.61201939912;7776.872353508709;7932.365410767125;7950.1254861965135;4544.886377840514;4564.3153526970555;4585.541445855388;4607.7004994675235;4671.929921051187;1866.6919958206743;1897.8102189781187;1927.2483731344787;1962.0974351798332;1993.063260267672;766.8197973476229;767.539476314207;784.4156103702778;811.0915774332667;813.1786895235855;16292.266847991868;16405.097719625297;16670.833291666928;16919.407820726214;16926.74609880853;784.5332027443662;816.7345612675904;834.7662654456761;863.9913600863911;876.3164731509432;9144.497052662167;9286.72139835806;9435.433873967584;9456.47989360578;9621.422714637145;500589;501514;506565;512998;514140;95282.52358738161;96627;97214;98495.50752246194;98834.5058274704;964.8842138943372;974.9512524373753;993.4238141877838;996.4170959988343;1010.5301035018751;15192.696146076796;15620.531384058497;15699.921500392426;15705;15755;41141.58858411378;43171.35242971295;43176.784116079216;43575.34636980385;43847.78076109599;58442.70778646079;58981.705091474265;59700.40299596948;60954.39045609665;61043;8674.262687671619;8804.911950880665;8891.422057566497;9076.183143517115;9113.863292050757;12964.286964217059;13585.252811095485;13817.79273310881;13936.233507157203;13950.860491395362;12191.878081219074;12274.693132671755;12381.62855114348;12614.49542018309;12643.494260229856;12314.81527777102;12383.69040773988;12453.501859925502;12562.811557826457;12598.055145863913;12390.380480975735;12545.435455404711;12554.246745195318;12838.29389383593;13082.215067096005;7433;8090.352771778126;8779;9049.321300902327;9085.137546802758;12240.632781016584;12360.81458778137;12482;12603.243805371707;12629.87370126287 21:42:06 INFO - PROCESS | 23323 | |3;mootools.html;1314.8224989626397;1332.8867046301068;1413.6395219219098;1490.2399776114185;1774.6805574996495;8047.91952080479;8451.02813176485;8454.704085357014;8749.168828961254;8775.6050977706;8532.616032278547;8674.522901240429;8689.91310086899;8693.56532173392;8708.824308718322;1993.3820515640198;2213.4908970936694;2241.9215327463503;2243.270936945491;2267.637178051512;2237.697910782048;2245.786650268222;2246.887655617221;2249.6737972993906;2250.2124256510256;2252.3918541993735;2256.7856053674873;2296.632538793793;2298.9655155172686;2302.0561569756405;1823.462078686784;2132.872027678329;2194.078487035449;2194.1442837293466;2206.944826379345;2196.846220764547;2198.8460807743463;2217.855839370452;2219.4895174109884;2221.7222847144108;8897.466152030835;8914.28685705142;8943.821123577492;8951.283897288267;8956.104389560991;5092.3125378073855;5146.202338637479;5180.171172612401;5188.507091826271;5191.22131680251;3210.4060748761553;3262.3964566555264;3296.950545741816;3307.818070006149;3318.883839065621;1048.9318194317345;1059.7138772531373;2202.5925203837182;2239.3729755668437;2243.5849367866995;12440.440180191914;12480.126391152622;12536.561220357335;12540.937295313557;12553.309567973758;4314.158739045856;4404.911901761947;4529.433820772403;4532.660050496226;4533;9795.412275263507;9810.558524866397;9816.116549510436;9824.705258842247;9832.950835245922;5230.241614965808;5230.660007099526;5231.136862417658;5234.476552344735;5238.449962753933;4288.742675439484;4778.331033655291;4901.5588597026435;4908.263760435963;4968.354113965162;3746.868859589901;3809.104860357814;3826.7895265760094;3875.399313106473;3921.1961547882615;1032.6282538286212;1111.105560024172;1117.1677100559973;1136.9204155709022;1142.1833389126814;897.546738896853;908.7546362482093;912.2975309012023;944.3767113705059;946.5030858799186;5759.452851979056;5776.653400795965;5815.331236907725;5818.5345172386105;5819.266625233064;828.9709860154986;846.2383854530972;874.8687696845524;879.4811061473761;895.4000819450983;3968.3650615901315;4091.468109145792;4101.159262351271;4113.526944401372;4113.670906327487;10715.46422678863;11063.612773552886;11148.832767508495;11179.72050698739;11185.937335953071;11017.944910275557;11031.613893513688;11038.613648522263;11039.006489415991;11057.557697692164;7849.4897831640765;8300.916990830014;8378.53918034514;8381.28759055475;8383.580820958927;5884.235049443545;5986.461218490357;6167.105769663463;6260.186175797117;6316.336784637547;10482.318649287772;10592.947035265082;10604.8939510607;10614.522346494272;10617;10254.230932680228;10415.270931034755;10828.783424331627;10839.729006774895;10864.782704345711;8087.555184464675;8168.509889406655;8212.17878212174;8252.05101413345;8255.215754503313;8379.329653627574;8448.535330556879;8462.280706140047;8624.741257762276;8625.69810056645;6259.280182779039;7672.309492145734;7729.111152217342;7741.690332386866;7943.0071241094865;7332.890006649798;7491.550506969599;7518.398528117847;7690.461667683208;7738.845223095619;6705.932940670726;6891.793246202622;6947.305269473214;6957.373836354753;6957.652117394211;4871.415430148405;4895.388076490439;4922.237053256607;4937.950620493749;5015.899682006412;4948.208286674115;4949.802007919787;5020.723860187724;5030.220315851049;5032.119379108714 21:42:06 INFO - PROCESS | 23323 | |4;prototype.html;314.5344889563446;326.9068315530074;332.3300415412552;332.70887973023605;335.6760725899507;5219.686818790875;5252.6848389096685;5279.445658205881;5293.973530132349;5341.813036543712;4932.309476673268;5092.872678183047;5093.770780314885;5094.847154585359;5230.581553475722;3943.93513751287;4035.85874494392;4085.12169883475;4117.69117316201;4131.194417088669;4080.367543030835;4105.815238314268;4108.192395346038;4109;4112.807285887104;3905.3556163233034;4085.611866872642;4088.650745254059;4098.262312783698;4101.9179616407655;4055.0876052887866;4075.572064933169;4088.8568900088353;4093.22228776533;4095.9795201024103;3603.531540899666;3607.549056367954;3608.116011577154;3613.223157021253;3615.168511242429;4860.8055677772845;5128;5130.743462826881;5150.429119118668;5151.845444636667;4670.836520721792;4675.509071547506;4678;4683.391159149289;4695.812167513295;5470.972645136789;5476.452354764531;5478.561715062825;5495.560355171577;5507.824409358321;3882.3788193889127;3979.3633018716864;3979.8408063677416;3986.3223252047223;3988.940165897514;5655.1799989001365;5668.68822214778;5685.40303268155;5715.828525144252;5717.685527295997;4041.8383264669674;4048.514178298623;4048.777317247521;4054.6958978076764;4054.9659836741444;4089.386592011222;4111.48606424197;4115.588441155861;4117;4125.443065186161;4438.533953934855;4641.164590373765;4667.743274119956;4670.089332580183;4689.835855745033;5473.151661492475;5492.862678433071;5506.256655351556;5507.476789704971;5526.47498487643;1347.5957212836306;1354.1807206640037;1394.835312514062;1416.7945647881;1419.8722115009698;924.9075092490697;935.8175155844544;945.2438049560325;947.4836214263244;949.3971328206501;5310.60170487215;5314.077257508355;5315.707636079976;5318.016167009116;5323.946760532423;5598.188262701967;5600.243967064475;5601.187827765033;5603.467670571289;5609.467100625434;5125.589952803767;5262.473882574087;5301.734913254322;5309.203619457112;5385.7576409061685;2991.641003079644;3000.4149190908;3007.0828397338582;3007.9398412032074;3016.4570377332293;5830.62100963436;5831;5848;5859.707014649336;5866.23738913947;5565.994363043992;5741.368449470555;5755.798547050917;5787.75885504119;5816.389279125631;5750.332403602908;5812.38969908162;5842.269716285465;5848.268966379288;5863.853403664857;5426.864328391822;5627.127795191752;5628.662280263197;5635.6618602883955;5672.716364181857;5533.3083364579425;5563.749631266522;5598;5628.74670639814;5644.8024319148635;5837.883242335045;5867.6772777497645;5876.500497457764;5877.265341832271;5879.676617785892;3847.2690188864026;3968.9206215876097;3969;3974.980125099356;4026.778527181033;5362;5581.74882130297;5615.803446879339;5629.4652008059165;5650.152477128464;5363.651362661571;5513.807016754395;5518.813455107172;5528.834134975958;5534.944650553443;5396.379416367011;5401.351837779492;5414.404415514212;5414.456879789241;5467.753951072132;5265.21021846726;5455.918161227664;5458.5087342139395;5476.507114359727;5495.230667706444;5511.807086752105;5512.173174023928;5518.144687573433;5535.7785688572;5537.1140617501005;5392.892142157057;5402.270693456333;5413.431589683027;5419.674819510842;5428.212909128233 21:42:06 INFO - PROCESS | 23323 | |5;yui.html;711.217660573369;758.8926524490181;780.8165081205917;783.8784988326807;845.5645342648534;13599.18404895707;14588.708225835477;14698.559043228694;14705.044172128817;14713.852861471381;13273;13685.384157712902;13949.721005579882;14110.78833817491;14112.153270803734;774.3611520495585;788.5741699482272;793.1711361627084;793.9563324017176;794.7973266816954;645.0743183531623;763.2177018555997;801.8596745569502;801.8997625296838;809.1180613131685;853.7950891785957;856.1823458597056;856.751542052804;857.9699710510133;859.2953777902122;852.1776485691338;852.526847599582;852.5353682243192;852.8209076093997;853.1681610429844;495.9355283813117;587.73551901644;604.5858586867965;607.9998402627652;615.566025951703;12440.440180191914;12632.936835315857;12651.304178270191;12836.80744788829;12871.613851584467;12610;12699.174553654075;13624.455021799116;13665.18008919458;13774.104683195561;12866.549670761571;12936.805947910789;13013.804792928113;13257.138286011379;13574.524891628746;4305.78471076448;4344.500382456026;4414.359917811899;4440.356148358503;4511.436070491189;80306;80506;81220;82520.58739706263;83407.16592834116;10528.684139475828;10730.624428144978;10798.730031749112;10825.07986821129;10868.184886133571;20066.398008059783;20067.799322006595;20080.799192008184;20090;20093.598128037356;8075.394345424117;8229.588520573947;8288.792780180424;8302.086770455246;8350.874736878952;4622.699524530894;4729.645276604199;4731.243001119873;4805;4815.831445899446;3360.445526488102;3399.3711163434846;3450.654934506529;3456.9654303456646;3464.4110501214855;584.2434047907884;584.9736761845727;596.5794115148809;599.9820005399845;604.6281536854802;541.753965878478;550.1829782772579;580.1095318685797;582.126809785322;588.3351812451988;8516.233538981398;8803.043663492901;9107.954460227656;9182.816343673223;9360.391574547768;495.8834673851642;568.7696482924422;607.6080927801544;620.7734177025444;631.8136149835809;4432.180046691373;4451.910961780746;4474.843380481668;4506.842260520866;4580.039010735426;68920.6553967227;69353.3064669357;69490.65254673694;74786;122503;97886.5105674467;100445.49777251213;101990.49004754929;102521.48739256256;106750;89612.5519372399;90517;90620.54689726509;91308.54345728362;93848.53075734578;8263.132371101188;9358.344915855825;9480.668176613786;9676.12914837668;9709.320347575602;44193.895152621444;45186.966586503026;49638.75180624074;51979.22031169611;54420.18369724537;76644;77849.61075194587;78199.21800781919;78324.60837695775;80722.5963870177;11312.321260724382;11418.429078546205;11462.140339474407;11654.70863228426;11739.23694959825;12149.453274602487;12157.635270941886;12476.251424914533;12495.437705303464;12914.547990820276;11555.4800033997;11773.470193841127;11821.76356472883;12115.878841211475;12157.027437804778;12277;12551.372431378577;12571.245725256515;12599;13001.739965200832;11902;12302.81545776832;12570.748585028432;12603.49586016549;12622.11645184865;9662.339726871094;10149.949250253701;10431.68704938853;10516.158707303244;10521.368717876645;9702.466364350028;10258.589231530734;10495.947520262349;10686.519106640375;11043.779124417628 21:42:06 INFO - PROCESS | 23323 | __end_tp_report 21:42:06 INFO - PROCESS | 23323 | __start_cc_report 21:42:06 INFO - PROCESS | 23323 | _x_x_mozilla_cycle_collect,896 21:42:06 INFO - PROCESS | 23323 | __end_cc_report 21:42:06 INFO - PROCESS | 23323 | __startTimestamp1468039326566__endTimestamp 21:42:06 INFO - PROCESS | 23323 | 21:42:06 INFO - PROCESS | 23323 | ------- Summary: start ------- 21:42:06 INFO - PROCESS | 23323 | Number of tests: 6 21:42:06 INFO - PROCESS | 23323 | 21:42:06 INFO - PROCESS | 23323 | [#0] dojo.html Cycles:165 Average:5342.29 Median:5543.20 stddev:627.97 (11.3%) stddev-sans-first:601.13 21:42:06 INFO - PROCESS | 23323 | Values: 2947.2 2963.7 3005.5 3045.3 3073.3 5245.5 5301.9 5369.4 5428.2 5429.8 5356.8 5386.2 5419.2 5428.3 5445.3 4853.2 4917.3 4937.6 4955.1 5001.7 4925.7 4932.5 4967.7 4984.4 4990.2 4811.1 4819.8 4825.2 4868.8 4908.7 4830.9 4914.2 4923.4 4925.7 4955.4 4863.6 4895.3 4897.2 4897.5 4908.4 5265.9 5292.2 5368.4 5394.1 5423.6 5720.2 5756.1 5760.8 5781.8 5789.6 5644.0 5796.4 5828.0 5844.2 5854.4 5294.5 5353.9 5354.0 5402.9 5409.3 5938.5 5950.3 5977.5 5988.5 5997.5 5470.0 5534.1 5747.6 5749.4 5756.0 5667.4 5770.0 5772.5 5776.2 5778.4 5637.3 5690.1 5696.5 5697.4 5740.9 5523.0 5647.3 5650.8 5696.5 5700.7 4366.6 4369.3 4373.9 4409.4 4414.7 3845.1 3866.4 3872.1 3895.6 3900.3 5289.6 5379.3 5398.6 5440.1 5481.8 5746.1 5762.8 5771.7 5780.5 5822.6 5471.7 5477.3 5480.2 5483.4 5490.4 4752.1 4820.5 4844.9 4861.0 4869.9 6003.6 6006.7 6010.1 6013.2 6017.1 5731.9 5814.6 5823.2 5824.4 5827.4 5844.1 5884.0 5956.3 5960.8 6001.8 5627.4 5662.2 5673.1 5676.2 5678.6 5612.7 5737.5 5751.9 5754.0 5761.2 5603.1 5670.3 5681.5 5684.3 5685.2 5621.1 5633.8 5635.6 5638.2 5638.2 5511.4 5538.8 5606.4 5678.5 5681.0 5649.4 5657.8 5663.0 5723.0 5731.1 5534.7 5539.9 5543.2 5544.4 5546.9 21:42:06 INFO - PROCESS | 23323 | 21:42:06 INFO - PROCESS | 23323 | [#1] ext.html Cycles:180 Average:61854.33 Median:227055.29 stddev:124744.34 (54.9%) stddev-sans-first:125009.49 21:42:06 INFO - PROCESS | 23323 | Values: 596.6 605.0 616.2 617.4 632.2 29087.9 36472.1 36802.0 37114.3 37182.3 44665.3 45271.5 45358.0 45425.8 45445.5 8543.5 8675.2 8684.6 8690.3 8699.2 8775.6 8879.4 8883.8 8884.2 8886.0 8935.2 8967.9 8980.2 8980.8 8994.5 8883.0 8918.4 8939.3 8943.9 8952.0 8812.3 8873.8 8874.5 8879.7 8882.9 36495.3 36599.6 36626.6 36661.6 36839.8 3115.7 3169.7 3614.3 3988.9 4138.3 26827.7 28914.7 28926.0 28946.6 28970.0 4341.2 4366.5 4468.5 4594.7 4637.9 402322.0 403538.0 404273.0 406233.0 406358.0 59895.4 59958.7 60342.7 60497.4 60596.4 63151.0 63500.0 63951.4 64071.7 64105.4 15638.0 15960.1 15976.8 15992.8 16021.0 12700.9 12777.9 12785.8 12788.0 12796.4 18325.7 19215.9 19236.9 19395.0 19563.9 6901.7 7056.6 7118.0 7209.8 7227.4 972.4 1077.2 1088.1 1088.1 1088.3 32425.2 32733.1 32907.0 32990.0 33458.0 985.0 1021.6 1033.1 1091.2 1127.7 16732.6 16881.2 17006.7 17049.7 17133.3 574736.0 574807.0 576216.0 576758.0 580578.0 59348.4 59647.0 59754.0 59961.4 60034.0 1230.2 1292.5 1350.9 1371.0 1372.5 32478.5 33730.5 33856.5 33952.4 34014.1 49460.5 50300.0 50317.7 50391.0 50439.7 396638.0 405344.0 408009.0 409547.0 412899.0 22452.0 26690.7 26995.2 27440.0 28947.4 48328.0 48346.8 48812.3 49377.3 49709.3 40388.4 40580.0 41633.7 42039.6 42143.6 41211.6 41495.6 41510.6 41917.0 42611.8 40204.6 40881.0 41782.6 42039.4 42115.4 33165.7 36640.0 37608.2 37610.6 37765.8 27674.4 28110.0 28135.4 28188.5 28463.1 21:42:06 INFO - PROCESS | 23323 | 21:42:06 INFO - PROCESS | 23323 | [#2] jquery.html Cycles:180 Average:29536.79 Median:43711.56 stddev:83744.26 (191.6%) stddev-sans-first:83950.56 21:42:06 INFO - PROCESS | 23323 | Values: 377.4 380.8 384.8 393.5 397.9 15498.4 15517.1 18105.8 20593.9 20644.0 17965.6 18455.5 18507.2 19788.0 19812.8 5320.6 5416.9 5439.7 5457.8 5465.7 3973.2 5370.6 5513.0 5751.5 5758.7 5818.0 5826.9 5841.5 5851.2 5855.0 5703.7 5983.4 5992.1 5998.9 5999.9 5595.0 5787.9 5790.9 5798.5 5835.5 13955.2 14302.6 19489.8 23484.0 23648.9 2158.2 2450.7 2494.7 2725.1 2951.8 10073.8 10203.3 10632.5 10646.3 10678.6 1890.9 1932.5 1946.9 1978.7 2014.5 79161.6 83170.2 84059.6 84736.2 84856.6 10370.8 10689.1 10700.2 10847.8 11079.6 14782.6 14795.8 14828.3 14915.7 14979.5 7820.6 8049.7 8058.4 8191.5 8220.7 7755.1 7759.6 7776.9 7932.4 7950.1 4544.9 4564.3 4585.5 4607.7 4671.9 1866.7 1897.8 1927.2 1962.1 1993.1 766.8 767.5 784.4 811.1 813.2 16292.3 16405.1 16670.8 16919.4 16926.7 784.5 816.7 834.8 864.0 876.3 9144.5 9286.7 9435.4 9456.5 9621.4 500589.0 501514.0 506565.0 512998.0 514140.0 95282.5 96627.0 97214.0 98495.5 98834.5 964.9 975.0 993.4 996.4 1010.5 15192.7 15620.5 15699.9 15705.0 15755.0 41141.6 43171.4 43176.8 43575.3 43847.8 58442.7 58981.7 59700.4 60954.4 61043.0 8674.3 8804.9 8891.4 9076.2 9113.9 12964.3 13585.3 13817.8 13936.2 13950.9 12191.9 12274.7 12381.6 12614.5 12643.5 12314.8 12383.7 12453.5 12562.8 12598.1 12390.4 12545.4 12554.2 12838.3 13082.2 7433.0 8090.4 8779.0 9049.3 9085.1 12240.6 12360.8 12482.0 12603.2 12629.9 21:42:06 INFO - PROCESS | 23323 | 21:42:06 INFO - PROCESS | 23323 | [#3] mootools.html Cycles:180 Average:5789.80 Median:4915.25 stddev:3355.92 (68.3%) stddev-sans-first:3348.48 21:42:06 INFO - PROCESS | 23323 | Values: 1314.8 1332.9 1413.6 1490.2 1774.7 8047.9 8451.0 8454.7 8749.2 8775.6 8532.6 8674.5 8689.9 8693.6 8708.8 1993.4 2213.5 2241.9 2243.3 2267.6 2237.7 2245.8 2246.9 2249.7 2250.2 2252.4 2256.8 2296.6 2299.0 2302.1 1823.5 2132.9 2194.1 2194.1 2206.9 2196.8 2198.8 2217.9 2219.5 2221.7 8897.5 8914.3 8943.8 8951.3 8956.1 5092.3 5146.2 5180.2 5188.5 5191.2 3210.4 3262.4 3297.0 3307.8 3318.9 1048.9 1059.7 2202.6 2239.4 2243.6 12440.4 12480.1 12536.6 12540.9 12553.3 4314.2 4404.9 4529.4 4532.7 4533.0 9795.4 9810.6 9816.1 9824.7 9833.0 5230.2 5230.7 5231.1 5234.5 5238.4 4288.7 4778.3 4901.6 4908.3 4968.4 3746.9 3809.1 3826.8 3875.4 3921.2 1032.6 1111.1 1117.2 1136.9 1142.2 897.5 908.8 912.3 944.4 946.5 5759.5 5776.7 5815.3 5818.5 5819.3 829.0 846.2 874.9 879.5 895.4 3968.4 4091.5 4101.2 4113.5 4113.7 10715.5 11063.6 11148.8 11179.7 11185.9 11017.9 11031.6 11038.6 11039.0 11057.6 7849.5 8300.9 8378.5 8381.3 8383.6 5884.2 5986.5 6167.1 6260.2 6316.3 10482.3 10592.9 10604.9 10614.5 10617.0 10254.2 10415.3 10828.8 10839.7 10864.8 8087.6 8168.5 8212.2 8252.1 8255.2 8379.3 8448.5 8462.3 8624.7 8625.7 6259.3 7672.3 7729.1 7741.7 7943.0 7332.9 7491.6 7518.4 7690.5 7738.8 6705.9 6891.8 6947.3 6957.4 6957.7 4871.4 4895.4 4922.2 4938.0 5015.9 4948.2 4949.8 5020.7 5030.2 5032.1 21:42:06 INFO - PROCESS | 23323 | 21:42:06 INFO - PROCESS | 23323 | [#4] prototype.html Cycles:180 Average:4627.43 Median:5314.89 stddev:1360.35 (25.6%) stddev-sans-first:1325.09 21:42:06 INFO - PROCESS | 23323 | Values: 314.5 326.9 332.3 332.7 335.7 5219.7 5252.7 5279.4 5294.0 5341.8 4932.3 5092.9 5093.8 5094.8 5230.6 3943.9 4035.9 4085.1 4117.7 4131.2 4080.4 4105.8 4108.2 4109.0 4112.8 3905.4 4085.6 4088.7 4098.3 4101.9 4055.1 4075.6 4088.9 4093.2 4096.0 3603.5 3607.5 3608.1 3613.2 3615.2 4860.8 5128.0 5130.7 5150.4 5151.8 4670.8 4675.5 4678.0 4683.4 4695.8 5471.0 5476.5 5478.6 5495.6 5507.8 3882.4 3979.4 3979.8 3986.3 3988.9 5655.2 5668.7 5685.4 5715.8 5717.7 4041.8 4048.5 4048.8 4054.7 4055.0 4089.4 4111.5 4115.6 4117.0 4125.4 4438.5 4641.2 4667.7 4670.1 4689.8 5473.2 5492.9 5506.3 5507.5 5526.5 1347.6 1354.2 1394.8 1416.8 1419.9 924.9 935.8 945.2 947.5 949.4 5310.6 5314.1 5315.7 5318.0 5323.9 5598.2 5600.2 5601.2 5603.5 5609.5 5125.6 5262.5 5301.7 5309.2 5385.8 2991.6 3000.4 3007.1 3007.9 3016.5 5830.6 5831.0 5848.0 5859.7 5866.2 5566.0 5741.4 5755.8 5787.8 5816.4 5750.3 5812.4 5842.3 5848.3 5863.9 5426.9 5627.1 5628.7 5635.7 5672.7 5533.3 5563.7 5598.0 5628.7 5644.8 5837.9 5867.7 5876.5 5877.3 5879.7 3847.3 3968.9 3969.0 3975.0 4026.8 5362.0 5581.7 5615.8 5629.5 5650.2 5363.7 5513.8 5518.8 5528.8 5534.9 5396.4 5401.4 5414.4 5414.5 5467.8 5265.2 5455.9 5458.5 5476.5 5495.2 5511.8 5512.2 5518.1 5535.8 5537.1 5392.9 5402.3 5413.4 5419.7 5428.2 21:42:06 INFO - PROCESS | 23323 | 21:42:06 INFO - PROCESS | 23323 | [#5] yui.html Cycles:180 Average:19801.31 Median:4676.17 stddev:28714.10 (614.1%) stddev-sans-first:28758.87 21:42:06 INFO - PROCESS | 23323 | Values: 711.2 758.9 780.8 783.9 845.6 13599.2 14588.7 14698.6 14705.0 14713.9 13273.0 13685.4 13949.7 14110.8 14112.2 774.4 788.6 793.2 794.0 794.8 645.1 763.2 801.9 801.9 809.1 853.8 856.2 856.8 858.0 859.3 852.2 852.5 852.5 852.8 853.2 495.9 587.7 604.6 608.0 615.6 12440.4 12632.9 12651.3 12836.8 12871.6 12610.0 12699.2 13624.5 13665.2 13774.1 12866.5 12936.8 13013.8 13257.1 13574.5 4305.8 4344.5 4414.4 4440.4 4511.4 80306.0 80506.0 81220.0 82520.6 83407.2 10528.7 10730.6 10798.7 10825.1 10868.2 20066.4 20067.8 20080.8 20090.0 20093.6 8075.4 8229.6 8288.8 8302.1 8350.9 4622.7 4729.6 4731.2 4805.0 4815.8 3360.4 3399.4 3450.7 3457.0 3464.4 584.2 585.0 596.6 600.0 604.6 541.8 550.2 580.1 582.1 588.3 8516.2 8803.0 9108.0 9182.8 9360.4 495.9 568.8 607.6 620.8 631.8 4432.2 4451.9 4474.8 4506.8 4580.0 68920.7 69353.3 69490.7 74786.0 122503.0 97886.5 100445.5 101990.5 102521.5 106750.0 89612.6 90517.0 90620.5 91308.5 93848.5 8263.1 9358.3 9480.7 9676.1 9709.3 44193.9 45187.0 49638.8 51979.2 54420.2 76644.0 77849.6 78199.2 78324.6 80722.6 11312.3 11418.4 11462.1 11654.7 11739.2 12149.5 12157.6 12476.3 12495.4 12914.5 11555.5 11773.5 11821.8 12115.9 12157.0 12277.0 12551.4 12571.2 12599.0 13001.7 11902.0 12302.8 12570.7 12603.5 12622.1 9662.3 10149.9 10431.7 10516.2 10521.4 9702.5 10258.6 10495.9 10686.5 11043.8 21:42:06 INFO - PROCESS | 23323 | -------- Summary: end -------- 21:42:06 INFO - PROCESS | 23323 | 21:42:07 INFO - TEST-INFO | 23323: exit 0 21:42:07 INFO - TEST-OK | dromaeo_css | took 1113232ms 21:42:07 INFO - TEST-START | kraken 21:42:07 INFO - operating with platform_type : linux_ 21:42:07 INFO - Initialising browser for kraken test... 21:42:07 INFO - TEST-INFO | started process 23512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0gBY4I/profile http://localhost:40456/getInfo.html) 21:42:11 INFO - PROCESS | 23512 | __metrics Screen width/height:1600/1200 21:42:11 INFO - PROCESS | 23512 | colorDepth:24 21:42:11 INFO - PROCESS | 23512 | Browser inner width/height: 1024/697 21:42:11 INFO - PROCESS | 23512 | __metrics 21:42:12 INFO - PROCESS | 23512 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:42:12 INFO - PROCESS | 23512 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:42:13 INFO - TEST-INFO | 23512: exit 0 21:42:13 INFO - Browser initialized. 21:42:13 INFO - Running cycle 1/1 for kraken test... 21:42:13 INFO - TEST-INFO | started process 23595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0gBY4I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:42:24 INFO - PROCESS | 23595 | RSS: Main: 156459008 21:42:24 INFO - PROCESS | 23595 | 21:42:27 INFO - PROCESS | 23595 | Cycle 1(1): loaded http://localhost:40456/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40456/tests/kraken/driver.html?testName=audio-beat-detection) 21:42:28 INFO - PROCESS | 23595 | RSS: Main: 215478272 21:42:28 INFO - PROCESS | 23595 | 21:42:30 INFO - PROCESS | 23595 | Cycle 1(1): loaded http://localhost:40456/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40456/tests/kraken/driver.html?testName=audio-dft) 21:42:31 INFO - PROCESS | 23595 | RSS: Main: 202854400 21:42:31 INFO - PROCESS | 23595 | 21:42:34 INFO - PROCESS | 23595 | Cycle 1(1): loaded http://localhost:40456/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40456/tests/kraken/driver.html?testName=audio-fft) 21:42:35 INFO - PROCESS | 23595 | RSS: Main: 269307904 21:42:35 INFO - PROCESS | 23595 | 21:42:37 INFO - PROCESS | 23595 | Cycle 1(1): loaded http://localhost:40456/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40456/tests/kraken/driver.html?testName=audio-oscillator) 21:42:37 INFO - PROCESS | 23595 | RSS: Main: 179458048 21:42:37 INFO - PROCESS | 23595 | 21:42:39 INFO - PROCESS | 23595 | Cycle 1(1): loaded http://localhost:40456/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40456/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:42:40 INFO - PROCESS | 23595 | RSS: Main: 184754176 21:42:40 INFO - PROCESS | 23595 | 21:42:43 INFO - PROCESS | 23595 | Cycle 1(1): loaded http://localhost:40456/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40456/tests/kraken/driver.html?testName=imaging-darkroom) 21:42:44 INFO - PROCESS | 23595 | RSS: Main: 218963968 21:42:44 INFO - PROCESS | 23595 | 21:42:47 INFO - PROCESS | 23595 | Cycle 1(1): loaded http://localhost:40456/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40456/tests/kraken/driver.html?testName=imaging-desaturate) 21:42:48 INFO - PROCESS | 23595 | RSS: Main: 220913664 21:42:48 INFO - PROCESS | 23595 | 21:42:50 INFO - PROCESS | 23595 | Cycle 1(1): loaded http://localhost:40456/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40456/tests/kraken/driver.html?testName=json-parse-financial) 21:42:51 INFO - PROCESS | 23595 | RSS: Main: 221552640 21:42:51 INFO - PROCESS | 23595 | 21:42:53 INFO - PROCESS | 23595 | Cycle 1(1): loaded http://localhost:40456/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40456/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:42:53 INFO - PROCESS | 23595 | RSS: Main: 206774272 21:42:53 INFO - PROCESS | 23595 | 21:42:55 INFO - PROCESS | 23595 | Cycle 1(1): loaded http://localhost:40456/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40456/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:42:56 INFO - PROCESS | 23595 | RSS: Main: 211148800 21:42:56 INFO - PROCESS | 23595 | 21:42:58 INFO - PROCESS | 23595 | Cycle 1(1): loaded http://localhost:40456/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40456/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:42:58 INFO - PROCESS | 23595 | RSS: Main: 209764352 21:42:58 INFO - PROCESS | 23595 | 21:43:01 INFO - PROCESS | 23595 | Cycle 1(1): loaded http://localhost:40456/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:43:01 INFO - PROCESS | 23595 | RSS: Main: 223428608 21:43:01 INFO - PROCESS | 23595 | 21:43:04 INFO - PROCESS | 23595 | Cycle 1(1): loaded http://localhost:40456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:43:05 INFO - PROCESS | 23595 | RSS: Main: 225107968 21:43:05 INFO - PROCESS | 23595 | 21:43:06 INFO - PROCESS | 23595 | Cycle 1(1): loaded http://localhost:40456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40456/tests/kraken/driver.html?testName=ai-astar) 21:43:07 INFO - PROCESS | 23595 | RSS: Main: 268128256 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | __start_tp_report 21:43:07 INFO - PROCESS | 23595 | _x_x_mozilla_page_load 21:43:07 INFO - PROCESS | 23595 | _x_x_mozilla_page_load_details 21:43:07 INFO - PROCESS | 23595 | |i|pagename|runs| 21:43:07 INFO - PROCESS | 23595 | |0;ai-astar;102;112;110;111;113;111;109;110;111;110 21:43:07 INFO - PROCESS | 23595 | |1;audio-beat-detection;156;116;118;172;119;119;153;117;161;115 21:43:07 INFO - PROCESS | 23595 | |2;audio-dft;161;161;160;161;161;161;159;160;160;160 21:43:07 INFO - PROCESS | 23595 | |3;audio-fft;74;74;76;109;76;75;75;75;102;75 21:43:07 INFO - PROCESS | 23595 | |4;audio-oscillator;84;84;117;83;83;84;130;83;84;125 21:43:07 INFO - PROCESS | 23595 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;117;116;117 21:43:07 INFO - PROCESS | 23595 | |6;imaging-darkroom;146;147;146;146;146;148;147;145;146;147 21:43:07 INFO - PROCESS | 23595 | |7;imaging-desaturate;96;95;95;95;95;94;95;95;94;95 21:43:07 INFO - PROCESS | 23595 | |8;json-parse-financial;55;52;53;54;54;53;54;55;55;53 21:43:07 INFO - PROCESS | 23595 | |9;json-stringify-tinderbox;63;63;63;63;62;62;62;67;62;62 21:43:07 INFO - PROCESS | 23595 | |10;stanford-crypto-aes;75;78;80;75;74;75;74;75;81;78 21:43:07 INFO - PROCESS | 23595 | |11;stanford-crypto-ccm;129;132;117;124;120;129;118;118;165;118 21:43:07 INFO - PROCESS | 23595 | |12;stanford-crypto-pbkdf2;157;164;160;158;159;156;154;159;155;156 21:43:07 INFO - PROCESS | 23595 | |13;stanford-crypto-sha256-iterative;66;62;63;66;62;63;61;64;62;61 21:43:07 INFO - PROCESS | 23595 | __end_tp_report 21:43:07 INFO - PROCESS | 23595 | __start_cc_report 21:43:07 INFO - PROCESS | 23595 | _x_x_mozilla_cycle_collect,1639 21:43:07 INFO - PROCESS | 23595 | __end_cc_report 21:43:07 INFO - PROCESS | 23595 | __startTimestamp1468039387010__endTimestamp 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | ------- Summary: start ------- 21:43:07 INFO - PROCESS | 23595 | Number of tests: 14 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.00 (2.7%) stddev-sans-first:1.20 21:43:07 INFO - PROCESS | 23595 | Values: 102.0 112.0 110.0 111.0 113.0 111.0 109.0 110.0 111.0 110.0 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:136.00 stddev:22.84 (16.8%) stddev-sans-first:22.87 21:43:07 INFO - PROCESS | 23595 | Values: 156.0 116.0 118.0 172.0 119.0 119.0 153.0 117.0 161.0 115.0 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 21:43:07 INFO - PROCESS | 23595 | Values: 161.0 161.0 160.0 161.0 161.0 161.0 159.0 160.0 160.0 160.0 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:12.98 (17.3%) stddev-sans-first:13.51 21:43:07 INFO - PROCESS | 23595 | Values: 74.0 74.0 76.0 109.0 76.0 75.0 75.0 75.0 102.0 75.0 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:83.50 stddev:19.78 (23.7%) stddev-sans-first:20.52 21:43:07 INFO - PROCESS | 23595 | Values: 84.0 84.0 117.0 83.0 83.0 84.0 130.0 83.0 84.0 125.0 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 21:43:07 INFO - PROCESS | 23595 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 21:43:07 INFO - PROCESS | 23595 | Values: 146.0 147.0 146.0 146.0 146.0 148.0 147.0 145.0 146.0 147.0 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 21:43:07 INFO - PROCESS | 23595 | Values: 96.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.03 (1.9%) stddev-sans-first:1.00 21:43:07 INFO - PROCESS | 23595 | Values: 55.0 52.0 53.0 54.0 54.0 53.0 54.0 55.0 55.0 53.0 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:1.52 (2.4%) stddev-sans-first:1.62 21:43:07 INFO - PROCESS | 23595 | Values: 63.0 63.0 63.0 63.0 62.0 62.0 62.0 67.0 62.0 62.0 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.50 stddev:2.55 (3.3%) stddev-sans-first:2.65 21:43:07 INFO - PROCESS | 23595 | Values: 75.0 78.0 80.0 75.0 74.0 75.0 74.0 75.0 81.0 78.0 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:126.50 stddev:14.45 (11.4%) stddev-sans-first:15.30 21:43:07 INFO - PROCESS | 23595 | Values: 129.0 132.0 117.0 124.0 120.0 129.0 118.0 118.0 165.0 118.0 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.80 Median:158.50 stddev:2.90 (1.8%) stddev-sans-first:3.06 21:43:07 INFO - PROCESS | 23595 | Values: 157.0 164.0 160.0 158.0 159.0 156.0 154.0 159.0 155.0 156.0 21:43:07 INFO - PROCESS | 23595 | 21:43:07 INFO - PROCESS | 23595 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.83 (2.9%) stddev-sans-first:1.58 21:43:07 INFO - PROCESS | 23595 | Values: 66.0 62.0 63.0 66.0 62.0 63.0 61.0 64.0 62.0 61.0 21:43:07 INFO - PROCESS | 23595 | -------- Summary: end -------- 21:43:07 INFO - PROCESS | 23595 | 21:43:08 INFO - TEST-INFO | 23595: exit 0 21:43:08 INFO - TEST-OK | kraken | took 60767ms 21:43:08 INFO - SUITE-END | took 1173s 21:43:08 INFO - Completed test suite (00:19:34) 21:43:08 INFO - javascript benchmark 21:43:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2947.189522881206, 2963.6591791943906, 3005.504091824849, 3045.3452507710845, 3073.3085055862434, 5245.4754524547525, 5301.893962120765, 5369.382521010085, 5428.240046393508, 5429.7828086876525, 5356.758945847437, 5386.1920711893235, 5419.160030195316, 5428.294321738178, 5445.319335083114, 4853.247746599265, 4917.3361596184595, 4937.629677774164, 4955.083309587738, 5001.6998980061135, 4925.729084900329, 4932.531409516108, 4967.677100988442, 4984.37695288089, 4990.226514890198, 4811.109944660249, 4819.783109760034, 4825.179719447685, 4868.780904859272, 4908.705477671351, 4830.879228019293, 4914.164592019365, 4923.384576927884, 4925.655204135712, 4955.40535135786, 4863.635227357927, 4895.290182923456, 4897.240927656219, 4897.51024897511, 4908.386451693538, 5265.86835329116, 5292.206169074631, 5368.409474957752, 5394.136938089926, 5423.566114710814, 5720.170575266605, 5756.050251708463, 5760.7695692172265, 5781.797637082682, 5789.623674461147, 5644.0, 5796.449337312949, 5828.038373668382, 5844.240248767633, 5854.385289544622, 5294.497022782868, 5353.946460535384, 5353.973230133864, 5402.864928376744, 5409.323834520685, 5938.465538101505, 5950.256217972754, 5977.491913187428, 5988.461038506555, 5997.490213331916, 5470.0, 5534.142207957773, 5747.597668163188, 5749.396313387034, 5756.0, 5667.376588575254, 5770.019096753562, 5772.538196944234, 5776.220210271644, 5778.393268706809, 5637.295338082739, 5690.118031705092, 5696.487316141567, 5697.401772813795, 5740.856478588069, 5522.972385138049, 5647.322321321468, 5650.830475085754, 5696.51579615729, 5700.743466543932, 4366.628836548929, 4369.300911854088, 4373.9125217495475, 4409.382686423904, 4414.668899832525, 3845.0964023454467, 3866.4007078902814, 3872.0707030312524, 3895.6299151580556, 3900.278448487039, 5289.550388216968, 5379.327584051994, 5398.6220964532895, 5440.075187218183, 5481.808136715196, 5746.080627099727, 5762.7694892203845, 5771.7114144293455, 5780.508656764138, 5822.592418530662, 5471.7264136793, 5477.260569823103, 5480.205370221295, 5483.396826349099, 5490.396056433869, 4752.144613969519, 4820.517948205152, 4844.927326090112, 4861.027794441055, 4869.9269510957365, 6003.579749417586, 6006.729697163551, 6010.068439391988, 6013.1581578579035, 6017.097435384728, 5731.942680573141, 5814.592978491634, 5823.242978412779, 5824.3593204748295, 5827.446392592697, 5844.064949608042, 5883.970305196659, 5956.344802071682, 5960.821175364746, 6001.759929602942, 5627.43725627434, 5662.150677398423, 5673.092305231308, 5676.17695434168, 5678.574106942078, 5612.691301978431, 5737.540996720169, 5751.9424805751405, 5754.0, 5761.164631128379, 5603.10350343943, 5670.319561652628, 5681.517071049007, 5684.346300175533, 5685.232493613309, 5621.072523033818, 5633.8309850704545, 5635.633683810539, 5638.15427685834, 5638.23883775685, 5511.4213007633625, 5538.750756215899, 5606.355269143937, 5678.488935995781, 5681.034224181816, 5649.350324712711, 5657.8019769307875, 5663.0, 5722.971385143048, 5731.140328950691, 5534.667919924656, 5539.9169012464035, 5543.196236545759, 5544.362398324244, 5546.861328466821], "value": 5297.712501699088, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.6479776931612, 604.9939500604993, 616.2266355723567, 617.4350469320569, 632.2444678609061, 29087.85456072719, 36472.08819779507, 36802.0, 37114.257714845684, 37182.25635487289, 44665.330020049725, 45271.54728452714, 45358.0, 45425.77287113568, 45445.54554454455, 8543.530105844176, 8675.219230269275, 8684.609192586317, 8690.304775617968, 8699.217070463657, 8775.56122193891, 8879.44609693301, 8883.77790555238, 8884.156005179497, 8886.0, 8935.195832375084, 8967.910320896774, 8980.191782739552, 8980.775480613005, 8994.505302208376, 8882.955585222066, 8918.375713700043, 8939.329550283723, 8943.910560894374, 8952.0, 8812.295016398673, 8873.822523549557, 8874.46753194804, 8879.689210877588, 8882.86675699865, 36495.27009459796, 36599.63400365989, 36626.63373366286, 36661.633383666085, 36839.81580092109, 3115.6572776994512, 3169.730572901306, 3614.27714457107, 3988.880333589997, 4138.255114079465, 26827.731722682915, 28914.71085289141, 28926.0, 28946.565801512996, 28970.0, 4341.196878577442, 4366.497852746943, 4468.486124095738, 4594.724316540985, 4637.895093805166, 402322.0, 403538.0, 404273.0, 406233.0, 406358.0, 59895.401045989856, 59958.70020649869, 60342.69828650829, 60497.39502604918, 60596.39403605996, 63151.0, 63500.0, 63951.36048639547, 64071.67964160149, 64105.35894640994, 15638.0, 15960.122193279249, 15976.76034859478, 15992.840071599368, 16021.0, 12700.87299126997, 12777.872221277854, 12785.808212876815, 12788.0, 12796.424160912782, 18325.724731306113, 19215.90392048031, 19236.903815480833, 19394.96352882955, 19563.90218048929, 6901.689423975933, 7056.647167641598, 7117.964410177916, 7209.783706488814, 7227.421806255487, 972.3922548407245, 1077.2459278505078, 1088.1077516436446, 1088.145805542661, 1088.2762962629763, 32425.18937026546, 32733.07203135639, 32907.0, 32990.0, 33458.0, 985.0, 1021.6475316015963, 1033.0599154769275, 1091.1761619977026, 1127.6617014895498, 16732.58168545796, 16881.24034418454, 17006.744898826528, 17049.7442538362, 17133.31466741341, 574736.0, 574807.0, 576216.0, 576758.0, 580578.0, 59348.406515934286, 59647.0, 59754.0, 59961.40038599646, 60034.0, 1230.249547775856, 1292.5088466382715, 1350.9189448633113, 1370.9725805483833, 1372.540199033335, 32478.512822307213, 33730.49404258889, 33856.49215261724, 33952.429124578244, 34014.149646259044, 49460.50539494703, 50300.0, 50317.74841125918, 50391.0, 50439.74780126076, 396638.0, 405344.0, 408009.0, 409547.0, 412899.0, 22452.0, 26690.733092668826, 26995.190144295702, 27440.0, 28947.421051579273, 48328.0, 48346.758266208446, 48812.2678159835, 49377.259341109195, 49709.25436118533, 40388.394174087996, 40580.0, 41633.71679523324, 42039.57960420479, 42143.57856421397, 41211.587884121975, 41495.58504414917, 41510.58489415188, 41917.0, 42611.7869410651, 40204.597954020086, 40881.0, 41782.582174179086, 42039.36940945827, 42115.368269475366, 33165.668343316254, 36640.0, 37608.247835042595, 37610.62389376071, 37765.81117094397, 27674.44651107007, 28110.0, 28135.43729125447, 28188.46303832665, 28463.146105616866], "value": 20028.16818492224, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.4074702716735, 380.8495644220533, 384.7652931711657, 393.4511356657463, 397.90649197438614, 15498.380064797395, 15517.146556939391, 18105.81894181058, 20593.897030514847, 20644.0, 17965.64068718625, 18455.538611534717, 18507.16717747701, 19788.0, 19812.801871981275, 5320.6275560710765, 5416.91874621881, 5439.700816455093, 5457.754401051962, 5465.672059676433, 3973.2450834341525, 5370.624056316059, 5513.035218836688, 5751.511121554673, 5758.683272420015, 5818.0, 5826.854328641797, 5841.503472204868, 5851.180834683148, 5855.0, 5703.74333155009, 5983.401659834025, 5992.071228959497, 5998.8500287492725, 5999.850003749898, 5595.048841696921, 5787.88424231513, 5790.942090579082, 5798.536117110621, 5835.474807267324, 13955.232462214573, 14302.64243393913, 19489.830610163437, 23484.0, 23648.881755591283, 2158.190678495564, 2450.718167410735, 2494.6756921600077, 2725.0734750185034, 2951.8081324713826, 10073.798524029551, 10203.33678310915, 10632.46837658114, 10646.25476216665, 10678.62624808128, 1890.905454727272, 1932.5361913140885, 1946.8539859510593, 1978.6834106542883, 2014.546726986431, 79161.60419197925, 83170.16829831745, 84059.5797021017, 84736.15263847282, 84856.57571712101, 10370.844437333446, 10689.144868410509, 10700.197485188643, 10847.783044339069, 11079.612213572647, 14782.556523304318, 14795.778063329059, 14828.3327250274, 14915.701685966436, 14979.475718349806, 7820.648070836826, 8049.718259860877, 8058.395620328499, 8191.467554608931, 8220.712275070344, 7755.108162561265, 7759.61201939912, 7776.872353508709, 7932.365410767125, 7950.1254861965135, 4544.886377840514, 4564.3153526970555, 4585.541445855388, 4607.7004994675235, 4671.929921051187, 1866.6919958206743, 1897.8102189781187, 1927.2483731344787, 1962.0974351798332, 1993.063260267672, 766.8197973476229, 767.539476314207, 784.4156103702778, 811.0915774332667, 813.1786895235855, 16292.266847991868, 16405.097719625297, 16670.833291666928, 16919.407820726214, 16926.74609880853, 784.5332027443662, 816.7345612675904, 834.7662654456761, 863.9913600863911, 876.3164731509432, 9144.497052662167, 9286.72139835806, 9435.433873967584, 9456.47989360578, 9621.422714637145, 500589.0, 501514.0, 506565.0, 512998.0, 514140.0, 95282.52358738161, 96627.0, 97214.0, 98495.50752246194, 98834.5058274704, 964.8842138943372, 974.9512524373753, 993.4238141877838, 996.4170959988343, 1010.5301035018751, 15192.696146076796, 15620.531384058497, 15699.921500392426, 15705.0, 15755.0, 41141.58858411378, 43171.35242971295, 43176.784116079216, 43575.34636980385, 43847.78076109599, 58442.70778646079, 58981.705091474265, 59700.40299596948, 60954.39045609665, 61043.0, 8674.262687671619, 8804.911950880665, 8891.422057566497, 9076.183143517115, 9113.863292050757, 12964.286964217059, 13585.252811095485, 13817.79273310881, 13936.233507157203, 13950.860491395362, 12191.878081219074, 12274.693132671755, 12381.62855114348, 12614.49542018309, 12643.494260229856, 12314.81527777102, 12383.69040773988, 12453.501859925502, 12562.811557826457, 12598.055145863913, 12390.380480975735, 12545.435455404711, 12554.246745195318, 12838.29389383593, 13082.215067096005, 7433.0, 8090.352771778126, 8779.0, 9049.321300902327, 9085.137546802758, 12240.632781016584, 12360.81458778137, 12482.0, 12603.243805371707, 12629.87370126287], "value": 9058.13566073181, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.8224989626397, 1332.8867046301068, 1413.6395219219098, 1490.2399776114185, 1774.6805574996495, 8047.91952080479, 8451.02813176485, 8454.704085357014, 8749.168828961254, 8775.6050977706, 8532.616032278547, 8674.522901240429, 8689.91310086899, 8693.56532173392, 8708.824308718322, 1993.3820515640198, 2213.4908970936694, 2241.9215327463503, 2243.270936945491, 2267.637178051512, 2237.697910782048, 2245.786650268222, 2246.887655617221, 2249.6737972993906, 2250.2124256510256, 2252.3918541993735, 2256.7856053674873, 2296.632538793793, 2298.9655155172686, 2302.0561569756405, 1823.462078686784, 2132.872027678329, 2194.078487035449, 2194.1442837293466, 2206.944826379345, 2196.846220764547, 2198.8460807743463, 2217.855839370452, 2219.4895174109884, 2221.7222847144108, 8897.466152030835, 8914.28685705142, 8943.821123577492, 8951.283897288267, 8956.104389560991, 5092.3125378073855, 5146.202338637479, 5180.171172612401, 5188.507091826271, 5191.22131680251, 3210.4060748761553, 3262.3964566555264, 3296.950545741816, 3307.818070006149, 3318.883839065621, 1048.9318194317345, 1059.7138772531373, 2202.5925203837182, 2239.3729755668437, 2243.5849367866995, 12440.440180191914, 12480.126391152622, 12536.561220357335, 12540.937295313557, 12553.309567973758, 4314.158739045856, 4404.911901761947, 4529.433820772403, 4532.660050496226, 4533.0, 9795.412275263507, 9810.558524866397, 9816.116549510436, 9824.705258842247, 9832.950835245922, 5230.241614965808, 5230.660007099526, 5231.136862417658, 5234.476552344735, 5238.449962753933, 4288.742675439484, 4778.331033655291, 4901.5588597026435, 4908.263760435963, 4968.354113965162, 3746.868859589901, 3809.104860357814, 3826.7895265760094, 3875.399313106473, 3921.1961547882615, 1032.6282538286212, 1111.105560024172, 1117.1677100559973, 1136.9204155709022, 1142.1833389126814, 897.546738896853, 908.7546362482093, 912.2975309012023, 944.3767113705059, 946.5030858799186, 5759.452851979056, 5776.653400795965, 5815.331236907725, 5818.5345172386105, 5819.266625233064, 828.9709860154986, 846.2383854530972, 874.8687696845524, 879.4811061473761, 895.4000819450983, 3968.3650615901315, 4091.468109145792, 4101.159262351271, 4113.526944401372, 4113.670906327487, 10715.46422678863, 11063.612773552886, 11148.832767508495, 11179.72050698739, 11185.937335953071, 11017.944910275557, 11031.613893513688, 11038.613648522263, 11039.006489415991, 11057.557697692164, 7849.4897831640765, 8300.916990830014, 8378.53918034514, 8381.28759055475, 8383.580820958927, 5884.235049443545, 5986.461218490357, 6167.105769663463, 6260.186175797117, 6316.336784637547, 10482.318649287772, 10592.947035265082, 10604.8939510607, 10614.522346494272, 10617.0, 10254.230932680228, 10415.270931034755, 10828.783424331627, 10839.729006774895, 10864.782704345711, 8087.555184464675, 8168.509889406655, 8212.17878212174, 8252.05101413345, 8255.215754503313, 8379.329653627574, 8448.535330556879, 8462.280706140047, 8624.741257762276, 8625.69810056645, 6259.280182779039, 7672.309492145734, 7729.111152217342, 7741.690332386866, 7943.0071241094865, 7332.890006649798, 7491.550506969599, 7518.398528117847, 7690.461667683208, 7738.845223095619, 6705.932940670726, 6891.793246202622, 6947.305269473214, 6957.373836354753, 6957.652117394211, 4871.415430148405, 4895.388076490439, 4922.237053256607, 4937.950620493749, 5015.899682006412, 4948.208286674115, 4949.802007919787, 5020.723860187724, 5030.220315851049, 5032.119379108714], "value": 4607.322086314249, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.5344889563446, 326.9068315530074, 332.3300415412552, 332.70887973023605, 335.6760725899507, 5219.686818790875, 5252.6848389096685, 5279.445658205881, 5293.973530132349, 5341.813036543712, 4932.309476673268, 5092.872678183047, 5093.770780314885, 5094.847154585359, 5230.581553475722, 3943.93513751287, 4035.85874494392, 4085.12169883475, 4117.69117316201, 4131.194417088669, 4080.367543030835, 4105.815238314268, 4108.192395346038, 4109.0, 4112.807285887104, 3905.3556163233034, 4085.611866872642, 4088.650745254059, 4098.262312783698, 4101.9179616407655, 4055.0876052887866, 4075.572064933169, 4088.8568900088353, 4093.22228776533, 4095.9795201024103, 3603.531540899666, 3607.549056367954, 3608.116011577154, 3613.223157021253, 3615.168511242429, 4860.8055677772845, 5128.0, 5130.743462826881, 5150.429119118668, 5151.845444636667, 4670.836520721792, 4675.509071547506, 4678.0, 4683.391159149289, 4695.812167513295, 5470.972645136789, 5476.452354764531, 5478.561715062825, 5495.560355171577, 5507.824409358321, 3882.3788193889127, 3979.3633018716864, 3979.8408063677416, 3986.3223252047223, 3988.940165897514, 5655.1799989001365, 5668.68822214778, 5685.40303268155, 5715.828525144252, 5717.685527295997, 4041.8383264669674, 4048.514178298623, 4048.777317247521, 4054.6958978076764, 4054.9659836741444, 4089.386592011222, 4111.48606424197, 4115.588441155861, 4117.0, 4125.443065186161, 4438.533953934855, 4641.164590373765, 4667.743274119956, 4670.089332580183, 4689.835855745033, 5473.151661492475, 5492.862678433071, 5506.256655351556, 5507.476789704971, 5526.47498487643, 1347.5957212836306, 1354.1807206640037, 1394.835312514062, 1416.7945647881, 1419.8722115009698, 924.9075092490697, 935.8175155844544, 945.2438049560325, 947.4836214263244, 949.3971328206501, 5310.60170487215, 5314.077257508355, 5315.707636079976, 5318.016167009116, 5323.946760532423, 5598.188262701967, 5600.243967064475, 5601.187827765033, 5603.467670571289, 5609.467100625434, 5125.589952803767, 5262.473882574087, 5301.734913254322, 5309.203619457112, 5385.7576409061685, 2991.641003079644, 3000.4149190908, 3007.0828397338582, 3007.9398412032074, 3016.4570377332293, 5830.62100963436, 5831.0, 5848.0, 5859.707014649336, 5866.23738913947, 5565.994363043992, 5741.368449470555, 5755.798547050917, 5787.75885504119, 5816.389279125631, 5750.332403602908, 5812.38969908162, 5842.269716285465, 5848.268966379288, 5863.853403664857, 5426.864328391822, 5627.127795191752, 5628.662280263197, 5635.6618602883955, 5672.716364181857, 5533.3083364579425, 5563.749631266522, 5598.0, 5628.74670639814, 5644.8024319148635, 5837.883242335045, 5867.6772777497645, 5876.500497457764, 5877.265341832271, 5879.676617785892, 3847.2690188864026, 3968.9206215876097, 3969.0, 3974.980125099356, 4026.778527181033, 5362.0, 5581.74882130297, 5615.803446879339, 5629.4652008059165, 5650.152477128464, 5363.651362661571, 5513.807016754395, 5518.813455107172, 5528.834134975958, 5534.944650553443, 5396.379416367011, 5401.351837779492, 5414.404415514212, 5414.456879789241, 5467.753951072132, 5265.21021846726, 5455.918161227664, 5458.5087342139395, 5476.507114359727, 5495.230667706444, 5511.807086752105, 5512.173174023928, 5518.144687573433, 5535.7785688572, 5537.1140617501005, 5392.892142157057, 5402.270693456333, 5413.431589683027, 5419.674819510842, 5428.212909128233], "value": 4193.316727236703, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.217660573369, 758.8926524490181, 780.8165081205917, 783.8784988326807, 845.5645342648534, 13599.18404895707, 14588.708225835477, 14698.559043228694, 14705.044172128817, 14713.852861471381, 13273.0, 13685.384157712902, 13949.721005579882, 14110.78833817491, 14112.153270803734, 774.3611520495585, 788.5741699482272, 793.1711361627084, 793.9563324017176, 794.7973266816954, 645.0743183531623, 763.2177018555997, 801.8596745569502, 801.8997625296838, 809.1180613131685, 853.7950891785957, 856.1823458597056, 856.751542052804, 857.9699710510133, 859.2953777902122, 852.1776485691338, 852.526847599582, 852.5353682243192, 852.8209076093997, 853.1681610429844, 495.9355283813117, 587.73551901644, 604.5858586867965, 607.9998402627652, 615.566025951703, 12440.440180191914, 12632.936835315857, 12651.304178270191, 12836.80744788829, 12871.613851584467, 12610.0, 12699.174553654075, 13624.455021799116, 13665.18008919458, 13774.104683195561, 12866.549670761571, 12936.805947910789, 13013.804792928113, 13257.138286011379, 13574.524891628746, 4305.78471076448, 4344.500382456026, 4414.359917811899, 4440.356148358503, 4511.436070491189, 80306.0, 80506.0, 81220.0, 82520.58739706263, 83407.16592834116, 10528.684139475828, 10730.624428144978, 10798.730031749112, 10825.07986821129, 10868.184886133571, 20066.398008059783, 20067.799322006595, 20080.799192008184, 20090.0, 20093.598128037356, 8075.394345424117, 8229.588520573947, 8288.792780180424, 8302.086770455246, 8350.874736878952, 4622.699524530894, 4729.645276604199, 4731.243001119873, 4805.0, 4815.831445899446, 3360.445526488102, 3399.3711163434846, 3450.654934506529, 3456.9654303456646, 3464.4110501214855, 584.2434047907884, 584.9736761845727, 596.5794115148809, 599.9820005399845, 604.6281536854802, 541.753965878478, 550.1829782772579, 580.1095318685797, 582.126809785322, 588.3351812451988, 8516.233538981398, 8803.043663492901, 9107.954460227656, 9182.816343673223, 9360.391574547768, 495.8834673851642, 568.7696482924422, 607.6080927801544, 620.7734177025444, 631.8136149835809, 4432.180046691373, 4451.910961780746, 4474.843380481668, 4506.842260520866, 4580.039010735426, 68920.6553967227, 69353.3064669357, 69490.65254673694, 74786.0, 122503.0, 97886.5105674467, 100445.49777251213, 101990.49004754929, 102521.48739256256, 106750.0, 89612.5519372399, 90517.0, 90620.54689726509, 91308.54345728362, 93848.53075734578, 8263.132371101188, 9358.344915855825, 9480.668176613786, 9676.12914837668, 9709.320347575602, 44193.895152621444, 45186.966586503026, 49638.75180624074, 51979.22031169611, 54420.18369724537, 76644.0, 77849.61075194587, 78199.21800781919, 78324.60837695775, 80722.5963870177, 11312.321260724382, 11418.429078546205, 11462.140339474407, 11654.70863228426, 11739.23694959825, 12149.453274602487, 12157.635270941886, 12476.251424914533, 12495.437705303464, 12914.547990820276, 11555.4800033997, 11773.470193841127, 11821.76356472883, 12115.878841211475, 12157.027437804778, 12277.0, 12551.372431378577, 12571.245725256515, 12599.0, 13001.739965200832, 11902.0, 12302.81545776832, 12570.748585028432, 12603.49586016549, 12622.11645184865, 9662.339726871094, 10149.949250253701, 10431.68704938853, 10516.158707303244, 10521.368717876645, 9702.466364350028, 10258.589231530734, 10495.947520262349, 10686.519106640375, 11043.779124417628], "value": 7148.7196421454855, "unit": "score"}], "name": "dromaeo_css", "value": 7142.354153883275, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 111.0, 113.0, 111.0, 109.0, 110.0, 111.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 116.0, 118.0, 172.0, 119.0, 119.0, 153.0, 117.0, 161.0, 115.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 159.0, 160.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 109.0, 76.0, 75.0, 75.0, 75.0, 102.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 117.0, 83.0, 83.0, 84.0, 130.0, 83.0, 84.0, 125.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 147.0, 145.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 54.0, 54.0, 53.0, 54.0, 55.0, 55.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 62.0, 67.0, 62.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 80.0, 75.0, 74.0, 75.0, 74.0, 75.0, 81.0, 78.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 132.0, 117.0, 124.0, 120.0, 129.0, 118.0, 118.0, 165.0, 118.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 164.0, 160.0, 158.0, 159.0, 156.0, 154.0, 159.0, 155.0, 156.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 63.0, 66.0, 62.0, 63.0, 61.0, 64.0, 62.0, 61.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1480.7, "alertThreshold": 2.0}]} 21:43:08 INFO - Return code: 0 21:43:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:43:08 INFO - # TBPL SUCCESS # 21:43:08 INFO - Running post-action listener: _resource_record_post_action 21:43:08 INFO - ##### 21:43:08 INFO - ##### Finished run-tests step (success) 21:43:08 INFO - ##### 21:43:08 INFO - Running post-run listener: _resource_record_post_run 21:43:08 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 308551680; Read time: 0; Write time: 246028 21:43:08 INFO - TinderboxPrint: CPU usage
13.0% 21:43:08 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:43:08 INFO - TinderboxPrint: I/O write bytes / time
308,551,680 / 246,028 21:43:08 INFO - TinderboxPrint: CPU idle
8,272.5 (87.0%) 21:43:08 INFO - TinderboxPrint: CPU user
1,191.9 (12.5%) 21:43:08 INFO - TinderboxPrint: Swap in / out
0 / 0 21:43:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13963264; Read time: 0; Write time: 4828 21:43:08 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 294588416; Read time: 0; Write time: 241200 21:43:08 INFO - Running post-run listener: _upload_blobber_files 21:43:08 INFO - Blob upload gear active. 21:43:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:43:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:43:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:43:09 INFO - (blobuploader) - INFO - Open directory for files ... 21:43:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:43:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:43:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:10 INFO - (blobuploader) - INFO - Done attempting. 21:43:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:43:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:13 INFO - (blobuploader) - INFO - Done attempting. 21:43:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:43:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:13 INFO - (blobuploader) - INFO - Done attempting. 21:43:13 INFO - (blobuploader) - INFO - Iteration through files over. 21:43:13 INFO - Return code: 0 21:43:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:43:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:43:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3a6595737ac1f0b0554e9fdfb3de4158aecb89e0718f03c2318af5647fc25f2ed0b0e7060a45659b3055eed31403da8858f7127b45339cb443fcb4ebacdf042f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ea1e0817cde941c40b6ed03ba5a9e64dd21709a865310c82d919f22c897284170e245c77617d5d6d8e5edd13321e4fab8a8af5d2e0e4ee0cba9bec280e7c285c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f2659c21f9a1b4bd8837e904338166551b6bdb3ad9df3771d4501fb912a1bc6d194755e8209cac3385097296d96410615519ede916fc9c19e6de347e9ab0f3af"} 21:43:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:43:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:43:13 INFO - Contents: 21:43:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3a6595737ac1f0b0554e9fdfb3de4158aecb89e0718f03c2318af5647fc25f2ed0b0e7060a45659b3055eed31403da8858f7127b45339cb443fcb4ebacdf042f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ea1e0817cde941c40b6ed03ba5a9e64dd21709a865310c82d919f22c897284170e245c77617d5d6d8e5edd13321e4fab8a8af5d2e0e4ee0cba9bec280e7c285c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f2659c21f9a1b4bd8837e904338166551b6bdb3ad9df3771d4501fb912a1bc6d194755e8209cac3385097296d96410615519ede916fc9c19e6de347e9ab0f3af"} 21:43:13 INFO - Running post-run listener: copy_logs_to_upload_dir 21:43:13 INFO - Copying logs to upload dir... 21:43:13 INFO - mkdir: /builds/slave/test/build/upload/logs 21:43:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.905803 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-08 21:43:13.891339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 21:43:13.897701) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659 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/3a6595737ac1f0b0554e9fdfb3de4158aecb89e0718f03c2318af5647fc25f2ed0b0e7060a45659b3055eed31403da8858f7127b45339cb443fcb4ebacdf042f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ea1e0817cde941c40b6ed03ba5a9e64dd21709a865310c82d919f22c897284170e245c77617d5d6d8e5edd13321e4fab8a8af5d2e0e4ee0cba9bec280e7c285c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f2659c21f9a1b4bd8837e904338166551b6bdb3ad9df3771d4501fb912a1bc6d194755e8209cac3385097296d96410615519ede916fc9c19e6de347e9ab0f3af"} build_url:https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/JHL7Otj3SIK5eNEBBdhRYw/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/3a6595737ac1f0b0554e9fdfb3de4158aecb89e0718f03c2318af5647fc25f2ed0b0e7060a45659b3055eed31403da8858f7127b45339cb443fcb4ebacdf042f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ea1e0817cde941c40b6ed03ba5a9e64dd21709a865310c82d919f22c897284170e245c77617d5d6d8e5edd13321e4fab8a8af5d2e0e4ee0cba9bec280e7c285c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f2659c21f9a1b4bd8837e904338166551b6bdb3ad9df3771d4501fb912a1bc6d194755e8209cac3385097296d96410615519ede916fc9c19e6de347e9ab0f3af"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 21:43:13.922359) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 21:43:13.922646) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1468026954.694606-2104047659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 21:43:14.006283) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 21:43:14.006622) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 21:43:14.006895) ========= ========= Total master_lag: 0.17 =========