builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1468870904.75 results: success (0) buildid: 20160718083017 builduid: f4132788998e43cc9f2e21ac1971a65c revision: ec19b4cb42d5355d336967e00059ddee3053f924 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 12:41:44.749100) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 12:41:44.749820) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 12:41:44.750305) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 12:41:44.766734) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 12:41:44.767258) ========= 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=db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 12:41:44-- 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% 24.1M=0s 2016-07-18 12:41:45 (24.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124994 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 12:41:44.983806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 12:41:44.984130) ========= 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=db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018625 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 12:41:45.016812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 12:41:45.017149) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ec19b4cb42d5355d336967e00059ddee3053f924 --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 ec19b4cb42d5355d336967e00059ddee3053f924 --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=db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 12:41:45,191 truncating revision to first 12 chars 2016-07-18 12:41:45,191 Setting DEBUG logging. 2016-07-18 12:41:45,191 attempt 1/10 2016-07-18 12:41:45,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ec19b4cb42d5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 12:41:45,514 unpacking tar archive at: fx-team-ec19b4cb42d5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652016 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 12:41:45.683511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 12:41:45.683903) ========= script_repo_revision: ec19b4cb42d5355d336967e00059ddee3053f924 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 12:41:45.684333) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 12:41:45.684646) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 12:41:45.695391) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-18 12:41:45.695737) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:41:45 INFO - MultiFileLogger online at 20160718 12:41:45 in /builds/slave/test 12:41:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:41:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:41:45 INFO - {'append_to_log': False, 12:41:45 INFO - 'base_work_dir': '/builds/slave/test', 12:41:45 INFO - 'blob_upload_branch': 'Fx-Team', 12:41:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:41:45 INFO - 'branch': 'Fx-Team', 12:41:45 INFO - 'buildbot_json_path': 'buildprops.json', 12:41:45 INFO - 'config_files': ('talos/linux_config.py',), 12:41:45 INFO - 'default_actions': ('clobber', 12:41:45 INFO - 'read-buildbot-config', 12:41:45 INFO - 'download-and-extract', 12:41:45 INFO - 'populate-webroot', 12:41:45 INFO - 'create-virtualenv', 12:41:45 INFO - 'install', 12:41:45 INFO - 'run-tests'), 12:41:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:41:45 INFO - 'download_minidump_stackwalk': True, 12:41:45 INFO - 'download_symbols': 'ondemand', 12:41:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:41:45 INFO - 'tooltool.py': '/tools/tooltool.py', 12:41:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:41:45 INFO - '/tools/misc-python/virtualenv.py')}, 12:41:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:41:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:41:45 INFO - 'installer_path': 'installer.exe', 12:41:45 INFO - 'log_level': 'info', 12:41:45 INFO - 'log_name': 'talos', 12:41:45 INFO - 'log_to_console': True, 12:41:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:41:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:41:45 INFO - 'opt_config_files': (), 12:41:45 INFO - 'pip_index': False, 12:41:45 INFO - 'sps_profile': False, 12:41:45 INFO - 'sps_profile_interval': 0, 12:41:45 INFO - 'suite': 'dromaeojs', 12:41:45 INFO - 'system_bits': '32', 12:41:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:41:45 INFO - 'title': 'talos-linux64-ix-031', 12:41:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:41:45 INFO - 'use_talos_json': True, 12:41:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:41:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:41:45 INFO - 'work_dir': 'build'} 12:41:45 INFO - ##### 12:41:45 INFO - ##### Running clobber step. 12:41:45 INFO - ##### 12:41:45 INFO - Running pre-action listener: _resource_record_pre_action 12:41:45 INFO - Running main action method: clobber 12:41:45 INFO - rmtree: /builds/slave/test/build 12:41:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:41:46 INFO - Running post-action listener: _resource_record_post_action 12:41:46 INFO - ##### 12:41:46 INFO - ##### Finished clobber step (success) 12:41:46 INFO - ##### 12:41:46 INFO - ##### 12:41:46 INFO - ##### Running read-buildbot-config step. 12:41:46 INFO - ##### 12:41:46 INFO - Running pre-action listener: _resource_record_pre_action 12:41:46 INFO - Running main action method: read_buildbot_config 12:41:46 INFO - Using buildbot properties: 12:41:46 INFO - { 12:41:46 INFO - "project": "", 12:41:46 INFO - "product": "firefox", 12:41:46 INFO - "script_repo_revision": "production", 12:41:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:41:46 INFO - "repository": "", 12:41:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:41:46 INFO - "buildid": "20160718083017", 12:41:46 INFO - "pgo_build": "True", 12:41:46 INFO - "basedir": "/builds/slave/test", 12:41:46 INFO - "buildnumber": 1332, 12:41:46 INFO - "slavename": "talos-linux64-ix-031", 12:41:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:41:46 INFO - "platform": "ubuntu64_hw", 12:41:46 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:41:46 INFO - "branch": "fx-team", 12:41:46 INFO - "repo_path": "integration/fx-team", 12:41:46 INFO - "revision": "ec19b4cb42d5355d336967e00059ddee3053f924", 12:41:46 INFO - "stage_platform": "linux64-pgo", 12:41:46 INFO - "builduid": "f4132788998e43cc9f2e21ac1971a65c", 12:41:46 INFO - "slavebuilddir": "test" 12:41:46 INFO - } 12:41:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:41:46 INFO - Running post-action listener: _resource_record_post_action 12:41:46 INFO - ##### 12:41:46 INFO - ##### Finished read-buildbot-config step (success) 12:41:46 INFO - ##### 12:41:46 INFO - ##### 12:41:46 INFO - ##### Running download-and-extract step. 12:41:46 INFO - ##### 12:41:46 INFO - Running pre-action listener: _resource_record_pre_action 12:41:46 INFO - Running main action method: download_and_extract 12:41:46 INFO - mkdir: /builds/slave/test/build/tests 12:41: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')]} 12:41:46 INFO - https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:41:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:41:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:41:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/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 12:41:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/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 12:41:50 INFO - Downloaded 1361 bytes. 12:41:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:41:50 INFO - Using the following test package requirements: 12:41:50 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:41:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:41:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:41:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:50 INFO - u'jsshell-linux-x86_64.zip'], 12:41:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:41:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:41:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:41:50 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:41:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:41:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:41:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:41: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')]} 12:41:50 INFO - https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:41:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:41:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:41:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/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 12:41:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/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 12:41:57 INFO - Downloaded 24333771 bytes. 12:41:57 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'] 12:41:57 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 12:41:58 INFO - Return code: 0 12:41:58 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 12:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:41:58 INFO - https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:41:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:41:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:41:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/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 12:41:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/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 12:42:00 INFO - Downloaded 24333771 bytes. 12:42:00 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'] 12:42:00 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 12:42:01 INFO - Return code: 0 12:42: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')]} 12:42:01 INFO - https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:42:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:42:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:42:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/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 12:42:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/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 12:42:03 INFO - Downloaded 14403317 bytes. 12:42:03 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'] 12:42:03 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 12:42:03 INFO - Return code: 0 12:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:03 INFO - https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:42:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:42:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:42:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/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 12:42:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/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 12:42:05 INFO - Downloaded 60849652 bytes. 12:42:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:42:05 INFO - mkdir: /builds/slave/test/properties 12:42:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:42:05 INFO - Writing to file /builds/slave/test/properties/build_url 12:42:05 INFO - Contents: 12:42:05 INFO - build_url:https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:42:06 INFO - Running post-action listener: _resource_record_post_action 12:42:06 INFO - Running post-action listener: set_extra_try_arguments 12:42:06 INFO - ##### 12:42:06 INFO - ##### Finished download-and-extract step (success) 12:42:06 INFO - ##### 12:42:06 INFO - ##### 12:42:06 INFO - ##### Running populate-webroot step. 12:42:06 INFO - ##### 12:42:06 INFO - Running pre-action listener: _resource_record_pre_action 12:42:06 INFO - Running main action method: populate_webroot 12:42:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:42:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:42:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:42:06 INFO - '--tppagecycles', 12:42:06 INFO - '7'], 12:42:06 INFO - 'tests': ['tsvgm']}}, 12:42:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:42:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:42:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:42:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:42:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:42:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:42:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:06 INFO - 'talos_options': ['--disable-e10s'], 12:42:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:42:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:42:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:06 INFO - 'talos_options': ['--disable-e10s'], 12:42:06 INFO - 'tests': ['damp', 'tps']}, 12:42:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:06 INFO - 'tests': ['damp', 'tps']}, 12:42:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:42:06 INFO - 'tests': ['dromaeo_dom']}, 12:42:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:42:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:42:06 INFO - 'tests': ['basic_compositor_video']}, 12:42:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:42:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:42:06 INFO - 'tests': ['a11yr', 12:42:06 INFO - 'ts_paint', 12:42:06 INFO - 'tpaint', 12:42:06 INFO - 'sessionrestore', 12:42:06 INFO - 'sessionrestore_no_auto_restore', 12:42:06 INFO - 'tabpaint']}, 12:42:06 INFO - 'other-e10s': {'tests': ['a11yr', 12:42:06 INFO - 'ts_paint', 12:42:06 INFO - 'tpaint', 12:42:06 INFO - 'sessionrestore', 12:42:06 INFO - 'sessionrestore_no_auto_restore', 12:42:06 INFO - 'tabpaint']}, 12:42:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:42:06 INFO - 'ts_paint', 12:42:06 INFO - 'tpaint', 12:42:06 INFO - 'sessionrestore', 12:42:06 INFO - 'sessionrestore_no_auto_restore', 12:42:06 INFO - 'tabpaint']}, 12:42:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:42:06 INFO - 'ts_paint', 12:42:06 INFO - 'tpaint', 12:42:06 INFO - 'sessionrestore', 12:42:06 INFO - 'sessionrestore_no_auto_restore', 12:42:06 INFO - 'tabpaint']}, 12:42:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:42:06 INFO - 'tests': ['a11yr', 12:42:06 INFO - 'ts_paint', 12:42:06 INFO - 'tpaint', 12:42:06 INFO - 'sessionrestore', 12:42:06 INFO - 'sessionrestore_no_auto_restore', 12:42:06 INFO - 'tabpaint']}, 12:42:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:42:06 INFO - 'tests': ['a11yr', 12:42:06 INFO - 'ts_paint', 12:42:06 INFO - 'tpaint', 12:42:06 INFO - 'sessionrestore', 12:42:06 INFO - 'sessionrestore_no_auto_restore', 12:42:06 INFO - 'tabpaint']}, 12:42:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:42:06 INFO - 'tests': ['tsvgx', 12:42:06 INFO - 'tsvgr_opacity', 12:42:06 INFO - 'tart', 12:42:06 INFO - 'tscrollx', 12:42:06 INFO - 'cart']}, 12:42:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:42:06 INFO - 'tsvgr_opacity', 12:42:06 INFO - 'tart', 12:42:06 INFO - 'tscrollx', 12:42:06 INFO - 'cart']}, 12:42:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:06 INFO - 'talos_options': ['--disable-e10s'], 12:42:06 INFO - 'tests': ['tp5o']}, 12:42:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:06 INFO - 'tests': ['tp5o']}, 12:42:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:06 INFO - 'talos_options': ['--disable-e10s', 12:42:06 INFO - '--xperf_path', 12:42:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:42:06 INFO - 'tests': ['tp5n']}, 12:42:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:06 INFO - 'talos_options': ['--xperf_path', 12:42:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:42:06 INFO - 'tests': ['tp5n']}}, 12:42:06 INFO - 'talos.zip': {'path': '', 12:42:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:42:06 INFO - Running post-action listener: _resource_record_post_action 12:42:06 INFO - ##### 12:42:06 INFO - ##### Finished populate-webroot step (success) 12:42:06 INFO - ##### 12:42:06 INFO - ##### 12:42:06 INFO - ##### Running create-virtualenv step. 12:42:06 INFO - ##### 12:42:06 INFO - Running pre-action listener: _resource_record_pre_action 12:42:06 INFO - Running main action method: create_virtualenv 12:42:06 INFO - Creating virtualenv /builds/slave/test/build/venv 12:42:06 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 12:42:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:42:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:42:06 INFO - Using real prefix '/usr' 12:42:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:42:07 INFO - Installing distribute.............................................................................................................................................................................................done. 12:42:08 INFO - Installing pip.................done. 12:42:09 INFO - Return code: 0 12:42:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:09 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 0x1ee0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f3b0>, '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 0x21a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0740>, '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': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', '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 12:42:09 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 12:42:09 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 12:42:09 INFO - Using env: {'DISPLAY': ':0', 12:42:09 INFO - 'HOME': '/home/cltbld', 12:42:09 INFO - 'LANG': 'en_US.UTF-8', 12:42:09 INFO - 'LANGUAGE': 'en_US:en', 12:42:09 INFO - 'LOGNAME': 'cltbld', 12:42:09 INFO - 'MAIL': '/var/mail/cltbld', 12:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:09 INFO - 'MOZ_NO_REMOTE': '1', 12:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:09 INFO - 'NO_EM_RESTART': '1', 12:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:09 INFO - 'PWD': '/builds/slave/test', 12:42:09 INFO - 'SHELL': '/bin/bash', 12:42:09 INFO - 'SHLVL': '1', 12:42:09 INFO - 'TERM': 'linux', 12:42:09 INFO - 'TMOUT': '86400', 12:42:09 INFO - 'USER': 'cltbld', 12:42:09 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', 12:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:09 INFO - '_': '/tools/buildbot/bin/python'} 12:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:09 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 12:42:09 INFO - Cleaning up... 12:42:09 INFO - Return code: 0 12:42:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:09 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 0x1ee0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f3b0>, '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 0x21a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0740>, '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': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', '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 12:42:09 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 12:42:09 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 12:42:09 INFO - Using env: {'DISPLAY': ':0', 12:42:09 INFO - 'HOME': '/home/cltbld', 12:42:09 INFO - 'LANG': 'en_US.UTF-8', 12:42:09 INFO - 'LANGUAGE': 'en_US:en', 12:42:09 INFO - 'LOGNAME': 'cltbld', 12:42:09 INFO - 'MAIL': '/var/mail/cltbld', 12:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:09 INFO - 'MOZ_NO_REMOTE': '1', 12:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:09 INFO - 'NO_EM_RESTART': '1', 12:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:09 INFO - 'PWD': '/builds/slave/test', 12:42:09 INFO - 'SHELL': '/bin/bash', 12:42:09 INFO - 'SHLVL': '1', 12:42:09 INFO - 'TERM': 'linux', 12:42:09 INFO - 'TMOUT': '86400', 12:42:09 INFO - 'USER': 'cltbld', 12:42:09 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', 12:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:09 INFO - '_': '/tools/buildbot/bin/python'} 12:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:09 INFO - Downloading/unpacking psutil>=3.1.1 12:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:42:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:42:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:42:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:42:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:42:11 INFO - Installing collected packages: psutil 12:42:11 INFO - Running setup.py install for psutil 12:42:11 INFO - building 'psutil._psutil_linux' extension 12:42:11 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 12:42:11 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 12:42:11 INFO - building 'psutil._psutil_posix' extension 12:42:11 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 12:42:11 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 12:42:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:42:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:42:11 INFO - Successfully installed psutil 12:42:11 INFO - Cleaning up... 12:42:12 INFO - Return code: 0 12:42:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f3b0>, '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 0x21a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0740>, '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': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', '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 12:42:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:42:12 INFO - Using env: {'DISPLAY': ':0', 12:42:12 INFO - 'HOME': '/home/cltbld', 12:42:12 INFO - 'LANG': 'en_US.UTF-8', 12:42:12 INFO - 'LANGUAGE': 'en_US:en', 12:42:12 INFO - 'LOGNAME': 'cltbld', 12:42:12 INFO - 'MAIL': '/var/mail/cltbld', 12:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:12 INFO - 'MOZ_NO_REMOTE': '1', 12:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:12 INFO - 'NO_EM_RESTART': '1', 12:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:12 INFO - 'PWD': '/builds/slave/test', 12:42:12 INFO - 'SHELL': '/bin/bash', 12:42:12 INFO - 'SHLVL': '1', 12:42:12 INFO - 'TERM': 'linux', 12:42:12 INFO - 'TMOUT': '86400', 12:42:12 INFO - 'USER': 'cltbld', 12:42:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', 12:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:12 INFO - '_': '/tools/buildbot/bin/python'} 12:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:42:14 INFO - Installing collected packages: mozsystemmonitor 12:42:14 INFO - Running setup.py install for mozsystemmonitor 12:42:14 INFO - Successfully installed mozsystemmonitor 12:42:14 INFO - Cleaning up... 12:42:14 INFO - Return code: 0 12:42:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:42: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')]} 12:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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')]} 12:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:14 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 0x1ee0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f3b0>, '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 0x21a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0740>, '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': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', '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 12:42:14 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 12:42:14 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 12:42:14 INFO - Using env: {'DISPLAY': ':0', 12:42:14 INFO - 'HOME': '/home/cltbld', 12:42:14 INFO - 'LANG': 'en_US.UTF-8', 12:42:14 INFO - 'LANGUAGE': 'en_US:en', 12:42:14 INFO - 'LOGNAME': 'cltbld', 12:42:14 INFO - 'MAIL': '/var/mail/cltbld', 12:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:14 INFO - 'MOZ_NO_REMOTE': '1', 12:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:14 INFO - 'NO_EM_RESTART': '1', 12:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:14 INFO - 'PWD': '/builds/slave/test', 12:42:14 INFO - 'SHELL': '/bin/bash', 12:42:14 INFO - 'SHLVL': '1', 12:42:14 INFO - 'TERM': 'linux', 12:42:14 INFO - 'TMOUT': '86400', 12:42:14 INFO - 'USER': 'cltbld', 12:42:14 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', 12:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:14 INFO - '_': '/tools/buildbot/bin/python'} 12:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:14 INFO - Downloading/unpacking jsonschema==2.5.1 12:42:14 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 12:42:14 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 12:42:14 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 12:42:14 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 12:42:14 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 12:42:14 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 12:42:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:42:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:42:16 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 12:42:16 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 12:42:16 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 12:42:16 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 12:42:16 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 12:42:16 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 12:42:16 INFO - Downloading functools32-3.2.3-2.tar.gz 12:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:42:16 INFO - warning: no files found matching '*.txt' 12:42:16 INFO - no previously-included directories found matching 'build' 12:42:16 INFO - no previously-included directories found matching 'dist' 12:42:16 INFO - no previously-included directories found matching '.git*' 12:42:16 INFO - Installing collected packages: jsonschema, functools32 12:42:16 INFO - Running setup.py install for functools32 12:42:16 INFO - warning: no files found matching '*.txt' 12:42:16 INFO - no previously-included directories found matching 'build' 12:42:16 INFO - no previously-included directories found matching 'dist' 12:42:16 INFO - no previously-included directories found matching '.git*' 12:42:16 INFO - Successfully installed jsonschema functools32 12:42:16 INFO - Cleaning up... 12:42:16 INFO - Return code: 0 12:42:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ee0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f3b0>, '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 0x21a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0740>, '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': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', '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 12:42:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:42:16 INFO - Using env: {'DISPLAY': ':0', 12:42:16 INFO - 'HOME': '/home/cltbld', 12:42:16 INFO - 'LANG': 'en_US.UTF-8', 12:42:16 INFO - 'LANGUAGE': 'en_US:en', 12:42:16 INFO - 'LOGNAME': 'cltbld', 12:42:16 INFO - 'MAIL': '/var/mail/cltbld', 12:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:16 INFO - 'MOZ_NO_REMOTE': '1', 12:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:16 INFO - 'NO_EM_RESTART': '1', 12:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:16 INFO - 'PWD': '/builds/slave/test', 12:42:16 INFO - 'SHELL': '/bin/bash', 12:42:16 INFO - 'SHLVL': '1', 12:42:16 INFO - 'TERM': 'linux', 12:42:16 INFO - 'TMOUT': '86400', 12:42:16 INFO - 'USER': 'cltbld', 12:42:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', 12:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:16 INFO - '_': '/tools/buildbot/bin/python'} 12:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:17 INFO - Downloading/unpacking blobuploader==1.2.4 12:42:17 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 12:42:17 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 12:42:17 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 12:42:17 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 12:42:17 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 12:42:17 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 12:42:19 INFO - Downloading blobuploader-1.2.4.tar.gz 12:42:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:42:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:42:19 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 12:42:19 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 12:42:19 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 12:42:19 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 12:42:19 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 12:42:19 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 12:42:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:42:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:42:19 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 12:42:19 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 12:42:19 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 12:42:19 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 12:42:19 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 12:42:19 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 12:42:19 INFO - Downloading docopt-0.6.1.tar.gz 12:42:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:42:19 INFO - Installing collected packages: blobuploader, requests, docopt 12:42:19 INFO - Running setup.py install for blobuploader 12:42:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:42:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:42:19 INFO - Running setup.py install for requests 12:42:20 INFO - Running setup.py install for docopt 12:42:20 INFO - Successfully installed blobuploader requests docopt 12:42:20 INFO - Cleaning up... 12:42:20 INFO - Return code: 0 12:42:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:20 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 0x1ee0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f3b0>, '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 0x21a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0740>, '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': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', '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 12:42:20 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 12:42:20 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 12:42:20 INFO - Using env: {'DISPLAY': ':0', 12:42:20 INFO - 'HOME': '/home/cltbld', 12:42:20 INFO - 'LANG': 'en_US.UTF-8', 12:42:20 INFO - 'LANGUAGE': 'en_US:en', 12:42:20 INFO - 'LOGNAME': 'cltbld', 12:42:20 INFO - 'MAIL': '/var/mail/cltbld', 12:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:20 INFO - 'MOZ_NO_REMOTE': '1', 12:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:20 INFO - 'NO_EM_RESTART': '1', 12:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:20 INFO - 'PWD': '/builds/slave/test', 12:42:20 INFO - 'SHELL': '/bin/bash', 12:42:20 INFO - 'SHLVL': '1', 12:42:20 INFO - 'TERM': 'linux', 12:42:20 INFO - 'TMOUT': '86400', 12:42:20 INFO - 'USER': 'cltbld', 12:42:20 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', 12:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:20 INFO - '_': '/tools/buildbot/bin/python'} 12:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:42:20 INFO - Running setup.py (path:/tmp/pip-eRdH3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:42:20 INFO - Running setup.py (path:/tmp/pip-bvTPLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:42:20 INFO - Running setup.py (path:/tmp/pip-HZwYmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:42:20 INFO - Running setup.py (path:/tmp/pip-N1XDGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:42:20 INFO - Running setup.py (path:/tmp/pip-x6BYUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:42:20 INFO - Running setup.py (path:/tmp/pip-9LS6QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:42:21 INFO - Running setup.py (path:/tmp/pip-ALoXt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:42:21 INFO - Running setup.py (path:/tmp/pip-G3Lx0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:42:21 INFO - Running setup.py (path:/tmp/pip-BFYPDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:42:21 INFO - Running setup.py (path:/tmp/pip-439uLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:42:21 INFO - Running setup.py (path:/tmp/pip-JoRqLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:42:21 INFO - Running setup.py (path:/tmp/pip-qYtlHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:42:21 INFO - Running setup.py (path:/tmp/pip-tgXRxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:42:21 INFO - Running setup.py (path:/tmp/pip-r3058a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:21 INFO - Running setup.py (path:/tmp/pip-66vG9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:42:21 INFO - Running setup.py (path:/tmp/pip-X9X6QJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:42:21 INFO - Running setup.py (path:/tmp/pip-XVzdvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:42:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:42:21 INFO - Running setup.py install for manifestparser 12:42:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:42:21 INFO - Running setup.py install for mozcrash 12:42:22 INFO - Running setup.py install for mozdebug 12:42:22 INFO - Running setup.py install for mozdevice 12:42:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:42:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:42:22 INFO - Running setup.py install for mozfile 12:42:22 INFO - Running setup.py install for mozhttpd 12:42:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:42:22 INFO - Running setup.py install for mozinfo 12:42:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:42:22 INFO - Running setup.py install for mozInstall 12:42:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:42:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:42:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:42:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:42:22 INFO - Running setup.py install for mozleak 12:42:22 INFO - Running setup.py install for mozlog 12:42:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:42:22 INFO - Running setup.py install for moznetwork 12:42:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:42:22 INFO - Running setup.py install for mozprocess 12:42:23 INFO - Running setup.py install for mozprofile 12:42:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:42:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:42:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:42:23 INFO - Running setup.py install for mozrunner 12:42:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:42:23 INFO - Running setup.py install for mozscreenshot 12:42:23 INFO - Running setup.py install for moztest 12:42:23 INFO - Running setup.py install for mozversion 12:42:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:42:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:42:23 INFO - Cleaning up... 12:42:23 INFO - Return code: 0 12:42:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:42:23 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')]} 12:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:23 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')]} 12:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:23 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 0x1ee0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f3b0>, '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 0x21a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0740>, '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': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', '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 12:42:23 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 12:42:23 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 12:42:23 INFO - Using env: {'DISPLAY': ':0', 12:42:23 INFO - 'HOME': '/home/cltbld', 12:42:23 INFO - 'LANG': 'en_US.UTF-8', 12:42:23 INFO - 'LANGUAGE': 'en_US:en', 12:42:23 INFO - 'LOGNAME': 'cltbld', 12:42:23 INFO - 'MAIL': '/var/mail/cltbld', 12:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:23 INFO - 'MOZ_NO_REMOTE': '1', 12:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:23 INFO - 'NO_EM_RESTART': '1', 12:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:23 INFO - 'PWD': '/builds/slave/test', 12:42:23 INFO - 'SHELL': '/bin/bash', 12:42:23 INFO - 'SHLVL': '1', 12:42:23 INFO - 'TERM': 'linux', 12:42:23 INFO - 'TMOUT': '86400', 12:42:23 INFO - 'USER': 'cltbld', 12:42:23 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', 12:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:23 INFO - '_': '/tools/buildbot/bin/python'} 12:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:42:23 INFO - Running setup.py (path:/tmp/pip-ydSWnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:42:23 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)) 12:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:42:23 INFO - Running setup.py (path:/tmp/pip-CtBwSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:42:23 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)) 12:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:42:23 INFO - Running setup.py (path:/tmp/pip-fvq1DI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:42:24 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)) 12:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:42:24 INFO - Running setup.py (path:/tmp/pip-DhzpMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:42:24 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)) 12:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:42:24 INFO - Running setup.py (path:/tmp/pip-76pg_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:42:24 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)) 12:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:42:24 INFO - Running setup.py (path:/tmp/pip-6chaU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:42:24 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)) 12:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:42:24 INFO - Running setup.py (path:/tmp/pip-N0Fnza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:42:24 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)) 12:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:42:24 INFO - Running setup.py (path:/tmp/pip-vwdZ0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:42:24 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)) 12:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:42:24 INFO - Running setup.py (path:/tmp/pip-uTmaq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:42:24 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)) 12:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:42:24 INFO - Running setup.py (path:/tmp/pip-4FawQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:42:24 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)) 12:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:42:24 INFO - Running setup.py (path:/tmp/pip-Fp40H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:42:24 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)) 12:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:42:24 INFO - Running setup.py (path:/tmp/pip-Nf4e3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:42:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:42:24 INFO - Running setup.py (path:/tmp/pip-Xz_WS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:42:24 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)) 12:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:42:24 INFO - Running setup.py (path:/tmp/pip-e4WKoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:42:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:24 INFO - Running setup.py (path:/tmp/pip-vLarLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:24 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)) 12:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:42:24 INFO - Running setup.py (path:/tmp/pip-SPhJJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:42:25 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)) 12:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:42:25 INFO - Running setup.py (path:/tmp/pip-k9bftH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:42:25 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)) 12:42:25 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)) 12:42:25 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)) 12:42:25 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)) 12:42:25 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)) 12:42:25 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)) 12:42:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:42:25 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 12:42:25 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 12:42:25 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 12:42:25 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 12:42:25 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 12:42:25 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 12:42:27 INFO - Downloading blessings-1.6.tar.gz 12:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:42:27 INFO - Installing collected packages: blessings 12:42:27 INFO - Running setup.py install for blessings 12:42:27 INFO - Successfully installed blessings 12:42:27 INFO - Cleaning up... 12:42:27 INFO - Return code: 0 12:42:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:42:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:42:27 INFO - Reading from file tmpfile_stdout 12:42:27 INFO - Current package versions: 12:42:27 INFO - argparse == 1.2.1 12:42:27 INFO - blessings == 1.6 12:42:27 INFO - blobuploader == 1.2.4 12:42:27 INFO - docopt == 0.6.1 12:42:27 INFO - functools32 == 3.2.3-2 12:42:27 INFO - jsonschema == 2.5.1 12:42:27 INFO - manifestparser == 1.1 12:42:27 INFO - mozInstall == 1.12 12:42:27 INFO - mozcrash == 0.17 12:42:27 INFO - mozdebug == 0.1 12:42:27 INFO - mozdevice == 0.48 12:42:27 INFO - mozfile == 1.2 12:42:27 INFO - mozhttpd == 0.7 12:42:27 INFO - mozinfo == 0.9 12:42:27 INFO - mozleak == 0.1 12:42:27 INFO - mozlog == 3.2 12:42:27 INFO - moznetwork == 0.27 12:42:27 INFO - mozprocess == 0.23 12:42:27 INFO - mozprofile == 0.28 12:42:27 INFO - mozrunner == 6.12 12:42:27 INFO - mozscreenshot == 0.1 12:42:27 INFO - mozsystemmonitor == 0.3 12:42:27 INFO - moztest == 0.7 12:42:27 INFO - mozversion == 1.4 12:42:27 INFO - psutil == 3.1.1 12:42:27 INFO - requests == 1.2.3 12:42:27 INFO - wsgiref == 0.1.2 12:42:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:42:27 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')]} 12:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:27 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')]} 12:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:27 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 0x1ee0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f3b0>, '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 0x21a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0740>, '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': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', '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 12:42:27 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 12:42:27 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 12:42:27 INFO - Using env: {'DISPLAY': ':0', 12:42:27 INFO - 'HOME': '/home/cltbld', 12:42:27 INFO - 'LANG': 'en_US.UTF-8', 12:42:27 INFO - 'LANGUAGE': 'en_US:en', 12:42:27 INFO - 'LOGNAME': 'cltbld', 12:42:27 INFO - 'MAIL': '/var/mail/cltbld', 12:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:27 INFO - 'MOZ_NO_REMOTE': '1', 12:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:27 INFO - 'NO_EM_RESTART': '1', 12:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:27 INFO - 'PWD': '/builds/slave/test', 12:42:27 INFO - 'SHELL': '/bin/bash', 12:42:27 INFO - 'SHLVL': '1', 12:42:27 INFO - 'TERM': 'linux', 12:42:27 INFO - 'TMOUT': '86400', 12:42:27 INFO - 'USER': 'cltbld', 12:42:27 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', 12:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:27 INFO - '_': '/tools/buildbot/bin/python'} 12:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:27 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)) 12:42:27 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)) 12:42:27 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)) 12:42:27 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)) 12:42:27 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)) 12:42:27 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)) 12:42:27 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)) 12:42:27 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)) 12:42:27 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)) 12:42:27 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)) 12:42:27 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)) 12:42:27 INFO - Cleaning up... 12:42:27 INFO - Return code: 0 12:42:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:42:27 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')]} 12:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:27 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')]} 12:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:27 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 0x1ee0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219f3b0>, '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 0x21a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0740>, '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': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', '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 12:42:27 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 12:42:27 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 12:42:27 INFO - Using env: {'DISPLAY': ':0', 12:42:27 INFO - 'HOME': '/home/cltbld', 12:42:27 INFO - 'LANG': 'en_US.UTF-8', 12:42:27 INFO - 'LANGUAGE': 'en_US:en', 12:42:27 INFO - 'LOGNAME': 'cltbld', 12:42:27 INFO - 'MAIL': '/var/mail/cltbld', 12:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:27 INFO - 'MOZ_NO_REMOTE': '1', 12:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:27 INFO - 'NO_EM_RESTART': '1', 12:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:27 INFO - 'PWD': '/builds/slave/test', 12:42:27 INFO - 'SHELL': '/bin/bash', 12:42:27 INFO - 'SHLVL': '1', 12:42:27 INFO - 'TERM': 'linux', 12:42:27 INFO - 'TMOUT': '86400', 12:42:27 INFO - 'USER': 'cltbld', 12:42:27 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', 12:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:27 INFO - '_': '/tools/buildbot/bin/python'} 12:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:42:27 INFO - Cleaning up... 12:42:27 INFO - Return code: 0 12:42:27 INFO - Running post-action listener: _resource_record_post_action 12:42:27 INFO - Running post-action listener: _start_resource_monitoring 12:42:27 INFO - Starting resource monitoring. 12:42:27 INFO - ##### 12:42:27 INFO - ##### Finished create-virtualenv step (success) 12:42:27 INFO - ##### 12:42:27 INFO - ##### 12:42:27 INFO - ##### Running install step. 12:42:27 INFO - ##### 12:42:27 INFO - Running pre-action listener: _resource_record_pre_action 12:42:27 INFO - Running main action method: install 12:42:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:42:28 INFO - Reading from file tmpfile_stdout 12:42:28 INFO - Detecting whether we're running mozinstall >=1.0... 12:42:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:42:28 INFO - Reading from file tmpfile_stdout 12:42:28 INFO - Output received: 12:42:28 INFO - Usage: mozinstall [options] installer 12:42:28 INFO - Options: 12:42:28 INFO - -h, --help show this help message and exit 12:42:28 INFO - -d DEST, --destination=DEST 12:42:28 INFO - Directory to install application into. [default: 12:42:28 INFO - "/builds/slave/test"] 12:42:28 INFO - --app=APP Application being installed. [default: firefox] 12:42:28 INFO - mkdir: /builds/slave/test/build/application 12:42:28 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'] 12:42:28 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 12:42:45 INFO - Reading from file tmpfile_stdout 12:42:45 INFO - Output received: 12:42:45 INFO - /builds/slave/test/build/application/firefox/firefox 12:42:45 INFO - Running post-action listener: _resource_record_post_action 12:42:45 INFO - ##### 12:42:45 INFO - ##### Finished install step (success) 12:42:45 INFO - ##### 12:42:45 INFO - ##### 12:42:45 INFO - ##### Running run-tests step. 12:42:45 INFO - ##### 12:42:45 INFO - Running pre-action listener: _resource_record_pre_action 12:42:45 INFO - Running main action method: run_tests 12:42:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:42:45 INFO - Python 2.7.3 12:42:45 INFO - Return code: 0 12:42:45 INFO - grabbing minidump binary from tooltool 12:42: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')]} 12:42:45 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 0x219f3b0>, '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 0x21a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:42:45 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 12:42:45 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 12:42:45 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 12:42:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:42:45 INFO - Return code: 0 12:42:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:42:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:42:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:42:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:42:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:42:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 12:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 12:42:45 INFO - Using env: {'DISPLAY': ':0', 12:42:45 INFO - 'HOME': '/home/cltbld', 12:42:45 INFO - 'LANG': 'en_US.UTF-8', 12:42:45 INFO - 'LANGUAGE': 'en_US:en', 12:42:45 INFO - 'LOGNAME': 'cltbld', 12:42:45 INFO - 'MAIL': '/var/mail/cltbld', 12:42:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:42:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:45 INFO - 'MOZ_NO_REMOTE': '1', 12:42:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:45 INFO - 'NO_EM_RESTART': '1', 12:42:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:45 INFO - 'PWD': '/builds/slave/test', 12:42:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:42:45 INFO - 'SHELL': '/bin/bash', 12:42:45 INFO - 'SHLVL': '1', 12:42:45 INFO - 'TERM': 'linux', 12:42:45 INFO - 'TMOUT': '86400', 12:42:45 INFO - 'USER': 'cltbld', 12:42:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345', 12:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:45 INFO - '_': '/tools/buildbot/bin/python'} 12:42:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 12:42:45 INFO - mozversion application_buildid: 20160718083017 12:42:45 INFO - mozversion application_changeset: ec19b4cb42d5355d336967e00059ddee3053f924 12:42:45 INFO - mozversion application_display_name: Nightly 12:42:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:42:45 INFO - mozversion application_name: Firefox 12:42:45 INFO - mozversion application_remotingname: firefox 12:42:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:42:45 INFO - mozversion application_vendor: Mozilla 12:42:45 INFO - mozversion application_version: 50.0a1 12:42:45 INFO - mozversion platform_buildid: 20160718083017 12:42:45 INFO - mozversion platform_changeset: ec19b4cb42d5355d336967e00059ddee3053f924 12:42:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:42:45 INFO - mozversion platform_version: 50.0a1 12:42:45 INFO - using testdate: 1468870965 12:42:45 INFO - actual date: 1468870965 12:42:45 INFO - starting webserver on 'localhost:48106' 12:42:45 INFO - SUITE-START | Running 2 tests 12:42:45 INFO - TEST-START | dromaeo_css 12:42:45 INFO - operating with platform_type : linux_ 12:42:45 INFO - Initialising browser for dromaeo_css test... 12:42:45 INFO - TEST-INFO | started process 30143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa2JMtM/profile http://localhost:48106/getInfo.html) 12:42:49 INFO - PROCESS | 30143 | __metrics Screen width/height:1600/1200 12:42:49 INFO - PROCESS | 30143 | colorDepth:24 12:42:49 INFO - PROCESS | 30143 | Browser inner width/height: 1024/697 12:42:49 INFO - PROCESS | 30143 | __metrics 12:42:50 INFO - PROCESS | 30143 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:42:50 INFO - PROCESS | 30143 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:42:51 INFO - TEST-INFO | 30143: exit 0 12:42:51 INFO - Browser initialized. 12:42:51 INFO - Running cycle 1/1 for dromaeo_css test... 12:42:51 INFO - TEST-INFO | started process 30223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa2JMtM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:43:03 INFO - PROCESS | 30223 | RSS: Main: 157884416 12:43:03 INFO - PROCESS | 30223 | 12:43:54 INFO - PROCESS | 30223 | 1468871034705 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] 12:46:02 INFO - PROCESS | 30223 | Cycle 1(1): loaded http://localhost:48106/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48106/tests/dromaeo/cssquery-ext.html) 12:46:03 INFO - PROCESS | 30223 | RSS: Main: 248430592 12:46:03 INFO - PROCESS | 30223 | 12:49:05 INFO - PROCESS | 30223 | Cycle 1(1): loaded http://localhost:48106/tests/dromaeo/cssquery-ext.html (next: http://localhost:48106/tests/dromaeo/cssquery-jquery.html) 12:49:06 INFO - PROCESS | 30223 | RSS: Main: 244654080 12:49:06 INFO - PROCESS | 30223 | 12:52:08 INFO - PROCESS | 30223 | Cycle 1(1): loaded http://localhost:48106/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48106/tests/dromaeo/cssquery-mootools.html) 12:52:09 INFO - PROCESS | 30223 | RSS: Main: 253960192 12:52:09 INFO - PROCESS | 30223 | 12:55:11 INFO - PROCESS | 30223 | Cycle 1(1): loaded http://localhost:48106/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48106/tests/dromaeo/cssquery-prototype.html) 12:55:11 INFO - PROCESS | 30223 | RSS: Main: 245899264 12:55:11 INFO - PROCESS | 30223 | 12:58:14 INFO - PROCESS | 30223 | Cycle 1(1): loaded http://localhost:48106/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48106/tests/dromaeo/cssquery-yui.html) 12:58:15 INFO - PROCESS | 30223 | RSS: Main: 205897728 12:58:15 INFO - PROCESS | 30223 | 13:01:17 INFO - PROCESS | 30223 | Cycle 1(1): loaded http://localhost:48106/tests/dromaeo/cssquery-yui.html (next: http://localhost:48106/tests/dromaeo/cssquery-dojo.html) 13:01:18 INFO - PROCESS | 30223 | RSS: Main: 281366528 13:01:18 INFO - PROCESS | 30223 | 13:01:18 INFO - PROCESS | 30223 | __start_tp_report 13:01:18 INFO - PROCESS | 30223 | _x_x_mozilla_page_load 13:01:18 INFO - PROCESS | 30223 | _x_x_mozilla_page_load_details 13:01:18 INFO - PROCESS | 30223 | |i|pagename|runs| 13:01:18 INFO - PROCESS | 30223 | |0;dojo.html;3070.4780187368146;3094.5667606535076;3108.6735892731263;3115.9844200778994;3130.5617213590103;5246.108161612526;5292.073887069767;5432.103702889023;5531.197976293435;5544.556435485157;5347.331583552056;5391.029614669358;5409.29679141711;5417.945820541793;5462.371827239868;4829.51704829516;4915.6313276504225;4927.950720492785;4947.752612369385;5120.436751957282;5011.123053465629;5015.247712843066;5043.949560504403;5068.011737711129;5076.46697096805;4824.083424149418;4875.829345972892;4902.730349830758;4918.90162196754;4927.531884470969;4812.494688057738;4813.109574728686;4823.372961515016;4849.878753031202;4947.03532811102;4846.660733748639;4864.659473836833;4877.244027175793;4893.070316639827;4924.409070911478;5221.112410890158;5310.840674779724;5375.059364611177;5398.028354896117;5517.227588137664;5717.656940583578;5757.280339957505;5772.422757724236;5773.769049238067;5775.653460792324;5773.538116950634;5794.217780599607;5837.3287071986415;5837.795677151322;5847.619904706223;5288.497592728685;5423.810166644188;5443.237946687467;5467.234587157801;5533.6403133796175;6034.034554471264;6037.6679282639;6045.637261764308;6047.365026672224;6047.818565443044;5514.338279406497;5794.710264486843;5805.245318108703;5807.709614519257;5825.563082768809;5821.010428227211;5821.301443826768;5873.911891321633;5957.6127551709;5960.880782384328;5852.326982396994;5875.735591898375;5881.05903055509;5882.294124705063;5931.051031834972;5674.886502269931;5774.2782152230975;5843.678597677169;5899.380565040609;5907.556933230025;4452.777361131931;4465.59809617136;4466.2853943369555;4498.1003799239625;4505.211587972091;3948.0919388540797;3961.801909904551;3972.3644216925154;3973.7615743055508;4007.2786898358577;5396.649217800909;5427.185922111636;5434.619576629677;5589.524890384281;5607.214989901417;5757.510611598061;5815.709214539341;5830.504407125357;5831.2127862738835;5890.823275301748;5411.729413529308;5437.864053398617;5443.183522471661;5446.564274858081;5448.046591846491;4936.703797772145;4941.50584941503;4951.10880041596;4967.677100988424;4999.550040496373;6000.159977603226;6005.03919372907;6006.189164462829;6011.879762404815;6048.818535443856;5829.59192856496;5831.912521312099;5836.795712150054;5844.386339434298;5844.590878638624;5876.382979787232;5912.881742365214;5934.821955341346;5964.612300200473;5999.1901093351835;5693.117566777156;5750;5755.597108202385;5756.079027355603;5756.510696590837;5839.8540036497725;5845.41545845412;5845.766169353178;5853.239078919713;5858.443447872445;5484.424135465878;5691.573132015033;5701.572382071278;5729.598928074995;5765.827025189251;5688.914666280092;5720.6853623049465;5725.16985037159;5732.340780810094;5742.971285143548;5577.693226872561;5722.914156287576;5728.255326807488;5730.111832665943;5737.426257374229;5621.971890140523;5646.7458964347525;5646.88706225865;5690.4878560928055;5739.5695322850115;5560.332760068818;5561.777528898799;5571.582131340085;5573.303337082864;5581.944180558143 13:01:18 INFO - PROCESS | 30223 | |1;ext.html;633.8161933039419;637.7162162837537;647.2168675902158;651.3356376495974;655.1286788571201;31614.841925790366;44129.117417651665;45732.542674573204;45797.08405831881;49529.25706114411;48517;49017.75491122539;49043.50956490434;49086.50913490864;49106;9158.633654653806;9298.721038368825;9299.256059515257;9306.348555601111;9307.534623268843;9071.092890710908;9144.4970526621;9163.725088247364;9165.212783507219;9173.357864949456;9162.404443711137;9181.908180918206;9223.723288301328;9228.446293222429;9229.907700922971;9149.45103293798;9156.130167634064;9207.90792092084;9222.123898229658;9224;9115.22520585751;9128.132827381389;9147.725568232963;9165.358424910259;9182.586783594688;44880.775596122134;45177.32234016492;45317.32024019642;45326.093478130584;45344.3198352025;3314.2377253231653;3486;3642.2351306225723;3708.8516459341595;4019.979900100481;34131.31737365239;34433.65566344329;34493.48259776105;34499.482507762405;35880.820595896854;4366.847160349373;4400.405945197389;4417.359482874997;4462.553744625544;4488.887777805581;239532;239914;240206.7989660058;240490;240979;63855;63915;63926.680366597866;64084;64267.357326426136;57987.71006144942;64119.358806411336;65545.67227163834;65819.67090164518;67198.32801671921;16330;16478.42325518601;16550.83449165517;16566.50300490987;16573.83426165723;11883.643490695293;12018.15872888907;12018.639440816789;12028;12029.518819247307;16580.75128873068;16868.662626747395;18598.814011859708;19106;19163.233470661296;6458.8351707662905;6550.901736473957;6579.80260592183;6597.109390232353;6630.469562434993;970.2189737261431;1036.8859425463193;1074.3929679730927;1085.8696956365286;1130.46867972053;33551.49672754911;33681.494777577864;33792;33855.66144338525;33933.32133357319;1075.2258373970728;1117.9776404472027;1122.927009744364;1203.9036877049814;1205.3069485046133;17857.46427607174;17960.461186164437;17998;18046;18087.18607662658;557110;557806.1645376612;562692;563622;565084;60659.39340606538;60758.39241607527;60847.391526085055;60949.69525152346;61083;1339.3771896068374;1344.5562964221783;1364.8703373179533;1378.4141739760562;1390.8400533938727;32303;33550;33664.49503257404;33829.154271143416;34455.138621534665;63584.36415635784;64988;65044.349556505724;65311.346886532425;65324.34675653183;388919;395583;395585;395825;396436;25333.113341032975;28434.715652844036;29188.708112918597;29485.410291793614;29562.704372956854;50004.749976249885;50457.24314135218;51199.74400127975;54147.458525414244;54985;42882;43195.78402107969;44028.77985610051;44418.111637766415;44639.55360446354;43180.352294716235;43865.12269754651;43928.56071439372;44234.77882610566;44895.32657010082;44441.33337999868;44913.32630010618;45474;46667.533324667675;47069.76465117653;36774.26451471009;38701.22597547977;39323.83544738413;39398.60601393949;39893.60106399015;29106.12681619555;29197.562036569045;29589.408211836075;29669.703302966693;29914.850425747733 13:01:18 INFO - PROCESS | 30223 | |2;jquery.html;396.32031066720566;399.8840336302472;401.3377926421404;401.77701375736456;421.91350773091517;13645;19201.615967680656;20776.272830450936;20799.792002079976;21230.77076906926;20132.698009529868;20532.07605657745;20892.866070089494;21122.366329010154;21136.260230891923;5402.729863506819;5522.337319521663;5528.281323427948;5529.695866727328;5555.555555555566;4038.9394159087637;5450.073487507133;5488.259085023531;5491.670499770006;5493.945060549383;7374;7733.961330193341;7744.225577442267;7756.883646745275;7901.051873775155;7415.88876166858;7689.50018248812;7738.110117336522;7750.0699916010435;7752.341051010642;7197.856042879165;7402.518836275679;7407.555546667218;7544.886826697549;7549.584772837547;27578;28136.29659258535;28210.71789282122;28439.289017774514;28540.714592854012;2495.1516484395393;2526.734692857242;2554.8339357941672;2599.6620439342764;2610.7128215896237;16002.519924402286;16692.24884880183;17209.225584848587;17261.56846078858;17276.56808579783;2117.6929345245007;2140.8501404901663;2160.1899287767087;2211.9447013824783;2212.5021870079263;102464;103309.48345258301;103967.4801625987;104520;104878.99999999924;18122.184501697455;18634.440966771017;18742.531436713918;18974.335898243495;19476.70784938227;33803.32393352119;33933.83033084868;34285;34383.484247736305;34402.311953760785;9450.763730906645;9539.427634341962;9632.566534505964;9677.758056048655;9740.269479789044;7833.1775163608145;7894.447388682737;7923.286904178652;8021.2379823916635;8063.5968201589685;9025.909740902638;9057.637694492147;9213.539323033821;9298.302627302844;9409.412411586869;3349.598048234179;3394.9830250848586;3563.8396272167815;3582.874599389009;3646.854125834937;921.3964853021282;986.5313975861409;1001.7395477175987;1013.8479228115841;1085.2403317677656;19656.80343196578;20072.297469588495;20919;21199.364019079454;22107.11571537153;974.8488984207318;1008.5814387029448;1027.6403258859339;1027.7851230598073;1047.1256500821898;11241.662750117346;11770.705732356759;11782.823257651142;11917.940410297893;11957;191891;515934;584342;597439;602766;104015;104775.99999999847;105207;105352;105560;1052.9105026072716;1056.4189695667353;1083.8590983172137;1090.0788833435734;1092.3500517192258;18408.815911841248;18539.35112271064;18873.71689424632;19009.914830309648;19208.807911920703;42725.786371067945;44237.778811107026;44740.10519789651;44916.30052833917;44942.550574493835;58272.4172758267;58577.414225857196;63593.3640663606;64296.106675200666;64535.67732161309;8229.506229626242;8565.657373705231;8655.56722163902;8661;9085.409448385833;7786.454948153575;8706.695265665672;9748.732664753537;9761.46311952821;13594.11638243511;11236.775264494829;11401.543938242377;11415.60045398407;11438.485268162785;11474.426278685865;11410.942945285553;11493.540258389905;11503.194776365573;11578.71053223676;11830.46762895689;11544.94227528857;11800.291982481078;11892.167548271884;11910.344931028876;11971.880281197426;8609.48343099416;8742.256908162622;8793.20861122502;8806.735797926072;8913.509756963429;11716.355600441717;11766.58816941403;11867.525298987945;11940.223885447418;12030.879691202976 13:01:18 INFO - PROCESS | 30223 | |3;mootools.html;1339.1161833190097;1482.6589884326609;1526.107227272046;1676.7149584570623;1828.5611453251224;8497.617607207674;8776.297896168307;8782.912170878297;8796.736097917064;9029.142231488015;8352.582370881462;8610.741677749662;8772.29821614271;8797.912020879789;8804.33967452442;2065.297798748425;2119.73503312086;2120.7455105387376;2337.871417072056;2383.0944241188413;2172.3808714516285;2179.607670619288;2342.0982921575146;2412.421018955447;2414.782669559739;2380.0836677879056;2388.36708272308;2413.095089341497;2413.3966508372905;2413.650020746991;2046.1610739596695;2328.2433209206993;2331.2306938710185;2333.195047708538;2334.1713691639393;2271.8409711320214;2336.4158960259933;2350.811935045192;2351.353377821096;2356.7996720278625;8865.911340886638;8898.4660920345;8923.509206993613;8926.196642302159;8941.284697224206;5374.193870919355;5495.752691128869;5511.862203444906;5513.669179849222;5529.612927095105;3330.1008727643643;3408.2842603053386;3506.4389697648508;3508.2106526031694;3521.1197200699826;1224.406163010939;1230.7538492301576;1241.503398640542;1273.6179146256086;1288.6005338345144;12540.24758514492;12867.163634363736;12910.031747618967;12911.80632290507;12956.09307348486;4797.808087676523;4822.324874517571;4833.4441539223435;4890.339804126468;4942.135126352874;10752.731181720363;10773.35359878394;10792.190585706103;10805.621803237007;10805.945970270099;5548.69482178476;5563.638363506359;5571.1086226203615;5575.414581468968;5575.832725018256;5028.245763135559;5081.9745901271;5105.897882042413;5107.336046313955;5145.897082058338;4075.7146999709735;4086.17136418224;4147.730397524151;4182.790860456965;4188.643965262987;1249.5688987299368;1252.9060320476;1277.5975567696146;1280.2638482872385;1326.6683329167709;1008.2438171371472;1012.7771890184295;1012.8581998520214;1015.4770293298957;1036.486938965217;6171;6255.97038688103;6441.549091563639;6483.578567393104;6493.285738568754;463.84693051292993;476.56632464457175;487.90973669871187;490.0908814149772;492.4533767518052;4469.798859051285;4497.8425755098415;4517.457905051349;4523.705959112647;4552.476465206478;10866.836997445045;11299.435028248554;11320.943395282971;11384.829227561593;11391;10802.459877006118;11209.215354925076;11216.102711783038;11236.269642473377;11264.887351126548;8421.578921054046;8535.890334256506;8591.097934716765;8622.655093796304;8632.35257355701;6356.936430635635;6386.489080873426;6688.431483323778;6688.431483323972;6806.319368063352;10085.29402941787;10702.250842440955;10727.839082413926;10815.621453249098;10838.729031774268;9515.33392662507;10187.694369168938;10492.632757853438;10825.67522974312;10839.67480975572;7652.966849475472;7976.202379761978;7983.72056978003;8009.479383840032;8036.839263214586;8787.648494060422;8874.156955089256;8880.555972201493;8883.33374996865;8897.955510222408;7521.661525231269;7728.227177282227;7759.146493885781;7868.803279918048;7919.08930473003;7633.732819351296;7869.3311068559815;7920;8096.87854682192;8102;7250.564966102051;7274.6726397313305;7308.817279568053;7316.451266154953;7319.74380896666;5371.811986580451;5409.83770486886;5537.6954267515675;5645.802396916089;5705.058665320175;5477.233187353853;5494.587905906993;5504.9449505504435;5785.450382213683;5830.53355731549 13:01:18 INFO - PROCESS | 30223 | |4;prototype.html;330.79463898009857;337.89187460012795;346.2434580441735;347.41634054787977;348.42509858733104;5296.947030529694;5300.893982120355;5327.2808170896915;5357.642637239616;5381.730913454321;5264.447233040533;5279.63042587019;5301.920471192935;5309.133068143207;5313.22958171065;3982.6614737747327;4187.602177793105;4198.958010419895;4220.514640816299;4224.366345048252;3859.864904728335;3919.196564704229;4009.8596549120784;4035.899102522446;4142.875713728593;4085.8774236772942;4089.6114869087387;4098.323776576876;4127.36025915982;4130.690198235129;4064.841520166753;4105.958940410603;4111.1366613011305;4124.91750164995;4139.296319625671;3537.7700449470703;3596.1908570571672;3697.8890633281044;3703.518542589473;3727.403615421547;5117.33474648297;5127.307813445212;5143.305653736735;5157;5161.61287903405;4779.661694725482;4785.186518291864;4792.209285467894;4795.232762757977;4812.446568644616;5542.422773410383;5548.944510554883;5568.9443105569235;5586.217929489874;5589.133684278943;3893.532776066862;3983.8406463741417;4115.73247738896;4124.793760311973;4125.443065186221;5464.289642346509;5630.831075067755;5639.238702775114;5678.488935995739;5710.600257981984;3989.7805620691142;4045.8583949561626;4060;4066.7356621820077;4072.633462988286;4006.2988976928923;4111.671066314688;4127;4128.112455821953;4163.208990291835;4672.836450724276;4696.9060618787435;4724.189107481044;4757.549861821165;4760.500147484534;5477.917831232535;5483.533899618497;5484;5484.369297530755;5507.917381239285;1398.9440422383195;1415.950441734555;1435.1389166500016;1435.454527279627;1436.5115860607443;940.6895724410928;965.2181732796457;965.9130678238993;966.8211380894417;972.6692924405736;4653.674242802971;4758.904821903542;4761.214399624093;4778.761061946889;4797.40032495938;5009.974950125226;5031.74841257943;5042.873928151826;5049.192129259301;5056.772445239973;4754.23932170851;4773.618110551148;4793.688410253322;4797.832075877328;4897.191963326082;2517.43357744506;2669.1449442637568;2669.7585622685547;2696.9325766855986;2702.7297270273207;5127.8718032048755;5137.486251374833;5152.201408781645;5160.406553246425;5168.9483105168465;5103.907397966816;5125.308083408692;5134.204198349187;5136.149437062391;5193.3767947845745;5134.409542902539;5143.688359468311;5158.664686795346;5442.23808666779;5887.293524777054;5657.60396772222;5683.658980461186;5715.714214289185;5716.314042314949;5718.456746609066;5405.648632838853;5537.141743029837;5669.574781891457;5729.512991395612;5735.3977832327;5866.178734977021;5866.560007999503;5881.617694849821;5893.499052580579;5897.321807991964;4062.2078694655443;4089.325261331847;4099.1596722672375;4122.587741225853;4125.133721918431;5609.382967873449;5709.571782116441;5737.139429085503;5755.1367294906095;5761.510271626791;5547.61166718342;5594.776208951596;5642.069058605448;5672.688002159921;5680.943190568207;5336.3863155736035;5560.6107572471155;5580.665160090408;5588.41321661236;5609.298837645294;5555.111182210827;5583.55331573465;5585.3297604287745;5590.133529302964;5600.943990560042;5557.5831812613405;5577.406505974741;5629.536320556766;5653.717314134195;5696.231008813923;5241.659292145999;5508.9724551376985;5511.614187006871;5515.751791169327;5524.475174858382 13:01:18 INFO - PROCESS | 30223 | |5;yui.html;817.5503473089801;836.6109758962082;851.1148405658116;859.3683642522741;863.7970077031898;17251.741223881636;17840.464786056407;17874;17879.37422190222;17946;15885.84114158858;15998.200089995511;16007.19964001801;16034.75947860783;16045.277962491688;679.5956405938458;828.1552816127546;851.4763420496381;852.5566705313233;853.1511146409331;822.181928980665;841.247083859945;843.0768308701993;844.7339088187201;846.2510678049908;878.2578720980792;882.3999680217449;884.2793123604242;887.2901678657081;888.2272422991974;706.6360824175554;714.9714011439536;880.2649787427506;882.6557642519423;882.8278485695292;533.1868899927641;620.1225266248254;628.3339659960457;633.2843886408375;635.1330433957614;15923.601909952344;15926.28331725075;15930.362785488567;15935.760963585555;16031.679366412607;14294.857483069116;14302.141871487744;14522.854771452256;14538.273086345745;14550.854491455162;12998.740025199537;13067.346632668423;13081.476740930351;13210.537631182959;13294.069415140944;4491.663125265585;4494.325851122358;4501.842435514774;4510.368548403226;4706.599939005188;79464.60267698682;80417;81360.59319703422;81637;82598.58700706458;11373;11493.597724079616;11561.015642485954;11566.132540059361;11847.703807404712;21132.683009754866;21140.365789026353;21144.471388215417;21159.25942592002;21168.259110931045;8178.386621003448;8220.876686849702;8346.540940248224;8449.986001679837;8453.619587118594;4672.602828759525;4727.220008698595;4772.880677983008;4859.1496488114435;5021.72380519075;3274.885379011723;3363.4618461046116;3370.5449764282;3374.443216869189;3375.0549846043145;640.3308542573022;647.152230577935;653.9182602174728;654.9967250163814;656.7832615236961;654.482958462809;679.2392520377209;703.5778532880231;710.4245561095529;714.8284411741249;9574.521273936276;10003.949980250052;10060.144887684482;10080.647177348757;10097.545610447547;605.4581149870841;686.6703982088626;693.1197379328325;721.4084450750335;744.728174216418;4857.247126695368;5001.374828146481;5135.563477104488;5330.173823057432;5460.6177567569885;110878;113102;113605;114288.42855785668;117852;98515;101393.99999999853;103612.48193758982;103837.48081259546;106787;92270.53864730634;94288;94348;94470;94747;9556.378835375679;9639.71080867575;9662.178714809039;9864.408135511892;9909.603615855285;45256.77371613121;48394;48460.273095902885;51195.232071518214;53289.73355133199;49282.26076608782;66025.0096248547;75291.21214242114;77967.22032779599;79640.60179699064;13464.663383415493;13505.161287122126;13592.932035340156;13634.590962271148;14099.577012689635;15406.845931540542;15423;15539.766903496682;15695.136767477441;15778.605534861721;13887.861121388656;14107.858921410654;14235.50175743844;14472.710545789236;14660.85339146595;12942.741145176855;13488.73022539524;13524.72950540964;13719.176849389069;13764.862351376358;13505.12216705911;13553.932230338785;13581.796273055714;13915.108459220513;14075;11606.24559403636;11606.30362178272;11635.301881887113;11832.645020649394;11962.342071186169;10879.347239165676;11425.2002359834;11425.31448113116;11429.428528573371;11609.419529023684 13:01:18 INFO - PROCESS | 30223 | __end_tp_report 13:01:18 INFO - PROCESS | 30223 | __start_cc_report 13:01:18 INFO - PROCESS | 30223 | _x_x_mozilla_cycle_collect,912 13:01:18 INFO - PROCESS | 30223 | __end_cc_report 13:01:18 INFO - PROCESS | 30223 | __startTimestamp1468872078070__endTimestamp 13:01:18 INFO - PROCESS | 30223 | 13:01:18 INFO - PROCESS | 30223 | ------- Summary: start ------- 13:01:18 INFO - PROCESS | 30223 | Number of tests: 6 13:01:18 INFO - PROCESS | 30223 | 13:01:18 INFO - PROCESS | 30223 | [#0] dojo.html Cycles:165 Average:5398.94 Median:5607.21 stddev:625.87 (11.2%) stddev-sans-first:600.54 13:01:18 INFO - PROCESS | 30223 | Values: 3070.5 3094.6 3108.7 3116.0 3130.6 5246.1 5292.1 5432.1 5531.2 5544.6 5347.3 5391.0 5409.3 5417.9 5462.4 4829.5 4915.6 4928.0 4947.8 5120.4 5011.1 5015.2 5043.9 5068.0 5076.5 4824.1 4875.8 4902.7 4918.9 4927.5 4812.5 4813.1 4823.4 4849.9 4947.0 4846.7 4864.7 4877.2 4893.1 4924.4 5221.1 5310.8 5375.1 5398.0 5517.2 5717.7 5757.3 5772.4 5773.8 5775.7 5773.5 5794.2 5837.3 5837.8 5847.6 5288.5 5423.8 5443.2 5467.2 5533.6 6034.0 6037.7 6045.6 6047.4 6047.8 5514.3 5794.7 5805.2 5807.7 5825.6 5821.0 5821.3 5873.9 5957.6 5960.9 5852.3 5875.7 5881.1 5882.3 5931.1 5674.9 5774.3 5843.7 5899.4 5907.6 4452.8 4465.6 4466.3 4498.1 4505.2 3948.1 3961.8 3972.4 3973.8 4007.3 5396.6 5427.2 5434.6 5589.5 5607.2 5757.5 5815.7 5830.5 5831.2 5890.8 5411.7 5437.9 5443.2 5446.6 5448.0 4936.7 4941.5 4951.1 4967.7 4999.6 6000.2 6005.0 6006.2 6011.9 6048.8 5829.6 5831.9 5836.8 5844.4 5844.6 5876.4 5912.9 5934.8 5964.6 5999.2 5693.1 5750.0 5755.6 5756.1 5756.5 5839.9 5845.4 5845.8 5853.2 5858.4 5484.4 5691.6 5701.6 5729.6 5765.8 5688.9 5720.7 5725.2 5732.3 5743.0 5577.7 5722.9 5728.3 5730.1 5737.4 5622.0 5646.7 5646.9 5690.5 5739.6 5560.3 5561.8 5571.6 5573.3 5581.9 13:01:18 INFO - PROCESS | 30223 | 13:01:18 INFO - PROCESS | 30223 | [#1] ext.html Cycles:180 Average:58364.88 Median:44326.45 stddev:111504.21 (251.6%) stddev-sans-first:111732.76 13:01:18 INFO - PROCESS | 30223 | Values: 633.8 637.7 647.2 651.3 655.1 31614.8 44129.1 45732.5 45797.1 49529.3 48517.0 49017.8 49043.5 49086.5 49106.0 9158.6 9298.7 9299.3 9306.3 9307.5 9071.1 9144.5 9163.7 9165.2 9173.4 9162.4 9181.9 9223.7 9228.4 9229.9 9149.5 9156.1 9207.9 9222.1 9224.0 9115.2 9128.1 9147.7 9165.4 9182.6 44880.8 45177.3 45317.3 45326.1 45344.3 3314.2 3486.0 3642.2 3708.9 4020.0 34131.3 34433.7 34493.5 34499.5 35880.8 4366.8 4400.4 4417.4 4462.6 4488.9 239532.0 239914.0 240206.8 240490.0 240979.0 63855.0 63915.0 63926.7 64084.0 64267.4 57987.7 64119.4 65545.7 65819.7 67198.3 16330.0 16478.4 16550.8 16566.5 16573.8 11883.6 12018.2 12018.6 12028.0 12029.5 16580.8 16868.7 18598.8 19106.0 19163.2 6458.8 6550.9 6579.8 6597.1 6630.5 970.2 1036.9 1074.4 1085.9 1130.5 33551.5 33681.5 33792.0 33855.7 33933.3 1075.2 1118.0 1122.9 1203.9 1205.3 17857.5 17960.5 17998.0 18046.0 18087.2 557110.0 557806.2 562692.0 563622.0 565084.0 60659.4 60758.4 60847.4 60949.7 61083.0 1339.4 1344.6 1364.9 1378.4 1390.8 32303.0 33550.0 33664.5 33829.2 34455.1 63584.4 64988.0 65044.3 65311.3 65324.3 388919.0 395583.0 395585.0 395825.0 396436.0 25333.1 28434.7 29188.7 29485.4 29562.7 50004.7 50457.2 51199.7 54147.5 54985.0 42882.0 43195.8 44028.8 44418.1 44639.6 43180.4 43865.1 43928.6 44234.8 44895.3 44441.3 44913.3 45474.0 46667.5 47069.8 36774.3 38701.2 39323.8 39398.6 39893.6 29106.1 29197.6 29589.4 29669.7 29914.9 13:01:18 INFO - PROCESS | 30223 | 13:01:18 INFO - PROCESS | 30223 | [#2] jquery.html Cycles:180 Average:31907.14 Median:28173.51 stddev:86767.15 (308.0%) stddev-sans-first:86978.29 13:01:18 INFO - PROCESS | 30223 | Values: 396.3 399.9 401.3 401.8 421.9 13645.0 19201.6 20776.3 20799.8 21230.8 20132.7 20532.1 20892.9 21122.4 21136.3 5402.7 5522.3 5528.3 5529.7 5555.6 4038.9 5450.1 5488.3 5491.7 5493.9 7374.0 7734.0 7744.2 7756.9 7901.1 7415.9 7689.5 7738.1 7750.1 7752.3 7197.9 7402.5 7407.6 7544.9 7549.6 27578.0 28136.3 28210.7 28439.3 28540.7 2495.2 2526.7 2554.8 2599.7 2610.7 16002.5 16692.2 17209.2 17261.6 17276.6 2117.7 2140.9 2160.2 2211.9 2212.5 102464.0 103309.5 103967.5 104520.0 104879.0 18122.2 18634.4 18742.5 18974.3 19476.7 33803.3 33933.8 34285.0 34383.5 34402.3 9450.8 9539.4 9632.6 9677.8 9740.3 7833.2 7894.4 7923.3 8021.2 8063.6 9025.9 9057.6 9213.5 9298.3 9409.4 3349.6 3395.0 3563.8 3582.9 3646.9 921.4 986.5 1001.7 1013.8 1085.2 19656.8 20072.3 20919.0 21199.4 22107.1 974.8 1008.6 1027.6 1027.8 1047.1 11241.7 11770.7 11782.8 11917.9 11957.0 191891.0 515934.0 584342.0 597439.0 602766.0 104015.0 104776.0 105207.0 105352.0 105560.0 1052.9 1056.4 1083.9 1090.1 1092.4 18408.8 18539.4 18873.7 19009.9 19208.8 42725.8 44237.8 44740.1 44916.3 44942.6 58272.4 58577.4 63593.4 64296.1 64535.7 8229.5 8565.7 8655.6 8661.0 9085.4 7786.5 8706.7 9748.7 9761.5 13594.1 11236.8 11401.5 11415.6 11438.5 11474.4 11410.9 11493.5 11503.2 11578.7 11830.5 11544.9 11800.3 11892.2 11910.3 11971.9 8609.5 8742.3 8793.2 8806.7 8913.5 11716.4 11766.6 11867.5 11940.2 12030.9 13:01:18 INFO - PROCESS | 30223 | 13:01:18 INFO - PROCESS | 30223 | [#3] mootools.html Cycles:180 Average:6001.38 Median:2637.19 stddev:3420.94 (129.7%) stddev-sans-first:3412.59 13:01:18 INFO - PROCESS | 30223 | Values: 1339.1 1482.7 1526.1 1676.7 1828.6 8497.6 8776.3 8782.9 8796.7 9029.1 8352.6 8610.7 8772.3 8797.9 8804.3 2065.3 2119.7 2120.7 2337.9 2383.1 2172.4 2179.6 2342.1 2412.4 2414.8 2380.1 2388.4 2413.1 2413.4 2413.7 2046.2 2328.2 2331.2 2333.2 2334.2 2271.8 2336.4 2350.8 2351.4 2356.8 8865.9 8898.5 8923.5 8926.2 8941.3 5374.2 5495.8 5511.9 5513.7 5529.6 3330.1 3408.3 3506.4 3508.2 3521.1 1224.4 1230.8 1241.5 1273.6 1288.6 12540.2 12867.2 12910.0 12911.8 12956.1 4797.8 4822.3 4833.4 4890.3 4942.1 10752.7 10773.4 10792.2 10805.6 10805.9 5548.7 5563.6 5571.1 5575.4 5575.8 5028.2 5082.0 5105.9 5107.3 5145.9 4075.7 4086.2 4147.7 4182.8 4188.6 1249.6 1252.9 1277.6 1280.3 1326.7 1008.2 1012.8 1012.9 1015.5 1036.5 6171.0 6256.0 6441.5 6483.6 6493.3 463.8 476.6 487.9 490.1 492.5 4469.8 4497.8 4517.5 4523.7 4552.5 10866.8 11299.4 11320.9 11384.8 11391.0 10802.5 11209.2 11216.1 11236.3 11264.9 8421.6 8535.9 8591.1 8622.7 8632.4 6356.9 6386.5 6688.4 6688.4 6806.3 10085.3 10702.3 10727.8 10815.6 10838.7 9515.3 10187.7 10492.6 10825.7 10839.7 7653.0 7976.2 7983.7 8009.5 8036.8 8787.6 8874.2 8880.6 8883.3 8898.0 7521.7 7728.2 7759.1 7868.8 7919.1 7633.7 7869.3 7920.0 8096.9 8102.0 7250.6 7274.7 7308.8 7316.5 7319.7 5371.8 5409.8 5537.7 5645.8 5705.1 5477.2 5494.6 5504.9 5785.5 5830.5 13:01:18 INFO - PROCESS | 30223 | 13:01:18 INFO - PROCESS | 30223 | [#4] prototype.html Cycles:180 Average:4573.36 Median:5134.31 stddev:1335.07 (26.0%) stddev-sans-first:1300.28 13:01:18 INFO - PROCESS | 30223 | Values: 330.8 337.9 346.2 347.4 348.4 5296.9 5300.9 5327.3 5357.6 5381.7 5264.4 5279.6 5301.9 5309.1 5313.2 3982.7 4187.6 4199.0 4220.5 4224.4 3859.9 3919.2 4009.9 4035.9 4142.9 4085.9 4089.6 4098.3 4127.4 4130.7 4064.8 4106.0 4111.1 4124.9 4139.3 3537.8 3596.2 3697.9 3703.5 3727.4 5117.3 5127.3 5143.3 5157.0 5161.6 4779.7 4785.2 4792.2 4795.2 4812.4 5542.4 5548.9 5568.9 5586.2 5589.1 3893.5 3983.8 4115.7 4124.8 4125.4 5464.3 5630.8 5639.2 5678.5 5710.6 3989.8 4045.9 4060.0 4066.7 4072.6 4006.3 4111.7 4127.0 4128.1 4163.2 4672.8 4696.9 4724.2 4757.5 4760.5 5477.9 5483.5 5484.0 5484.4 5507.9 1398.9 1416.0 1435.1 1435.5 1436.5 940.7 965.2 965.9 966.8 972.7 4653.7 4758.9 4761.2 4778.8 4797.4 5010.0 5031.7 5042.9 5049.2 5056.8 4754.2 4773.6 4793.7 4797.8 4897.2 2517.4 2669.1 2669.8 2696.9 2702.7 5127.9 5137.5 5152.2 5160.4 5168.9 5103.9 5125.3 5134.2 5136.1 5193.4 5134.4 5143.7 5158.7 5442.2 5887.3 5657.6 5683.7 5715.7 5716.3 5718.5 5405.6 5537.1 5669.6 5729.5 5735.4 5866.2 5866.6 5881.6 5893.5 5897.3 4062.2 4089.3 4099.2 4122.6 4125.1 5609.4 5709.6 5737.1 5755.1 5761.5 5547.6 5594.8 5642.1 5672.7 5680.9 5336.4 5560.6 5580.7 5588.4 5609.3 5555.1 5583.6 5585.3 5590.1 5600.9 5557.6 5577.4 5629.5 5653.7 5696.2 5241.7 5509.0 5511.6 5515.8 5524.5 13:01:18 INFO - PROCESS | 30223 | 13:01:18 INFO - PROCESS | 30223 | [#5] yui.html Cycles:180 Average:21315.65 Median:4506.11 stddev:30569.86 (678.4%) stddev-sans-first:30616.87 13:01:18 INFO - PROCESS | 30223 | Values: 817.6 836.6 851.1 859.4 863.8 17251.7 17840.5 17874.0 17879.4 17946.0 15885.8 15998.2 16007.2 16034.8 16045.3 679.6 828.2 851.5 852.6 853.2 822.2 841.2 843.1 844.7 846.3 878.3 882.4 884.3 887.3 888.2 706.6 715.0 880.3 882.7 882.8 533.2 620.1 628.3 633.3 635.1 15923.6 15926.3 15930.4 15935.8 16031.7 14294.9 14302.1 14522.9 14538.3 14550.9 12998.7 13067.3 13081.5 13210.5 13294.1 4491.7 4494.3 4501.8 4510.4 4706.6 79464.6 80417.0 81360.6 81637.0 82598.6 11373.0 11493.6 11561.0 11566.1 11847.7 21132.7 21140.4 21144.5 21159.3 21168.3 8178.4 8220.9 8346.5 8450.0 8453.6 4672.6 4727.2 4772.9 4859.1 5021.7 3274.9 3363.5 3370.5 3374.4 3375.1 640.3 647.2 653.9 655.0 656.8 654.5 679.2 703.6 710.4 714.8 9574.5 10003.9 10060.1 10080.6 10097.5 605.5 686.7 693.1 721.4 744.7 4857.2 5001.4 5135.6 5330.2 5460.6 110878.0 113102.0 113605.0 114288.4 117852.0 98515.0 101394.0 103612.5 103837.5 106787.0 92270.5 94288.0 94348.0 94470.0 94747.0 9556.4 9639.7 9662.2 9864.4 9909.6 45256.8 48394.0 48460.3 51195.2 53289.7 49282.3 66025.0 75291.2 77967.2 79640.6 13464.7 13505.2 13592.9 13634.6 14099.6 15406.8 15423.0 15539.8 15695.1 15778.6 13887.9 14107.9 14235.5 14472.7 14660.9 12942.7 13488.7 13524.7 13719.2 13764.9 13505.1 13553.9 13581.8 13915.1 14075.0 11606.2 11606.3 11635.3 11832.6 11962.3 10879.3 11425.2 11425.3 11429.4 11609.4 13:01:18 INFO - PROCESS | 30223 | -------- Summary: end -------- 13:01:18 INFO - PROCESS | 30223 | 13:01:18 INFO - TEST-INFO | 30223: exit 0 13:01:18 INFO - TEST-OK | dromaeo_css | took 1113005ms 13:01:18 INFO - TEST-START | kraken 13:01:18 INFO - operating with platform_type : linux_ 13:01:18 INFO - Initialising browser for kraken test... 13:01:18 INFO - TEST-INFO | started process 30409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzmG4Qy/profile http://localhost:48106/getInfo.html) 13:01:22 INFO - PROCESS | 30409 | __metrics Screen width/height:1600/1200 13:01:22 INFO - PROCESS | 30409 | colorDepth:24 13:01:22 INFO - PROCESS | 30409 | Browser inner width/height: 1024/697 13:01:22 INFO - PROCESS | 30409 | __metrics 13:01:23 INFO - PROCESS | 30409 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:01:23 INFO - PROCESS | 30409 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:01:23 INFO - PROCESS | 30409 | console.error: PushService: 13:01:23 INFO - PROCESS | 30409 | stateChangeProcessEnqueue: Error transitioning state 13:01:23 INFO - PROCESS | 30409 | UnknownError 13:01:24 INFO - TEST-INFO | 30409: exit 0 13:01:24 INFO - Browser initialized. 13:01:24 INFO - Running cycle 1/1 for kraken test... 13:01:24 INFO - TEST-INFO | started process 30492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzmG4Qy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:01:36 INFO - PROCESS | 30492 | RSS: Main: 157683712 13:01:36 INFO - PROCESS | 30492 | 13:01:38 INFO - PROCESS | 30492 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48106/tests/kraken/driver.html?testName=audio-beat-detection) 13:01:39 INFO - PROCESS | 30492 | RSS: Main: 217722880 13:01:39 INFO - PROCESS | 30492 | 13:01:42 INFO - PROCESS | 30492 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48106/tests/kraken/driver.html?testName=audio-dft) 13:01:42 INFO - PROCESS | 30492 | RSS: Main: 205828096 13:01:42 INFO - PROCESS | 30492 | 13:01:46 INFO - PROCESS | 30492 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48106/tests/kraken/driver.html?testName=audio-fft) 13:01:46 INFO - PROCESS | 30492 | RSS: Main: 270065664 13:01:46 INFO - PROCESS | 30492 | 13:01:48 INFO - PROCESS | 30492 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48106/tests/kraken/driver.html?testName=audio-oscillator) 13:01:49 INFO - PROCESS | 30492 | RSS: Main: 180592640 13:01:49 INFO - PROCESS | 30492 | 13:01:51 INFO - PROCESS | 30492 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48106/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:01:52 INFO - PROCESS | 30492 | RSS: Main: 185163776 13:01:52 INFO - PROCESS | 30492 | 13:01:55 INFO - PROCESS | 30492 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48106/tests/kraken/driver.html?testName=imaging-darkroom) 13:01:55 INFO - PROCESS | 30492 | RSS: Main: 219787264 13:01:55 INFO - PROCESS | 30492 | 13:01:59 INFO - PROCESS | 30492 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48106/tests/kraken/driver.html?testName=imaging-desaturate) 13:01:59 INFO - PROCESS | 30492 | RSS: Main: 221900800 13:01:59 INFO - PROCESS | 30492 | 13:02:02 INFO - PROCESS | 30492 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48106/tests/kraken/driver.html?testName=json-parse-financial) 13:02:03 INFO - PROCESS | 30492 | RSS: Main: 222629888 13:02:03 INFO - PROCESS | 30492 | 13:02:04 INFO - PROCESS | 30492 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48106/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:02:05 INFO - PROCESS | 30492 | RSS: Main: 210509824 13:02:05 INFO - PROCESS | 30492 | 13:02:06 INFO - PROCESS | 30492 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:02:07 INFO - PROCESS | 30492 | RSS: Main: 215228416 13:02:07 INFO - PROCESS | 30492 | 13:02:09 INFO - PROCESS | 30492 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:02:10 INFO - PROCESS | 30492 | RSS: Main: 214949888 13:02:10 INFO - PROCESS | 30492 | 13:02:12 INFO - PROCESS | 30492 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:02:13 INFO - PROCESS | 30492 | RSS: Main: 223330304 13:02:13 INFO - PROCESS | 30492 | 13:02:15 INFO - PROCESS | 30492 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:02:16 INFO - PROCESS | 30492 | RSS: Main: 224681984 13:02:16 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48106/tests/kraken/driver.html?testName=ai-astar) 13:02:18 INFO - PROCESS | 30492 | RSS: Main: 266698752 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | __start_tp_report 13:02:18 INFO - PROCESS | 30492 | _x_x_mozilla_page_load 13:02:18 INFO - PROCESS | 30492 | _x_x_mozilla_page_load_details 13:02:18 INFO - PROCESS | 30492 | |i|pagename|runs| 13:02:18 INFO - PROCESS | 30492 | |0;ai-astar;102;111;112;110;112;112;111;111;112;110 13:02:18 INFO - PROCESS | 30492 | |1;audio-beat-detection;151;116;125;173;121;125;143;121;159;116 13:02:18 INFO - PROCESS | 30492 | |2;audio-dft;162;162;161;162;160;161;161;162;161;162 13:02:18 INFO - PROCESS | 30492 | |3;audio-fft;76;74;74;111;75;75;75;75;101;75 13:02:18 INFO - PROCESS | 30492 | |4;audio-oscillator;83;88;117;84;84;84;123;83;84;132 13:02:18 INFO - PROCESS | 30492 | |5;imaging-gaussian-blur;117;117;116;116;117;117;116;118;116;117 13:02:18 INFO - PROCESS | 30492 | |6;imaging-darkroom;146;146;145;146;146;146;146;145;146;146 13:02:18 INFO - PROCESS | 30492 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;94;96 13:02:18 INFO - PROCESS | 30492 | |8;json-parse-financial;53;51;50;50;49;51;50;50;51;52 13:02:18 INFO - PROCESS | 30492 | |9;json-stringify-tinderbox;61;62;61;61;61;60;60;61;61;61 13:02:18 INFO - PROCESS | 30492 | |10;stanford-crypto-aes;78;80;75;73;74;74;77;81;80;74 13:02:18 INFO - PROCESS | 30492 | |11;stanford-crypto-ccm;119;120;117;118;118;129;140;118;172;117 13:02:18 INFO - PROCESS | 30492 | |12;stanford-crypto-pbkdf2;156;154;153;155;153;154;156;160;156;156 13:02:18 INFO - PROCESS | 30492 | |13;stanford-crypto-sha256-iterative;63;62;62;63;61;61;61;61;62;62 13:02:18 INFO - PROCESS | 30492 | __end_tp_report 13:02:18 INFO - PROCESS | 30492 | __start_cc_report 13:02:18 INFO - PROCESS | 30492 | _x_x_mozilla_cycle_collect,1628 13:02:18 INFO - PROCESS | 30492 | __end_cc_report 13:02:18 INFO - PROCESS | 30492 | __startTimestamp1468872138313__endTimestamp 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | ------- Summary: start ------- 13:02:18 INFO - PROCESS | 30492 | Number of tests: 14 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.02 (2.7%) stddev-sans-first:0.83 13:02:18 INFO - PROCESS | 30492 | Values: 102.0 111.0 112.0 110.0 112.0 112.0 111.0 111.0 112.0 110.0 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:134.00 stddev:20.15 (15.0%) stddev-sans-first:20.52 13:02:18 INFO - PROCESS | 30492 | Values: 151.0 116.0 125.0 173.0 121.0 125.0 143.0 121.0 159.0 116.0 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 13:02:18 INFO - PROCESS | 30492 | Values: 162.0 162.0 161.0 162.0 160.0 161.0 161.0 162.0 161.0 162.0 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:13.35 (17.8%) stddev-sans-first:14.03 13:02:18 INFO - PROCESS | 30492 | Values: 76.0 74.0 74.0 111.0 75.0 75.0 75.0 75.0 101.0 75.0 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:84.00 stddev:19.56 (23.3%) stddev-sans-first:20.16 13:02:18 INFO - PROCESS | 30492 | Values: 83.0 88.0 117.0 84.0 84.0 84.0 123.0 83.0 84.0 132.0 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 13:02:18 INFO - PROCESS | 30492 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 116.0 118.0 116.0 117.0 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 13:02:18 INFO - PROCESS | 30492 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:02:18 INFO - PROCESS | 30492 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 96.0 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:51.00 stddev:1.16 (2.3%) stddev-sans-first:0.88 13:02:18 INFO - PROCESS | 30492 | Values: 53.0 51.0 50.0 50.0 49.0 51.0 50.0 50.0 51.0 52.0 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 13:02:18 INFO - PROCESS | 30492 | Values: 61.0 62.0 61.0 61.0 61.0 60.0 60.0 61.0 61.0 61.0 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:77.50 stddev:2.99 (3.9%) stddev-sans-first:3.13 13:02:18 INFO - PROCESS | 30492 | Values: 78.0 80.0 75.0 73.0 74.0 74.0 77.0 81.0 80.0 74.0 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:119.50 stddev:17.49 (14.6%) stddev-sans-first:18.32 13:02:18 INFO - PROCESS | 30492 | Values: 119.0 120.0 117.0 118.0 118.0 129.0 140.0 118.0 172.0 117.0 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:156.00 stddev:2.06 (1.3%) stddev-sans-first:2.17 13:02:18 INFO - PROCESS | 30492 | Values: 156.0 154.0 153.0 155.0 153.0 154.0 156.0 160.0 156.0 156.0 13:02:18 INFO - PROCESS | 30492 | 13:02:18 INFO - PROCESS | 30492 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.71 13:02:18 INFO - PROCESS | 30492 | Values: 63.0 62.0 62.0 63.0 61.0 61.0 61.0 61.0 62.0 62.0 13:02:18 INFO - PROCESS | 30492 | -------- Summary: end -------- 13:02:18 INFO - PROCESS | 30492 | 13:02:19 INFO - TEST-INFO | 30492: exit 0 13:02:19 INFO - TEST-OK | kraken | took 60573ms 13:02:19 INFO - SUITE-END | took 1173s 13:02:19 INFO - Completed test suite (00:19:33) 13:02:19 INFO - javascript benchmark 13:02:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.4780187368146, 3094.5667606535076, 3108.6735892731263, 3115.9844200778994, 3130.5617213590103, 5246.108161612526, 5292.073887069767, 5432.103702889023, 5531.197976293435, 5544.556435485157, 5347.331583552056, 5391.029614669358, 5409.29679141711, 5417.945820541793, 5462.371827239868, 4829.51704829516, 4915.6313276504225, 4927.950720492785, 4947.752612369385, 5120.436751957282, 5011.123053465629, 5015.247712843066, 5043.949560504403, 5068.011737711129, 5076.46697096805, 4824.083424149418, 4875.829345972892, 4902.730349830758, 4918.90162196754, 4927.531884470969, 4812.494688057738, 4813.109574728686, 4823.372961515016, 4849.878753031202, 4947.03532811102, 4846.660733748639, 4864.659473836833, 4877.244027175793, 4893.070316639827, 4924.409070911478, 5221.112410890158, 5310.840674779724, 5375.059364611177, 5398.028354896117, 5517.227588137664, 5717.656940583578, 5757.280339957505, 5772.422757724236, 5773.769049238067, 5775.653460792324, 5773.538116950634, 5794.217780599607, 5837.3287071986415, 5837.795677151322, 5847.619904706223, 5288.497592728685, 5423.810166644188, 5443.237946687467, 5467.234587157801, 5533.6403133796175, 6034.034554471264, 6037.6679282639, 6045.637261764308, 6047.365026672224, 6047.818565443044, 5514.338279406497, 5794.710264486843, 5805.245318108703, 5807.709614519257, 5825.563082768809, 5821.010428227211, 5821.301443826768, 5873.911891321633, 5957.6127551709, 5960.880782384328, 5852.326982396994, 5875.735591898375, 5881.05903055509, 5882.294124705063, 5931.051031834972, 5674.886502269931, 5774.2782152230975, 5843.678597677169, 5899.380565040609, 5907.556933230025, 4452.777361131931, 4465.59809617136, 4466.2853943369555, 4498.1003799239625, 4505.211587972091, 3948.0919388540797, 3961.801909904551, 3972.3644216925154, 3973.7615743055508, 4007.2786898358577, 5396.649217800909, 5427.185922111636, 5434.619576629677, 5589.524890384281, 5607.214989901417, 5757.510611598061, 5815.709214539341, 5830.504407125357, 5831.2127862738835, 5890.823275301748, 5411.729413529308, 5437.864053398617, 5443.183522471661, 5446.564274858081, 5448.046591846491, 4936.703797772145, 4941.50584941503, 4951.10880041596, 4967.677100988424, 4999.550040496373, 6000.159977603226, 6005.03919372907, 6006.189164462829, 6011.879762404815, 6048.818535443856, 5829.59192856496, 5831.912521312099, 5836.795712150054, 5844.386339434298, 5844.590878638624, 5876.382979787232, 5912.881742365214, 5934.821955341346, 5964.612300200473, 5999.1901093351835, 5693.117566777156, 5750.0, 5755.597108202385, 5756.079027355603, 5756.510696590837, 5839.8540036497725, 5845.41545845412, 5845.766169353178, 5853.239078919713, 5858.443447872445, 5484.424135465878, 5691.573132015033, 5701.572382071278, 5729.598928074995, 5765.827025189251, 5688.914666280092, 5720.6853623049465, 5725.16985037159, 5732.340780810094, 5742.971285143548, 5577.693226872561, 5722.914156287576, 5728.255326807488, 5730.111832665943, 5737.426257374229, 5621.971890140523, 5646.7458964347525, 5646.88706225865, 5690.4878560928055, 5739.5695322850115, 5560.332760068818, 5561.777528898799, 5571.582131340085, 5573.303337082864, 5581.944180558143], "value": 5355.810597761958, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.8161933039419, 637.7162162837537, 647.2168675902158, 651.3356376495974, 655.1286788571201, 31614.841925790366, 44129.117417651665, 45732.542674573204, 45797.08405831881, 49529.25706114411, 48517.0, 49017.75491122539, 49043.50956490434, 49086.50913490864, 49106.0, 9158.633654653806, 9298.721038368825, 9299.256059515257, 9306.348555601111, 9307.534623268843, 9071.092890710908, 9144.4970526621, 9163.725088247364, 9165.212783507219, 9173.357864949456, 9162.404443711137, 9181.908180918206, 9223.723288301328, 9228.446293222429, 9229.907700922971, 9149.45103293798, 9156.130167634064, 9207.90792092084, 9222.123898229658, 9224.0, 9115.22520585751, 9128.132827381389, 9147.725568232963, 9165.358424910259, 9182.586783594688, 44880.775596122134, 45177.32234016492, 45317.32024019642, 45326.093478130584, 45344.3198352025, 3314.2377253231653, 3486.0, 3642.2351306225723, 3708.8516459341595, 4019.979900100481, 34131.31737365239, 34433.65566344329, 34493.48259776105, 34499.482507762405, 35880.820595896854, 4366.847160349373, 4400.405945197389, 4417.359482874997, 4462.553744625544, 4488.887777805581, 239532.0, 239914.0, 240206.7989660058, 240490.0, 240979.0, 63855.0, 63915.0, 63926.680366597866, 64084.0, 64267.357326426136, 57987.71006144942, 64119.358806411336, 65545.67227163834, 65819.67090164518, 67198.32801671921, 16330.0, 16478.42325518601, 16550.83449165517, 16566.50300490987, 16573.83426165723, 11883.643490695293, 12018.15872888907, 12018.639440816789, 12028.0, 12029.518819247307, 16580.75128873068, 16868.662626747395, 18598.814011859708, 19106.0, 19163.233470661296, 6458.8351707662905, 6550.901736473957, 6579.80260592183, 6597.109390232353, 6630.469562434993, 970.2189737261431, 1036.8859425463193, 1074.3929679730927, 1085.8696956365286, 1130.46867972053, 33551.49672754911, 33681.494777577864, 33792.0, 33855.66144338525, 33933.32133357319, 1075.2258373970728, 1117.9776404472027, 1122.927009744364, 1203.9036877049814, 1205.3069485046133, 17857.46427607174, 17960.461186164437, 17998.0, 18046.0, 18087.18607662658, 557110.0, 557806.1645376612, 562692.0, 563622.0, 565084.0, 60659.39340606538, 60758.39241607527, 60847.391526085055, 60949.69525152346, 61083.0, 1339.3771896068374, 1344.5562964221783, 1364.8703373179533, 1378.4141739760562, 1390.8400533938727, 32303.0, 33550.0, 33664.49503257404, 33829.154271143416, 34455.138621534665, 63584.36415635784, 64988.0, 65044.349556505724, 65311.346886532425, 65324.34675653183, 388919.0, 395583.0, 395585.0, 395825.0, 396436.0, 25333.113341032975, 28434.715652844036, 29188.708112918597, 29485.410291793614, 29562.704372956854, 50004.749976249885, 50457.24314135218, 51199.74400127975, 54147.458525414244, 54985.0, 42882.0, 43195.78402107969, 44028.77985610051, 44418.111637766415, 44639.55360446354, 43180.352294716235, 43865.12269754651, 43928.56071439372, 44234.77882610566, 44895.32657010082, 44441.33337999868, 44913.32630010618, 45474.0, 46667.533324667675, 47069.76465117653, 36774.26451471009, 38701.22597547977, 39323.83544738413, 39398.60601393949, 39893.60106399015, 29106.12681619555, 29197.562036569045, 29589.408211836075, 29669.703302966693, 29914.850425747733], "value": 20688.316995980353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.32031066720566, 399.8840336302472, 401.3377926421404, 401.77701375736456, 421.91350773091517, 13645.0, 19201.615967680656, 20776.272830450936, 20799.792002079976, 21230.77076906926, 20132.698009529868, 20532.07605657745, 20892.866070089494, 21122.366329010154, 21136.260230891923, 5402.729863506819, 5522.337319521663, 5528.281323427948, 5529.695866727328, 5555.555555555566, 4038.9394159087637, 5450.073487507133, 5488.259085023531, 5491.670499770006, 5493.945060549383, 7374.0, 7733.961330193341, 7744.225577442267, 7756.883646745275, 7901.051873775155, 7415.88876166858, 7689.50018248812, 7738.110117336522, 7750.0699916010435, 7752.341051010642, 7197.856042879165, 7402.518836275679, 7407.555546667218, 7544.886826697549, 7549.584772837547, 27578.0, 28136.29659258535, 28210.71789282122, 28439.289017774514, 28540.714592854012, 2495.1516484395393, 2526.734692857242, 2554.8339357941672, 2599.6620439342764, 2610.7128215896237, 16002.519924402286, 16692.24884880183, 17209.225584848587, 17261.56846078858, 17276.56808579783, 2117.6929345245007, 2140.8501404901663, 2160.1899287767087, 2211.9447013824783, 2212.5021870079263, 102464.0, 103309.48345258301, 103967.4801625987, 104520.0, 104878.99999999924, 18122.184501697455, 18634.440966771017, 18742.531436713918, 18974.335898243495, 19476.70784938227, 33803.32393352119, 33933.83033084868, 34285.0, 34383.484247736305, 34402.311953760785, 9450.763730906645, 9539.427634341962, 9632.566534505964, 9677.758056048655, 9740.269479789044, 7833.1775163608145, 7894.447388682737, 7923.286904178652, 8021.2379823916635, 8063.5968201589685, 9025.909740902638, 9057.637694492147, 9213.539323033821, 9298.302627302844, 9409.412411586869, 3349.598048234179, 3394.9830250848586, 3563.8396272167815, 3582.874599389009, 3646.854125834937, 921.3964853021282, 986.5313975861409, 1001.7395477175987, 1013.8479228115841, 1085.2403317677656, 19656.80343196578, 20072.297469588495, 20919.0, 21199.364019079454, 22107.11571537153, 974.8488984207318, 1008.5814387029448, 1027.6403258859339, 1027.7851230598073, 1047.1256500821898, 11241.662750117346, 11770.705732356759, 11782.823257651142, 11917.940410297893, 11957.0, 191891.0, 515934.0, 584342.0, 597439.0, 602766.0, 104015.0, 104775.99999999847, 105207.0, 105352.0, 105560.0, 1052.9105026072716, 1056.4189695667353, 1083.8590983172137, 1090.0788833435734, 1092.3500517192258, 18408.815911841248, 18539.35112271064, 18873.71689424632, 19009.914830309648, 19208.807911920703, 42725.786371067945, 44237.778811107026, 44740.10519789651, 44916.30052833917, 44942.550574493835, 58272.4172758267, 58577.414225857196, 63593.3640663606, 64296.106675200666, 64535.67732161309, 8229.506229626242, 8565.657373705231, 8655.56722163902, 8661.0, 9085.409448385833, 7786.454948153575, 8706.695265665672, 9748.732664753537, 9761.46311952821, 13594.11638243511, 11236.775264494829, 11401.543938242377, 11415.60045398407, 11438.485268162785, 11474.426278685865, 11410.942945285553, 11493.540258389905, 11503.194776365573, 11578.71053223676, 11830.46762895689, 11544.94227528857, 11800.291982481078, 11892.167548271884, 11910.344931028876, 11971.880281197426, 8609.48343099416, 8742.256908162622, 8793.20861122502, 8806.735797926072, 8913.509756963429, 11716.355600441717, 11766.58816941403, 11867.525298987945, 11940.223885447418, 12030.879691202976], "value": 10622.388949828382, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.1161833190097, 1482.6589884326609, 1526.107227272046, 1676.7149584570623, 1828.5611453251224, 8497.617607207674, 8776.297896168307, 8782.912170878297, 8796.736097917064, 9029.142231488015, 8352.582370881462, 8610.741677749662, 8772.29821614271, 8797.912020879789, 8804.33967452442, 2065.297798748425, 2119.73503312086, 2120.7455105387376, 2337.871417072056, 2383.0944241188413, 2172.3808714516285, 2179.607670619288, 2342.0982921575146, 2412.421018955447, 2414.782669559739, 2380.0836677879056, 2388.36708272308, 2413.095089341497, 2413.3966508372905, 2413.650020746991, 2046.1610739596695, 2328.2433209206993, 2331.2306938710185, 2333.195047708538, 2334.1713691639393, 2271.8409711320214, 2336.4158960259933, 2350.811935045192, 2351.353377821096, 2356.7996720278625, 8865.911340886638, 8898.4660920345, 8923.509206993613, 8926.196642302159, 8941.284697224206, 5374.193870919355, 5495.752691128869, 5511.862203444906, 5513.669179849222, 5529.612927095105, 3330.1008727643643, 3408.2842603053386, 3506.4389697648508, 3508.2106526031694, 3521.1197200699826, 1224.406163010939, 1230.7538492301576, 1241.503398640542, 1273.6179146256086, 1288.6005338345144, 12540.24758514492, 12867.163634363736, 12910.031747618967, 12911.80632290507, 12956.09307348486, 4797.808087676523, 4822.324874517571, 4833.4441539223435, 4890.339804126468, 4942.135126352874, 10752.731181720363, 10773.35359878394, 10792.190585706103, 10805.621803237007, 10805.945970270099, 5548.69482178476, 5563.638363506359, 5571.1086226203615, 5575.414581468968, 5575.832725018256, 5028.245763135559, 5081.9745901271, 5105.897882042413, 5107.336046313955, 5145.897082058338, 4075.7146999709735, 4086.17136418224, 4147.730397524151, 4182.790860456965, 4188.643965262987, 1249.5688987299368, 1252.9060320476, 1277.5975567696146, 1280.2638482872385, 1326.6683329167709, 1008.2438171371472, 1012.7771890184295, 1012.8581998520214, 1015.4770293298957, 1036.486938965217, 6171.0, 6255.97038688103, 6441.549091563639, 6483.578567393104, 6493.285738568754, 463.84693051292993, 476.56632464457175, 487.90973669871187, 490.0908814149772, 492.4533767518052, 4469.798859051285, 4497.8425755098415, 4517.457905051349, 4523.705959112647, 4552.476465206478, 10866.836997445045, 11299.435028248554, 11320.943395282971, 11384.829227561593, 11391.0, 10802.459877006118, 11209.215354925076, 11216.102711783038, 11236.269642473377, 11264.887351126548, 8421.578921054046, 8535.890334256506, 8591.097934716765, 8622.655093796304, 8632.35257355701, 6356.936430635635, 6386.489080873426, 6688.431483323778, 6688.431483323972, 6806.319368063352, 10085.29402941787, 10702.250842440955, 10727.839082413926, 10815.621453249098, 10838.729031774268, 9515.33392662507, 10187.694369168938, 10492.632757853438, 10825.67522974312, 10839.67480975572, 7652.966849475472, 7976.202379761978, 7983.72056978003, 8009.479383840032, 8036.839263214586, 8787.648494060422, 8874.156955089256, 8880.555972201493, 8883.33374996865, 8897.955510222408, 7521.661525231269, 7728.227177282227, 7759.146493885781, 7868.803279918048, 7919.08930473003, 7633.732819351296, 7869.3311068559815, 7920.0, 8096.87854682192, 8102.0, 7250.564966102051, 7274.6726397313305, 7308.817279568053, 7316.451266154953, 7319.74380896666, 5371.811986580451, 5409.83770486886, 5537.6954267515675, 5645.802396916089, 5705.058665320175, 5477.233187353853, 5494.587905906993, 5504.9449505504435, 5785.450382213683, 5830.53355731549], "value": 4716.773706078191, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.79463898009857, 337.89187460012795, 346.2434580441735, 347.41634054787977, 348.42509858733104, 5296.947030529694, 5300.893982120355, 5327.2808170896915, 5357.642637239616, 5381.730913454321, 5264.447233040533, 5279.63042587019, 5301.920471192935, 5309.133068143207, 5313.22958171065, 3982.6614737747327, 4187.602177793105, 4198.958010419895, 4220.514640816299, 4224.366345048252, 3859.864904728335, 3919.196564704229, 4009.8596549120784, 4035.899102522446, 4142.875713728593, 4085.8774236772942, 4089.6114869087387, 4098.323776576876, 4127.36025915982, 4130.690198235129, 4064.841520166753, 4105.958940410603, 4111.1366613011305, 4124.91750164995, 4139.296319625671, 3537.7700449470703, 3596.1908570571672, 3697.8890633281044, 3703.518542589473, 3727.403615421547, 5117.33474648297, 5127.307813445212, 5143.305653736735, 5157.0, 5161.61287903405, 4779.661694725482, 4785.186518291864, 4792.209285467894, 4795.232762757977, 4812.446568644616, 5542.422773410383, 5548.944510554883, 5568.9443105569235, 5586.217929489874, 5589.133684278943, 3893.532776066862, 3983.8406463741417, 4115.73247738896, 4124.793760311973, 4125.443065186221, 5464.289642346509, 5630.831075067755, 5639.238702775114, 5678.488935995739, 5710.600257981984, 3989.7805620691142, 4045.8583949561626, 4060.0, 4066.7356621820077, 4072.633462988286, 4006.2988976928923, 4111.671066314688, 4127.0, 4128.112455821953, 4163.208990291835, 4672.836450724276, 4696.9060618787435, 4724.189107481044, 4757.549861821165, 4760.500147484534, 5477.917831232535, 5483.533899618497, 5484.0, 5484.369297530755, 5507.917381239285, 1398.9440422383195, 1415.950441734555, 1435.1389166500016, 1435.454527279627, 1436.5115860607443, 940.6895724410928, 965.2181732796457, 965.9130678238993, 966.8211380894417, 972.6692924405736, 4653.674242802971, 4758.904821903542, 4761.214399624093, 4778.761061946889, 4797.40032495938, 5009.974950125226, 5031.74841257943, 5042.873928151826, 5049.192129259301, 5056.772445239973, 4754.23932170851, 4773.618110551148, 4793.688410253322, 4797.832075877328, 4897.191963326082, 2517.43357744506, 2669.1449442637568, 2669.7585622685547, 2696.9325766855986, 2702.7297270273207, 5127.8718032048755, 5137.486251374833, 5152.201408781645, 5160.406553246425, 5168.9483105168465, 5103.907397966816, 5125.308083408692, 5134.204198349187, 5136.149437062391, 5193.3767947845745, 5134.409542902539, 5143.688359468311, 5158.664686795346, 5442.23808666779, 5887.293524777054, 5657.60396772222, 5683.658980461186, 5715.714214289185, 5716.314042314949, 5718.456746609066, 5405.648632838853, 5537.141743029837, 5669.574781891457, 5729.512991395612, 5735.3977832327, 5866.178734977021, 5866.560007999503, 5881.617694849821, 5893.499052580579, 5897.321807991964, 4062.2078694655443, 4089.325261331847, 4099.1596722672375, 4122.587741225853, 4125.133721918431, 5609.382967873449, 5709.571782116441, 5737.139429085503, 5755.1367294906095, 5761.510271626791, 5547.61166718342, 5594.776208951596, 5642.069058605448, 5672.688002159921, 5680.943190568207, 5336.3863155736035, 5560.6107572471155, 5580.665160090408, 5588.41321661236, 5609.298837645294, 5555.111182210827, 5583.55331573465, 5585.3297604287745, 5590.133529302964, 5600.943990560042, 5557.5831812613405, 5577.406505974741, 5629.536320556766, 5653.717314134195, 5696.231008813923, 5241.659292145999, 5508.9724551376985, 5511.614187006871, 5515.751791169327, 5524.475174858382], "value": 4155.286524862989, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.5503473089801, 836.6109758962082, 851.1148405658116, 859.3683642522741, 863.7970077031898, 17251.741223881636, 17840.464786056407, 17874.0, 17879.37422190222, 17946.0, 15885.84114158858, 15998.200089995511, 16007.19964001801, 16034.75947860783, 16045.277962491688, 679.5956405938458, 828.1552816127546, 851.4763420496381, 852.5566705313233, 853.1511146409331, 822.181928980665, 841.247083859945, 843.0768308701993, 844.7339088187201, 846.2510678049908, 878.2578720980792, 882.3999680217449, 884.2793123604242, 887.2901678657081, 888.2272422991974, 706.6360824175554, 714.9714011439536, 880.2649787427506, 882.6557642519423, 882.8278485695292, 533.1868899927641, 620.1225266248254, 628.3339659960457, 633.2843886408375, 635.1330433957614, 15923.601909952344, 15926.28331725075, 15930.362785488567, 15935.760963585555, 16031.679366412607, 14294.857483069116, 14302.141871487744, 14522.854771452256, 14538.273086345745, 14550.854491455162, 12998.740025199537, 13067.346632668423, 13081.476740930351, 13210.537631182959, 13294.069415140944, 4491.663125265585, 4494.325851122358, 4501.842435514774, 4510.368548403226, 4706.599939005188, 79464.60267698682, 80417.0, 81360.59319703422, 81637.0, 82598.58700706458, 11373.0, 11493.597724079616, 11561.015642485954, 11566.132540059361, 11847.703807404712, 21132.683009754866, 21140.365789026353, 21144.471388215417, 21159.25942592002, 21168.259110931045, 8178.386621003448, 8220.876686849702, 8346.540940248224, 8449.986001679837, 8453.619587118594, 4672.602828759525, 4727.220008698595, 4772.880677983008, 4859.1496488114435, 5021.72380519075, 3274.885379011723, 3363.4618461046116, 3370.5449764282, 3374.443216869189, 3375.0549846043145, 640.3308542573022, 647.152230577935, 653.9182602174728, 654.9967250163814, 656.7832615236961, 654.482958462809, 679.2392520377209, 703.5778532880231, 710.4245561095529, 714.8284411741249, 9574.521273936276, 10003.949980250052, 10060.144887684482, 10080.647177348757, 10097.545610447547, 605.4581149870841, 686.6703982088626, 693.1197379328325, 721.4084450750335, 744.728174216418, 4857.247126695368, 5001.374828146481, 5135.563477104488, 5330.173823057432, 5460.6177567569885, 110878.0, 113102.0, 113605.0, 114288.42855785668, 117852.0, 98515.0, 101393.99999999853, 103612.48193758982, 103837.48081259546, 106787.0, 92270.53864730634, 94288.0, 94348.0, 94470.0, 94747.0, 9556.378835375679, 9639.71080867575, 9662.178714809039, 9864.408135511892, 9909.603615855285, 45256.77371613121, 48394.0, 48460.273095902885, 51195.232071518214, 53289.73355133199, 49282.26076608782, 66025.0096248547, 75291.21214242114, 77967.22032779599, 79640.60179699064, 13464.663383415493, 13505.161287122126, 13592.932035340156, 13634.590962271148, 14099.577012689635, 15406.845931540542, 15423.0, 15539.766903496682, 15695.136767477441, 15778.605534861721, 13887.861121388656, 14107.858921410654, 14235.50175743844, 14472.710545789236, 14660.85339146595, 12942.741145176855, 13488.73022539524, 13524.72950540964, 13719.176849389069, 13764.862351376358, 13505.12216705911, 13553.932230338785, 13581.796273055714, 13915.108459220513, 14075.0, 11606.24559403636, 11606.30362178272, 11635.301881887113, 11832.645020649394, 11962.342071186169, 10879.347239165676, 11425.2002359834, 11425.31448113116, 11429.428528573371, 11609.419529023684], "value": 7776.4333782855, "unit": "score"}], "name": "dromaeo_css", "value": 7510.0225981165095, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 112.0, 110.0, 112.0, 112.0, 111.0, 111.0, 112.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 116.0, 125.0, 173.0, 121.0, 125.0, 143.0, 121.0, 159.0, 116.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 160.0, 161.0, 161.0, 162.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 111.0, 75.0, 75.0, 75.0, 75.0, 101.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 117.0, 84.0, 84.0, 84.0, 123.0, 83.0, 84.0, 132.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 118.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 96.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 50.0, 50.0, 49.0, 51.0, 50.0, 50.0, 51.0, 52.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 60.0, 60.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 75.0, 73.0, 74.0, 74.0, 77.0, 81.0, 80.0, 74.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 117.0, 118.0, 118.0, 129.0, 140.0, 118.0, 172.0, 117.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 153.0, 155.0, 153.0, 154.0, 156.0, 160.0, 156.0, 156.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 63.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0], "value": 61.8, "unit": "score"}], "name": "kraken", "value": 1473.5, "alertThreshold": 2.0}]} 13:02:19 INFO - Return code: 0 13:02:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:02:19 INFO - # TBPL SUCCESS # 13:02:19 INFO - Running post-action listener: _resource_record_post_action 13:02:19 INFO - ##### 13:02:19 INFO - ##### Finished run-tests step (success) 13:02:19 INFO - ##### 13:02:19 INFO - Running post-run listener: _resource_record_post_run 13:02:19 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 554172416; Read time: 148; Write time: 579128 13:02:19 INFO - TinderboxPrint: CPU usage
13.0% 13:02:19 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 148 13:02:19 INFO - TinderboxPrint: I/O write bytes / time
554,172,416 / 579,128 13:02:19 INFO - TinderboxPrint: CPU idle
8,264.8 (86.9%) 13:02:19 INFO - TinderboxPrint: CPU user
1,196.1 (12.6%) 13:02:19 INFO - TinderboxPrint: Swap in / out
0 / 0 13:02:19 INFO - install - Wall time: 18s; CPU: 15.0%; Read bytes: 0; Write bytes: 257449984; Read time: 0; Write time: 378548 13:02:19 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296722432; Read time: 136; Write time: 200580 13:02:20 INFO - Running post-run listener: _upload_blobber_files 13:02:20 INFO - Blob upload gear active. 13:02:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:02:20 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 13:02:20 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:02:20 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:02:20 INFO - (blobuploader) - INFO - Open directory for files ... 13:02:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:02:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:02:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:24 INFO - (blobuploader) - INFO - Done attempting. 13:02:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:02:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:02:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:25 INFO - (blobuploader) - INFO - Done attempting. 13:02:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:02:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:02:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:26 INFO - (blobuploader) - INFO - Done attempting. 13:02:26 INFO - (blobuploader) - INFO - Iteration through files over. 13:02:26 INFO - Return code: 0 13:02:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:02:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:02:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a0c05ca49aa9ce2e512bd4ea76db9410664156cae14650a0d28ffd93db9fd1b0bfac02bebd91533a2dec186d7d1e60470469acb32d948ed8cd87649e4cb4827", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d986fe2da7c66fc9733030adaadd22245d288bb3b328b83900de64b44f495a697c6b5793cb604d6b74b019ffb83a472a5f1204ff831dda14808e8d002bcff7d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/890e61f93383beda3e2a363f7ae9901c086c9140485c44e674a0c5eaf2c3f4c4e2fda149ba8d8d1ecc68e21c0006e7c0825aa1c6c87aa4d1e0a3d05fdde20162"} 13:02:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:02:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:02:26 INFO - Contents: 13:02:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a0c05ca49aa9ce2e512bd4ea76db9410664156cae14650a0d28ffd93db9fd1b0bfac02bebd91533a2dec186d7d1e60470469acb32d948ed8cd87649e4cb4827", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d986fe2da7c66fc9733030adaadd22245d288bb3b328b83900de64b44f495a697c6b5793cb604d6b74b019ffb83a472a5f1204ff831dda14808e8d002bcff7d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/890e61f93383beda3e2a363f7ae9901c086c9140485c44e674a0c5eaf2c3f4c4e2fda149ba8d8d1ecc68e21c0006e7c0825aa1c6c87aa4d1e0a3d05fdde20162"} 13:02:26 INFO - Running post-run listener: copy_logs_to_upload_dir 13:02:26 INFO - Copying logs to upload dir... 13:02:26 INFO - mkdir: /builds/slave/test/build/upload/logs 13:02:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.336462 ========= master_lag: 11.81 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-18 13:02:37.839011) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 13:02:37.842906) ========= 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=db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345 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/sha512/3a0c05ca49aa9ce2e512bd4ea76db9410664156cae14650a0d28ffd93db9fd1b0bfac02bebd91533a2dec186d7d1e60470469acb32d948ed8cd87649e4cb4827", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d986fe2da7c66fc9733030adaadd22245d288bb3b328b83900de64b44f495a697c6b5793cb604d6b74b019ffb83a472a5f1204ff831dda14808e8d002bcff7d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/890e61f93383beda3e2a363f7ae9901c086c9140485c44e674a0c5eaf2c3f4c4e2fda149ba8d8d1ecc68e21c0006e7c0825aa1c6c87aa4d1e0a3d05fdde20162"} build_url:https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/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/sha512/3a0c05ca49aa9ce2e512bd4ea76db9410664156cae14650a0d28ffd93db9fd1b0bfac02bebd91533a2dec186d7d1e60470469acb32d948ed8cd87649e4cb4827", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d986fe2da7c66fc9733030adaadd22245d288bb3b328b83900de64b44f495a697c6b5793cb604d6b74b019ffb83a472a5f1204ff831dda14808e8d002bcff7d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/890e61f93383beda3e2a363f7ae9901c086c9140485c44e674a0c5eaf2c3f4c4e2fda149ba8d8d1ecc68e21c0006e7c0825aa1c6c87aa4d1e0a3d05fdde20162"}' ========= master_lag: 0.35 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 13:02:38.202087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 13:02:38.202494) ========= 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=db0483c52d987ecb441a263b000001ad-1468869047.36635-2003378345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 1.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 13:02:39.213539) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 13:02:39.213842) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 13:02:39.458215) ========= ========= Total master_lag: 13.28 =========