builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1467667663.25 results: success (0) buildid: 20160704135223 builduid: 5620937691b44aadb88a7f4cf0869f9a revision: 760b8e6d19e41780e554573b3983aa8647bf3cbd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 14:27:43.246812) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 14:27:43.247278) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 14:27:43.247555) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 14:27:43.262404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 14:27:43.262664) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 14:27:43-- 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% 70.9M=0s 2016-07-04 14:27:43 (70.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.316962 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 14:27:43.594245) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 14:27:43.594557) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019687 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 14:27:43.644011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 14:27:43.644438) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 760b8e6d19e41780e554573b3983aa8647bf3cbd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 760b8e6d19e41780e554573b3983aa8647bf3cbd --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=17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 14:27:44,060 truncating revision to first 12 chars 2016-07-04 14:27:44,060 Setting DEBUG logging. 2016-07-04 14:27:44,060 attempt 1/10 2016-07-04 14:27:44,060 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/760b8e6d19e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 14:27:44,378 unpacking tar archive at: fx-team-760b8e6d19e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.723203 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 14:27:44.381395) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 14:27:44.381717) ========= script_repo_revision: 760b8e6d19e41780e554573b3983aa8647bf3cbd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 14:27:44.382114) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 14:27:44.382380) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 14:27:44.393158) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-04 14:27:44.393451) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:27:44 INFO - MultiFileLogger online at 20160704 14:27:44 in /builds/slave/test 14:27:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:27:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:27:44 INFO - {'append_to_log': False, 14:27:44 INFO - 'base_work_dir': '/builds/slave/test', 14:27:44 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:27:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:27:44 INFO - 'branch': 'Fx-Team-Non-PGO', 14:27:44 INFO - 'buildbot_json_path': 'buildprops.json', 14:27:44 INFO - 'config_files': ('talos/linux_config.py',), 14:27:44 INFO - 'default_actions': ('clobber', 14:27:44 INFO - 'read-buildbot-config', 14:27:44 INFO - 'download-and-extract', 14:27:44 INFO - 'populate-webroot', 14:27:44 INFO - 'create-virtualenv', 14:27:44 INFO - 'install', 14:27:44 INFO - 'run-tests'), 14:27:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:27:44 INFO - 'download_minidump_stackwalk': True, 14:27:44 INFO - 'download_symbols': 'ondemand', 14:27:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:27:44 INFO - 'tooltool.py': '/tools/tooltool.py', 14:27:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:27:44 INFO - '/tools/misc-python/virtualenv.py')}, 14:27:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:27:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:27:44 INFO - 'installer_path': 'installer.exe', 14:27:44 INFO - 'log_level': 'info', 14:27:44 INFO - 'log_name': 'talos', 14:27:44 INFO - 'log_to_console': True, 14:27:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:27:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:27:44 INFO - 'opt_config_files': (), 14:27:44 INFO - 'pip_index': False, 14:27:44 INFO - 'sps_profile': False, 14:27:44 INFO - 'sps_profile_interval': 0, 14:27:44 INFO - 'suite': 'dromaeojs', 14:27:44 INFO - 'system_bits': '32', 14:27:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:27:44 INFO - 'title': 'talos-linux64-ix-009', 14:27:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:27:44 INFO - 'use_talos_json': True, 14:27:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:27:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:27:44 INFO - 'work_dir': 'build'} 14:27:44 INFO - ##### 14:27:44 INFO - ##### Running clobber step. 14:27:44 INFO - ##### 14:27:44 INFO - Running pre-action listener: _resource_record_pre_action 14:27:44 INFO - Running main action method: clobber 14:27:44 INFO - rmtree: /builds/slave/test/build 14:27:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:27:45 INFO - Running post-action listener: _resource_record_post_action 14:27:45 INFO - ##### 14:27:45 INFO - ##### Finished clobber step (success) 14:27:45 INFO - ##### 14:27:45 INFO - ##### 14:27:45 INFO - ##### Running read-buildbot-config step. 14:27:45 INFO - ##### 14:27:45 INFO - Running pre-action listener: _resource_record_pre_action 14:27:45 INFO - Running main action method: read_buildbot_config 14:27:45 INFO - Using buildbot properties: 14:27:45 INFO - { 14:27:45 INFO - "project": "", 14:27:45 INFO - "product": "firefox", 14:27:45 INFO - "script_repo_revision": "production", 14:27:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:27:45 INFO - "repository": "", 14:27:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:27:45 INFO - "buildid": "20160704135223", 14:27:45 INFO - "pgo_build": "False", 14:27:45 INFO - "basedir": "/builds/slave/test", 14:27:45 INFO - "buildnumber": 3129, 14:27:45 INFO - "slavename": "talos-linux64-ix-009", 14:27:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:27:45 INFO - "platform": "ubuntu64_hw", 14:27:45 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:27:45 INFO - "branch": "fx-team", 14:27:45 INFO - "repo_path": "integration/fx-team", 14:27:45 INFO - "revision": "760b8e6d19e41780e554573b3983aa8647bf3cbd", 14:27:45 INFO - "stage_platform": "linux64", 14:27:45 INFO - "builduid": "5620937691b44aadb88a7f4cf0869f9a", 14:27:45 INFO - "slavebuilddir": "test" 14:27:45 INFO - } 14:27:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:27:45 INFO - Running post-action listener: _resource_record_post_action 14:27:45 INFO - ##### 14:27:45 INFO - ##### Finished read-buildbot-config step (success) 14:27:45 INFO - ##### 14:27:45 INFO - ##### 14:27:45 INFO - ##### Running download-and-extract step. 14:27:45 INFO - ##### 14:27:45 INFO - Running pre-action listener: _resource_record_pre_action 14:27:45 INFO - Running main action method: download_and_extract 14:27:45 INFO - mkdir: /builds/slave/test/build/tests 14:27:45 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')]} 14:27:45 INFO - https://queue.taskcluster.net/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:27:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:27:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:27:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/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 14:27:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/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 14:27:46 INFO - Downloaded 1361 bytes. 14:27:46 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:27:46 INFO - Using the following test package requirements: 14:27:46 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:27:46 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:27:46 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:27:46 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:46 INFO - u'jsshell-linux-x86_64.zip'], 14:27:46 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:27:46 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:27:46 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:27:46 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:27:46 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:27:46 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:27:46 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:27:46 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')]} 14:27:46 INFO - https://queue.taskcluster.net/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:27:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:27:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:27:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/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 14:27:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/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 14:27:47 INFO - Downloaded 22709746 bytes. 14:27:47 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'] 14:27:47 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 14:27:48 INFO - Return code: 0 14:27:48 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 14:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:27:48 INFO - https://queue.taskcluster.net/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:27:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:27:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:27:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/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 14:27:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/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 14:27:49 INFO - Downloaded 22709746 bytes. 14:27:49 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'] 14:27:49 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 14:27:50 INFO - Return code: 0 14:27: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')]} 14:27:50 INFO - https://queue.taskcluster.net/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:27:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:27:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:27:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/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 14:27:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/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 14:27:51 INFO - Downloaded 14403333 bytes. 14:27: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'] 14:27: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 14:27:51 INFO - Return code: 0 14:27: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')]} 14:27:51 INFO - https://queue.taskcluster.net/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:27:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:27:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:27:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/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 14:27:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/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 14:27:53 INFO - Downloaded 56485180 bytes. 14:27:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:27:53 INFO - mkdir: /builds/slave/test/properties 14:27:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:27:53 INFO - Writing to file /builds/slave/test/properties/build_url 14:27:53 INFO - Contents: 14:27:53 INFO - build_url:https://queue.taskcluster.net/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:27:53 INFO - Running post-action listener: _resource_record_post_action 14:27:53 INFO - Running post-action listener: set_extra_try_arguments 14:27:53 INFO - ##### 14:27:53 INFO - ##### Finished download-and-extract step (success) 14:27:53 INFO - ##### 14:27:53 INFO - ##### 14:27:53 INFO - ##### Running populate-webroot step. 14:27:53 INFO - ##### 14:27:53 INFO - Running pre-action listener: _resource_record_pre_action 14:27:53 INFO - Running main action method: populate_webroot 14:27:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:27:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:27:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:27:53 INFO - '--tppagecycles', 14:27:53 INFO - '7'], 14:27:53 INFO - 'tests': ['tsvgm']}}, 14:27:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:27:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:27:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:27:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:27:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:27:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:27:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:53 INFO - 'talos_options': ['--disable-e10s'], 14:27:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:53 INFO - 'talos_options': ['--disable-e10s'], 14:27:53 INFO - 'tests': ['damp', 'tps']}, 14:27:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:53 INFO - 'tests': ['damp', 'tps']}, 14:27:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:27:53 INFO - 'tests': ['dromaeo_dom']}, 14:27:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:27:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:27:53 INFO - 'tests': ['basic_compositor_video']}, 14:27:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:27:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:27:53 INFO - 'tests': ['a11yr', 14:27:53 INFO - 'ts_paint', 14:27:53 INFO - 'tpaint', 14:27:53 INFO - 'sessionrestore', 14:27:53 INFO - 'sessionrestore_no_auto_restore', 14:27:53 INFO - 'tabpaint']}, 14:27:53 INFO - 'other-e10s': {'tests': ['a11yr', 14:27:53 INFO - 'ts_paint', 14:27:53 INFO - 'tpaint', 14:27:53 INFO - 'sessionrestore', 14:27:53 INFO - 'sessionrestore_no_auto_restore', 14:27:53 INFO - 'tabpaint']}, 14:27:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:27:53 INFO - 'ts_paint', 14:27:53 INFO - 'tpaint', 14:27:53 INFO - 'sessionrestore', 14:27:53 INFO - 'sessionrestore_no_auto_restore', 14:27:53 INFO - 'tabpaint']}, 14:27:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:27:53 INFO - 'ts_paint', 14:27:53 INFO - 'tpaint', 14:27:53 INFO - 'sessionrestore', 14:27:53 INFO - 'sessionrestore_no_auto_restore', 14:27:53 INFO - 'tabpaint']}, 14:27:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:27:53 INFO - 'tests': ['a11yr', 14:27:53 INFO - 'ts_paint', 14:27:53 INFO - 'tpaint', 14:27:53 INFO - 'sessionrestore', 14:27:53 INFO - 'sessionrestore_no_auto_restore', 14:27:53 INFO - 'tabpaint']}, 14:27:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:27:53 INFO - 'tests': ['a11yr', 14:27:53 INFO - 'ts_paint', 14:27:53 INFO - 'tpaint', 14:27:53 INFO - 'sessionrestore', 14:27:53 INFO - 'sessionrestore_no_auto_restore', 14:27:53 INFO - 'tabpaint']}, 14:27:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:27:53 INFO - 'tests': ['tsvgx', 14:27:53 INFO - 'tsvgr_opacity', 14:27:53 INFO - 'tart', 14:27:53 INFO - 'tscrollx', 14:27:53 INFO - 'cart']}, 14:27:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:27:53 INFO - 'tsvgr_opacity', 14:27:53 INFO - 'tart', 14:27:53 INFO - 'tscrollx', 14:27:53 INFO - 'cart']}, 14:27:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:53 INFO - 'talos_options': ['--disable-e10s'], 14:27:53 INFO - 'tests': ['tp5o']}, 14:27:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:53 INFO - 'tests': ['tp5o']}, 14:27:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:53 INFO - 'talos_options': ['--disable-e10s', 14:27:53 INFO - '--xperf_path', 14:27:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:53 INFO - 'tests': ['tp5n']}, 14:27:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:53 INFO - 'talos_options': ['--xperf_path', 14:27:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:53 INFO - 'tests': ['tp5n']}}, 14:27:53 INFO - 'talos.zip': {'path': '', 14:27:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:27:53 INFO - Running post-action listener: _resource_record_post_action 14:27:53 INFO - ##### 14:27:53 INFO - ##### Finished populate-webroot step (success) 14:27:53 INFO - ##### 14:27:53 INFO - ##### 14:27:53 INFO - ##### Running create-virtualenv step. 14:27:53 INFO - ##### 14:27:53 INFO - Running pre-action listener: _resource_record_pre_action 14:27:53 INFO - Running main action method: create_virtualenv 14:27:53 INFO - Creating virtualenv /builds/slave/test/build/venv 14:27: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 14:27:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:27:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:27:54 INFO - Using real prefix '/usr' 14:27:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:27:54 INFO - Installing distribute.............................................................................................................................................................................................done. 14:27:56 INFO - Installing pip.................done. 14:27:56 INFO - Return code: 0 14:27:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:27: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')]} 14:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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')]} 14:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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 0x1d85030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20443b0>, '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 0x20452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', '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 14:27: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 14:27: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 14:27:56 INFO - Using env: {'DISPLAY': ':0', 14:27:56 INFO - 'HOME': '/home/cltbld', 14:27:56 INFO - 'LANG': 'en_US.UTF-8', 14:27:56 INFO - 'LANGUAGE': 'en_US:en', 14:27:56 INFO - 'LOGNAME': 'cltbld', 14:27:56 INFO - 'MAIL': '/var/mail/cltbld', 14:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:56 INFO - 'MOZ_NO_REMOTE': '1', 14:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:56 INFO - 'NO_EM_RESTART': '1', 14:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:56 INFO - 'PWD': '/builds/slave/test', 14:27:56 INFO - 'SHELL': '/bin/bash', 14:27:56 INFO - 'SHLVL': '1', 14:27:56 INFO - 'TERM': 'linux', 14:27:56 INFO - 'TMOUT': '86400', 14:27:56 INFO - 'USER': 'cltbld', 14:27:56 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', 14:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:56 INFO - '_': '/tools/buildbot/bin/python'} 14:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27: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 14:27:56 INFO - Cleaning up... 14:27:56 INFO - Return code: 0 14:27:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:27: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')]} 14:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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')]} 14:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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 0x1d85030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20443b0>, '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 0x20452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', '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 14:27: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 14:27: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 14:27:56 INFO - Using env: {'DISPLAY': ':0', 14:27:56 INFO - 'HOME': '/home/cltbld', 14:27:56 INFO - 'LANG': 'en_US.UTF-8', 14:27:56 INFO - 'LANGUAGE': 'en_US:en', 14:27:56 INFO - 'LOGNAME': 'cltbld', 14:27:56 INFO - 'MAIL': '/var/mail/cltbld', 14:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:56 INFO - 'MOZ_NO_REMOTE': '1', 14:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:56 INFO - 'NO_EM_RESTART': '1', 14:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:56 INFO - 'PWD': '/builds/slave/test', 14:27:56 INFO - 'SHELL': '/bin/bash', 14:27:56 INFO - 'SHLVL': '1', 14:27:56 INFO - 'TERM': 'linux', 14:27:56 INFO - 'TMOUT': '86400', 14:27:56 INFO - 'USER': 'cltbld', 14:27:56 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', 14:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:56 INFO - '_': '/tools/buildbot/bin/python'} 14:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:56 INFO - Downloading/unpacking psutil>=3.1.1 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:27:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:58 INFO - Installing collected packages: psutil 14:27:58 INFO - Running setup.py install for psutil 14:27:59 INFO - building 'psutil._psutil_linux' extension 14:27: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 14:27: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 14:27:59 INFO - building 'psutil._psutil_posix' extension 14:27: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 14:27: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 14:27:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:59 INFO - Successfully installed psutil 14:27:59 INFO - Cleaning up... 14:27:59 INFO - Return code: 0 14:27:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1d85030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20443b0>, '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 0x20452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', '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 14:27:59 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 14:27:59 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 14:27:59 INFO - Using env: {'DISPLAY': ':0', 14:27:59 INFO - 'HOME': '/home/cltbld', 14:27:59 INFO - 'LANG': 'en_US.UTF-8', 14:27:59 INFO - 'LANGUAGE': 'en_US:en', 14:27:59 INFO - 'LOGNAME': 'cltbld', 14:27:59 INFO - 'MAIL': '/var/mail/cltbld', 14:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:59 INFO - 'MOZ_NO_REMOTE': '1', 14:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:59 INFO - 'NO_EM_RESTART': '1', 14:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:59 INFO - 'PWD': '/builds/slave/test', 14:27:59 INFO - 'SHELL': '/bin/bash', 14:27:59 INFO - 'SHLVL': '1', 14:27:59 INFO - 'TERM': 'linux', 14:27:59 INFO - 'TMOUT': '86400', 14:27:59 INFO - 'USER': 'cltbld', 14:27:59 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', 14:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:59 INFO - '_': '/tools/buildbot/bin/python'} 14:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:59 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 14:27:59 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 14:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:28:01 INFO - Installing collected packages: mozsystemmonitor 14:28:01 INFO - Running setup.py install for mozsystemmonitor 14:28:01 INFO - Successfully installed mozsystemmonitor 14:28:01 INFO - Cleaning up... 14:28:01 INFO - Return code: 0 14:28:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d85030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20443b0>, '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 0x20452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', '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 14:28:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:28:01 INFO - Using env: {'DISPLAY': ':0', 14:28:01 INFO - 'HOME': '/home/cltbld', 14:28:01 INFO - 'LANG': 'en_US.UTF-8', 14:28:01 INFO - 'LANGUAGE': 'en_US:en', 14:28:01 INFO - 'LOGNAME': 'cltbld', 14:28:01 INFO - 'MAIL': '/var/mail/cltbld', 14:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:01 INFO - 'MOZ_NO_REMOTE': '1', 14:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:01 INFO - 'NO_EM_RESTART': '1', 14:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:01 INFO - 'PWD': '/builds/slave/test', 14:28:01 INFO - 'SHELL': '/bin/bash', 14:28:01 INFO - 'SHLVL': '1', 14:28:01 INFO - 'TERM': 'linux', 14:28:01 INFO - 'TMOUT': '86400', 14:28:01 INFO - 'USER': 'cltbld', 14:28:01 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', 14:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:01 INFO - '_': '/tools/buildbot/bin/python'} 14:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:01 INFO - Downloading/unpacking jsonschema==2.5.1 14:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:28:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:04 INFO - Downloading functools32-3.2.3-2.tar.gz 14:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:28:04 INFO - warning: no files found matching '*.txt' 14:28:04 INFO - no previously-included directories found matching 'build' 14:28:04 INFO - no previously-included directories found matching 'dist' 14:28:04 INFO - no previously-included directories found matching '.git*' 14:28:04 INFO - Installing collected packages: jsonschema, functools32 14:28:04 INFO - Running setup.py install for functools32 14:28:04 INFO - warning: no files found matching '*.txt' 14:28:04 INFO - no previously-included directories found matching 'build' 14:28:04 INFO - no previously-included directories found matching 'dist' 14:28:04 INFO - no previously-included directories found matching '.git*' 14:28:04 INFO - Successfully installed jsonschema functools32 14:28:04 INFO - Cleaning up... 14:28:04 INFO - Return code: 0 14:28:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:04 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 0x1d85030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20443b0>, '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 0x20452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', '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 14:28:04 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 14:28:04 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 14:28:04 INFO - Using env: {'DISPLAY': ':0', 14:28:04 INFO - 'HOME': '/home/cltbld', 14:28:04 INFO - 'LANG': 'en_US.UTF-8', 14:28:04 INFO - 'LANGUAGE': 'en_US:en', 14:28:04 INFO - 'LOGNAME': 'cltbld', 14:28:04 INFO - 'MAIL': '/var/mail/cltbld', 14:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:04 INFO - 'MOZ_NO_REMOTE': '1', 14:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:04 INFO - 'NO_EM_RESTART': '1', 14:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:04 INFO - 'PWD': '/builds/slave/test', 14:28:04 INFO - 'SHELL': '/bin/bash', 14:28:04 INFO - 'SHLVL': '1', 14:28:04 INFO - 'TERM': 'linux', 14:28:04 INFO - 'TMOUT': '86400', 14:28:04 INFO - 'USER': 'cltbld', 14:28:04 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', 14:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:04 INFO - '_': '/tools/buildbot/bin/python'} 14:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:04 INFO - Downloading/unpacking blobuploader==1.2.4 14:28: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 14:28: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 14:28: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 14:28: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 14:28: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 14:28: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 14:28:06 INFO - Downloading blobuploader-1.2.4.tar.gz 14:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:28:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:28:06 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 14:28:06 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 14:28:06 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 14:28:06 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 14:28:06 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 14:28:06 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 14:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:28:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:28:06 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 14:28:06 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 14:28:06 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 14:28:06 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 14:28:06 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 14:28:06 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 14:28:07 INFO - Downloading docopt-0.6.1.tar.gz 14:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:28:07 INFO - Installing collected packages: blobuploader, requests, docopt 14:28:07 INFO - Running setup.py install for blobuploader 14:28:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:28:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:28:07 INFO - Running setup.py install for requests 14:28:07 INFO - Running setup.py install for docopt 14:28:07 INFO - Successfully installed blobuploader requests docopt 14:28:07 INFO - Cleaning up... 14:28:07 INFO - Return code: 0 14:28:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:07 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 0x1d85030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20443b0>, '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 0x20452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', '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 14:28:07 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 14:28:07 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 14:28:07 INFO - Using env: {'DISPLAY': ':0', 14:28:07 INFO - 'HOME': '/home/cltbld', 14:28:07 INFO - 'LANG': 'en_US.UTF-8', 14:28:07 INFO - 'LANGUAGE': 'en_US:en', 14:28:07 INFO - 'LOGNAME': 'cltbld', 14:28:07 INFO - 'MAIL': '/var/mail/cltbld', 14:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:07 INFO - 'MOZ_NO_REMOTE': '1', 14:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:07 INFO - 'NO_EM_RESTART': '1', 14:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:07 INFO - 'PWD': '/builds/slave/test', 14:28:07 INFO - 'SHELL': '/bin/bash', 14:28:07 INFO - 'SHLVL': '1', 14:28:07 INFO - 'TERM': 'linux', 14:28:07 INFO - 'TMOUT': '86400', 14:28:07 INFO - 'USER': 'cltbld', 14:28:07 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', 14:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:07 INFO - '_': '/tools/buildbot/bin/python'} 14:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:08 INFO - Running setup.py (path:/tmp/pip-GNshOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:08 INFO - Running setup.py (path:/tmp/pip-IoNlkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:08 INFO - Running setup.py (path:/tmp/pip-83Uktv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:08 INFO - Running setup.py (path:/tmp/pip-0tSbZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:08 INFO - Running setup.py (path:/tmp/pip-Tr4ui6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:08 INFO - Running setup.py (path:/tmp/pip-bByvZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:08 INFO - Running setup.py (path:/tmp/pip-IZzK1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:08 INFO - Running setup.py (path:/tmp/pip-Qc8Cqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:08 INFO - Running setup.py (path:/tmp/pip-O6TQiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:08 INFO - Running setup.py (path:/tmp/pip-2O0TVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:08 INFO - Running setup.py (path:/tmp/pip-fFeh5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:08 INFO - Running setup.py (path:/tmp/pip-WskkS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:08 INFO - Running setup.py (path:/tmp/pip-5EacKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:09 INFO - Running setup.py (path:/tmp/pip-ouKI_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:09 INFO - Running setup.py (path:/tmp/pip-h6QNaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:09 INFO - Running setup.py (path:/tmp/pip-cMbMyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:09 INFO - Running setup.py (path:/tmp/pip-IlhxhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:28:09 INFO - Running setup.py install for manifestparser 14:28:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:28:09 INFO - Running setup.py install for mozcrash 14:28:09 INFO - Running setup.py install for mozdebug 14:28:09 INFO - Running setup.py install for mozdevice 14:28:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:28:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:28:09 INFO - Running setup.py install for mozfile 14:28:09 INFO - Running setup.py install for mozhttpd 14:28:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:28:09 INFO - Running setup.py install for mozinfo 14:28:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:28:10 INFO - Running setup.py install for mozInstall 14:28:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:28:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:28:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:28:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:28:10 INFO - Running setup.py install for mozleak 14:28:10 INFO - Running setup.py install for mozlog 14:28:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:28:10 INFO - Running setup.py install for moznetwork 14:28:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:28:10 INFO - Running setup.py install for mozprocess 14:28:10 INFO - Running setup.py install for mozprofile 14:28:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:28:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:28:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:28:10 INFO - Running setup.py install for mozrunner 14:28:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:28:10 INFO - Running setup.py install for mozscreenshot 14:28:10 INFO - Running setup.py install for moztest 14:28:11 INFO - Running setup.py install for mozversion 14:28:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:28:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:28:11 INFO - Cleaning up... 14:28:11 INFO - Return code: 0 14:28:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28: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')]} 14:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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')]} 14:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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 0x1d85030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20443b0>, '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 0x20452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', '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 14:28: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 14:28: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 14:28:11 INFO - Using env: {'DISPLAY': ':0', 14:28:11 INFO - 'HOME': '/home/cltbld', 14:28:11 INFO - 'LANG': 'en_US.UTF-8', 14:28:11 INFO - 'LANGUAGE': 'en_US:en', 14:28:11 INFO - 'LOGNAME': 'cltbld', 14:28:11 INFO - 'MAIL': '/var/mail/cltbld', 14:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:11 INFO - 'MOZ_NO_REMOTE': '1', 14:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:11 INFO - 'NO_EM_RESTART': '1', 14:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:11 INFO - 'PWD': '/builds/slave/test', 14:28:11 INFO - 'SHELL': '/bin/bash', 14:28:11 INFO - 'SHLVL': '1', 14:28:11 INFO - 'TERM': 'linux', 14:28:11 INFO - 'TMOUT': '86400', 14:28:11 INFO - 'USER': 'cltbld', 14:28:11 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', 14:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:11 INFO - '_': '/tools/buildbot/bin/python'} 14:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:11 INFO - Running setup.py (path:/tmp/pip-ZbSIgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:11 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)) 14:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:11 INFO - Running setup.py (path:/tmp/pip-U5P02R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:11 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)) 14:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:11 INFO - Running setup.py (path:/tmp/pip-I8ZYWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:11 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)) 14:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:11 INFO - Running setup.py (path:/tmp/pip-1GmtLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:11 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)) 14:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:11 INFO - Running setup.py (path:/tmp/pip-IkXxuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:11 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)) 14:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:11 INFO - Running setup.py (path:/tmp/pip-BOnwOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:11 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)) 14:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:11 INFO - Running setup.py (path:/tmp/pip-vvG7Ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:11 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)) 14:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:11 INFO - Running setup.py (path:/tmp/pip-h8JBiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:11 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)) 14:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:11 INFO - Running setup.py (path:/tmp/pip-3lgzzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:11 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)) 14:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:12 INFO - Running setup.py (path:/tmp/pip-pI8VZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28: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)) 14:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:12 INFO - Running setup.py (path:/tmp/pip-friT_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:12 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)) 14:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:12 INFO - Running setup.py (path:/tmp/pip-dGnOB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:12 INFO - Running setup.py (path:/tmp/pip-ibrlSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:12 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)) 14:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:12 INFO - Running setup.py (path:/tmp/pip-Onfnci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:12 INFO - Running setup.py (path:/tmp/pip-qi8ifL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:12 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)) 14:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:12 INFO - Running setup.py (path:/tmp/pip-5vgNxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:12 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)) 14:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:12 INFO - Running setup.py (path:/tmp/pip-2L6twG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:12 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)) 14:28:12 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)) 14:28:12 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)) 14:28:12 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)) 14:28:12 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)) 14:28:12 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)) 14:28:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:28:12 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 14:28:12 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 14:28:12 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 14:28:12 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 14:28:12 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 14:28:12 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 14:28:14 INFO - Downloading blessings-1.6.tar.gz 14:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:28:14 INFO - Installing collected packages: blessings 14:28:14 INFO - Running setup.py install for blessings 14:28:14 INFO - Successfully installed blessings 14:28:14 INFO - Cleaning up... 14:28:14 INFO - Return code: 0 14:28:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:28:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:14 INFO - Reading from file tmpfile_stdout 14:28:14 INFO - Current package versions: 14:28:14 INFO - argparse == 1.2.1 14:28:14 INFO - blessings == 1.6 14:28:14 INFO - blobuploader == 1.2.4 14:28:14 INFO - docopt == 0.6.1 14:28:14 INFO - functools32 == 3.2.3-2 14:28:14 INFO - jsonschema == 2.5.1 14:28:14 INFO - manifestparser == 1.1 14:28:14 INFO - mozInstall == 1.12 14:28:14 INFO - mozcrash == 0.17 14:28:14 INFO - mozdebug == 0.1 14:28:14 INFO - mozdevice == 0.48 14:28:14 INFO - mozfile == 1.2 14:28:14 INFO - mozhttpd == 0.7 14:28:14 INFO - mozinfo == 0.9 14:28:14 INFO - mozleak == 0.1 14:28:14 INFO - mozlog == 3.2 14:28:14 INFO - moznetwork == 0.27 14:28:14 INFO - mozprocess == 0.22 14:28:14 INFO - mozprofile == 0.28 14:28:14 INFO - mozrunner == 6.11 14:28:14 INFO - mozscreenshot == 0.1 14:28:14 INFO - mozsystemmonitor == 0.3 14:28:14 INFO - moztest == 0.7 14:28:14 INFO - mozversion == 1.4 14:28:14 INFO - psutil == 3.1.1 14:28:14 INFO - requests == 1.2.3 14:28:14 INFO - wsgiref == 0.1.2 14:28:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:14 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')]} 14:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:14 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')]} 14:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:14 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 0x1d85030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20443b0>, '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 0x20452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', '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 14:28:14 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 14:28:14 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 14:28:14 INFO - Using env: {'DISPLAY': ':0', 14:28:14 INFO - 'HOME': '/home/cltbld', 14:28:14 INFO - 'LANG': 'en_US.UTF-8', 14:28:14 INFO - 'LANGUAGE': 'en_US:en', 14:28:14 INFO - 'LOGNAME': 'cltbld', 14:28:14 INFO - 'MAIL': '/var/mail/cltbld', 14:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:14 INFO - 'MOZ_NO_REMOTE': '1', 14:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:14 INFO - 'NO_EM_RESTART': '1', 14:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:14 INFO - 'PWD': '/builds/slave/test', 14:28:14 INFO - 'SHELL': '/bin/bash', 14:28:14 INFO - 'SHLVL': '1', 14:28:14 INFO - 'TERM': 'linux', 14:28:14 INFO - 'TMOUT': '86400', 14:28:14 INFO - 'USER': 'cltbld', 14:28:14 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', 14:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:14 INFO - '_': '/tools/buildbot/bin/python'} 14:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:15 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)) 14:28:15 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)) 14:28:15 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)) 14:28:15 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)) 14:28:15 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)) 14:28:15 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)) 14:28:15 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)) 14:28:15 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)) 14:28:15 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)) 14:28:15 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)) 14:28:15 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)) 14:28:15 INFO - Cleaning up... 14:28:15 INFO - Return code: 0 14:28:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:28: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')]} 14:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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')]} 14:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:15 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 0x1d85030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20443b0>, '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 0x20452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', '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 14:28:15 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 14:28:15 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 14:28:15 INFO - Using env: {'DISPLAY': ':0', 14:28:15 INFO - 'HOME': '/home/cltbld', 14:28:15 INFO - 'LANG': 'en_US.UTF-8', 14:28:15 INFO - 'LANGUAGE': 'en_US:en', 14:28:15 INFO - 'LOGNAME': 'cltbld', 14:28:15 INFO - 'MAIL': '/var/mail/cltbld', 14:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:15 INFO - 'MOZ_NO_REMOTE': '1', 14:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:15 INFO - 'NO_EM_RESTART': '1', 14:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:15 INFO - 'PWD': '/builds/slave/test', 14:28:15 INFO - 'SHELL': '/bin/bash', 14:28:15 INFO - 'SHLVL': '1', 14:28:15 INFO - 'TERM': 'linux', 14:28:15 INFO - 'TMOUT': '86400', 14:28:15 INFO - 'USER': 'cltbld', 14:28:15 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', 14:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:15 INFO - '_': '/tools/buildbot/bin/python'} 14:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:28:15 INFO - Cleaning up... 14:28:15 INFO - Return code: 0 14:28:15 INFO - Running post-action listener: _resource_record_post_action 14:28:15 INFO - Running post-action listener: _start_resource_monitoring 14:28:15 INFO - Starting resource monitoring. 14:28:15 INFO - ##### 14:28:15 INFO - ##### Finished create-virtualenv step (success) 14:28:15 INFO - ##### 14:28:15 INFO - ##### 14:28:15 INFO - ##### Running install step. 14:28:15 INFO - ##### 14:28:15 INFO - Running pre-action listener: _resource_record_pre_action 14:28:15 INFO - Running main action method: install 14:28:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:15 INFO - Reading from file tmpfile_stdout 14:28:15 INFO - Detecting whether we're running mozinstall >=1.0... 14:28:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:28:15 INFO - Reading from file tmpfile_stdout 14:28:15 INFO - Output received: 14:28:15 INFO - Usage: mozinstall [options] installer 14:28:15 INFO - Options: 14:28:15 INFO - -h, --help show this help message and exit 14:28:15 INFO - -d DEST, --destination=DEST 14:28:15 INFO - Directory to install application into. [default: 14:28:15 INFO - "/builds/slave/test"] 14:28:15 INFO - --app=APP Application being installed. [default: firefox] 14:28:15 INFO - mkdir: /builds/slave/test/build/application 14:28:15 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'] 14:28:15 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 14:28:32 INFO - Reading from file tmpfile_stdout 14:28:32 INFO - Output received: 14:28:32 INFO - /builds/slave/test/build/application/firefox/firefox 14:28:32 INFO - Running post-action listener: _resource_record_post_action 14:28:32 INFO - ##### 14:28:32 INFO - ##### Finished install step (success) 14:28:32 INFO - ##### 14:28:32 INFO - ##### 14:28:32 INFO - ##### Running run-tests step. 14:28:32 INFO - ##### 14:28:32 INFO - Running pre-action listener: _resource_record_pre_action 14:28:32 INFO - Running main action method: run_tests 14:28:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:28:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:28:32 INFO - Python 2.7.3 14:28:32 INFO - Return code: 0 14:28:32 INFO - grabbing minidump binary from tooltool 14:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:32 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 0x20443b0>, '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 0x20452b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:28:32 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 14:28:32 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 14:28:32 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 14:28:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:28:32 INFO - Return code: 0 14:28:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:28:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:28:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:28:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:28:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:28:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 14:28:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 14:28:32 INFO - Using env: {'DISPLAY': ':0', 14:28:32 INFO - 'HOME': '/home/cltbld', 14:28:32 INFO - 'LANG': 'en_US.UTF-8', 14:28:32 INFO - 'LANGUAGE': 'en_US:en', 14:28:32 INFO - 'LOGNAME': 'cltbld', 14:28:32 INFO - 'MAIL': '/var/mail/cltbld', 14:28:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:28:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:32 INFO - 'MOZ_NO_REMOTE': '1', 14:28:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:32 INFO - 'NO_EM_RESTART': '1', 14:28:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:32 INFO - 'PWD': '/builds/slave/test', 14:28:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:28:32 INFO - 'SHELL': '/bin/bash', 14:28:32 INFO - 'SHLVL': '1', 14:28:32 INFO - 'TERM': 'linux', 14:28:32 INFO - 'TMOUT': '86400', 14:28:32 INFO - 'USER': 'cltbld', 14:28:32 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360', 14:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:32 INFO - '_': '/tools/buildbot/bin/python'} 14:28:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 14:28:32 INFO - mozversion application_buildid: 20160704135223 14:28:32 INFO - mozversion application_changeset: 760b8e6d19e41780e554573b3983aa8647bf3cbd 14:28:32 INFO - mozversion application_display_name: Nightly 14:28:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:28:32 INFO - mozversion application_name: Firefox 14:28:32 INFO - mozversion application_remotingname: firefox 14:28:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:28:32 INFO - mozversion application_vendor: Mozilla 14:28:32 INFO - mozversion application_version: 50.0a1 14:28:32 INFO - mozversion platform_buildid: 20160704135223 14:28:32 INFO - mozversion platform_changeset: 760b8e6d19e41780e554573b3983aa8647bf3cbd 14:28:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:28:32 INFO - mozversion platform_version: 50.0a1 14:28:32 INFO - using testdate: 1467667712 14:28:32 INFO - actual date: 1467667712 14:28:32 INFO - starting webserver on 'localhost:52381' 14:28:32 INFO - SUITE-START | Running 2 tests 14:28:32 INFO - TEST-START | dromaeo_css 14:28:32 INFO - operating with platform_type : linux_ 14:28:32 INFO - Initialising browser for dromaeo_css test... 14:28:32 INFO - TEST-INFO | started process 22986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHEQHY3/profile http://localhost:52381/getInfo.html) 14:28:36 INFO - PROCESS | 22986 | __metrics Screen width/height:1600/1200 14:28:36 INFO - PROCESS | 22986 | colorDepth:24 14:28:36 INFO - PROCESS | 22986 | Browser inner width/height: 1024/697 14:28:36 INFO - PROCESS | 22986 | __metrics 14:28:37 INFO - PROCESS | 22986 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:28:38 INFO - TEST-INFO | 22986: exit 0 14:28:38 INFO - Browser initialized. 14:28:38 INFO - Running cycle 1/1 for dromaeo_css test... 14:28:38 INFO - TEST-INFO | started process 23068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHEQHY3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:50 INFO - PROCESS | 23068 | RSS: Main: 158580736 14:28:50 INFO - PROCESS | 23068 | 14:29:41 INFO - PROCESS | 23068 | 1467667781201 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] 14:31:53 INFO - PROCESS | 23068 | Cycle 1(1): loaded http://localhost:52381/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52381/tests/dromaeo/cssquery-ext.html) 14:31:55 INFO - PROCESS | 23068 | RSS: Main: 234000384 14:31:55 INFO - PROCESS | 23068 | 14:34:57 INFO - PROCESS | 23068 | Cycle 1(1): loaded http://localhost:52381/tests/dromaeo/cssquery-ext.html (next: http://localhost:52381/tests/dromaeo/cssquery-jquery.html) 14:34:58 INFO - PROCESS | 23068 | RSS: Main: 237330432 14:34:58 INFO - PROCESS | 23068 | 14:38:00 INFO - PROCESS | 23068 | Cycle 1(1): loaded http://localhost:52381/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52381/tests/dromaeo/cssquery-mootools.html) 14:38:01 INFO - PROCESS | 23068 | RSS: Main: 238751744 14:38:01 INFO - PROCESS | 23068 | 14:41:03 INFO - PROCESS | 23068 | Cycle 1(1): loaded http://localhost:52381/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52381/tests/dromaeo/cssquery-prototype.html) 14:41:04 INFO - PROCESS | 23068 | RSS: Main: 237481984 14:41:04 INFO - PROCESS | 23068 | 14:44:07 INFO - PROCESS | 23068 | Cycle 1(1): loaded http://localhost:52381/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52381/tests/dromaeo/cssquery-yui.html) 14:44:07 INFO - PROCESS | 23068 | RSS: Main: 228327424 14:44:07 INFO - PROCESS | 23068 | 14:47:10 INFO - PROCESS | 23068 | Cycle 1(1): loaded http://localhost:52381/tests/dromaeo/cssquery-yui.html (next: http://localhost:52381/tests/dromaeo/cssquery-dojo.html) 14:47:10 INFO - PROCESS | 23068 | RSS: Main: 314810368 14:47:10 INFO - PROCESS | 23068 | 14:47:10 INFO - PROCESS | 23068 | __start_tp_report 14:47:10 INFO - PROCESS | 23068 | _x_x_mozilla_page_load 14:47:10 INFO - PROCESS | 23068 | _x_x_mozilla_page_load_details 14:47:10 INFO - PROCESS | 23068 | |i|pagename|runs| 14:47:10 INFO - PROCESS | 23068 | |0;dojo.html;2632.170866177154;2646.060648469794;2669.8531580763056;2686.5029969455654;2689.341111427702;4605.424321959755;4683.110209060284;4729.858104256869;4829.058333624945;4841.951580484194;4721.858344249669;4731;4750.263709125091;4750.976245118778;4759.381280433538;4155.6883233757435;4325.221460137166;4420.138073075752;4449.377087207794;4493.52817954115;4406.294992801152;4429.933550996738;4451.821927122927;4457.531959144276;4486.102779444108;4277.401163837066;4316.417283666696;4335.804888780012;4358.934615980763;4400.647948164171;4365.956340436586;4369.300911854088;4370.737755734666;4381.890452738675;4455.1535208310315;4398.8020539075815;4416.734995900256;4423.977880110579;4470.508244093147;4473.463184417858;4686.08621318843;4715.622750179978;4776.904461910777;4791.760411979422;4801.879953001168;5143.8456846294675;5189.7405129743365;5209.609279304067;5210.088234558937;5213.478652134756;5160.974195129038;5195.662281951699;5201.635885488017;5202.245674377232;5229.450907654679;4645.767711614406;4729.810807567727;4748.216544270226;4759;4785.066911952136;5259.631825772236;5269.473052694777;5287.524122828964;5289.497497737709;5290.259363689087;4870.586000189953;5084.084864724311;5084.33903592538;5086.54221120101;5090.618203634742;5083.669561478492;5118.692878427306;5122.334096567497;5128.820491282787;5205.323307969939;5064.290999260106;5090.211017292326;5103;5105.04379522064;5148.433672296044;4888.437829649636;5059.56993655536;5063.696178229318;5066.240063990431;5067.113255180402;4311.33174357975;4314.6548276138465;4320.3519472078815;4321.373400856858;4359.476862776487;3802.980985095057;3815.8933909166585;3821.4267859820693;3854.402567602026;3858.1319203179623;4257.063446041866;4429.822807087745;4435.556444355603;4480.283154695233;4480.507144214133;4980.950190498121;5086;5137.922931156036;5139.897202055938;5172.793088276427;4400.251957167289;4416.183006143874;4416.24923762961;4423.911521769546;4469.486009108994;4450.666200035011;4591.494935557086;4632.97683511587;4636.235021221461;4686.36734040907;4745.477997420281;4815.22956326986;4839.128956787812;4858.416989961227;4873.87815304606;5181.222816577543;5187.870303242449;5189.091908916;5194.039102766001;5244.134717771525;4668.603168730696;4783.043391321819;4820.927686084781;4867.026594681149;4913.729744864067;5034.194528875362;5060.721660308718;5078.873028174177;5080.618953578422;5126.512981266774;5144.176931690911;5152.046871328666;5156.303898973741;5157.252198431282;5205.297284866495;4834.395700537433;4952.10862044821;4983.501649835132;5014.548690617862;5018.949810501848;4990.975045124751;5008.073506401327;5014.022265658162;5018.7741551631;5050.671706339076;4936;4941.827036053721;4942.1104201244125;4981.352424184977;4981.775820088033;4853.733044682576;4984.925226121539;5020.598352131894;5031.069252188357;5038.319826823332;4933.679310844784;4951.801927922843;4954.50454954516;4959.950400495949;4993.15116430215 14:47:10 INFO - PROCESS | 23068 | |1;ext.html;557.6432337518872;588.2470437839565;591.3052163707642;599.9950083609953;600.5255847880175;27753;40318.59681403185;41389.17221655565;41499;41586.79206603966;41515;41994.16011679765;42001.789991050005;42023.579764202346;42054.78972605133;7393.519421237629;7544.170141284454;7545.584992825392;7751.147373788879;7909.327707144871;7684.692612295501;10014.949925250363;10252.794944101113;10278.486075696223;10586.841197382046;10424.895751042506;10474.738131546696;10484.108850747696;10489.842652360221;10493.422861742602;7590.203028682019;7788.610569471561;10264.230182736288;10326.7418314542;10331.225158113097;7726.266004729542;9837.754056148653;10284;10287.639932602324;10652.573897044109;39760;40181.19637607261;40183.19633607341;40203.39694904579;40204.59795402038;3005.1885990782366;3010.247438140465;3079.6766339534474;3139.293658926746;3204.583404157468;30392.8480357599;30483.390332193452;30624;30957.380852382827;31572.052838414886;3386.8814591489427;3387.762856600039;3430.3482338355634;3438.0717206354393;3543.255916257589;261932;261983;262219;262475;262583;53064.73467632637;53920.46079539155;53965;54055.45944540583;54127.458725412245;55908.32275031756;56125.15812262819;56136.43863561394;56139.43860561424;56213.437865621636;14310.85689143116;14744.705105897821;14748.483803066842;14750.262486875614;14754.262286885612;10311.432871192006;11072.058874995555;11245.100391968623;11362.318260904207;11413.942930285462;16556.50330490087;16576.585585360463;16604.25280862364;16619.584510387336;16641.50075497737;6526.9416202442535;6532.934670653328;6560.86878262432;6604.306547812411;6619.966900165565;799.6201804142986;867.913208679127;946.6402766948653;975.3465178330536;1016.7864748402918;27598.724012760016;28558.428831423254;28876.56766994231;28918.42163156725;28954.855225724157;937.2127412973135;951.4957072751453;993.9204863610894;1030.6753372687579;1066.424130969268;14982.700345993237;15229.923850380677;15358.846411535742;15535.766963495556;15575.454859079879;395271;399871;400380;400685;400790;50909.745451273244;51123.233151502754;51137.23294150591;51143.7442812791;51274;1076.3541874875011;1166.1953252255917;1169.5146514196513;1183.556166437586;1198.1193822540426;28695.282617934718;29939.401211975204;30190;30221.848890755406;30818;42995.35506967335;43232.78383608062;43508.347374790035;43581.038853252314;43597.782011089745;313973;317038;317216;318004;318632;31326.02402771733;36382;37290.6270937298;37387.813060934524;40132;42527.14945701007;42875.356869646355;42979.785101074296;43293;43911.56088439075;36248;37347.25305493929;37354.43968340423;37626.05934851651;37714.43428348632;36317.81841090778;36816.07959801026;37037.62962370342;39726.60273397345;41337;36638.63361366352;37140;37658.81170594239;37707;37746.81126594349;32075.518867216542;32455.513167302983;33763.155921101185;34181;34331.31337373288;24216.636750448404;25776.613350799376;25850.482990340464;26007.47985040251;26533 14:47:10 INFO - PROCESS | 23068 | |2;jquery.html;369.58052610287325;374.8163399934031;381.92170605025956;387.60077120565825;393.7775157036276;16710.91644541777;16846.49460516185;17828.108594570283;17852.28590856364;18061.729074063867;10204.897951020488;10229.897701022988;10294.279400441972;10459.163266938627;10470.842937355947;4480.910381792362;4673.929891051637;4838.250071238946;4874.878128046792;4877.341558889558;4785.808567657289;4833.854984350475;4849.248366503198;4849.684770489925;4867.488913664068;4855.101806165871;4878.390201224847;4883.267509873512;4915.852524424273;5210.895782084356;5147;5166.250893620404;5177.068127737006;5183.274341592161;5194.37667479901;4620.3762492063815;4625.074985003012;4625.3755742974945;4746.715197088186;5051.292819005343;12626.747465050648;12885.355732213446;12946.676333091655;12991.805122923164;16830;1897.0325134181528;1927.0075910905894;1942.2425254150892;1958.8334991525737;2007.29744589394;9013.143751343612;9086.636534538611;9505.809883802354;9611.231101511932;9722.125008749246;1732.5755189978536;1813.9727904081449;1830.4051183365327;1855.5546668799525;1860.0978525415162;56738.7163064182;56920.43079569193;69731.30268697349;73540.63229683871;77354.61322693407;8720;9412.764680883032;9525.38085024485;9767.267454940908;9784.804303913881;10995.570575825092;12646.557370491988;12652;12682;12706.237625742486;6749.257581666013;7101.715931362688;7129.287071292829;7145.321194486515;7229.09636295463;6833.487488438288;6881.793546193622;6891.689873955584;7132.215456299803;7190.9280907191305;3996.480457540559;4158.6673066154635;4169.666426685858;4275.5724427557;4426;1705.2582126774892;1745.7992330881857;1747.2137538107647;1776.8489678377482;1850.3338798032967;804.5896592737629;830.5349004557468;898.5731777405811;917.4403613795579;933.5518950903604;16698.83301166973;17220.311187552357;17426.302947882195;17667.55831104207;17859.553511162325;843.2916350265806;869.5347988826074;879.9956000219958;899.919007289334;946.0350442548562;9524.523773811281;9655.613775448903;9948.154406875497;10011.598376227334;10046.598136074621;374053;379044;381026.6640667563;381325;389735;60980.39019609747;71375;77821.22178778253;79419.60290198513;80039;895.4090300401704;902.5532361481108;907.9954600226956;930.437085563238;932.5896605493562;15671.294791734172;16060.839391605934;16097.919510402373;16274.837251627332;16572.419965301156;36440.81779591085;37246.44130338101;37831.81084094562;38246.043848904;38327.61672383352;53881;54305.72847135739;54345.72827135839;54438;54886.45113548813;7448.702051917862;7515.774526764206;7682.423818213768;7753.612319384121;7753.92246077532;11430.885691142983;11586.88413115858;11846.881531184577;11970.880291196976;12315.75368492643;9970.850437243302;10235.590576376862;10356.275060745675;10589.629362972259;10678.412687302272;10273.794524109626;10503.212259080752;10670.733231668959;10701.357918524913;10818.1886358525;10306.33008854452;10420.895791042296;10497.52761125736;10579.062932141103;10598.866900734145;7438.5536867788105;7513.549187048795;7513.549187048795;7653;7739.032620922385;10103.292769506064;10142.746431339276;10258.230632702427;10489.160867130458;10523 14:47:10 INFO - PROCESS | 23068 | |3;mootools.html;1387.5213051497233;1434.2040167706923;1511.9244037798107;1705.0451747021662;1728.0495727349946;6747.898781518281;7508.099028116627;7568.772936811904;8135.877961830577;8172.836543269131;7568.810779730509;7839.921600784005;7910.564918929456;7916.564588947605;7924.524528528293;2244.371575958734;2277.7836105569945;2277.9886100569556;2279.772022797715;2282.2468585366873;1882.4729075858713;2156.482444213393;2229.019231538126;2229.57638048771;2233.396982814639;2229.8550594211324;2238.0823862216494;2243.170027089979;2244.898979545916;2246.427161073924;2148.2373757316163;2188.2122435923056;2191.9561608767895;2194.2868567715477;2194.5281764420724;2159.298228075866;2172.2071443923014;2176.9891150544304;2185.6830759539935;2191.057845126595;7945;7978.361731061501;7980.3615710743;7994.6002699864775;8000.679972801081;4491.797869095899;4616.0537089896825;4621.4223222097235;4623.214053610861;4667.486576476585;2902.3324635333993;2956.556516522539;3003.264200270926;3057.1745628680133;3077.292222788749;911.0661571888801;927.1423932862076;927.7309580221728;955.2214944819949;957.4351132831663;10819.242653014293;10833.620823271147;10845.945770271177;10856.565737370496;10865.185111116698;4123.402106694512;4228.936565951513;4314.870553883388;4394.956050439519;4405.889852753643;9193.724188274362;9232.769180770534;9238.95380523093;9239.72280831576;9243.121903419164;4622.514635963175;4629.074185162981;4636.072785442925;4640.466346370143;4640.930386044144;3609.729270304738;4153.8961525962095;4172.7913604319665;4182.247195504778;4188.4136220929095;3570.8571657133944;3742.700583953277;3749.8687545935763;3750.5686846012513;3817.4464702617965;1181.8522684664417;1197.8382918306093;1207.1549915059318;1210.3766560221493;1210.7760064388117;757.954522728638;844.9324054075782;852.194676031157;863.201538576814;878.9472631642122;5127.359080114986;5257.158854583325;5322.893542129135;5389.784408623689;5393.056215162331;827.664795757719;869.7608157756667;878.6441491195948;880.4057261348564;886.0563499872615;3580.03339098442;3593.7664051836546;3616.511770910946;3628.854845806191;3682.0978860178893;9465.810683786285;9813.705588832347;9898.752531186778;9933.155681766986;9945.45300008492;9434.386764860263;9638.662646807468;9698.75753106178;9711.46586937711;9723.076307750753;7147.142342918779;7220.133583969852;7233.204347521769;7252.093488313961;7266.273372662691;4982.526659967298;5020.3724534433195;5061.987602479445;5115.74421278942;5233.842984710464;9038.870141232346;9075.727728168165;9138.817223655356;9280.118388753057;9305.441673499612;9244.861327080234;9316.767080823034;9344.205742511962;9352.906470935475;9482.95258523703;6215.160953271251;6709.4632429404555;6911.827204319932;7069.540479868792;7075.575465471882;7561.09266887977;7774.805629859073;7844.2155784423385;7854.567998760123;7856.646450909837;6742.42689371409;6870.45036397097;6892.104026476726;6903.344182302673;7047.40097091753;6740.6966686498245;6742.460603151834;6787.083743694538;6891.483138764713;6893.724251030103;5897.262842144732;6238.937610623836;6247.437730604267;6285;6286.842828929313;4478.507364189872;4484.708493947883;4558.860284928768;4608.055348653451;4642.791074401593;4511.210538155875;4547.567981041928;4591.242444996538;4593.035462552902;4619.745913974763 14:47:10 INFO - PROCESS | 23068 | |4;prototype.html;306.40098607222893;308.8162543286744;311.23746820290296;315.9826209558473;316.88908881891325;4790.760461976896;4907.656464047518;4939.678920870141;4988.40139183298;4995.80016799328;4754.9524504754945;4872.196087645543;4875.61095063419;4883.560479556848;4906.779194936227;3897.5517815451162;3897.941530877039;3902.1415288636595;3920.9607903921024;3920.9803950980204;3672;3695.7412981091334;3911.5110611173604;3911.6283953024417;3913.1195481016684;3876.8643097491595;3880.2239552089695;3886.570893191755;3886.8833934981853;3890.3580909149955;3863.3625451800417;3864.3237433449176;3866.149447121629;3874.496315478984;3889.591592882763;3463.7402194835236;3470.420958463893;3476.235228249781;3478.130467383154;3480.9477857832153;4617.538246175389;4850.8059677612855;4853.611711063107;4864;4881.145799485112;4321.524632290446;4341.891452713676;4357.516215757019;4364.650827933758;4364.978175109136;4979.402471703383;5140.820071297524;5168.2764412982215;5202.323697919284;5229.607779416521;3670.3576874046935;3678.521792167028;3683.4106542953;3685.1708365617787;3688.5204923359793;5378.489043540857;5447.264619276426;5450.8909821803345;5451.918221226685;5462.289902312714;3773.8112494564125;3792.50697409335;3795.905102372463;3799.5820459749407;3800.5819359870393;3658.378075727133;3805.752626079296;3812.0660438192267;3838.1556057667267;3846.1346197105427;4360.302351623788;4361.411209486679;4370.21336159488;4372.846950356722;4385.079133382025;5158.400895722338;5168.9741551292;5180.922286165711;5205.401378841406;5247.711375874287;1215;1258.9244645321128;1289.374653293152;1293.5537239652306;1313.0021183900114;878.3851304087165;886.3485338276362;903.5978989349676;905.3933864310927;913.9451632902047;4519;4522.163399771053;4523.434570678665;4532.773361331986;4533.206688829442;5268.81559145428;5304.787808487695;5307.3896501902;5311.203319502106;5318.574514038867;4527.886802829956;4527.932081018722;4531.161735079021;4540.455145382575;4547.749873756975;2704.2157774245643;2861.8998335058172;2863.398686275905;2864.1837076433117;2864.2982469295157;5016.54851063406;5021.8242361517905;5061.089003979319;5065.012322597132;5077.162268225775;5261.973690131525;5460.781568737286;5492.038893193675;5495.725213739297;5508.283923089973;5028.874278143076;5044.873878153002;5047.778977249998;5053.191489361684;5054.873628159252;5328.547073498641;5340.439253878442;5353.491418315254;5355;5372.1941708744;5019.799208031638;5247.763850626808;5249.7112658804135;5259.15853463444;5296.232046353334;5022.623303252198;5023.919857230713;5029.84910452687;5049.520295571915;5063.316452279042;3528.8412021458585;3726.478293039031;3728.3102626014274;3729.4219395993664;3755.849766009438;5282.181261904411;5304.416514183514;5313.760880760452;5330.680159190461;5336.2529245904825;5151.2273159026445;5151.665141765773;5157.510036546522;5168.992046550887;5180.7409629517615;5030.522100400456;5146.125158723101;5148.897022059463;5158.406783219828;5164.922526162186;5074.543291103819;5091.821786237464;5094.337736094284;5116.437191908962;5116.539511443988;5208.661437006734;5214.765335559985;5217.478252174752;5241.947580524146;5250.159974404077;4898.191798353232;5107.310513080835;5109.616778741683;5112.412072611697;5114.74426278692 14:47:10 INFO - PROCESS | 23068 | |5;yui.html;653.9509536784741;657.8914479110947;665.3845193196292;737.6348707389843;757.5227606607837;12433.191842530241;12979.286139262336;13702.177869327847;13705.931470342659;13752.381142848571;13515.189088654688;13548.93225533871;13612.387442565083;13643.113197642146;13679.452821887138;621.3165517930286;639.9008153736179;641.8459569703261;771.463832636318;794.5510786405691;644.3588629313839;646.9676516174196;757.4735558786646;780.169119887321;785.4030936488282;825.9174082591722;827.3546633625782;829.5105887526358;831.2477208126655;831.5551180118638;826.499967519654;826.8304997475503;827.437342607027;827.5034979012574;827.8385714785559;470.27812308106894;478.14889496695935;480.0710624940751;481.11955122126426;588.7262422973295;13278.867211327859;13791.10357826738;13843.653908652264;13865;13870.167789932637;11926.642200733992;12717.427715752814;13205.669858253525;13313;13692.52076177339;12070.517179312817;12228.327441990687;12345.938270308681;12367.62897113088;12441.564545240873;4221.197972385237;4256.212600668855;4298.362813328803;4302.139572085595;4367.279398899178;55508.16737748937;55920.44079559193;57047;62674.37325626731;62739.372606273355;10161.288709790244;10262.230332725076;10519.158467322595;10568.418736969541;10644.787104257872;18002.009889455945;18140.45578632643;18159.818401816075;18173.54566135857;18187;6524.575902566318;6559.934400655932;6582.539222254396;6775.491838112062;6851;3640.3265395901312;3657.04714380427;3725.2363265530503;3727.329080765434;3741.4761933329355;2718.3475965768075;2791.6231308773463;2796.6504186976626;2798.6501687289087;2799.4820958122405;511.23059795008277;517.7256054291232;528.9074411977889;539.2046731071716;540.0414264680146;464.17840422452747;511.2918607728323;541.5586297167796;542.9592780541475;547.7617236502134;7666.233376662289;7690.692372305157;7765.922340776633;8908.420952638058;9043.819123617492;449.2138757174944;473.33260103254247;484.73339663185106;581.528961541153;596.785157343356;3821.1975485147873;3899.200663863901;3945.585713500099;4039.6566291864933;4421.823127074946;55016.17475737867;55309.44690553043;56349;75655;79717.60141199257;82480;83680.58159709284;83802;84287;85120;61111.38888611146;63746.6812665943;65245.999999999054;72249;75501.24498755053;8849.336299777671;8940.776480588038;9116.407433517066;9222.95388523053;9277.953610231905;44191.3917675152;44662.3300650484;45305.546944530135;45469;46317.305240422094;63478.36521634724;67736;68006;68195.65902170655;68337.3166268331;10000.399976001463;10088.596456141671;10130.594776208869;10264.332818366782;10312.071913527518;12221.816672749737;12388.380580971096;12431;12542.749145016865;12953.740925181632;11728.354940478355;11789.76420471603;12054.578089766816;12255.448504817483;12379.876201237872;9992.700218993441;11385.386412661735;11961.342126183143;12045.81931271014;12437.37813109359;11750.187096998117;11843.703907402383;12104.75790484203;12349.444275007825;12375.443105060474;10177;10389.324693895174;10390.272680912565;10527.894721052999;10576.947115264375;9656.565454554422;10125.64560240388;10164.983501649776;10268.794624107626;10302.742431439274 14:47:10 INFO - PROCESS | 23068 | __end_tp_report 14:47:10 INFO - PROCESS | 23068 | __start_cc_report 14:47:10 INFO - PROCESS | 23068 | _x_x_mozilla_cycle_collect,995 14:47:10 INFO - PROCESS | 23068 | __end_cc_report 14:47:10 INFO - PROCESS | 23068 | __startTimestamp1467668830713__endTimestamp 14:47:10 INFO - PROCESS | 23068 | 14:47:10 INFO - PROCESS | 23068 | ------- Summary: start ------- 14:47:10 INFO - PROCESS | 23068 | Number of tests: 6 14:47:10 INFO - PROCESS | 23068 | 14:47:10 INFO - PROCESS | 23068 | [#0] dojo.html Cycles:165 Average:4734.64 Median:4853.73 stddev:503.39 (10.4%) stddev-sans-first:477.15 14:47:10 INFO - PROCESS | 23068 | Values: 2632.2 2646.1 2669.9 2686.5 2689.3 4605.4 4683.1 4729.9 4829.1 4842.0 4721.9 4731.0 4750.3 4751.0 4759.4 4155.7 4325.2 4420.1 4449.4 4493.5 4406.3 4429.9 4451.8 4457.5 4486.1 4277.4 4316.4 4335.8 4358.9 4400.6 4366.0 4369.3 4370.7 4381.9 4455.2 4398.8 4416.7 4424.0 4470.5 4473.5 4686.1 4715.6 4776.9 4791.8 4801.9 5143.8 5189.7 5209.6 5210.1 5213.5 5161.0 5195.7 5201.6 5202.2 5229.5 4645.8 4729.8 4748.2 4759.0 4785.1 5259.6 5269.5 5287.5 5289.5 5290.3 4870.6 5084.1 5084.3 5086.5 5090.6 5083.7 5118.7 5122.3 5128.8 5205.3 5064.3 5090.2 5103.0 5105.0 5148.4 4888.4 5059.6 5063.7 5066.2 5067.1 4311.3 4314.7 4320.4 4321.4 4359.5 3803.0 3815.9 3821.4 3854.4 3858.1 4257.1 4429.8 4435.6 4480.3 4480.5 4981.0 5086.0 5137.9 5139.9 5172.8 4400.3 4416.2 4416.2 4423.9 4469.5 4450.7 4591.5 4633.0 4636.2 4686.4 4745.5 4815.2 4839.1 4858.4 4873.9 5181.2 5187.9 5189.1 5194.0 5244.1 4668.6 4783.0 4820.9 4867.0 4913.7 5034.2 5060.7 5078.9 5080.6 5126.5 5144.2 5152.0 5156.3 5157.3 5205.3 4834.4 4952.1 4983.5 5014.5 5018.9 4991.0 5008.1 5014.0 5018.8 5050.7 4936.0 4941.8 4942.1 4981.4 4981.8 4853.7 4984.9 5020.6 5031.1 5038.3 4933.7 4951.8 4954.5 4960.0 4993.2 14:47:10 INFO - PROCESS | 23068 | 14:47:10 INFO - PROCESS | 23068 | [#1] ext.html Cycles:180 Average:49049.96 Median:36282.91 stddev:86977.43 (239.7%) stddev-sans-first:87145.22 14:47:10 INFO - PROCESS | 23068 | Values: 557.6 588.2 591.3 600.0 600.5 27753.0 40318.6 41389.2 41499.0 41586.8 41515.0 41994.2 42001.8 42023.6 42054.8 7393.5 7544.2 7545.6 7751.1 7909.3 7684.7 10014.9 10252.8 10278.5 10586.8 10424.9 10474.7 10484.1 10489.8 10493.4 7590.2 7788.6 10264.2 10326.7 10331.2 7726.3 9837.8 10284.0 10287.6 10652.6 39760.0 40181.2 40183.2 40203.4 40204.6 3005.2 3010.2 3079.7 3139.3 3204.6 30392.8 30483.4 30624.0 30957.4 31572.1 3386.9 3387.8 3430.3 3438.1 3543.3 261932.0 261983.0 262219.0 262475.0 262583.0 53064.7 53920.5 53965.0 54055.5 54127.5 55908.3 56125.2 56136.4 56139.4 56213.4 14310.9 14744.7 14748.5 14750.3 14754.3 10311.4 11072.1 11245.1 11362.3 11413.9 16556.5 16576.6 16604.3 16619.6 16641.5 6526.9 6532.9 6560.9 6604.3 6620.0 799.6 867.9 946.6 975.3 1016.8 27598.7 28558.4 28876.6 28918.4 28954.9 937.2 951.5 993.9 1030.7 1066.4 14982.7 15229.9 15358.8 15535.8 15575.5 395271.0 399871.0 400380.0 400685.0 400790.0 50909.7 51123.2 51137.2 51143.7 51274.0 1076.4 1166.2 1169.5 1183.6 1198.1 28695.3 29939.4 30190.0 30221.8 30818.0 42995.4 43232.8 43508.3 43581.0 43597.8 313973.0 317038.0 317216.0 318004.0 318632.0 31326.0 36382.0 37290.6 37387.8 40132.0 42527.1 42875.4 42979.8 43293.0 43911.6 36248.0 37347.3 37354.4 37626.1 37714.4 36317.8 36816.1 37037.6 39726.6 41337.0 36638.6 37140.0 37658.8 37707.0 37746.8 32075.5 32455.5 33763.2 34181.0 34331.3 24216.6 25776.6 25850.5 26007.5 26533.0 14:47:10 INFO - PROCESS | 23068 | 14:47:10 INFO - PROCESS | 23068 | [#2] jquery.html Cycles:180 Average:23606.75 Median:4453.46 stddev:63005.45 (1414.8%) stddev-sans-first:63158.04 14:47:10 INFO - PROCESS | 23068 | Values: 369.6 374.8 381.9 387.6 393.8 16710.9 16846.5 17828.1 17852.3 18061.7 10204.9 10229.9 10294.3 10459.2 10470.8 4480.9 4673.9 4838.3 4874.9 4877.3 4785.8 4833.9 4849.2 4849.7 4867.5 4855.1 4878.4 4883.3 4915.9 5210.9 5147.0 5166.3 5177.1 5183.3 5194.4 4620.4 4625.1 4625.4 4746.7 5051.3 12626.7 12885.4 12946.7 12991.8 16830.0 1897.0 1927.0 1942.2 1958.8 2007.3 9013.1 9086.6 9505.8 9611.2 9722.1 1732.6 1814.0 1830.4 1855.6 1860.1 56738.7 56920.4 69731.3 73540.6 77354.6 8720.0 9412.8 9525.4 9767.3 9784.8 10995.6 12646.6 12652.0 12682.0 12706.2 6749.3 7101.7 7129.3 7145.3 7229.1 6833.5 6881.8 6891.7 7132.2 7190.9 3996.5 4158.7 4169.7 4275.6 4426.0 1705.3 1745.8 1747.2 1776.8 1850.3 804.6 830.5 898.6 917.4 933.6 16698.8 17220.3 17426.3 17667.6 17859.6 843.3 869.5 880.0 899.9 946.0 9524.5 9655.6 9948.2 10011.6 10046.6 374053.0 379044.0 381026.7 381325.0 389735.0 60980.4 71375.0 77821.2 79419.6 80039.0 895.4 902.6 908.0 930.4 932.6 15671.3 16060.8 16097.9 16274.8 16572.4 36440.8 37246.4 37831.8 38246.0 38327.6 53881.0 54305.7 54345.7 54438.0 54886.5 7448.7 7515.8 7682.4 7753.6 7753.9 11430.9 11586.9 11846.9 11970.9 12315.8 9970.9 10235.6 10356.3 10589.6 10678.4 10273.8 10503.2 10670.7 10701.4 10818.2 10306.3 10420.9 10497.5 10579.1 10598.9 7438.6 7513.5 7513.5 7653.0 7739.0 10103.3 10142.7 10258.2 10489.2 10523.0 14:47:10 INFO - PROCESS | 23068 | 14:47:10 INFO - PROCESS | 23068 | [#3] mootools.html Cycles:180 Average:5195.49 Median:5245.50 stddev:2924.70 (55.8%) stddev-sans-first:2918.91 14:47:10 INFO - PROCESS | 23068 | Values: 1387.5 1434.2 1511.9 1705.0 1728.0 6747.9 7508.1 7568.8 8135.9 8172.8 7568.8 7839.9 7910.6 7916.6 7924.5 2244.4 2277.8 2278.0 2279.8 2282.2 1882.5 2156.5 2229.0 2229.6 2233.4 2229.9 2238.1 2243.2 2244.9 2246.4 2148.2 2188.2 2192.0 2194.3 2194.5 2159.3 2172.2 2177.0 2185.7 2191.1 7945.0 7978.4 7980.4 7994.6 8000.7 4491.8 4616.1 4621.4 4623.2 4667.5 2902.3 2956.6 3003.3 3057.2 3077.3 911.1 927.1 927.7 955.2 957.4 10819.2 10833.6 10845.9 10856.6 10865.2 4123.4 4228.9 4314.9 4395.0 4405.9 9193.7 9232.8 9239.0 9239.7 9243.1 4622.5 4629.1 4636.1 4640.5 4640.9 3609.7 4153.9 4172.8 4182.2 4188.4 3570.9 3742.7 3749.9 3750.6 3817.4 1181.9 1197.8 1207.2 1210.4 1210.8 758.0 844.9 852.2 863.2 878.9 5127.4 5257.2 5322.9 5389.8 5393.1 827.7 869.8 878.6 880.4 886.1 3580.0 3593.8 3616.5 3628.9 3682.1 9465.8 9813.7 9898.8 9933.2 9945.5 9434.4 9638.7 9698.8 9711.5 9723.1 7147.1 7220.1 7233.2 7252.1 7266.3 4982.5 5020.4 5062.0 5115.7 5233.8 9038.9 9075.7 9138.8 9280.1 9305.4 9244.9 9316.8 9344.2 9352.9 9483.0 6215.2 6709.5 6911.8 7069.5 7075.6 7561.1 7774.8 7844.2 7854.6 7856.6 6742.4 6870.5 6892.1 6903.3 7047.4 6740.7 6742.5 6787.1 6891.5 6893.7 5897.3 6238.9 6247.4 6285.0 6286.8 4478.5 4484.7 4558.9 4608.1 4642.8 4511.2 4547.6 4591.2 4593.0 4619.7 14:47:10 INFO - PROCESS | 23068 | 14:47:10 INFO - PROCESS | 23068 | [#4] prototype.html Cycles:180 Average:4300.74 Median:4902.49 stddev:1249.73 (25.5%) stddev-sans-first:1216.74 14:47:10 INFO - PROCESS | 23068 | Values: 306.4 308.8 311.2 316.0 316.9 4790.8 4907.7 4939.7 4988.4 4995.8 4755.0 4872.2 4875.6 4883.6 4906.8 3897.6 3897.9 3902.1 3921.0 3921.0 3672.0 3695.7 3911.5 3911.6 3913.1 3876.9 3880.2 3886.6 3886.9 3890.4 3863.4 3864.3 3866.1 3874.5 3889.6 3463.7 3470.4 3476.2 3478.1 3480.9 4617.5 4850.8 4853.6 4864.0 4881.1 4321.5 4341.9 4357.5 4364.7 4365.0 4979.4 5140.8 5168.3 5202.3 5229.6 3670.4 3678.5 3683.4 3685.2 3688.5 5378.5 5447.3 5450.9 5451.9 5462.3 3773.8 3792.5 3795.9 3799.6 3800.6 3658.4 3805.8 3812.1 3838.2 3846.1 4360.3 4361.4 4370.2 4372.8 4385.1 5158.4 5169.0 5180.9 5205.4 5247.7 1215.0 1258.9 1289.4 1293.6 1313.0 878.4 886.3 903.6 905.4 913.9 4519.0 4522.2 4523.4 4532.8 4533.2 5268.8 5304.8 5307.4 5311.2 5318.6 4527.9 4527.9 4531.2 4540.5 4547.7 2704.2 2861.9 2863.4 2864.2 2864.3 5016.5 5021.8 5061.1 5065.0 5077.2 5262.0 5460.8 5492.0 5495.7 5508.3 5028.9 5044.9 5047.8 5053.2 5054.9 5328.5 5340.4 5353.5 5355.0 5372.2 5019.8 5247.8 5249.7 5259.2 5296.2 5022.6 5023.9 5029.8 5049.5 5063.3 3528.8 3726.5 3728.3 3729.4 3755.8 5282.2 5304.4 5313.8 5330.7 5336.3 5151.2 5151.7 5157.5 5169.0 5180.7 5030.5 5146.1 5148.9 5158.4 5164.9 5074.5 5091.8 5094.3 5116.4 5116.5 5208.7 5214.8 5217.5 5241.9 5250.2 4898.2 5107.3 5109.6 5112.4 5114.7 14:47:10 INFO - PROCESS | 23068 | 14:47:10 INFO - PROCESS | 23068 | [#5] yui.html Cycles:180 Average:16802.71 Median:22877.38 stddev:22556.20 (98.6%) stddev-sans-first:22586.88 14:47:10 INFO - PROCESS | 23068 | Values: 654.0 657.9 665.4 737.6 757.5 12433.2 12979.3 13702.2 13705.9 13752.4 13515.2 13548.9 13612.4 13643.1 13679.5 621.3 639.9 641.8 771.5 794.6 644.4 647.0 757.5 780.2 785.4 825.9 827.4 829.5 831.2 831.6 826.5 826.8 827.4 827.5 827.8 470.3 478.1 480.1 481.1 588.7 13278.9 13791.1 13843.7 13865.0 13870.2 11926.6 12717.4 13205.7 13313.0 13692.5 12070.5 12228.3 12345.9 12367.6 12441.6 4221.2 4256.2 4298.4 4302.1 4367.3 55508.2 55920.4 57047.0 62674.4 62739.4 10161.3 10262.2 10519.2 10568.4 10644.8 18002.0 18140.5 18159.8 18173.5 18187.0 6524.6 6559.9 6582.5 6775.5 6851.0 3640.3 3657.0 3725.2 3727.3 3741.5 2718.3 2791.6 2796.7 2798.7 2799.5 511.2 517.7 528.9 539.2 540.0 464.2 511.3 541.6 543.0 547.8 7666.2 7690.7 7765.9 8908.4 9043.8 449.2 473.3 484.7 581.5 596.8 3821.2 3899.2 3945.6 4039.7 4421.8 55016.2 55309.4 56349.0 75655.0 79717.6 82480.0 83680.6 83802.0 84287.0 85120.0 61111.4 63746.7 65246.0 72249.0 75501.2 8849.3 8940.8 9116.4 9223.0 9278.0 44191.4 44662.3 45305.5 45469.0 46317.3 63478.4 67736.0 68006.0 68195.7 68337.3 10000.4 10088.6 10130.6 10264.3 10312.1 12221.8 12388.4 12431.0 12542.7 12953.7 11728.4 11789.8 12054.6 12255.4 12379.9 9992.7 11385.4 11961.3 12045.8 12437.4 11750.2 11843.7 12104.8 12349.4 12375.4 10177.0 10389.3 10390.3 10527.9 10576.9 9656.6 10125.6 10165.0 10268.8 10302.7 14:47:10 INFO - PROCESS | 23068 | -------- Summary: end -------- 14:47:10 INFO - PROCESS | 23068 | 14:47:11 INFO - TEST-INFO | 23068: exit 0 14:47:11 INFO - TEST-OK | dromaeo_css | took 1119069ms 14:47:11 INFO - TEST-START | kraken 14:47:11 INFO - operating with platform_type : linux_ 14:47:11 INFO - Initialising browser for kraken test... 14:47:11 INFO - TEST-INFO | started process 23256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgoIgmR/profile http://localhost:52381/getInfo.html) 14:47:15 INFO - PROCESS | 23256 | __metrics Screen width/height:1600/1200 14:47:15 INFO - PROCESS | 23256 | colorDepth:24 14:47:15 INFO - PROCESS | 23256 | Browser inner width/height: 1024/697 14:47:15 INFO - PROCESS | 23256 | __metrics 14:47:16 INFO - PROCESS | 23256 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:47:17 INFO - TEST-INFO | 23256: exit 0 14:47:17 INFO - Browser initialized. 14:47:17 INFO - Running cycle 1/1 for kraken test... 14:47:17 INFO - TEST-INFO | started process 23336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgoIgmR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:47:29 INFO - PROCESS | 23336 | RSS: Main: 158064640 14:47:29 INFO - PROCESS | 23336 | 14:47:32 INFO - PROCESS | 23336 | Cycle 1(1): loaded http://localhost:52381/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52381/tests/kraken/driver.html?testName=audio-beat-detection) 14:47:33 INFO - PROCESS | 23336 | RSS: Main: 216457216 14:47:33 INFO - PROCESS | 23336 | 14:47:36 INFO - PROCESS | 23336 | Cycle 1(1): loaded http://localhost:52381/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52381/tests/kraken/driver.html?testName=audio-dft) 14:47:36 INFO - PROCESS | 23336 | RSS: Main: 203882496 14:47:36 INFO - PROCESS | 23336 | 14:47:39 INFO - PROCESS | 23336 | Cycle 1(1): loaded http://localhost:52381/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52381/tests/kraken/driver.html?testName=audio-fft) 14:47:40 INFO - PROCESS | 23336 | RSS: Main: 271294464 14:47:40 INFO - PROCESS | 23336 | 14:47:42 INFO - PROCESS | 23336 | Cycle 1(1): loaded http://localhost:52381/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52381/tests/kraken/driver.html?testName=audio-oscillator) 14:47:43 INFO - PROCESS | 23336 | RSS: Main: 181329920 14:47:43 INFO - PROCESS | 23336 | 14:47:45 INFO - PROCESS | 23336 | Cycle 1(1): loaded http://localhost:52381/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52381/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:47:46 INFO - PROCESS | 23336 | RSS: Main: 185163776 14:47:46 INFO - PROCESS | 23336 | 14:47:49 INFO - PROCESS | 23336 | Cycle 1(1): loaded http://localhost:52381/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52381/tests/kraken/driver.html?testName=imaging-darkroom) 14:47:49 INFO - PROCESS | 23336 | RSS: Main: 221663232 14:47:49 INFO - PROCESS | 23336 | 14:47:53 INFO - PROCESS | 23336 | Cycle 1(1): loaded http://localhost:52381/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52381/tests/kraken/driver.html?testName=imaging-desaturate) 14:47:54 INFO - PROCESS | 23336 | RSS: Main: 222113792 14:47:54 INFO - PROCESS | 23336 | 14:47:56 INFO - PROCESS | 23336 | Cycle 1(1): loaded http://localhost:52381/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52381/tests/kraken/driver.html?testName=json-parse-financial) 14:47:57 INFO - PROCESS | 23336 | RSS: Main: 222044160 14:47:57 INFO - PROCESS | 23336 | 14:47:59 INFO - PROCESS | 23336 | Cycle 1(1): loaded http://localhost:52381/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52381/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:47:59 INFO - PROCESS | 23336 | RSS: Main: 210067456 14:47:59 INFO - PROCESS | 23336 | 14:48:01 INFO - PROCESS | 23336 | Cycle 1(1): loaded http://localhost:52381/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52381/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:48:02 INFO - PROCESS | 23336 | RSS: Main: 215871488 14:48:02 INFO - PROCESS | 23336 | 14:48:04 INFO - PROCESS | 23336 | Cycle 1(1): loaded http://localhost:52381/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52381/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:48:05 INFO - PROCESS | 23336 | RSS: Main: 212381696 14:48:05 INFO - PROCESS | 23336 | 14:48:07 INFO - PROCESS | 23336 | Cycle 1(1): loaded http://localhost:52381/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:48:08 INFO - PROCESS | 23336 | RSS: Main: 224210944 14:48:08 INFO - PROCESS | 23336 | 14:48:11 INFO - PROCESS | 23336 | Cycle 1(1): loaded http://localhost:52381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:48:12 INFO - PROCESS | 23336 | RSS: Main: 225763328 14:48:12 INFO - PROCESS | 23336 | 14:48:13 INFO - PROCESS | 23336 | Cycle 1(1): loaded http://localhost:52381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52381/tests/kraken/driver.html?testName=ai-astar) 14:48:14 INFO - PROCESS | 23336 | RSS: Main: 267833344 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | __start_tp_report 14:48:14 INFO - PROCESS | 23336 | _x_x_mozilla_page_load 14:48:14 INFO - PROCESS | 23336 | _x_x_mozilla_page_load_details 14:48:14 INFO - PROCESS | 23336 | |i|pagename|runs| 14:48:14 INFO - PROCESS | 23336 | |0;ai-astar;102;115;114;113;114;113;113;112;114;113 14:48:14 INFO - PROCESS | 23336 | |1;audio-beat-detection;153;122;130;168;126;124;151;122;165;127 14:48:14 INFO - PROCESS | 23336 | |2;audio-dft;162;161;162;162;161;161;162;162;161;161 14:48:14 INFO - PROCESS | 23336 | |3;audio-fft;76;76;76;119;77;77;74;76;109;75 14:48:14 INFO - PROCESS | 23336 | |4;audio-oscillator;85;86;118;94;85;85;118;86;85;133 14:48:14 INFO - PROCESS | 23336 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 14:48:14 INFO - PROCESS | 23336 | |6;imaging-darkroom;147;147;146;146;146;146;146;146;146;148 14:48:14 INFO - PROCESS | 23336 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 14:48:14 INFO - PROCESS | 23336 | |8;json-parse-financial;63;64;62;63;63;64;64;62;63;63 14:48:14 INFO - PROCESS | 23336 | |9;json-stringify-tinderbox;67;66;66;68;66;66;65;66;65;64 14:48:14 INFO - PROCESS | 23336 | |10;stanford-crypto-aes;86;81;82;77;77;78;77;77;77;81 14:48:14 INFO - PROCESS | 23336 | |11;stanford-crypto-ccm;138;128;135;129;148;131;131;139;170;144 14:48:14 INFO - PROCESS | 23336 | |12;stanford-crypto-pbkdf2;173;166;172;170;170;175;167;173;172;171 14:48:14 INFO - PROCESS | 23336 | |13;stanford-crypto-sha256-iterative;68;70;72;68;68;68;72;73;70;66 14:48:14 INFO - PROCESS | 23336 | __end_tp_report 14:48:14 INFO - PROCESS | 23336 | __start_cc_report 14:48:14 INFO - PROCESS | 23336 | _x_x_mozilla_cycle_collect,1930 14:48:14 INFO - PROCESS | 23336 | __end_cc_report 14:48:14 INFO - PROCESS | 23336 | __startTimestamp1467668894148__endTimestamp 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | ------- Summary: start ------- 14:48:14 INFO - PROCESS | 23336 | Number of tests: 14 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.50 stddev:3.71 (3.3%) stddev-sans-first:0.88 14:48:14 INFO - PROCESS | 23336 | Values: 102.0 115.0 114.0 113.0 114.0 113.0 113.0 112.0 114.0 113.0 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:140.50 stddev:18.42 (13.1%) stddev-sans-first:18.81 14:48:14 INFO - PROCESS | 23336 | Values: 153.0 122.0 130.0 168.0 126.0 124.0 151.0 122.0 165.0 127.0 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 14:48:14 INFO - PROCESS | 23336 | Values: 162.0 161.0 162.0 162.0 161.0 161.0 162.0 162.0 161.0 161.0 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.00 stddev:16.27 (21.4%) stddev-sans-first:17.03 14:48:14 INFO - PROCESS | 23336 | Values: 76.0 76.0 76.0 119.0 77.0 77.0 74.0 76.0 109.0 75.0 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:85.00 stddev:18.27 (21.5%) stddev-sans-first:18.80 14:48:14 INFO - PROCESS | 23336 | Values: 85.0 86.0 118.0 94.0 85.0 85.0 118.0 86.0 85.0 133.0 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:48:14 INFO - PROCESS | 23336 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 14:48:14 INFO - PROCESS | 23336 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 148.0 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 14:48:14 INFO - PROCESS | 23336 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 14:48:14 INFO - PROCESS | 23336 | Values: 63.0 64.0 62.0 63.0 63.0 64.0 64.0 62.0 63.0 63.0 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.09 14:48:14 INFO - PROCESS | 23336 | Values: 67.0 66.0 66.0 68.0 66.0 66.0 65.0 66.0 65.0 64.0 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.50 stddev:3.09 (3.9%) stddev-sans-first:2.13 14:48:14 INFO - PROCESS | 23336 | Values: 86.0 81.0 82.0 77.0 77.0 78.0 77.0 77.0 77.0 81.0 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:138.50 stddev:12.61 (9.1%) stddev-sans-first:13.37 14:48:14 INFO - PROCESS | 23336 | Values: 138.0 128.0 135.0 129.0 148.0 131.0 131.0 139.0 170.0 144.0 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:172.00 stddev:2.77 (1.6%) stddev-sans-first:2.83 14:48:14 INFO - PROCESS | 23336 | Values: 173.0 166.0 172.0 170.0 170.0 175.0 167.0 173.0 172.0 171.0 14:48:14 INFO - PROCESS | 23336 | 14:48:14 INFO - PROCESS | 23336 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:2.27 (3.2%) stddev-sans-first:2.35 14:48:14 INFO - PROCESS | 23336 | Values: 68.0 70.0 72.0 68.0 68.0 68.0 72.0 73.0 70.0 66.0 14:48:14 INFO - PROCESS | 23336 | -------- Summary: end -------- 14:48:14 INFO - PROCESS | 23336 | 14:48:15 INFO - TEST-INFO | 23336: exit 0 14:48:15 INFO - TEST-OK | kraken | took 63861ms 14:48:15 INFO - SUITE-END | took 1182s 14:48:15 INFO - Completed test suite (00:19:43) 14:48:15 INFO - javascript benchmark 14:48:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.170866177154, 2646.060648469794, 2669.8531580763056, 2686.5029969455654, 2689.341111427702, 4605.424321959755, 4683.110209060284, 4729.858104256869, 4829.058333624945, 4841.951580484194, 4721.858344249669, 4731.0, 4750.263709125091, 4750.976245118778, 4759.381280433538, 4155.6883233757435, 4325.221460137166, 4420.138073075752, 4449.377087207794, 4493.52817954115, 4406.294992801152, 4429.933550996738, 4451.821927122927, 4457.531959144276, 4486.102779444108, 4277.401163837066, 4316.417283666696, 4335.804888780012, 4358.934615980763, 4400.647948164171, 4365.956340436586, 4369.300911854088, 4370.737755734666, 4381.890452738675, 4455.1535208310315, 4398.8020539075815, 4416.734995900256, 4423.977880110579, 4470.508244093147, 4473.463184417858, 4686.08621318843, 4715.622750179978, 4776.904461910777, 4791.760411979422, 4801.879953001168, 5143.8456846294675, 5189.7405129743365, 5209.609279304067, 5210.088234558937, 5213.478652134756, 5160.974195129038, 5195.662281951699, 5201.635885488017, 5202.245674377232, 5229.450907654679, 4645.767711614406, 4729.810807567727, 4748.216544270226, 4759.0, 4785.066911952136, 5259.631825772236, 5269.473052694777, 5287.524122828964, 5289.497497737709, 5290.259363689087, 4870.586000189953, 5084.084864724311, 5084.33903592538, 5086.54221120101, 5090.618203634742, 5083.669561478492, 5118.692878427306, 5122.334096567497, 5128.820491282787, 5205.323307969939, 5064.290999260106, 5090.211017292326, 5103.0, 5105.04379522064, 5148.433672296044, 4888.437829649636, 5059.56993655536, 5063.696178229318, 5066.240063990431, 5067.113255180402, 4311.33174357975, 4314.6548276138465, 4320.3519472078815, 4321.373400856858, 4359.476862776487, 3802.980985095057, 3815.8933909166585, 3821.4267859820693, 3854.402567602026, 3858.1319203179623, 4257.063446041866, 4429.822807087745, 4435.556444355603, 4480.283154695233, 4480.507144214133, 4980.950190498121, 5086.0, 5137.922931156036, 5139.897202055938, 5172.793088276427, 4400.251957167289, 4416.183006143874, 4416.24923762961, 4423.911521769546, 4469.486009108994, 4450.666200035011, 4591.494935557086, 4632.97683511587, 4636.235021221461, 4686.36734040907, 4745.477997420281, 4815.22956326986, 4839.128956787812, 4858.416989961227, 4873.87815304606, 5181.222816577543, 5187.870303242449, 5189.091908916, 5194.039102766001, 5244.134717771525, 4668.603168730696, 4783.043391321819, 4820.927686084781, 4867.026594681149, 4913.729744864067, 5034.194528875362, 5060.721660308718, 5078.873028174177, 5080.618953578422, 5126.512981266774, 5144.176931690911, 5152.046871328666, 5156.303898973741, 5157.252198431282, 5205.297284866495, 4834.395700537433, 4952.10862044821, 4983.501649835132, 5014.548690617862, 5018.949810501848, 4990.975045124751, 5008.073506401327, 5014.022265658162, 5018.7741551631, 5050.671706339076, 4936.0, 4941.827036053721, 4942.1104201244125, 4981.352424184977, 4981.775820088033, 4853.733044682576, 4984.925226121539, 5020.598352131894, 5031.069252188357, 5038.319826823332, 4933.679310844784, 4951.801927922843, 4954.50454954516, 4959.950400495949, 4993.15116430215], "value": 4702.22845844299, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.6432337518872, 588.2470437839565, 591.3052163707642, 599.9950083609953, 600.5255847880175, 27753.0, 40318.59681403185, 41389.17221655565, 41499.0, 41586.79206603966, 41515.0, 41994.16011679765, 42001.789991050005, 42023.579764202346, 42054.78972605133, 7393.519421237629, 7544.170141284454, 7545.584992825392, 7751.147373788879, 7909.327707144871, 7684.692612295501, 10014.949925250363, 10252.794944101113, 10278.486075696223, 10586.841197382046, 10424.895751042506, 10474.738131546696, 10484.108850747696, 10489.842652360221, 10493.422861742602, 7590.203028682019, 7788.610569471561, 10264.230182736288, 10326.7418314542, 10331.225158113097, 7726.266004729542, 9837.754056148653, 10284.0, 10287.639932602324, 10652.573897044109, 39760.0, 40181.19637607261, 40183.19633607341, 40203.39694904579, 40204.59795402038, 3005.1885990782366, 3010.247438140465, 3079.6766339534474, 3139.293658926746, 3204.583404157468, 30392.8480357599, 30483.390332193452, 30624.0, 30957.380852382827, 31572.052838414886, 3386.8814591489427, 3387.762856600039, 3430.3482338355634, 3438.0717206354393, 3543.255916257589, 261932.0, 261983.0, 262219.0, 262475.0, 262583.0, 53064.73467632637, 53920.46079539155, 53965.0, 54055.45944540583, 54127.458725412245, 55908.32275031756, 56125.15812262819, 56136.43863561394, 56139.43860561424, 56213.437865621636, 14310.85689143116, 14744.705105897821, 14748.483803066842, 14750.262486875614, 14754.262286885612, 10311.432871192006, 11072.058874995555, 11245.100391968623, 11362.318260904207, 11413.942930285462, 16556.50330490087, 16576.585585360463, 16604.25280862364, 16619.584510387336, 16641.50075497737, 6526.9416202442535, 6532.934670653328, 6560.86878262432, 6604.306547812411, 6619.966900165565, 799.6201804142986, 867.913208679127, 946.6402766948653, 975.3465178330536, 1016.7864748402918, 27598.724012760016, 28558.428831423254, 28876.56766994231, 28918.42163156725, 28954.855225724157, 937.2127412973135, 951.4957072751453, 993.9204863610894, 1030.6753372687579, 1066.424130969268, 14982.700345993237, 15229.923850380677, 15358.846411535742, 15535.766963495556, 15575.454859079879, 395271.0, 399871.0, 400380.0, 400685.0, 400790.0, 50909.745451273244, 51123.233151502754, 51137.23294150591, 51143.7442812791, 51274.0, 1076.3541874875011, 1166.1953252255917, 1169.5146514196513, 1183.556166437586, 1198.1193822540426, 28695.282617934718, 29939.401211975204, 30190.0, 30221.848890755406, 30818.0, 42995.35506967335, 43232.78383608062, 43508.347374790035, 43581.038853252314, 43597.782011089745, 313973.0, 317038.0, 317216.0, 318004.0, 318632.0, 31326.02402771733, 36382.0, 37290.6270937298, 37387.813060934524, 40132.0, 42527.14945701007, 42875.356869646355, 42979.785101074296, 43293.0, 43911.56088439075, 36248.0, 37347.25305493929, 37354.43968340423, 37626.05934851651, 37714.43428348632, 36317.81841090778, 36816.07959801026, 37037.62962370342, 39726.60273397345, 41337.0, 36638.63361366352, 37140.0, 37658.81170594239, 37707.0, 37746.81126594349, 32075.518867216542, 32455.513167302983, 33763.155921101185, 34181.0, 34331.31337373288, 24216.636750448404, 25776.613350799376, 25850.482990340464, 26007.47985040251, 26533.0], "value": 18409.631454792114, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.58052610287325, 374.8163399934031, 381.92170605025956, 387.60077120565825, 393.7775157036276, 16710.91644541777, 16846.49460516185, 17828.108594570283, 17852.28590856364, 18061.729074063867, 10204.897951020488, 10229.897701022988, 10294.279400441972, 10459.163266938627, 10470.842937355947, 4480.910381792362, 4673.929891051637, 4838.250071238946, 4874.878128046792, 4877.341558889558, 4785.808567657289, 4833.854984350475, 4849.248366503198, 4849.684770489925, 4867.488913664068, 4855.101806165871, 4878.390201224847, 4883.267509873512, 4915.852524424273, 5210.895782084356, 5147.0, 5166.250893620404, 5177.068127737006, 5183.274341592161, 5194.37667479901, 4620.3762492063815, 4625.074985003012, 4625.3755742974945, 4746.715197088186, 5051.292819005343, 12626.747465050648, 12885.355732213446, 12946.676333091655, 12991.805122923164, 16830.0, 1897.0325134181528, 1927.0075910905894, 1942.2425254150892, 1958.8334991525737, 2007.29744589394, 9013.143751343612, 9086.636534538611, 9505.809883802354, 9611.231101511932, 9722.125008749246, 1732.5755189978536, 1813.9727904081449, 1830.4051183365327, 1855.5546668799525, 1860.0978525415162, 56738.7163064182, 56920.43079569193, 69731.30268697349, 73540.63229683871, 77354.61322693407, 8720.0, 9412.764680883032, 9525.38085024485, 9767.267454940908, 9784.804303913881, 10995.570575825092, 12646.557370491988, 12652.0, 12682.0, 12706.237625742486, 6749.257581666013, 7101.715931362688, 7129.287071292829, 7145.321194486515, 7229.09636295463, 6833.487488438288, 6881.793546193622, 6891.689873955584, 7132.215456299803, 7190.9280907191305, 3996.480457540559, 4158.6673066154635, 4169.666426685858, 4275.5724427557, 4426.0, 1705.2582126774892, 1745.7992330881857, 1747.2137538107647, 1776.8489678377482, 1850.3338798032967, 804.5896592737629, 830.5349004557468, 898.5731777405811, 917.4403613795579, 933.5518950903604, 16698.83301166973, 17220.311187552357, 17426.302947882195, 17667.55831104207, 17859.553511162325, 843.2916350265806, 869.5347988826074, 879.9956000219958, 899.919007289334, 946.0350442548562, 9524.523773811281, 9655.613775448903, 9948.154406875497, 10011.598376227334, 10046.598136074621, 374053.0, 379044.0, 381026.6640667563, 381325.0, 389735.0, 60980.39019609747, 71375.0, 77821.22178778253, 79419.60290198513, 80039.0, 895.4090300401704, 902.5532361481108, 907.9954600226956, 930.437085563238, 932.5896605493562, 15671.294791734172, 16060.839391605934, 16097.919510402373, 16274.837251627332, 16572.419965301156, 36440.81779591085, 37246.44130338101, 37831.81084094562, 38246.043848904, 38327.61672383352, 53881.0, 54305.72847135739, 54345.72827135839, 54438.0, 54886.45113548813, 7448.702051917862, 7515.774526764206, 7682.423818213768, 7753.612319384121, 7753.92246077532, 11430.885691142983, 11586.88413115858, 11846.881531184577, 11970.880291196976, 12315.75368492643, 9970.850437243302, 10235.590576376862, 10356.275060745675, 10589.629362972259, 10678.412687302272, 10273.794524109626, 10503.212259080752, 10670.733231668959, 10701.357918524913, 10818.1886358525, 10306.33008854452, 10420.895791042296, 10497.52761125736, 10579.062932141103, 10598.866900734145, 7438.5536867788105, 7513.549187048795, 7513.549187048795, 7653.0, 7739.032620922385, 10103.292769506064, 10142.746431339276, 10258.230632702427, 10489.160867130458, 10523.0], "value": 7922.809209873302, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.5213051497233, 1434.2040167706923, 1511.9244037798107, 1705.0451747021662, 1728.0495727349946, 6747.898781518281, 7508.099028116627, 7568.772936811904, 8135.877961830577, 8172.836543269131, 7568.810779730509, 7839.921600784005, 7910.564918929456, 7916.564588947605, 7924.524528528293, 2244.371575958734, 2277.7836105569945, 2277.9886100569556, 2279.772022797715, 2282.2468585366873, 1882.4729075858713, 2156.482444213393, 2229.019231538126, 2229.57638048771, 2233.396982814639, 2229.8550594211324, 2238.0823862216494, 2243.170027089979, 2244.898979545916, 2246.427161073924, 2148.2373757316163, 2188.2122435923056, 2191.9561608767895, 2194.2868567715477, 2194.5281764420724, 2159.298228075866, 2172.2071443923014, 2176.9891150544304, 2185.6830759539935, 2191.057845126595, 7945.0, 7978.361731061501, 7980.3615710743, 7994.6002699864775, 8000.679972801081, 4491.797869095899, 4616.0537089896825, 4621.4223222097235, 4623.214053610861, 4667.486576476585, 2902.3324635333993, 2956.556516522539, 3003.264200270926, 3057.1745628680133, 3077.292222788749, 911.0661571888801, 927.1423932862076, 927.7309580221728, 955.2214944819949, 957.4351132831663, 10819.242653014293, 10833.620823271147, 10845.945770271177, 10856.565737370496, 10865.185111116698, 4123.402106694512, 4228.936565951513, 4314.870553883388, 4394.956050439519, 4405.889852753643, 9193.724188274362, 9232.769180770534, 9238.95380523093, 9239.72280831576, 9243.121903419164, 4622.514635963175, 4629.074185162981, 4636.072785442925, 4640.466346370143, 4640.930386044144, 3609.729270304738, 4153.8961525962095, 4172.7913604319665, 4182.247195504778, 4188.4136220929095, 3570.8571657133944, 3742.700583953277, 3749.8687545935763, 3750.5686846012513, 3817.4464702617965, 1181.8522684664417, 1197.8382918306093, 1207.1549915059318, 1210.3766560221493, 1210.7760064388117, 757.954522728638, 844.9324054075782, 852.194676031157, 863.201538576814, 878.9472631642122, 5127.359080114986, 5257.158854583325, 5322.893542129135, 5389.784408623689, 5393.056215162331, 827.664795757719, 869.7608157756667, 878.6441491195948, 880.4057261348564, 886.0563499872615, 3580.03339098442, 3593.7664051836546, 3616.511770910946, 3628.854845806191, 3682.0978860178893, 9465.810683786285, 9813.705588832347, 9898.752531186778, 9933.155681766986, 9945.45300008492, 9434.386764860263, 9638.662646807468, 9698.75753106178, 9711.46586937711, 9723.076307750753, 7147.142342918779, 7220.133583969852, 7233.204347521769, 7252.093488313961, 7266.273372662691, 4982.526659967298, 5020.3724534433195, 5061.987602479445, 5115.74421278942, 5233.842984710464, 9038.870141232346, 9075.727728168165, 9138.817223655356, 9280.118388753057, 9305.441673499612, 9244.861327080234, 9316.767080823034, 9344.205742511962, 9352.906470935475, 9482.95258523703, 6215.160953271251, 6709.4632429404555, 6911.827204319932, 7069.540479868792, 7075.575465471882, 7561.09266887977, 7774.805629859073, 7844.2155784423385, 7854.567998760123, 7856.646450909837, 6742.42689371409, 6870.45036397097, 6892.104026476726, 6903.344182302673, 7047.40097091753, 6740.6966686498245, 6742.460603151834, 6787.083743694538, 6891.483138764713, 6893.724251030103, 5897.262842144732, 6238.937610623836, 6247.437730604267, 6285.0, 6286.842828929313, 4478.507364189872, 4484.708493947883, 4558.860284928768, 4608.055348653451, 4642.791074401593, 4511.210538155875, 4547.567981041928, 4591.242444996538, 4593.035462552902, 4619.745913974763], "value": 4184.953673869354, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.40098607222893, 308.8162543286744, 311.23746820290296, 315.9826209558473, 316.88908881891325, 4790.760461976896, 4907.656464047518, 4939.678920870141, 4988.40139183298, 4995.80016799328, 4754.9524504754945, 4872.196087645543, 4875.61095063419, 4883.560479556848, 4906.779194936227, 3897.5517815451162, 3897.941530877039, 3902.1415288636595, 3920.9607903921024, 3920.9803950980204, 3672.0, 3695.7412981091334, 3911.5110611173604, 3911.6283953024417, 3913.1195481016684, 3876.8643097491595, 3880.2239552089695, 3886.570893191755, 3886.8833934981853, 3890.3580909149955, 3863.3625451800417, 3864.3237433449176, 3866.149447121629, 3874.496315478984, 3889.591592882763, 3463.7402194835236, 3470.420958463893, 3476.235228249781, 3478.130467383154, 3480.9477857832153, 4617.538246175389, 4850.8059677612855, 4853.611711063107, 4864.0, 4881.145799485112, 4321.524632290446, 4341.891452713676, 4357.516215757019, 4364.650827933758, 4364.978175109136, 4979.402471703383, 5140.820071297524, 5168.2764412982215, 5202.323697919284, 5229.607779416521, 3670.3576874046935, 3678.521792167028, 3683.4106542953, 3685.1708365617787, 3688.5204923359793, 5378.489043540857, 5447.264619276426, 5450.8909821803345, 5451.918221226685, 5462.289902312714, 3773.8112494564125, 3792.50697409335, 3795.905102372463, 3799.5820459749407, 3800.5819359870393, 3658.378075727133, 3805.752626079296, 3812.0660438192267, 3838.1556057667267, 3846.1346197105427, 4360.302351623788, 4361.411209486679, 4370.21336159488, 4372.846950356722, 4385.079133382025, 5158.400895722338, 5168.9741551292, 5180.922286165711, 5205.401378841406, 5247.711375874287, 1215.0, 1258.9244645321128, 1289.374653293152, 1293.5537239652306, 1313.0021183900114, 878.3851304087165, 886.3485338276362, 903.5978989349676, 905.3933864310927, 913.9451632902047, 4519.0, 4522.163399771053, 4523.434570678665, 4532.773361331986, 4533.206688829442, 5268.81559145428, 5304.787808487695, 5307.3896501902, 5311.203319502106, 5318.574514038867, 4527.886802829956, 4527.932081018722, 4531.161735079021, 4540.455145382575, 4547.749873756975, 2704.2157774245643, 2861.8998335058172, 2863.398686275905, 2864.1837076433117, 2864.2982469295157, 5016.54851063406, 5021.8242361517905, 5061.089003979319, 5065.012322597132, 5077.162268225775, 5261.973690131525, 5460.781568737286, 5492.038893193675, 5495.725213739297, 5508.283923089973, 5028.874278143076, 5044.873878153002, 5047.778977249998, 5053.191489361684, 5054.873628159252, 5328.547073498641, 5340.439253878442, 5353.491418315254, 5355.0, 5372.1941708744, 5019.799208031638, 5247.763850626808, 5249.7112658804135, 5259.15853463444, 5296.232046353334, 5022.623303252198, 5023.919857230713, 5029.84910452687, 5049.520295571915, 5063.316452279042, 3528.8412021458585, 3726.478293039031, 3728.3102626014274, 3729.4219395993664, 3755.849766009438, 5282.181261904411, 5304.416514183514, 5313.760880760452, 5330.680159190461, 5336.2529245904825, 5151.2273159026445, 5151.665141765773, 5157.510036546522, 5168.992046550887, 5180.7409629517615, 5030.522100400456, 5146.125158723101, 5148.897022059463, 5158.406783219828, 5164.922526162186, 5074.543291103819, 5091.821786237464, 5094.337736094284, 5116.437191908962, 5116.539511443988, 5208.661437006734, 5214.765335559985, 5217.478252174752, 5241.947580524146, 5250.159974404077, 4898.191798353232, 5107.310513080835, 5109.616778741683, 5112.412072611697, 5114.74426278692], "value": 3904.612417829664, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.9509536784741, 657.8914479110947, 665.3845193196292, 737.6348707389843, 757.5227606607837, 12433.191842530241, 12979.286139262336, 13702.177869327847, 13705.931470342659, 13752.381142848571, 13515.189088654688, 13548.93225533871, 13612.387442565083, 13643.113197642146, 13679.452821887138, 621.3165517930286, 639.9008153736179, 641.8459569703261, 771.463832636318, 794.5510786405691, 644.3588629313839, 646.9676516174196, 757.4735558786646, 780.169119887321, 785.4030936488282, 825.9174082591722, 827.3546633625782, 829.5105887526358, 831.2477208126655, 831.5551180118638, 826.499967519654, 826.8304997475503, 827.437342607027, 827.5034979012574, 827.8385714785559, 470.27812308106894, 478.14889496695935, 480.0710624940751, 481.11955122126426, 588.7262422973295, 13278.867211327859, 13791.10357826738, 13843.653908652264, 13865.0, 13870.167789932637, 11926.642200733992, 12717.427715752814, 13205.669858253525, 13313.0, 13692.52076177339, 12070.517179312817, 12228.327441990687, 12345.938270308681, 12367.62897113088, 12441.564545240873, 4221.197972385237, 4256.212600668855, 4298.362813328803, 4302.139572085595, 4367.279398899178, 55508.16737748937, 55920.44079559193, 57047.0, 62674.37325626731, 62739.372606273355, 10161.288709790244, 10262.230332725076, 10519.158467322595, 10568.418736969541, 10644.787104257872, 18002.009889455945, 18140.45578632643, 18159.818401816075, 18173.54566135857, 18187.0, 6524.575902566318, 6559.934400655932, 6582.539222254396, 6775.491838112062, 6851.0, 3640.3265395901312, 3657.04714380427, 3725.2363265530503, 3727.329080765434, 3741.4761933329355, 2718.3475965768075, 2791.6231308773463, 2796.6504186976626, 2798.6501687289087, 2799.4820958122405, 511.23059795008277, 517.7256054291232, 528.9074411977889, 539.2046731071716, 540.0414264680146, 464.17840422452747, 511.2918607728323, 541.5586297167796, 542.9592780541475, 547.7617236502134, 7666.233376662289, 7690.692372305157, 7765.922340776633, 8908.420952638058, 9043.819123617492, 449.2138757174944, 473.33260103254247, 484.73339663185106, 581.528961541153, 596.785157343356, 3821.1975485147873, 3899.200663863901, 3945.585713500099, 4039.6566291864933, 4421.823127074946, 55016.17475737867, 55309.44690553043, 56349.0, 75655.0, 79717.60141199257, 82480.0, 83680.58159709284, 83802.0, 84287.0, 85120.0, 61111.38888611146, 63746.6812665943, 65245.999999999054, 72249.0, 75501.24498755053, 8849.336299777671, 8940.776480588038, 9116.407433517066, 9222.95388523053, 9277.953610231905, 44191.3917675152, 44662.3300650484, 45305.546944530135, 45469.0, 46317.305240422094, 63478.36521634724, 67736.0, 68006.0, 68195.65902170655, 68337.3166268331, 10000.399976001463, 10088.596456141671, 10130.594776208869, 10264.332818366782, 10312.071913527518, 12221.816672749737, 12388.380580971096, 12431.0, 12542.749145016865, 12953.740925181632, 11728.354940478355, 11789.76420471603, 12054.578089766816, 12255.448504817483, 12379.876201237872, 9992.700218993441, 11385.386412661735, 11961.342126183143, 12045.81931271014, 12437.37813109359, 11750.187096998117, 11843.703907402383, 12104.75790484203, 12349.444275007825, 12375.443105060474, 10177.0, 10389.324693895174, 10390.272680912565, 10527.894721052999, 10576.947115264375, 9656.565454554422, 10125.64560240388, 10164.983501649776, 10268.794624107626, 10302.742431439274], "value": 6481.829010997509, "unit": "score"}], "name": "dromaeo_css", "value": 6459.624244341588, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 114.0, 113.0, 114.0, 113.0, 113.0, 112.0, 114.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 130.0, 168.0, 126.0, 124.0, 151.0, 122.0, 165.0, 127.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 119.0, 77.0, 77.0, 74.0, 76.0, 109.0, 75.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 118.0, 94.0, 85.0, 85.0, 118.0, 86.0, 85.0, 133.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 148.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 63.0, 64.0, 64.0, 62.0, 63.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 68.0, 66.0, 66.0, 65.0, 66.0, 65.0, 64.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 81.0, 82.0, 77.0, 77.0, 78.0, 77.0, 77.0, 77.0, 81.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 128.0, 135.0, 129.0, 148.0, 131.0, 131.0, 139.0, 170.0, 144.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 166.0, 172.0, 170.0, 170.0, 175.0, 167.0, 173.0, 172.0, 171.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 72.0, 68.0, 68.0, 68.0, 72.0, 73.0, 70.0, 66.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1539.9, "alertThreshold": 2.0}]} 14:48:15 INFO - Return code: 0 14:48:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:48:15 INFO - # TBPL SUCCESS # 14:48:15 INFO - Running post-action listener: _resource_record_post_action 14:48:15 INFO - ##### 14:48:15 INFO - ##### Finished run-tests step (success) 14:48:15 INFO - ##### 14:48:15 INFO - Running post-run listener: _resource_record_post_run 14:48:15 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538198016; Read time: 4; Write time: 460564 14:48:15 INFO - TinderboxPrint: CPU usage
13.0% 14:48:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 14:48:15 INFO - TinderboxPrint: I/O write bytes / time
538,198,016 / 460,564 14:48:15 INFO - TinderboxPrint: CPU idle
8,328.1 (87.0%) 14:48:15 INFO - TinderboxPrint: CPU user
1,199.4 (12.5%) 14:48:15 INFO - TinderboxPrint: Swap in / out
0 / 0 14:48:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 245800960; Read time: 0; Write time: 254844 14:48:15 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287768576; Read time: 4; Write time: 205304 14:48:16 INFO - Running post-run listener: _upload_blobber_files 14:48:16 INFO - Blob upload gear active. 14:48:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:48:16 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 14:48:16 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:48:16 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:48:16 INFO - (blobuploader) - INFO - Open directory for files ... 14:48:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:48:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:48:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:17 INFO - (blobuploader) - INFO - Done attempting. 14:48:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:48:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:48:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:17 INFO - (blobuploader) - INFO - Done attempting. 14:48:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:48:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:48:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:22 INFO - (blobuploader) - INFO - Done attempting. 14:48:22 INFO - (blobuploader) - INFO - Iteration through files over. 14:48:22 INFO - Return code: 0 14:48:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:48:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:48:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6b1a68da339db3a239d0bf7453a36e16a2e43c968ee4e77d932727ddb3857027da53ab5ab65cf193dd44d248380e186ba07574b8476bbe4a0a4e22e85a6d96dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e17cc13fb19fc4b8ba48c9b33610c6ee11b6055ea3bb7bb1d946c3ec2845745d0fded7759202ac00b5607d14c8eed1d51bf18347297e9df039951deea08d885", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2605e0c4108d9ccd2701dcff16d3acf5006f17e0231ca78132cc428c6b4bfeaf84ac9b96043f2490f2fa8243a0dbad86b178f71416d7ee509e476cd30cd28165"} 14:48:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:48:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:48:22 INFO - Contents: 14:48:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6b1a68da339db3a239d0bf7453a36e16a2e43c968ee4e77d932727ddb3857027da53ab5ab65cf193dd44d248380e186ba07574b8476bbe4a0a4e22e85a6d96dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e17cc13fb19fc4b8ba48c9b33610c6ee11b6055ea3bb7bb1d946c3ec2845745d0fded7759202ac00b5607d14c8eed1d51bf18347297e9df039951deea08d885", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2605e0c4108d9ccd2701dcff16d3acf5006f17e0231ca78132cc428c6b4bfeaf84ac9b96043f2490f2fa8243a0dbad86b178f71416d7ee509e476cd30cd28165"} 14:48:22 INFO - Running post-run listener: copy_logs_to_upload_dir 14:48:22 INFO - Copying logs to upload dir... 14:48:22 INFO - mkdir: /builds/slave/test/build/upload/logs 14:48:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.039220 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-04 14:48:22.449286) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 14:48:22.452503) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6b1a68da339db3a239d0bf7453a36e16a2e43c968ee4e77d932727ddb3857027da53ab5ab65cf193dd44d248380e186ba07574b8476bbe4a0a4e22e85a6d96dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e17cc13fb19fc4b8ba48c9b33610c6ee11b6055ea3bb7bb1d946c3ec2845745d0fded7759202ac00b5607d14c8eed1d51bf18347297e9df039951deea08d885", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2605e0c4108d9ccd2701dcff16d3acf5006f17e0231ca78132cc428c6b4bfeaf84ac9b96043f2490f2fa8243a0dbad86b178f71416d7ee509e476cd30cd28165"} build_url:https://queue.taskcluster.net/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/VWJX0Z_VRFyH5Kenxz2q0Q/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/Fx-Team-Non-PGO/sha512/6b1a68da339db3a239d0bf7453a36e16a2e43c968ee4e77d932727ddb3857027da53ab5ab65cf193dd44d248380e186ba07574b8476bbe4a0a4e22e85a6d96dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e17cc13fb19fc4b8ba48c9b33610c6ee11b6055ea3bb7bb1d946c3ec2845745d0fded7759202ac00b5607d14c8eed1d51bf18347297e9df039951deea08d885", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2605e0c4108d9ccd2701dcff16d3acf5006f17e0231ca78132cc428c6b4bfeaf84ac9b96043f2490f2fa8243a0dbad86b178f71416d7ee509e476cd30cd28165"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 14:48:22.477804) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 14:48:22.478134) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467667662.945876-740950360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 14:48:22.562135) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 14:48:22.562444) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 14:48:22.562740) ========= ========= Total master_lag: 0.17 =========