builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1469017800.38 results: success (0) buildid: 20160720023015 builduid: d793c3754662446ca2c5d4cb8c6c7edb revision: e904e18d7dfcd8097f92d44104ca1462fc5d1335 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 05:30:00.384742) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 05:30:00.385273) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 05:30:00.385578) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 05:30:00.455847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 05:30:00.456257) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 05:30:00-- 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% 21.2M=0.001s 2016-07-20 05:30:00 (21.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191201 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 05:30:00.677050) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 05:30:00.677614) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.125657 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 05:30:00.816620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 05:30:00.817005) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e904e18d7dfcd8097f92d44104ca1462fc5d1335 --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 e904e18d7dfcd8097f92d44104ca1462fc5d1335 --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=9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 05:30:00,839 truncating revision to first 12 chars 2016-07-20 05:30:00,839 Setting DEBUG logging. 2016-07-20 05:30:00,839 attempt 1/10 2016-07-20 05:30:00,839 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e904e18d7dfc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 05:30:01,145 unpacking tar archive at: fx-team-e904e18d7dfc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 05:30:01.475680) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 05:30:01.476091) ========= script_repo_revision: e904e18d7dfcd8097f92d44104ca1462fc5d1335 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 05:30:01.476613) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 05:30:01.476890) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 05:30:01.487898) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-20 05:30:01.488300) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:30:01 INFO - MultiFileLogger online at 20160720 05:30:01 in /builds/slave/test 05:30:01 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 05:30:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:30:01 INFO - {'append_to_log': False, 05:30:01 INFO - 'base_work_dir': '/builds/slave/test', 05:30:01 INFO - 'blob_upload_branch': 'Fx-Team', 05:30:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:30:01 INFO - 'branch': 'Fx-Team', 05:30:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:30:01 INFO - 'config_files': ('talos/linux_config.py',), 05:30:01 INFO - 'default_actions': ('clobber', 05:30:01 INFO - 'read-buildbot-config', 05:30:01 INFO - 'download-and-extract', 05:30:01 INFO - 'populate-webroot', 05:30:01 INFO - 'create-virtualenv', 05:30:01 INFO - 'install', 05:30:01 INFO - 'run-tests'), 05:30:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:30:01 INFO - 'download_minidump_stackwalk': True, 05:30:01 INFO - 'download_symbols': 'ondemand', 05:30:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:30:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:30:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:30:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:30:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:30:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:30:01 INFO - 'installer_path': 'installer.exe', 05:30:01 INFO - 'log_level': 'info', 05:30:01 INFO - 'log_name': 'talos', 05:30:01 INFO - 'log_to_console': True, 05:30:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:30:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:30:01 INFO - 'opt_config_files': (), 05:30:01 INFO - 'pip_index': False, 05:30:01 INFO - 'sps_profile': False, 05:30:01 INFO - 'sps_profile_interval': 0, 05:30:01 INFO - 'suite': 'dromaeojs', 05:30:01 INFO - 'system_bits': '32', 05:30:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:30:01 INFO - 'title': 'talos-linux64-ix-040', 05:30:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:30:01 INFO - 'use_talos_json': True, 05:30:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:30:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:30:01 INFO - 'work_dir': 'build'} 05:30:01 INFO - [mozharness: 2016-07-20 12:30:01.742942Z] Running clobber step. 05:30:01 INFO - Running pre-action listener: _resource_record_pre_action 05:30:01 INFO - Running main action method: clobber 05:30:01 INFO - rmtree: /builds/slave/test/build 05:30:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:30:02 INFO - Running post-action listener: _resource_record_post_action 05:30:02 INFO - [mozharness: 2016-07-20 12:30:02.900879Z] Finished clobber step (success) 05:30:02 INFO - [mozharness: 2016-07-20 12:30:02.900980Z] Running read-buildbot-config step. 05:30:02 INFO - Running pre-action listener: _resource_record_pre_action 05:30:02 INFO - Running main action method: read_buildbot_config 05:30:02 INFO - Using buildbot properties: 05:30:02 INFO - { 05:30:02 INFO - "project": "", 05:30:02 INFO - "product": "firefox", 05:30:02 INFO - "script_repo_revision": "production", 05:30:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:30:02 INFO - "repository": "", 05:30:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:30:02 INFO - "buildid": "20160720023015", 05:30:02 INFO - "pgo_build": "True", 05:30:02 INFO - "basedir": "/builds/slave/test", 05:30:02 INFO - "buildnumber": 304, 05:30:02 INFO - "slavename": "talos-linux64-ix-040", 05:30:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:30:02 INFO - "platform": "ubuntu64_hw", 05:30:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:30:02 INFO - "branch": "fx-team", 05:30:02 INFO - "repo_path": "integration/fx-team", 05:30:02 INFO - "revision": "e904e18d7dfcd8097f92d44104ca1462fc5d1335", 05:30:02 INFO - "stage_platform": "linux64-pgo", 05:30:02 INFO - "builduid": "d793c3754662446ca2c5d4cb8c6c7edb", 05:30:02 INFO - "slavebuilddir": "test" 05:30:02 INFO - } 05:30:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:30:02 INFO - Running post-action listener: _resource_record_post_action 05:30:02 INFO - [mozharness: 2016-07-20 12:30:02.903464Z] Finished read-buildbot-config step (success) 05:30:02 INFO - [mozharness: 2016-07-20 12:30:02.903553Z] Running download-and-extract step. 05:30:02 INFO - Running pre-action listener: _resource_record_pre_action 05:30:02 INFO - Running main action method: download_and_extract 05:30:02 INFO - mkdir: /builds/slave/test/build/tests 05:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:02 INFO - https://queue.taskcluster.net/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:30:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:30:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:30:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/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 05:30:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/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 05:30:04 INFO - Downloaded 1361 bytes. 05:30:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:30:04 INFO - Using the following test package requirements: 05:30:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:30:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:30:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:30:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:04 INFO - u'jsshell-linux-x86_64.zip'], 05:30:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:30:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:30:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:30:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:30:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:30:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:30:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:04 INFO - https://queue.taskcluster.net/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:30:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:30:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:30:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/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 05:30:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/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 05:30:05 INFO - Downloaded 24343482 bytes. 05:30:05 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'] 05:30:05 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 05:30:06 INFO - Return code: 0 05:30:06 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 05:30:06 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')]} 05:30:06 INFO - https://queue.taskcluster.net/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:30:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:30:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:30:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/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 05:30:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/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 05:30:07 INFO - Downloaded 24343482 bytes. 05:30:07 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'] 05:30:07 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 05:30:09 INFO - Return code: 0 05:30: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')]} 05:30:09 INFO - https://queue.taskcluster.net/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:30:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:30:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:30:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/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 05:30:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/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 05:30:10 INFO - Downloaded 14403317 bytes. 05:30:10 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'] 05:30:10 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 05:30:10 INFO - Return code: 0 05:30:10 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')]} 05:30:10 INFO - https://queue.taskcluster.net/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:30:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:30:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:30:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/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 05:30:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_Nqahx5S5GUT_YikbDSiA/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 05:30:11 INFO - Downloaded 60896485 bytes. 05:30:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:30:11 INFO - mkdir: /builds/slave/test/properties 05:30:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:30:11 INFO - Writing to file /builds/slave/test/properties/build_url 05:30:11 INFO - Contents: 05:30:11 INFO - build_url:https://queue.taskcluster.net/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:30:12 INFO - Running post-action listener: _resource_record_post_action 05:30:12 INFO - Running post-action listener: set_extra_try_arguments 05:30:12 INFO - [mozharness: 2016-07-20 12:30:12.627690Z] Finished download-and-extract step (success) 05:30:12 INFO - [mozharness: 2016-07-20 12:30:12.627924Z] Running populate-webroot step. 05:30:12 INFO - Running pre-action listener: _resource_record_pre_action 05:30:12 INFO - Running main action method: populate_webroot 05:30:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:30:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:30:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:30:12 INFO - '--tppagecycles', 05:30:12 INFO - '7'], 05:30:12 INFO - 'tests': ['tsvgm']}}, 05:30:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:30:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:30:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:30:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:30:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:30:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:30:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:12 INFO - 'talos_options': ['--disable-e10s'], 05:30:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:12 INFO - 'talos_options': ['--disable-e10s'], 05:30:12 INFO - 'tests': ['damp', 'tps']}, 05:30:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:12 INFO - 'tests': ['damp', 'tps']}, 05:30:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:30:12 INFO - 'tests': ['dromaeo_dom']}, 05:30:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:30:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:30:12 INFO - 'tests': ['basic_compositor_video']}, 05:30:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:30:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:30:12 INFO - 'tests': ['a11yr', 05:30:12 INFO - 'ts_paint', 05:30:12 INFO - 'tpaint', 05:30:12 INFO - 'sessionrestore', 05:30:12 INFO - 'sessionrestore_no_auto_restore', 05:30:12 INFO - 'tabpaint']}, 05:30:12 INFO - 'other-e10s': {'tests': ['a11yr', 05:30:12 INFO - 'ts_paint', 05:30:12 INFO - 'tpaint', 05:30:12 INFO - 'sessionrestore', 05:30:12 INFO - 'sessionrestore_no_auto_restore', 05:30:12 INFO - 'tabpaint']}, 05:30:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:30:12 INFO - 'ts_paint', 05:30:12 INFO - 'tpaint', 05:30:12 INFO - 'sessionrestore', 05:30:12 INFO - 'sessionrestore_no_auto_restore', 05:30:12 INFO - 'tabpaint']}, 05:30:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:30:12 INFO - 'ts_paint', 05:30:12 INFO - 'tpaint', 05:30:12 INFO - 'sessionrestore', 05:30:12 INFO - 'sessionrestore_no_auto_restore', 05:30:12 INFO - 'tabpaint']}, 05:30:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:30:12 INFO - 'tests': ['a11yr', 05:30:12 INFO - 'ts_paint', 05:30:12 INFO - 'tpaint', 05:30:12 INFO - 'sessionrestore', 05:30:12 INFO - 'sessionrestore_no_auto_restore', 05:30:12 INFO - 'tabpaint']}, 05:30:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:30:12 INFO - 'tests': ['a11yr', 05:30:12 INFO - 'ts_paint', 05:30:12 INFO - 'tpaint', 05:30:12 INFO - 'sessionrestore', 05:30:12 INFO - 'sessionrestore_no_auto_restore', 05:30:12 INFO - 'tabpaint']}, 05:30:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:30:12 INFO - 'tests': ['tsvgx', 05:30:12 INFO - 'tsvgr_opacity', 05:30:12 INFO - 'tart', 05:30:12 INFO - 'tscrollx', 05:30:12 INFO - 'cart']}, 05:30:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:30:12 INFO - 'tsvgr_opacity', 05:30:12 INFO - 'tart', 05:30:12 INFO - 'tscrollx', 05:30:12 INFO - 'cart']}, 05:30:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:12 INFO - 'talos_options': ['--disable-e10s'], 05:30:12 INFO - 'tests': ['tp5o']}, 05:30:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:12 INFO - 'tests': ['tp5o']}, 05:30:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:12 INFO - 'talos_options': ['--disable-e10s', 05:30:12 INFO - '--xperf_path', 05:30:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:12 INFO - 'tests': ['tp5n']}, 05:30:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:12 INFO - 'talos_options': ['--xperf_path', 05:30:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:12 INFO - 'tests': ['tp5n']}}, 05:30:12 INFO - 'talos.zip': {'path': '', 05:30:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:30:12 INFO - Running post-action listener: _resource_record_post_action 05:30:12 INFO - [mozharness: 2016-07-20 12:30:12.647383Z] Finished populate-webroot step (success) 05:30:12 INFO - [mozharness: 2016-07-20 12:30:12.647472Z] Running create-virtualenv step. 05:30:12 INFO - Running pre-action listener: _resource_record_pre_action 05:30:12 INFO - Running main action method: create_virtualenv 05:30:12 INFO - Creating virtualenv /builds/slave/test/build/venv 05:30:12 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 05:30:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:30:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:12 INFO - Using real prefix '/usr' 05:30:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:30:13 INFO - Installing distribute.............................................................................................................................................................................................done. 05:30:16 INFO - Installing pip.................done. 05:30:16 INFO - Return code: 0 05:30:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b63b0>, '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 0x20b72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b7740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', '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 05:30: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', 'pip>=1.5'] in /builds/slave/test/build 05:30: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 pip>=1.5 05:30:16 INFO - Using env: {'DISPLAY': ':0', 05:30:16 INFO - 'HOME': '/home/cltbld', 05:30:16 INFO - 'LANG': 'en_US.UTF-8', 05:30:16 INFO - 'LANGUAGE': 'en_US:en', 05:30:16 INFO - 'LOGNAME': 'cltbld', 05:30:16 INFO - 'MAIL': '/var/mail/cltbld', 05:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:16 INFO - 'MOZ_NO_REMOTE': '1', 05:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:16 INFO - 'NO_EM_RESTART': '1', 05:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:16 INFO - 'PWD': '/builds/slave/test', 05:30:16 INFO - 'SHELL': '/bin/bash', 05:30:16 INFO - 'SHLVL': '1', 05:30:16 INFO - 'TERM': 'linux', 05:30:16 INFO - 'TMOUT': '86400', 05:30:16 INFO - 'USER': 'cltbld', 05:30:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', 05:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:16 INFO - '_': '/tools/buildbot/bin/python'} 05:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:16 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 05:30:16 INFO - Cleaning up... 05:30:16 INFO - Return code: 0 05:30:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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', '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 0x1df7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b63b0>, '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 0x20b72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b7740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', '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 05:30: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:30: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 psutil>=3.1.1 05:30:16 INFO - Using env: {'DISPLAY': ':0', 05:30:16 INFO - 'HOME': '/home/cltbld', 05:30:16 INFO - 'LANG': 'en_US.UTF-8', 05:30:16 INFO - 'LANGUAGE': 'en_US:en', 05:30:16 INFO - 'LOGNAME': 'cltbld', 05:30:16 INFO - 'MAIL': '/var/mail/cltbld', 05:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:16 INFO - 'MOZ_NO_REMOTE': '1', 05:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:16 INFO - 'NO_EM_RESTART': '1', 05:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:16 INFO - 'PWD': '/builds/slave/test', 05:30:16 INFO - 'SHELL': '/bin/bash', 05:30:16 INFO - 'SHLVL': '1', 05:30:16 INFO - 'TERM': 'linux', 05:30:16 INFO - 'TMOUT': '86400', 05:30:16 INFO - 'USER': 'cltbld', 05:30:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', 05:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:16 INFO - '_': '/tools/buildbot/bin/python'} 05:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:17 INFO - Downloading/unpacking psutil>=3.1.1 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:30:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:19 INFO - Installing collected packages: psutil 05:30:19 INFO - Running setup.py install for psutil 05:30:19 INFO - building 'psutil._psutil_linux' extension 05:30:19 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 05:30:20 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 05:30:20 INFO - building 'psutil._psutil_posix' extension 05:30:20 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 05:30:21 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 05:30:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:21 INFO - Successfully installed psutil 05:30:21 INFO - Cleaning up... 05:30:21 INFO - Return code: 0 05:30:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:21 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 0x1df7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b63b0>, '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 0x20b72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b7740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', '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 05:30:21 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 05:30:21 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 05:30:21 INFO - Using env: {'DISPLAY': ':0', 05:30:21 INFO - 'HOME': '/home/cltbld', 05:30:21 INFO - 'LANG': 'en_US.UTF-8', 05:30:21 INFO - 'LANGUAGE': 'en_US:en', 05:30:21 INFO - 'LOGNAME': 'cltbld', 05:30:21 INFO - 'MAIL': '/var/mail/cltbld', 05:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:21 INFO - 'MOZ_NO_REMOTE': '1', 05:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:21 INFO - 'NO_EM_RESTART': '1', 05:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:21 INFO - 'PWD': '/builds/slave/test', 05:30:21 INFO - 'SHELL': '/bin/bash', 05:30:21 INFO - 'SHLVL': '1', 05:30:21 INFO - 'TERM': 'linux', 05:30:21 INFO - 'TMOUT': '86400', 05:30:21 INFO - 'USER': 'cltbld', 05:30:21 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', 05:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:21 INFO - '_': '/tools/buildbot/bin/python'} 05:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:30:21 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 05:30:21 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 05:30:21 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 05:30:21 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 05:30:21 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 05:30:21 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 05:30:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:30:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:30:23 INFO - Installing collected packages: mozsystemmonitor 05:30:23 INFO - Running setup.py install for mozsystemmonitor 05:30:23 INFO - Successfully installed mozsystemmonitor 05:30:23 INFO - Cleaning up... 05:30:23 INFO - Return code: 0 05:30:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:23 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 0x1df7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b63b0>, '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 0x20b72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b7740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', '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 05:30:23 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 05:30:23 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 05:30:23 INFO - Using env: {'DISPLAY': ':0', 05:30:23 INFO - 'HOME': '/home/cltbld', 05:30:23 INFO - 'LANG': 'en_US.UTF-8', 05:30:23 INFO - 'LANGUAGE': 'en_US:en', 05:30:23 INFO - 'LOGNAME': 'cltbld', 05:30:23 INFO - 'MAIL': '/var/mail/cltbld', 05:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:23 INFO - 'MOZ_NO_REMOTE': '1', 05:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:23 INFO - 'NO_EM_RESTART': '1', 05:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:23 INFO - 'PWD': '/builds/slave/test', 05:30:23 INFO - 'SHELL': '/bin/bash', 05:30:23 INFO - 'SHLVL': '1', 05:30:23 INFO - 'TERM': 'linux', 05:30:23 INFO - 'TMOUT': '86400', 05:30:23 INFO - 'USER': 'cltbld', 05:30:23 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', 05:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:23 INFO - '_': '/tools/buildbot/bin/python'} 05:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:23 INFO - Downloading/unpacking jsonschema==2.5.1 05:30:23 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 05:30:23 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 05:30:23 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 05:30:23 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 05:30:23 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 05:30:23 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 05:30:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:30:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30:25 INFO - Downloading functools32-3.2.3-2.tar.gz 05:30:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:30:26 INFO - warning: no files found matching '*.txt' 05:30:26 INFO - no previously-included directories found matching 'build' 05:30:26 INFO - no previously-included directories found matching 'dist' 05:30:26 INFO - no previously-included directories found matching '.git*' 05:30:26 INFO - Installing collected packages: jsonschema, functools32 05:30:26 INFO - Running setup.py install for functools32 05:30:26 INFO - warning: no files found matching '*.txt' 05:30:26 INFO - no previously-included directories found matching 'build' 05:30:26 INFO - no previously-included directories found matching 'dist' 05:30:26 INFO - no previously-included directories found matching '.git*' 05:30:26 INFO - Successfully installed jsonschema functools32 05:30:26 INFO - Cleaning up... 05:30:26 INFO - Return code: 0 05:30:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:26 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 0x1df7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b63b0>, '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 0x20b72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b7740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', '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 05:30:26 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 05:30:26 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 05:30:26 INFO - Using env: {'DISPLAY': ':0', 05:30:26 INFO - 'HOME': '/home/cltbld', 05:30:26 INFO - 'LANG': 'en_US.UTF-8', 05:30:26 INFO - 'LANGUAGE': 'en_US:en', 05:30:26 INFO - 'LOGNAME': 'cltbld', 05:30:26 INFO - 'MAIL': '/var/mail/cltbld', 05:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:26 INFO - 'MOZ_NO_REMOTE': '1', 05:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:26 INFO - 'NO_EM_RESTART': '1', 05:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:26 INFO - 'PWD': '/builds/slave/test', 05:30:26 INFO - 'SHELL': '/bin/bash', 05:30:26 INFO - 'SHLVL': '1', 05:30:26 INFO - 'TERM': 'linux', 05:30:26 INFO - 'TMOUT': '86400', 05:30:26 INFO - 'USER': 'cltbld', 05:30:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', 05:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:26 INFO - '_': '/tools/buildbot/bin/python'} 05:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:26 INFO - Downloading/unpacking blobuploader==1.2.4 05:30:26 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 05:30:26 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 05:30:26 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 05:30:26 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 05:30:26 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 05:30:26 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 05:30:28 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30:28 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 05:30:28 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 05:30:28 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 05:30:28 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 05:30:28 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 05:30:28 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 05:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:30:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30:28 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 05:30:28 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 05:30:28 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 05:30:28 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 05:30:28 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 05:30:28 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 05:30:29 INFO - Downloading docopt-0.6.1.tar.gz 05:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:29 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:29 INFO - Running setup.py install for blobuploader 05:30:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:30:29 INFO - Running setup.py install for requests 05:30:29 INFO - Running setup.py install for docopt 05:30:29 INFO - Successfully installed blobuploader requests docopt 05:30:29 INFO - Cleaning up... 05:30:29 INFO - Return code: 0 05:30:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:29 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 0x1df7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b63b0>, '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 0x20b72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b7740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', '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 05:30:29 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 05:30:29 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 05:30:29 INFO - Using env: {'DISPLAY': ':0', 05:30:29 INFO - 'HOME': '/home/cltbld', 05:30:29 INFO - 'LANG': 'en_US.UTF-8', 05:30:29 INFO - 'LANGUAGE': 'en_US:en', 05:30:29 INFO - 'LOGNAME': 'cltbld', 05:30:29 INFO - 'MAIL': '/var/mail/cltbld', 05:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:29 INFO - 'MOZ_NO_REMOTE': '1', 05:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:29 INFO - 'NO_EM_RESTART': '1', 05:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:29 INFO - 'PWD': '/builds/slave/test', 05:30:29 INFO - 'SHELL': '/bin/bash', 05:30:29 INFO - 'SHLVL': '1', 05:30:29 INFO - 'TERM': 'linux', 05:30:29 INFO - 'TMOUT': '86400', 05:30:29 INFO - 'USER': 'cltbld', 05:30:29 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', 05:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:29 INFO - '_': '/tools/buildbot/bin/python'} 05:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:29 INFO - Running setup.py (path:/tmp/pip-5T1nwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:30 INFO - Running setup.py (path:/tmp/pip-lMv79v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:30 INFO - Running setup.py (path:/tmp/pip-SRvNOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:30 INFO - Running setup.py (path:/tmp/pip-HXqyIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:30 INFO - Running setup.py (path:/tmp/pip-pMk_Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:30 INFO - Running setup.py (path:/tmp/pip-xPcJKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:30 INFO - Running setup.py (path:/tmp/pip-Q9Dj74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:30 INFO - Running setup.py (path:/tmp/pip-di1Jac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:30 INFO - Running setup.py (path:/tmp/pip-l1U4Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:30 INFO - Running setup.py (path:/tmp/pip-DNuPrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:30 INFO - Running setup.py (path:/tmp/pip-sQmdjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:30 INFO - Running setup.py (path:/tmp/pip-5buaex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:30 INFO - Running setup.py (path:/tmp/pip-hGhf05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:30 INFO - Running setup.py (path:/tmp/pip-5_fwTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:30 INFO - Running setup.py (path:/tmp/pip-X46lJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:31 INFO - Running setup.py (path:/tmp/pip-EtBIZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:31 INFO - Running setup.py (path:/tmp/pip-thlZM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:31 INFO - Running setup.py install for manifestparser 05:30:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Running setup.py install for mozcrash 05:30:31 INFO - Running setup.py install for mozdebug 05:30:31 INFO - Running setup.py install for mozdevice 05:30:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Running setup.py install for mozfile 05:30:31 INFO - Running setup.py install for mozhttpd 05:30:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Running setup.py install for mozinfo 05:30:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Running setup.py install for mozInstall 05:30:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:30:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:30:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:30:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:30:32 INFO - Running setup.py install for mozleak 05:30:32 INFO - Running setup.py install for mozlog 05:30:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:30:32 INFO - Running setup.py install for moznetwork 05:30:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:30:32 INFO - Running setup.py install for mozprocess 05:30:32 INFO - Running setup.py install for mozprofile 05:30:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:30:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:30:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:30:32 INFO - Running setup.py install for mozrunner 05:30:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:30:32 INFO - Running setup.py install for mozscreenshot 05:30:32 INFO - Running setup.py install for moztest 05:30:32 INFO - Running setup.py install for mozversion 05:30:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:30:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:32 INFO - Cleaning up... 05:30:32 INFO - Return code: 0 05:30:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:33 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 0x1df7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b63b0>, '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 0x20b72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b7740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', '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 05:30:33 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 05:30:33 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 05:30:33 INFO - Using env: {'DISPLAY': ':0', 05:30:33 INFO - 'HOME': '/home/cltbld', 05:30:33 INFO - 'LANG': 'en_US.UTF-8', 05:30:33 INFO - 'LANGUAGE': 'en_US:en', 05:30:33 INFO - 'LOGNAME': 'cltbld', 05:30:33 INFO - 'MAIL': '/var/mail/cltbld', 05:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:33 INFO - 'MOZ_NO_REMOTE': '1', 05:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:33 INFO - 'NO_EM_RESTART': '1', 05:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:33 INFO - 'PWD': '/builds/slave/test', 05:30:33 INFO - 'SHELL': '/bin/bash', 05:30:33 INFO - 'SHLVL': '1', 05:30:33 INFO - 'TERM': 'linux', 05:30:33 INFO - 'TMOUT': '86400', 05:30:33 INFO - 'USER': 'cltbld', 05:30:33 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', 05:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:33 INFO - '_': '/tools/buildbot/bin/python'} 05:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:33 INFO - Running setup.py (path:/tmp/pip-wQJytt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:33 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)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:33 INFO - Running setup.py (path:/tmp/pip-1ac7tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:33 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)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:33 INFO - Running setup.py (path:/tmp/pip-O8cLlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:33 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)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:33 INFO - Running setup.py (path:/tmp/pip-iOOUrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:33 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)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:33 INFO - Running setup.py (path:/tmp/pip-RWnb9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:33 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)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:33 INFO - Running setup.py (path:/tmp/pip-Rnn4RY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:33 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)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:33 INFO - Running setup.py (path:/tmp/pip-XNjCMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:33 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)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:33 INFO - Running setup.py (path:/tmp/pip-9UQfIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:33 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)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:33 INFO - Running setup.py (path:/tmp/pip-pbg_oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:33 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)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:33 INFO - Running setup.py (path:/tmp/pip-LnaEQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:33 INFO - Running setup.py (path:/tmp/pip-mMu7YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:34 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)) 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:34 INFO - Running setup.py (path:/tmp/pip-Ad6rpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:34 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)) 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:34 INFO - Running setup.py (path:/tmp/pip-zowwq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:34 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)) 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:34 INFO - Running setup.py (path:/tmp/pip-nvvV66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:34 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)) 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:34 INFO - Running setup.py (path:/tmp/pip-mwIK7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:34 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)) 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:34 INFO - Running setup.py (path:/tmp/pip-aXYeTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:34 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)) 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:34 INFO - Running setup.py (path:/tmp/pip-9gOyts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:34 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)) 05:30:34 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)) 05:30:34 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)) 05:30:34 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)) 05:30:34 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)) 05:30:34 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)) 05:30:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:36 INFO - Downloading blessings-1.6.tar.gz 05:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:36 INFO - Installing collected packages: blessings 05:30:36 INFO - Running setup.py install for blessings 05:30:36 INFO - Successfully installed blessings 05:30:36 INFO - Cleaning up... 05:30:36 INFO - Return code: 0 05:30:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:30:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:36 INFO - Reading from file tmpfile_stdout 05:30:36 INFO - Current package versions: 05:30:36 INFO - argparse == 1.2.1 05:30:36 INFO - blessings == 1.6 05:30:36 INFO - blobuploader == 1.2.4 05:30:36 INFO - docopt == 0.6.1 05:30:36 INFO - functools32 == 3.2.3-2 05:30:36 INFO - jsonschema == 2.5.1 05:30:36 INFO - manifestparser == 1.1 05:30:36 INFO - mozInstall == 1.12 05:30:36 INFO - mozcrash == 0.17 05:30:36 INFO - mozdebug == 0.1 05:30:36 INFO - mozdevice == 0.48 05:30:36 INFO - mozfile == 1.2 05:30:36 INFO - mozhttpd == 0.7 05:30:36 INFO - mozinfo == 0.9 05:30:36 INFO - mozleak == 0.1 05:30:36 INFO - mozlog == 3.3 05:30:36 INFO - moznetwork == 0.27 05:30:36 INFO - mozprocess == 0.23 05:30:36 INFO - mozprofile == 0.28 05:30:36 INFO - mozrunner == 6.12 05:30:36 INFO - mozscreenshot == 0.1 05:30:36 INFO - mozsystemmonitor == 0.3 05:30:36 INFO - moztest == 0.7 05:30:36 INFO - mozversion == 1.4 05:30:36 INFO - psutil == 3.1.1 05:30:36 INFO - requests == 1.2.3 05:30:36 INFO - wsgiref == 0.1.2 05:30:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:36 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 0x1df7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b63b0>, '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 0x20b72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b7740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', '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 05:30:36 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 05:30:36 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 05:30:36 INFO - Using env: {'DISPLAY': ':0', 05:30:36 INFO - 'HOME': '/home/cltbld', 05:30:36 INFO - 'LANG': 'en_US.UTF-8', 05:30:36 INFO - 'LANGUAGE': 'en_US:en', 05:30:36 INFO - 'LOGNAME': 'cltbld', 05:30:36 INFO - 'MAIL': '/var/mail/cltbld', 05:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:36 INFO - 'MOZ_NO_REMOTE': '1', 05:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:36 INFO - 'NO_EM_RESTART': '1', 05:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:36 INFO - 'PWD': '/builds/slave/test', 05:30:36 INFO - 'SHELL': '/bin/bash', 05:30:36 INFO - 'SHLVL': '1', 05:30:36 INFO - 'TERM': 'linux', 05:30:36 INFO - 'TMOUT': '86400', 05:30:36 INFO - 'USER': 'cltbld', 05:30:36 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', 05:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:36 INFO - '_': '/tools/buildbot/bin/python'} 05:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:37 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)) 05:30:37 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)) 05:30:37 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)) 05:30:37 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)) 05:30:37 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)) 05:30:37 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)) 05:30:37 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)) 05:30:37 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)) 05:30:37 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)) 05:30:37 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)) 05:30:37 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)) 05:30:37 INFO - Cleaning up... 05:30:37 INFO - Return code: 0 05:30:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:30:37 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')]} 05:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:37 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')]} 05:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:37 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 0x1df7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b63b0>, '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 0x20b72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b7740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', '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 05:30:37 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 05:30:37 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 05:30:37 INFO - Using env: {'DISPLAY': ':0', 05:30:37 INFO - 'HOME': '/home/cltbld', 05:30:37 INFO - 'LANG': 'en_US.UTF-8', 05:30:37 INFO - 'LANGUAGE': 'en_US:en', 05:30:37 INFO - 'LOGNAME': 'cltbld', 05:30:37 INFO - 'MAIL': '/var/mail/cltbld', 05:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:37 INFO - 'MOZ_NO_REMOTE': '1', 05:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:37 INFO - 'NO_EM_RESTART': '1', 05:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:37 INFO - 'PWD': '/builds/slave/test', 05:30:37 INFO - 'SHELL': '/bin/bash', 05:30:37 INFO - 'SHLVL': '1', 05:30:37 INFO - 'TERM': 'linux', 05:30:37 INFO - 'TMOUT': '86400', 05:30:37 INFO - 'USER': 'cltbld', 05:30:37 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', 05:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:37 INFO - '_': '/tools/buildbot/bin/python'} 05:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:30:37 INFO - Cleaning up... 05:30:37 INFO - Return code: 0 05:30:37 INFO - Running post-action listener: _resource_record_post_action 05:30:37 INFO - Running post-action listener: _start_resource_monitoring 05:30:37 INFO - Starting resource monitoring. 05:30:37 INFO - [mozharness: 2016-07-20 12:30:37.363507Z] Finished create-virtualenv step (success) 05:30:37 INFO - [mozharness: 2016-07-20 12:30:37.364467Z] Running install step. 05:30:37 INFO - Running pre-action listener: _resource_record_pre_action 05:30:37 INFO - Running main action method: install 05:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:37 INFO - Reading from file tmpfile_stdout 05:30:37 INFO - Detecting whether we're running mozinstall >=1.0... 05:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:30:37 INFO - Reading from file tmpfile_stdout 05:30:37 INFO - Output received: 05:30:37 INFO - Usage: mozinstall [options] installer 05:30:37 INFO - Options: 05:30:37 INFO - -h, --help show this help message and exit 05:30:37 INFO - -d DEST, --destination=DEST 05:30:37 INFO - Directory to install application into. [default: 05:30:37 INFO - "/builds/slave/test"] 05:30:37 INFO - --app=APP Application being installed. [default: firefox] 05:30:37 INFO - mkdir: /builds/slave/test/build/application 05:30:37 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'] 05:30:37 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 05:30:54 INFO - Reading from file tmpfile_stdout 05:30:54 INFO - Output received: 05:30:54 INFO - /builds/slave/test/build/application/firefox/firefox 05:30:54 INFO - Running post-action listener: _resource_record_post_action 05:30:54 INFO - [mozharness: 2016-07-20 12:30:54.905334Z] Finished install step (success) 05:30:54 INFO - [mozharness: 2016-07-20 12:30:54.905690Z] Running run-tests step. 05:30:54 INFO - Running pre-action listener: _resource_record_pre_action 05:30:54 INFO - Running main action method: run_tests 05:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:30:54 INFO - Python 2.7.3 05:30:54 INFO - Return code: 0 05:30:54 INFO - grabbing minidump binary from tooltool 05:30:54 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')]} 05:30:54 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 0x20b63b0>, '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 0x20b72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:30:54 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 05:30:54 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 05:30:54 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 05:30:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:30:55 INFO - Return code: 0 05:30:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:30:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:30:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:30:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:30:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:30:55 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/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 05:30:55 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/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 05:30:55 INFO - Using env: {'DISPLAY': ':0', 05:30:55 INFO - 'HOME': '/home/cltbld', 05:30:55 INFO - 'LANG': 'en_US.UTF-8', 05:30:55 INFO - 'LANGUAGE': 'en_US:en', 05:30:55 INFO - 'LOGNAME': 'cltbld', 05:30:55 INFO - 'MAIL': '/var/mail/cltbld', 05:30:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:30:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:55 INFO - 'MOZ_NO_REMOTE': '1', 05:30:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:55 INFO - 'NO_EM_RESTART': '1', 05:30:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:55 INFO - 'PWD': '/builds/slave/test', 05:30:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:30:55 INFO - 'SHELL': '/bin/bash', 05:30:55 INFO - 'SHLVL': '1', 05:30:55 INFO - 'TERM': 'linux', 05:30:55 INFO - 'TMOUT': '86400', 05:30:55 INFO - 'USER': 'cltbld', 05:30:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737', 05:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:55 INFO - '_': '/tools/buildbot/bin/python'} 05:30:55 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/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 05:30:55 INFO - mozversion application_buildid: 20160720023015 05:30:55 INFO - mozversion application_changeset: e904e18d7dfcd8097f92d44104ca1462fc5d1335 05:30:55 INFO - mozversion application_display_name: Nightly 05:30:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:30:55 INFO - mozversion application_name: Firefox 05:30:55 INFO - mozversion application_remotingname: firefox 05:30:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:30:55 INFO - mozversion application_vendor: Mozilla 05:30:55 INFO - mozversion application_version: 50.0a1 05:30:55 INFO - mozversion platform_buildid: 20160720023015 05:30:55 INFO - mozversion platform_changeset: e904e18d7dfcd8097f92d44104ca1462fc5d1335 05:30:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:30:55 INFO - mozversion platform_version: 50.0a1 05:30:55 INFO - using testdate: 1469017855 05:30:55 INFO - actual date: 1469017855 05:30:55 INFO - starting webserver on 'localhost:35234' 05:30:55 INFO - SUITE-START | Running 2 tests 05:30:55 INFO - TEST-START | dromaeo_css 05:30:55 INFO - operating with platform_type : linux_ 05:30:55 INFO - Initialising browser for dromaeo_css test... 05:30:55 INFO - TEST-INFO | started process 3318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0nRKNa/profile http://localhost:35234/getInfo.html) 05:31:00 INFO - PROCESS | 3318 | __metrics Screen width/height:1600/1200 05:31:00 INFO - PROCESS | 3318 | colorDepth:24 05:31:00 INFO - PROCESS | 3318 | Browser inner width/height: 1024/697 05:31:00 INFO - PROCESS | 3318 | __metrics 05:31:02 INFO - PROCESS | 3318 | 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" 05:31:02 INFO - PROCESS | 3318 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:31:02 INFO - PROCESS | 3318 | console.error: PushService: 05:31:02 INFO - PROCESS | 3318 | stateChangeProcessEnqueue: Error transitioning state 05:31:02 INFO - PROCESS | 3318 | UnknownError 05:31:03 INFO - TEST-INFO | 3318: exit 0 05:31:03 INFO - Browser initialized. 05:31:03 INFO - Running cycle 1/1 for dromaeo_css test... 05:31:03 INFO - TEST-INFO | started process 3404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0nRKNa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:14 INFO - PROCESS | 3404 | RSS: Main: 157835264 05:31:14 INFO - PROCESS | 3404 | 05:32:06 INFO - PROCESS | 3404 | 1469017926485 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] 05:34:14 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:35234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35234/tests/dromaeo/cssquery-ext.html) 05:34:15 INFO - PROCESS | 3404 | RSS: Main: 247963648 05:34:15 INFO - PROCESS | 3404 | 05:37:18 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:35234/tests/dromaeo/cssquery-ext.html (next: http://localhost:35234/tests/dromaeo/cssquery-jquery.html) 05:37:19 INFO - PROCESS | 3404 | RSS: Main: 255209472 05:37:19 INFO - PROCESS | 3404 | 05:40:21 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:35234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35234/tests/dromaeo/cssquery-mootools.html) 05:40:21 INFO - PROCESS | 3404 | RSS: Main: 253927424 05:40:21 INFO - PROCESS | 3404 | 05:43:23 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:35234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35234/tests/dromaeo/cssquery-prototype.html) 05:43:24 INFO - PROCESS | 3404 | RSS: Main: 192057344 05:43:24 INFO - PROCESS | 3404 | 05:46:27 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:35234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35234/tests/dromaeo/cssquery-yui.html) 05:46:27 INFO - PROCESS | 3404 | RSS: Main: 192081920 05:46:27 INFO - PROCESS | 3404 | 05:49:30 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:35234/tests/dromaeo/cssquery-yui.html (next: http://localhost:35234/tests/dromaeo/cssquery-dojo.html) 05:49:30 INFO - PROCESS | 3404 | RSS: Main: 276357120 05:49:30 INFO - PROCESS | 3404 | 05:49:30 INFO - PROCESS | 3404 | __start_tp_report 05:49:30 INFO - PROCESS | 3404 | _x_x_mozilla_page_load 05:49:30 INFO - PROCESS | 3404 | _x_x_mozilla_page_load_details 05:49:30 INFO - PROCESS | 3404 | |i|pagename|runs| 05:49:30 INFO - PROCESS | 3404 | |0;dojo.html;3066.892658756943;3068.9386212275767;3092.242400611849;3104.1463597510683;3115.112193024987;5302.3637163540425;5320.600954928376;5369.328833895758;5466.207399927008;5478.178273259013;5314.973425132878;5418.4039755626845;5424.9186262206;5445.618806683534;5507.366652834925;4875.756212189394;4933.506649335056;4952.331435256248;4982.153033984231;5040.218766091261;4913.975430122844;4992.725400102993;5048.545630893219;5053.5957123430035;5056.317397151374;4958.677685950402;5003.2995380646735;5016.874578135539;5020.196768517038;5047.116754567955;4820.011897560991;4838.371011768483;4896.436909755353;4925.679830810986;5022.874428139289;4855.46589875117;4860.125177468054;4879.146149423872;4950.579200767939;4984.601231901475;5437.429069947638;5448.264484294609;5458.536024437927;5518.475744804237;5531.778728850882;5657.4908258256955;5760.164776107483;5802.332731735863;5838.9124163137585;5904.645721256738;5809.6804675742815;5917.053271476543;5919.467247947662;5920.407959204088;5929.466348028698;5457;5457.263269458652;5464.153056276284;5505.256790333294;5510.201020852034;5744.023516002289;5841.795537156179;5896.734646940898;5910.822675319747;5929.6145750526075;5754.309482862083;5760.193572899798;5761.164631128463;5762.711864406763;5767.711614419262;5763.971180144073;5780.71096445176;5789.044807606782;5831.88336233273;5842.152887831241;5600.60795744294;5653.717314134276;5773.1051686988585;5805.071188609802;5834.358220595731;5627.240322556484;5702.515286200636;5709.714514274269;5761.452661997104;5763.538916886723;4308.849190278325;4313.525512193656;4349.086691794695;4354.629856462173;4393.231184542692;3862.517185351831;3869.7097717671286;3902.414637804352;3921.8235179416993;3946.1121247719034;5449.6730196188355;5478.150886612581;5502.697351645698;5541.445855414427;5541.667499950016;5791.478766910998;5794.101914203306;5795.275590551181;5849.151872978395;5854.063349864086;5322.547583455373;5483.177523371526;5545.168224766237;5545.861353466195;5548.389677135512;5028.220625803006;5057.544820966057;5062.316587260746;5062.645614806928;5108.6168537359845;6043.8186854394435;6058.454739073504;6059.091136329585;6063.242094738246;6063.393660633989;5720.11338242573;5752.108423194411;5849.415058494116;5868.823935281948;5869.031609784338;5986.700664966821;6049.274087109575;6050.606710563799;6102.115193297036;6103.42017508336;5692.1461780733225;5731.254936858349;5744.798932037359;5745.626534275259;5751.166080918327;5598.748056337393;5779.450952159538;5781.913271301018;5825.592208545361;5835.183074369506;5680.715964201856;5704.60067795267;5733.799317024051;5764.193012978102;5810.883782324415;5742.19609254713;5747.511461525817;5750.13747937796;5751.827445176651;5753.741081651419;5470.234167216672;5600.523955463831;5717.1995920570325;5728.455796699307;5729.914051289151;5655.038643430709;5715.2855893013375;5749.655020698771;5771.97114014444;5789.8552536186935;5586.050371436947;5602.831915042555;5607.299087614048;5613.88772224545;5614.07367784311 05:49:30 INFO - PROCESS | 3404 | |1;ext.html;604.8215776345977;618.7988903606326;644.6841047886537;657.1522735670985;659.0838734159516;42957.140857182836;44249.77875110624;44518.55481445188;48454.99999999991;48566.51433485673;46102.76948615252;46745.29882051764;46794.766026169906;46814.297785533156;46836.765816170955;8021.117677055519;8873.157050080248;9103.317251206186;9104.180623743861;10653.78692426151;10493;10975.396353200571;10978.066864316543;10978.176636752236;10978.780424391507;11010.889891101067;11076.501557429934;11083.944580277128;11088.057515111224;11103.888961110406;8140.226678465537;10583.629572964986;10704.036636702656;10956.34261944286;10998;10761.192910531741;10811.729706757314;10820.08029317509;10822.02601765837;10822.67531974042;43907.34138987918;44033.339499907524;44047.55952440466;44114.55885441136;44165;3261.836908154583;3343.180920674426;3430.2110514581536;3437.1922598189403;3514.5431093957623;33229;33560.83219583886;34183.316333673436;34208.65791342079;34235.486467703005;4200.188482714139;4212.262854000538;4238.724482908632;4320.1143765527995;4339.5877391648055;393431;395975;396618;398874;398881;61136.08295875565;61495.69252153711;61505.38494615086;61517.69241153765;61538;62996;63399;63587;63742;63765.36234637594;17184.742228866577;17397.391091311743;17447;17454.38909638182;17465.126743662768;12191.14661973671;13123.146995445266;13280.203187808762;13295.468181272641;13486.325683715972;17162.742558861628;17304.567385815204;17337.393191238247;17415.82584174142;17418.738718919227;6334;6367.363263673596;6415.101885736;6470.611763294218;6493.675316234169;930.5347326336831;1040.6357774778767;1107.617871834216;1139.9373034483183;1178.522698307187;32466.837665811992;32714.836425818194;33154.50268245978;33206.55018568849;33546.832265838515;1115.341948250536;1134.2513940799033;1144.9427528623535;1147.8363285207445;1218.713602303458;17204.913975430292;17262.482125536255;17316.65366692659;17331.393401230896;17428.825711742975;536080;538421;538943;540315;540634;58707.706461468275;58748;58888;59010.40989590049;59010.704946474994;1232.1067226261068;1239.5723475400973;1356.3760670091867;1366.3236697834636;1367.09771550776;29887.850560747058;33942;34258.828705856315;34290.14274643154;34395.14012149716;50302.49697502978;50780.492195077575;50785.74607126941;50913.49086509088;51087.48912510827;407769;408092;408767;409305;409821;35611.64388356187;40825.183496329315;41250.79374603108;41885.58114418817;41980.79009604932;47695.523044770496;48313.516864830905;48390.51609484001;48899.26651100307;49437.50562494329;40112.39831402473;40593.59406406016;40781.79609101936;41716.3742543856;42738.78630606827;41276.793616031726;41343.07812670255;41924.37113443362;42302.36546451867;42607.786961064994;40886.79556602198;41322.58677413187;42030.789846050575;42102;42141.78929105335;34302.82848585841;36601.81699091488;36705.44941825821;37002.97162814499;37418.812905935294;28119.71880281171;28147.802287865215;28439;28706.712932870403;28895.42209155847 05:49:30 INFO - PROCESS | 3404 | |2;jquery.html;389.46837566721433;397.3225650266296;403.1996486973358;405.18962075848304;416.0659319826987;13437.798433023512;18637.16132774025;19874.90062549687;19904.90047549762;20271.290504832334;15170.241487925614;15508.53474395767;15568;18591.44225673232;19442.805571944275;5405.729713514309;5586.720663966806;5786.334571524287;5788.450097240777;5794.826155215329;5648.830535083934;5750.769969201227;5753.827385178452;5760.6255593386295;5761.279840019997;3915.236528876856;5722.399148089453;6191.288001879774;6395.328490508499;6443.29123796382;5434.266374039494;6493.610383377012;6496.3503649634895;6496.772612958547;6499.577527460724;5459.590530710173;5571.9721401392735;5583.302087239095;5586.301712285965;5586.832395028156;12914.935425322907;13538.526151584745;13607.183568985893;13669.043166978316;13672.632736726348;2154.5798569278995;2199.571083638691;2227.3429338345063;2550.1705401760987;2560.8719564021912;9896.752581185456;9996.450195239258;10005.349652272578;10042.096211341015;10137.239707022003;1836.7704036995376;1903.4670292318035;1918.1279549943267;1926.1621194780316;1957.1877670766614;80168.59915700443;81155.5942220285;82653.9999999994;87986.5600671999;89554.5522272391;10649.84025239622;10809.83785243222;10900;10959;11047.613333533287;15323.31045102973;15334.156621385931;15339.156346401054;15346.846531534542;15347.846521534642;8142.715004974916;8353.164683531599;8387.329013678891;8552.358573107042;8557.058723540405;8073.717419890276;8141.837163256701;8178.1821817817745;8369.665213391518;8373.120822313569;4668.253079507263;4691.62467002639;4709.764511774466;4757.452892917289;4859;1974.7827738948704;1986.1757370691291;1989.6172160348708;1998.7701414337246;2064.865783724053;882.9205371516466;980.2501086668705;997.4912794474725;1047.8585390972273;1058.2856571813995;19032.809671903105;19464.22143114288;19500.414987550113;19509.414717558495;19582.31461898827;1006.3257617396362;1020.3877673395903;1027.8869324374314;1072.973175670599;1083.5936523803573;10353.223508236912;10831.404272764916;10934.179936504794;10947.124230061576;10956.835647465294;473558;476742;478302;508675;512838;91131.54434227919;94859.52570237104;95569;95799.52100239454;97102;964.1948972607811;995.7098673051952;1008.1581879131007;1012.7366884610054;1020.1481762728057;14776.77834832457;16508.504744857673;17062.402815901383;17087.743683845;17198.39805606848;41548;43105.35341969936;43539;44290.11419771522;45163.77418112889;57117.42882571121;59364.51588710317;61079;61666;62552.374476254656;8033.357331413356;8224.712135075244;8228.876566851382;8315.376346773895;8345.123762004901;10519.316244444086;12078.275303481467;12411.937940310241;12421.93789031049;12925.935370323088;10433.895661043292;10742.83885741699;10884.292520986111;10918.672439826818;11223.158263130135;9686.370385924893;9784.80430391374;10241.948790256001;10375.11811496001;10760;9792;10833.133349331876;10944.1791865612;11293.378864162221;11344.092472602008;7586.848263034819;7929.920700792918;8017.599120044091;8096.230858068474;8153.103158652425;9198.908010919806;11056.447177641247;11306.31345177682;11319.490622921823;11515.078793696652 05:49:30 INFO - PROCESS | 3404 | |3;mootools.html;1348.049625014365;1460.5180290504131;1535.1019653502701;1626.4713967960408;1801.7927938287094;8668.739937801869;8911.242544383727;9035.954820225897;9260.351775375726;9281.582328795204;9118;9223.538823058838;9224.677136300232;9227.815443691123;9228.953855230715;2356.564035653401;2367.9526409471887;2380.1788383007834;2389.7371289158177;2396.6524853896176;2310.7573704760925;2376.989779343781;2377.346229786805;2380.27401642499;2390.0320370249988;2335.509542995973;2339.1579031548713;2352.4824538601565;2355.034435881289;2360.775726305998;2315.7568455312203;2325.93022209334;2356.1046802215133;2357.1749887539395;2358.481134150484;2282.4978504729097;2334.7665233476687;2364.243442098529;2365.846219995695;2366.9526609467885;7987.920120798775;8138.593070346518;8999.865002024975;9077.092290770936;9127.680531181442;4821.903561928777;4938.827141050082;5235.450277720861;5301.893962120775;5333.866653333659;3465.289615628815;3526.3299973005305;3532.0993146747414;3590.263995880864;3598.8200589970397;1112.104755671684;1113.3653817324127;1123.7696272264166;1125.364402528838;1146.3694967767779;12875.227486350848;12999.155054921495;13025.413856376486;13037.282949437777;13038.152520086163;4480.686351955332;4731.243001119804;4748.334367988606;4839.056384005085;4889.755512224375;10391;10576.99518545737;10607.204459665556;10867.130629549774;10884.238103332691;5276.788928442896;5325.227841962894;5326.707031113326;5334.093204155303;5338.839834804962;4726.598239149642;4826.879328016757;4854.126257273654;4859.975700121477;4862.3922009748785;3897.2595206910596;3931.9803400983383;3991.201759648024;4029.1135950090934;4170.436991006236;1240.925544467335;1253.091508656217;1254.8368712067372;1266.290877108822;1278.654763213927;987.9407235565889;1006.1950439648399;1012.4026824173773;1027.1936529824052;1043.4261156363968;6258.3428739982555;6288.811335659938;6289.433950944437;6395.072714456378;6471.482281417475;503.8009986055487;507.9441261461236;508.59566644517696;510.2983397827987;511.74157050689905;4315.525292217853;4338.219120558329;4338.392625032435;4408.493023302297;4457.509673935864;11155.163362747826;11298.60454884075;11412.486438110305;11434.199606027665;11437;10723.517441715141;11118.22172447937;11147.052500537384;11463.942680286546;11466.827997580043;8421.326293896596;8542.316614670812;8547.487150770849;8593.398462107592;8595.914040859636;6200.131981522681;6342.23893132827;6440.162778838721;6623.205215374186;6667.766628167991;10408.895911041096;10474.895251047392;10540.367577945348;10668.30656007357;10798.56805727762;10626.8405973912;10722.356658600509;10744;10753;10771.461426928465;6833.794986150423;7329.816754581178;7549.698012079675;8195.590220489072;8199.795005124919;8956.865647015169;8998.505082220541;8998.64005439775;9000.774980625274;9029.503377314311;7769.417293702882;7865.134835168013;7897.13131555517;8066.677332906853;8111.1888811118415;7598.240175982358;7696.884546731691;7741;7761.262680045386;7837.333826624801;7331.376832969044;7403.851922961619;7440.813979650552;7450.031495905498;7451.44114191427;5444.26502422168;5481.287432633732;5483;5620.381758006698;5696.487316141567;5514.696691681996;5529.33647962231;5544.473275038865;5597.132444471114;5712.285964254468 05:49:30 INFO - PROCESS | 3404 | |4;prototype.html;315.82945209586825;321.4278584120267;322.22665602553883;325.72801710571673;330.64455710111633;5419.756110975006;5446.645968012076;5451.727413629317;5473.78104875805;5504.779808807642;5382.569394448445;5396.703181325026;5415.431379705134;5440.455954404558;5453.127499600065;3988.3419235826054;4078.9401352317186;4210.473690788652;4226.661867050629;4241.321388577828;4218.1563687262515;4233.576642335757;4236.872893813191;4256.808443620044;4258.659307255412;4154.626083652471;4155.729877557964;4186.769727664977;4204.726692764976;4212.431321771567;3990.521137463494;4014.1570270243137;4157.750534967911;4166;4170.311898536738;3684.373656478405;3685.3919103347916;3687.631236876318;3688.944665830015;3692.667659910594;5233.607479439057;5236.29310043147;5239.768654366221;5278.4721527846905;5334.786608535654;4727.432708075053;4760.509231434074;4778.5699287064335;4780.856574302742;4789.544993225638;5566.693831839248;5577.358603760538;5578.553715702734;5596.1605759136455;5663.745131469093;3922.8626998055215;4047;4066.2680717470844;4109.753414795122;4115.115250221217;5785.103308987113;5834.562407819388;5842.88985092831;5864.149698293723;5867.383924687889;4077.918441631151;4078.225137223918;4098.426220329156;4099.200655872076;4109;4104.651104656137;4159.7920103994675;4172.248995180836;4173.706151093171;4204.579542045771;4735.692180008288;4778.491292071691;4793.880152996203;4807.18277892759;4813.663043586986;5605.607607467438;5643.238162848045;5663.490285874291;5669.206311116447;5680.6591604503865;1399.531157062375;1414.3140576820233;1424.302091974925;1429.1925062339953;1437.7268319019354;918.5682729117304;924.4591913730409;925.833349997007;928.4150984879483;941.8022215334856;5346.8663283417445;5462.657187535919;5471.616986810965;5477.233187353773;5477.808276710296;5771.220885180447;5785.421457854265;5798.797042103591;5856.941430585724;5857.941420585739;5275.63070585063;5466.398696143421;5472.960137573848;5488.862778430492;5512.779488820483;3047.3295874907485;3058.990533124064;3071.2782496113396;3086.5678804967324;3093.1957691000503;5877.529797616266;6025.535317192632;6038.939610603926;6059.121427393004;6106.328303886569;5923.437273459014;5924.229850119457;5929.814037192493;5943.70281485924;5983.581149319593;5995.52035837132;6016.368281330485;6023.1567580537885;6027.276726792813;6075.088736689532;5693.459121383462;5719.0832675336715;5759.337676167294;5783.913241301468;5873.588848780544;5673.687947162945;5709.486146246858;5717.056685646821;5730.656160630376;5774.1338799178775;5734.455226753452;5996.760129594767;6043.54673399488;6045.546584006129;6067.696615169312;4072.775997320176;4106.876793696194;4113.321301985139;4119.97940010298;4125.834966601423;5800.477956983892;5805.970970145122;5873.970630146822;5878.853028674317;5888.852778680567;5529.806456773994;5727.427257274239;5768.846230753782;5791.667916379172;5800.50695690871;5694;5694.14587811815;5694.430556944438;5694.572907032072;5717.628354156966;5494.587905906993;5695.430456954271;5708;5734;5759.625624334405;5575.77696892136;5657.6888271143835;5661.235733175969;5664.915026274527;5667.603267771216;5560.443955604407;5563.13771365439;5564.749586268546;5574.5261652758345;5657.43425657431 05:49:30 INFO - PROCESS | 3404 | |5;yui.html;628.9402506761857;654.4796886475252;696.8571442854216;710.1549156503763;730.2729045806667;14305.928470357647;15452.45916392928;15549.06705597665;15564.221788910538;15656.3737450502;13775.793363099561;13981;14151.575452736408;14154.858451415483;14156.009079364449;799.1329407592768;799.6521513141773;799.7161007842219;806.2219957740779;807.4630370803409;660.0989649128928;682.9248782633931;683.1221879884349;684.7637565040053;818.1327792539927;841.8316336732647;864.6584599083359;865.7446053414258;871.1071152069117;873.5413907698446;832.0680837462021;836.9246767790897;836.9539675317855;838.6016642095017;838.9077201507829;501.8644965859234;613.8680183760468;614.118739608663;614.1218058176805;617.9351168127372;10854.45727713619;11356.886431135665;13416.195028298236;13672.65818354539;13762.036657433984;13192.142510736867;13221.405036773273;13750;13937.930310348384;13979.930100349535;11101.111911047097;11576.826347604709;11643.243189192675;11797.292162470194;11916.702082447922;3731.626837316274;3795.0512371907025;3829.215010922782;3920.5687374388795;3924.4309575111733;70740.99999999949;84231;84233;84616.15383846144;84751.57624211902;10707.250492465608;10743.83884241737;10782.73043173927;10883.401412922207;11194.66416007521;19101.426957191306;19285.132169052427;19341.323053693053;19348.70976935347;19349.226030958605;8278.875816862752;8455;8555.230029297392;8675.089115642893;8700.08649091849;4331.566843315706;4565.840195593139;4570.588647021717;4573.382593349922;4858.101251268456;3370.983145084259;3436.1581412554083;3461.671141241578;3465.757396982187;3466.445368740989;625.1466747889099;638.7413097695348;642.5983760149907;658.9769358072444;662.4998126414526;588.0238803586027;639.597053856077;662.6885363878969;687.6974131382176;719.4855678190014;9307.208887244524;9356.625734970525;9396.342256042011;9510.90489095114;9986.550605222783;649.6264647827518;697.0728930522394;719.126261592168;726.1939247435342;727.5670975769409;4425.181341451842;4496.235639941153;4521.909561808746;4525.434320709911;4581.289900065495;115761;115914;116176.41911790556;116225;119876;99074.50462747784;100385.49807250917;101631;102191.4890425558;104165;89788.5510572456;89927;92183.5390823055;92605;95440.99999999862;8144.470609410369;8344.37417193725;8443.620037098222;8533.66160199722;8843.646254149762;47012.7649361751;50415.49584504108;51571.742141289054;51612.74193629008;53941.460585395216;70715.8069450968;72027;77620.61189694016;78726.6063669678;79512.60243698745;10745.838812417664;11007.449627518752;11376.260543064674;11662.825057623973;12050.879491204976;13120.803187952379;13276.203427793977;13294.20234785916;13460;13577.321133943065;12240.204386714835;12354.196977196454;12402.9003093265;12591.307478088793;12786.61640150797;12040.819387709367;12137.332446715516;12229.143959923076;12513.624591262276;12697.873021269668;12328.32194229326;12485;12485.500579977062;12863.292518911176;13145.93427032897;9351.438913665203;9367.297452690938;9600.807983840145;9800;9999.3000489965;9078.863817042882;9986.950065249628;10055.899441005497;10133.847992279974;10184.439855807705 05:49:30 INFO - PROCESS | 3404 | __end_tp_report 05:49:30 INFO - PROCESS | 3404 | __start_cc_report 05:49:30 INFO - PROCESS | 3404 | _x_x_mozilla_cycle_collect,1002 05:49:30 INFO - PROCESS | 3404 | __end_cc_report 05:49:30 INFO - PROCESS | 3404 | __startTimestamp1469018970870__endTimestamp 05:49:30 INFO - PROCESS | 3404 | 05:49:30 INFO - PROCESS | 3404 | ------- Summary: start ------- 05:49:30 INFO - PROCESS | 3404 | Number of tests: 6 05:49:30 INFO - PROCESS | 3404 | 05:49:30 INFO - PROCESS | 3404 | [#0] dojo.html Cycles:165 Average:5400.86 Median:5613.89 stddev:628.54 (11.2%) stddev-sans-first:603.21 05:49:30 INFO - PROCESS | 3404 | Values: 3066.9 3068.9 3092.2 3104.1 3115.1 5302.4 5320.6 5369.3 5466.2 5478.2 5315.0 5418.4 5424.9 5445.6 5507.4 4875.8 4933.5 4952.3 4982.2 5040.2 4914.0 4992.7 5048.5 5053.6 5056.3 4958.7 5003.3 5016.9 5020.2 5047.1 4820.0 4838.4 4896.4 4925.7 5022.9 4855.5 4860.1 4879.1 4950.6 4984.6 5437.4 5448.3 5458.5 5518.5 5531.8 5657.5 5760.2 5802.3 5838.9 5904.6 5809.7 5917.1 5919.5 5920.4 5929.5 5457.0 5457.3 5464.2 5505.3 5510.2 5744.0 5841.8 5896.7 5910.8 5929.6 5754.3 5760.2 5761.2 5762.7 5767.7 5764.0 5780.7 5789.0 5831.9 5842.2 5600.6 5653.7 5773.1 5805.1 5834.4 5627.2 5702.5 5709.7 5761.5 5763.5 4308.8 4313.5 4349.1 4354.6 4393.2 3862.5 3869.7 3902.4 3921.8 3946.1 5449.7 5478.2 5502.7 5541.4 5541.7 5791.5 5794.1 5795.3 5849.2 5854.1 5322.5 5483.2 5545.2 5545.9 5548.4 5028.2 5057.5 5062.3 5062.6 5108.6 6043.8 6058.5 6059.1 6063.2 6063.4 5720.1 5752.1 5849.4 5868.8 5869.0 5986.7 6049.3 6050.6 6102.1 6103.4 5692.1 5731.3 5744.8 5745.6 5751.2 5598.7 5779.5 5781.9 5825.6 5835.2 5680.7 5704.6 5733.8 5764.2 5810.9 5742.2 5747.5 5750.1 5751.8 5753.7 5470.2 5600.5 5717.2 5728.5 5729.9 5655.0 5715.3 5749.7 5772.0 5789.9 5586.1 5602.8 5607.3 5613.9 5614.1 05:49:30 INFO - PROCESS | 3404 | 05:49:30 INFO - PROCESS | 3404 | [#1] ext.html Cycles:180 Average:61937.10 Median:40353.00 stddev:119732.22 (296.7%) stddev-sans-first:119979.55 05:49:30 INFO - PROCESS | 3404 | Values: 604.8 618.8 644.7 657.2 659.1 42957.1 44249.8 44518.6 48455.0 48566.5 46102.8 46745.3 46794.8 46814.3 46836.8 8021.1 8873.2 9103.3 9104.2 10653.8 10493.0 10975.4 10978.1 10978.2 10978.8 11010.9 11076.5 11083.9 11088.1 11103.9 8140.2 10583.6 10704.0 10956.3 10998.0 10761.2 10811.7 10820.1 10822.0 10822.7 43907.3 44033.3 44047.6 44114.6 44165.0 3261.8 3343.2 3430.2 3437.2 3514.5 33229.0 33560.8 34183.3 34208.7 34235.5 4200.2 4212.3 4238.7 4320.1 4339.6 393431.0 395975.0 396618.0 398874.0 398881.0 61136.1 61495.7 61505.4 61517.7 61538.0 62996.0 63399.0 63587.0 63742.0 63765.4 17184.7 17397.4 17447.0 17454.4 17465.1 12191.1 13123.1 13280.2 13295.5 13486.3 17162.7 17304.6 17337.4 17415.8 17418.7 6334.0 6367.4 6415.1 6470.6 6493.7 930.5 1040.6 1107.6 1139.9 1178.5 32466.8 32714.8 33154.5 33206.6 33546.8 1115.3 1134.3 1144.9 1147.8 1218.7 17204.9 17262.5 17316.7 17331.4 17428.8 536080.0 538421.0 538943.0 540315.0 540634.0 58707.7 58748.0 58888.0 59010.4 59010.7 1232.1 1239.6 1356.4 1366.3 1367.1 29887.9 33942.0 34258.8 34290.1 34395.1 50302.5 50780.5 50785.7 50913.5 51087.5 407769.0 408092.0 408767.0 409305.0 409821.0 35611.6 40825.2 41250.8 41885.6 41980.8 47695.5 48313.5 48390.5 48899.3 49437.5 40112.4 40593.6 40781.8 41716.4 42738.8 41276.8 41343.1 41924.4 42302.4 42607.8 40886.8 41322.6 42030.8 42102.0 42141.8 34302.8 36601.8 36705.4 37003.0 37418.8 28119.7 28147.8 28439.0 28706.7 28895.4 05:49:30 INFO - PROCESS | 3404 | 05:49:30 INFO - PROCESS | 3404 | [#2] jquery.html Cycles:180 Average:28774.01 Median:2156.28 stddev:81088.76 (3760.6%) stddev-sans-first:81288.23 05:49:30 INFO - PROCESS | 3404 | Values: 389.5 397.3 403.2 405.2 416.1 13437.8 18637.2 19874.9 19904.9 20271.3 15170.2 15508.5 15568.0 18591.4 19442.8 5405.7 5586.7 5786.3 5788.5 5794.8 5648.8 5750.8 5753.8 5760.6 5761.3 3915.2 5722.4 6191.3 6395.3 6443.3 5434.3 6493.6 6496.4 6496.8 6499.6 5459.6 5572.0 5583.3 5586.3 5586.8 12914.9 13538.5 13607.2 13669.0 13672.6 2154.6 2199.6 2227.3 2550.2 2560.9 9896.8 9996.5 10005.3 10042.1 10137.2 1836.8 1903.5 1918.1 1926.2 1957.2 80168.6 81155.6 82654.0 87986.6 89554.6 10649.8 10809.8 10900.0 10959.0 11047.6 15323.3 15334.2 15339.2 15346.8 15347.8 8142.7 8353.2 8387.3 8552.4 8557.1 8073.7 8141.8 8178.2 8369.7 8373.1 4668.3 4691.6 4709.8 4757.5 4859.0 1974.8 1986.2 1989.6 1998.8 2064.9 882.9 980.3 997.5 1047.9 1058.3 19032.8 19464.2 19500.4 19509.4 19582.3 1006.3 1020.4 1027.9 1073.0 1083.6 10353.2 10831.4 10934.2 10947.1 10956.8 473558.0 476742.0 478302.0 508675.0 512838.0 91131.5 94859.5 95569.0 95799.5 97102.0 964.2 995.7 1008.2 1012.7 1020.1 14776.8 16508.5 17062.4 17087.7 17198.4 41548.0 43105.4 43539.0 44290.1 45163.8 57117.4 59364.5 61079.0 61666.0 62552.4 8033.4 8224.7 8228.9 8315.4 8345.1 10519.3 12078.3 12411.9 12421.9 12925.9 10433.9 10742.8 10884.3 10918.7 11223.2 9686.4 9784.8 10241.9 10375.1 10760.0 9792.0 10833.1 10944.2 11293.4 11344.1 7586.8 7929.9 8017.6 8096.2 8153.1 9198.9 11056.4 11306.3 11319.5 11515.1 05:49:30 INFO - PROCESS | 3404 | 05:49:30 INFO - PROCESS | 3404 | [#3] mootools.html Cycles:180 Average:5992.45 Median:4728.92 stddev:3460.59 (73.2%) stddev-sans-first:3452.69 05:49:30 INFO - PROCESS | 3404 | Values: 1348.0 1460.5 1535.1 1626.5 1801.8 8668.7 8911.2 9036.0 9260.4 9281.6 9118.0 9223.5 9224.7 9227.8 9229.0 2356.6 2368.0 2380.2 2389.7 2396.7 2310.8 2377.0 2377.3 2380.3 2390.0 2335.5 2339.2 2352.5 2355.0 2360.8 2315.8 2325.9 2356.1 2357.2 2358.5 2282.5 2334.8 2364.2 2365.8 2367.0 7987.9 8138.6 8999.9 9077.1 9127.7 4821.9 4938.8 5235.5 5301.9 5333.9 3465.3 3526.3 3532.1 3590.3 3598.8 1112.1 1113.4 1123.8 1125.4 1146.4 12875.2 12999.2 13025.4 13037.3 13038.2 4480.7 4731.2 4748.3 4839.1 4889.8 10391.0 10577.0 10607.2 10867.1 10884.2 5276.8 5325.2 5326.7 5334.1 5338.8 4726.6 4826.9 4854.1 4860.0 4862.4 3897.3 3932.0 3991.2 4029.1 4170.4 1240.9 1253.1 1254.8 1266.3 1278.7 987.9 1006.2 1012.4 1027.2 1043.4 6258.3 6288.8 6289.4 6395.1 6471.5 503.8 507.9 508.6 510.3 511.7 4315.5 4338.2 4338.4 4408.5 4457.5 11155.2 11298.6 11412.5 11434.2 11437.0 10723.5 11118.2 11147.1 11463.9 11466.8 8421.3 8542.3 8547.5 8593.4 8595.9 6200.1 6342.2 6440.2 6623.2 6667.8 10408.9 10474.9 10540.4 10668.3 10798.6 10626.8 10722.4 10744.0 10753.0 10771.5 6833.8 7329.8 7549.7 8195.6 8199.8 8956.9 8998.5 8998.6 9000.8 9029.5 7769.4 7865.1 7897.1 8066.7 8111.2 7598.2 7696.9 7741.0 7761.3 7837.3 7331.4 7403.9 7440.8 7450.0 7451.4 5444.3 5481.3 5483.0 5620.4 5696.5 5514.7 5529.3 5544.5 5597.1 5712.3 05:49:30 INFO - PROCESS | 3404 | 05:49:30 INFO - PROCESS | 3404 | [#4] prototype.html Cycles:180 Average:4767.80 Median:5477.52 stddev:1417.69 (25.9%) stddev-sans-first:1381.73 05:49:30 INFO - PROCESS | 3404 | Values: 315.8 321.4 322.2 325.7 330.6 5419.8 5446.6 5451.7 5473.8 5504.8 5382.6 5396.7 5415.4 5440.5 5453.1 3988.3 4078.9 4210.5 4226.7 4241.3 4218.2 4233.6 4236.9 4256.8 4258.7 4154.6 4155.7 4186.8 4204.7 4212.4 3990.5 4014.2 4157.8 4166.0 4170.3 3684.4 3685.4 3687.6 3688.9 3692.7 5233.6 5236.3 5239.8 5278.5 5334.8 4727.4 4760.5 4778.6 4780.9 4789.5 5566.7 5577.4 5578.6 5596.2 5663.7 3922.9 4047.0 4066.3 4109.8 4115.1 5785.1 5834.6 5842.9 5864.1 5867.4 4077.9 4078.2 4098.4 4099.2 4109.0 4104.7 4159.8 4172.2 4173.7 4204.6 4735.7 4778.5 4793.9 4807.2 4813.7 5605.6 5643.2 5663.5 5669.2 5680.7 1399.5 1414.3 1424.3 1429.2 1437.7 918.6 924.5 925.8 928.4 941.8 5346.9 5462.7 5471.6 5477.2 5477.8 5771.2 5785.4 5798.8 5856.9 5857.9 5275.6 5466.4 5473.0 5488.9 5512.8 3047.3 3059.0 3071.3 3086.6 3093.2 5877.5 6025.5 6038.9 6059.1 6106.3 5923.4 5924.2 5929.8 5943.7 5983.6 5995.5 6016.4 6023.2 6027.3 6075.1 5693.5 5719.1 5759.3 5783.9 5873.6 5673.7 5709.5 5717.1 5730.7 5774.1 5734.5 5996.8 6043.5 6045.5 6067.7 4072.8 4106.9 4113.3 4120.0 4125.8 5800.5 5806.0 5874.0 5878.9 5888.9 5529.8 5727.4 5768.8 5791.7 5800.5 5694.0 5694.1 5694.4 5694.6 5717.6 5494.6 5695.4 5708.0 5734.0 5759.6 5575.8 5657.7 5661.2 5664.9 5667.6 5560.4 5563.1 5564.7 5574.5 5657.4 05:49:30 INFO - PROCESS | 3404 | 05:49:30 INFO - PROCESS | 3404 | [#5] yui.html Cycles:180 Average:20750.13 Median:25797.03 stddev:31105.83 (120.6%) stddev-sans-first:31156.40 05:49:30 INFO - PROCESS | 3404 | Values: 628.9 654.5 696.9 710.2 730.3 14305.9 15452.5 15549.1 15564.2 15656.4 13775.8 13981.0 14151.6 14154.9 14156.0 799.1 799.7 799.7 806.2 807.5 660.1 682.9 683.1 684.8 818.1 841.8 864.7 865.7 871.1 873.5 832.1 836.9 837.0 838.6 838.9 501.9 613.9 614.1 614.1 617.9 10854.5 11356.9 13416.2 13672.7 13762.0 13192.1 13221.4 13750.0 13937.9 13979.9 11101.1 11576.8 11643.2 11797.3 11916.7 3731.6 3795.1 3829.2 3920.6 3924.4 70741.0 84231.0 84233.0 84616.2 84751.6 10707.3 10743.8 10782.7 10883.4 11194.7 19101.4 19285.1 19341.3 19348.7 19349.2 8278.9 8455.0 8555.2 8675.1 8700.1 4331.6 4565.8 4570.6 4573.4 4858.1 3371.0 3436.2 3461.7 3465.8 3466.4 625.1 638.7 642.6 659.0 662.5 588.0 639.6 662.7 687.7 719.5 9307.2 9356.6 9396.3 9510.9 9986.6 649.6 697.1 719.1 726.2 727.6 4425.2 4496.2 4521.9 4525.4 4581.3 115761.0 115914.0 116176.4 116225.0 119876.0 99074.5 100385.5 101631.0 102191.5 104165.0 89788.6 89927.0 92183.5 92605.0 95441.0 8144.5 8344.4 8443.6 8533.7 8843.6 47012.8 50415.5 51571.7 51612.7 53941.5 70715.8 72027.0 77620.6 78726.6 79512.6 10745.8 11007.4 11376.3 11662.8 12050.9 13120.8 13276.2 13294.2 13460.0 13577.3 12240.2 12354.2 12402.9 12591.3 12786.6 12040.8 12137.3 12229.1 12513.6 12697.9 12328.3 12485.0 12485.5 12863.3 13145.9 9351.4 9367.3 9600.8 9800.0 9999.3 9078.9 9987.0 10055.9 10133.8 10184.4 05:49:30 INFO - PROCESS | 3404 | -------- Summary: end -------- 05:49:30 INFO - PROCESS | 3404 | 05:49:31 INFO - TEST-INFO | 3404: exit 0 05:49:31 INFO - TEST-OK | dromaeo_css | took 1116088ms 05:49:31 INFO - TEST-START | kraken 05:49:31 INFO - operating with platform_type : linux_ 05:49:31 INFO - Initialising browser for kraken test... 05:49:31 INFO - TEST-INFO | started process 3593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcts1pt/profile http://localhost:35234/getInfo.html) 05:49:35 INFO - PROCESS | 3593 | __metrics Screen width/height:1600/1200 05:49:35 INFO - PROCESS | 3593 | colorDepth:24 05:49:35 INFO - PROCESS | 3593 | Browser inner width/height: 1024/697 05:49:35 INFO - PROCESS | 3593 | __metrics 05:49:36 INFO - PROCESS | 3593 | 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" 05:49:36 INFO - PROCESS | 3593 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:49:36 INFO - PROCESS | 3593 | console.error: PushService: 05:49:36 INFO - PROCESS | 3593 | stateChangeProcessEnqueue: Error transitioning state 05:49:36 INFO - PROCESS | 3593 | UnknownError 05:49:37 INFO - TEST-INFO | 3593: exit 0 05:49:37 INFO - Browser initialized. 05:49:37 INFO - Running cycle 1/1 for kraken test... 05:49:37 INFO - TEST-INFO | started process 3674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcts1pt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:49 INFO - PROCESS | 3674 | RSS: Main: 157564928 05:49:49 INFO - PROCESS | 3674 | 05:49:51 INFO - PROCESS | 3674 | Cycle 1(1): loaded http://localhost:35234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35234/tests/kraken/driver.html?testName=audio-beat-detection) 05:49:52 INFO - PROCESS | 3674 | RSS: Main: 214188032 05:49:52 INFO - PROCESS | 3674 | 05:49:54 INFO - PROCESS | 3674 | Cycle 1(1): loaded http://localhost:35234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35234/tests/kraken/driver.html?testName=audio-dft) 05:49:55 INFO - PROCESS | 3674 | RSS: Main: 191991808 05:49:55 INFO - PROCESS | 3674 | 05:49:58 INFO - PROCESS | 3674 | Cycle 1(1): loaded http://localhost:35234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35234/tests/kraken/driver.html?testName=audio-fft) 05:49:59 INFO - PROCESS | 3674 | RSS: Main: 269856768 05:49:59 INFO - PROCESS | 3674 | 05:50:01 INFO - PROCESS | 3674 | Cycle 1(1): loaded http://localhost:35234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35234/tests/kraken/driver.html?testName=audio-oscillator) 05:50:02 INFO - PROCESS | 3674 | RSS: Main: 180748288 05:50:02 INFO - PROCESS | 3674 | 05:50:04 INFO - PROCESS | 3674 | Cycle 1(1): loaded http://localhost:35234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35234/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:50:04 INFO - PROCESS | 3674 | RSS: Main: 185188352 05:50:04 INFO - PROCESS | 3674 | 05:50:07 INFO - PROCESS | 3674 | Cycle 1(1): loaded http://localhost:35234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35234/tests/kraken/driver.html?testName=imaging-darkroom) 05:50:08 INFO - PROCESS | 3674 | RSS: Main: 219504640 05:50:08 INFO - PROCESS | 3674 | 05:50:11 INFO - PROCESS | 3674 | Cycle 1(1): loaded http://localhost:35234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35234/tests/kraken/driver.html?testName=imaging-desaturate) 05:50:12 INFO - PROCESS | 3674 | RSS: Main: 221077504 05:50:12 INFO - PROCESS | 3674 | 05:50:15 INFO - PROCESS | 3674 | Cycle 1(1): loaded http://localhost:35234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35234/tests/kraken/driver.html?testName=json-parse-financial) 05:50:16 INFO - PROCESS | 3674 | RSS: Main: 220741632 05:50:16 INFO - PROCESS | 3674 | 05:50:17 INFO - PROCESS | 3674 | Cycle 1(1): loaded http://localhost:35234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35234/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:50:17 INFO - PROCESS | 3674 | RSS: Main: 185151488 05:50:17 INFO - PROCESS | 3674 | 05:50:19 INFO - PROCESS | 3674 | Cycle 1(1): loaded http://localhost:35234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35234/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:50:20 INFO - PROCESS | 3674 | RSS: Main: 189349888 05:50:20 INFO - PROCESS | 3674 | 05:50:22 INFO - PROCESS | 3674 | Cycle 1(1): loaded http://localhost:35234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35234/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:50:23 INFO - PROCESS | 3674 | RSS: Main: 195129344 05:50:23 INFO - PROCESS | 3674 | 05:50:25 INFO - PROCESS | 3674 | Cycle 1(1): loaded http://localhost:35234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:50:26 INFO - PROCESS | 3674 | RSS: Main: 188907520 05:50:26 INFO - PROCESS | 3674 | 05:50:29 INFO - PROCESS | 3674 | Cycle 1(1): loaded http://localhost:35234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:50:29 INFO - PROCESS | 3674 | RSS: Main: 192675840 05:50:29 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | Cycle 1(1): loaded http://localhost:35234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35234/tests/kraken/driver.html?testName=ai-astar) 05:50:31 INFO - PROCESS | 3674 | RSS: Main: 244117504 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | __start_tp_report 05:50:31 INFO - PROCESS | 3674 | _x_x_mozilla_page_load 05:50:31 INFO - PROCESS | 3674 | _x_x_mozilla_page_load_details 05:50:31 INFO - PROCESS | 3674 | |i|pagename|runs| 05:50:31 INFO - PROCESS | 3674 | |0;ai-astar;102;111;111;110;111;112;110;112;110;111 05:50:31 INFO - PROCESS | 3674 | |1;audio-beat-detection;144;116;118;172;118;119;143;120;151;117 05:50:31 INFO - PROCESS | 3674 | |2;audio-dft;161;161;159;159;161;159;162;161;159;161 05:50:31 INFO - PROCESS | 3674 | |3;audio-fft;74;75;74;110;74;76;73;75;112;76 05:50:31 INFO - PROCESS | 3674 | |4;audio-oscillator;85;83;120;83;83;84;130;83;83;129 05:50:31 INFO - PROCESS | 3674 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;116 05:50:31 INFO - PROCESS | 3674 | |6;imaging-darkroom;145;148;146;146;146;145;145;146;146;145 05:50:31 INFO - PROCESS | 3674 | |7;imaging-desaturate;96;95;96;95;96;96;95;96;95;95 05:50:31 INFO - PROCESS | 3674 | |8;json-parse-financial;59;52;52;53;53;53;52;52;51;52 05:50:31 INFO - PROCESS | 3674 | |9;json-stringify-tinderbox;62;62;63;62;62;61;62;62;63;63 05:50:31 INFO - PROCESS | 3674 | |10;stanford-crypto-aes;76;76;75;74;75;75;78;80;79;75 05:50:31 INFO - PROCESS | 3674 | |11;stanford-crypto-ccm;123;129;122;126;128;128;120;121;211;120 05:50:31 INFO - PROCESS | 3674 | |12;stanford-crypto-pbkdf2;161;159;165;160;161;163;165;160;157;158 05:50:31 INFO - PROCESS | 3674 | |13;stanford-crypto-sha256-iterative;64;64;65;63;63;62;63;62;61;62 05:50:31 INFO - PROCESS | 3674 | __end_tp_report 05:50:31 INFO - PROCESS | 3674 | __start_cc_report 05:50:31 INFO - PROCESS | 3674 | _x_x_mozilla_cycle_collect,1671 05:50:31 INFO - PROCESS | 3674 | __end_cc_report 05:50:31 INFO - PROCESS | 3674 | __startTimestamp1469019031673__endTimestamp 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | ------- Summary: start ------- 05:50:31 INFO - PROCESS | 3674 | Number of tests: 14 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.91 (2.6%) stddev-sans-first:0.78 05:50:31 INFO - PROCESS | 3674 | Values: 102.0 111.0 111.0 110.0 111.0 112.0 110.0 112.0 110.0 111.0 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:131.50 stddev:19.47 (14.8%) stddev-sans-first:20.14 05:50:31 INFO - PROCESS | 3674 | Values: 144.0 116.0 118.0 172.0 118.0 119.0 143.0 120.0 151.0 117.0 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 05:50:31 INFO - PROCESS | 3674 | Values: 161.0 161.0 159.0 159.0 161.0 159.0 162.0 161.0 159.0 161.0 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | [#3] audio-fft Cycles:10 Average:81.90 Median:74.50 stddev:15.37 (20.6%) stddev-sans-first:16.04 05:50:31 INFO - PROCESS | 3674 | Values: 74.0 75.0 74.0 110.0 74.0 76.0 73.0 75.0 112.0 76.0 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:83.00 stddev:20.90 (25.2%) stddev-sans-first:21.76 05:50:31 INFO - PROCESS | 3674 | Values: 85.0 83.0 120.0 83.0 83.0 84.0 130.0 83.0 83.0 129.0 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:50:31 INFO - PROCESS | 3674 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 05:50:31 INFO - PROCESS | 3674 | Values: 145.0 148.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:50:31 INFO - PROCESS | 3674 | Values: 96.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:52.50 stddev:2.23 (4.3%) stddev-sans-first:0.67 05:50:31 INFO - PROCESS | 3674 | Values: 59.0 52.0 52.0 53.0 53.0 53.0 52.0 52.0 51.0 52.0 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 05:50:31 INFO - PROCESS | 3674 | Values: 62.0 62.0 63.0 62.0 62.0 61.0 62.0 62.0 63.0 63.0 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:2.00 (2.6%) stddev-sans-first:2.12 05:50:31 INFO - PROCESS | 3674 | Values: 76.0 76.0 75.0 74.0 75.0 75.0 78.0 80.0 79.0 75.0 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:127.00 stddev:27.69 (21.8%) stddev-sans-first:29.14 05:50:31 INFO - PROCESS | 3674 | Values: 123.0 129.0 122.0 126.0 128.0 128.0 120.0 121.0 211.0 120.0 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.00 stddev:2.73 (1.7%) stddev-sans-first:2.89 05:50:31 INFO - PROCESS | 3674 | Values: 161.0 159.0 165.0 160.0 161.0 163.0 165.0 160.0 157.0 158.0 05:50:31 INFO - PROCESS | 3674 | 05:50:31 INFO - PROCESS | 3674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.20 (1.9%) stddev-sans-first:1.20 05:50:31 INFO - PROCESS | 3674 | Values: 64.0 64.0 65.0 63.0 63.0 62.0 63.0 62.0 61.0 62.0 05:50:31 INFO - PROCESS | 3674 | -------- Summary: end -------- 05:50:31 INFO - PROCESS | 3674 | 05:50:32 INFO - TEST-INFO | 3674: exit 0 05:50:32 INFO - TEST-OK | kraken | took 61111ms 05:50:32 INFO - SUITE-END | took 1177s 05:50:32 INFO - Completed test suite (00:19:37) 05:50:32 INFO - javascript benchmark 05:50:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3066.892658756943, 3068.9386212275767, 3092.242400611849, 3104.1463597510683, 3115.112193024987, 5302.3637163540425, 5320.600954928376, 5369.328833895758, 5466.207399927008, 5478.178273259013, 5314.973425132878, 5418.4039755626845, 5424.9186262206, 5445.618806683534, 5507.366652834925, 4875.756212189394, 4933.506649335056, 4952.331435256248, 4982.153033984231, 5040.218766091261, 4913.975430122844, 4992.725400102993, 5048.545630893219, 5053.5957123430035, 5056.317397151374, 4958.677685950402, 5003.2995380646735, 5016.874578135539, 5020.196768517038, 5047.116754567955, 4820.011897560991, 4838.371011768483, 4896.436909755353, 4925.679830810986, 5022.874428139289, 4855.46589875117, 4860.125177468054, 4879.146149423872, 4950.579200767939, 4984.601231901475, 5437.429069947638, 5448.264484294609, 5458.536024437927, 5518.475744804237, 5531.778728850882, 5657.4908258256955, 5760.164776107483, 5802.332731735863, 5838.9124163137585, 5904.645721256738, 5809.6804675742815, 5917.053271476543, 5919.467247947662, 5920.407959204088, 5929.466348028698, 5457.0, 5457.263269458652, 5464.153056276284, 5505.256790333294, 5510.201020852034, 5744.023516002289, 5841.795537156179, 5896.734646940898, 5910.822675319747, 5929.6145750526075, 5754.309482862083, 5760.193572899798, 5761.164631128463, 5762.711864406763, 5767.711614419262, 5763.971180144073, 5780.71096445176, 5789.044807606782, 5831.88336233273, 5842.152887831241, 5600.60795744294, 5653.717314134276, 5773.1051686988585, 5805.071188609802, 5834.358220595731, 5627.240322556484, 5702.515286200636, 5709.714514274269, 5761.452661997104, 5763.538916886723, 4308.849190278325, 4313.525512193656, 4349.086691794695, 4354.629856462173, 4393.231184542692, 3862.517185351831, 3869.7097717671286, 3902.414637804352, 3921.8235179416993, 3946.1121247719034, 5449.6730196188355, 5478.150886612581, 5502.697351645698, 5541.445855414427, 5541.667499950016, 5791.478766910998, 5794.101914203306, 5795.275590551181, 5849.151872978395, 5854.063349864086, 5322.547583455373, 5483.177523371526, 5545.168224766237, 5545.861353466195, 5548.389677135512, 5028.220625803006, 5057.544820966057, 5062.316587260746, 5062.645614806928, 5108.6168537359845, 6043.8186854394435, 6058.454739073504, 6059.091136329585, 6063.242094738246, 6063.393660633989, 5720.11338242573, 5752.108423194411, 5849.415058494116, 5868.823935281948, 5869.031609784338, 5986.700664966821, 6049.274087109575, 6050.606710563799, 6102.115193297036, 6103.42017508336, 5692.1461780733225, 5731.254936858349, 5744.798932037359, 5745.626534275259, 5751.166080918327, 5598.748056337393, 5779.450952159538, 5781.913271301018, 5825.592208545361, 5835.183074369506, 5680.715964201856, 5704.60067795267, 5733.799317024051, 5764.193012978102, 5810.883782324415, 5742.19609254713, 5747.511461525817, 5750.13747937796, 5751.827445176651, 5753.741081651419, 5470.234167216672, 5600.523955463831, 5717.1995920570325, 5728.455796699307, 5729.914051289151, 5655.038643430709, 5715.2855893013375, 5749.655020698771, 5771.97114014444, 5789.8552536186935, 5586.050371436947, 5602.831915042555, 5607.299087614048, 5613.88772224545, 5614.07367784311], "value": 5356.87697711553, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.8215776345977, 618.7988903606326, 644.6841047886537, 657.1522735670985, 659.0838734159516, 42957.140857182836, 44249.77875110624, 44518.55481445188, 48454.99999999991, 48566.51433485673, 46102.76948615252, 46745.29882051764, 46794.766026169906, 46814.297785533156, 46836.765816170955, 8021.117677055519, 8873.157050080248, 9103.317251206186, 9104.180623743861, 10653.78692426151, 10493.0, 10975.396353200571, 10978.066864316543, 10978.176636752236, 10978.780424391507, 11010.889891101067, 11076.501557429934, 11083.944580277128, 11088.057515111224, 11103.888961110406, 8140.226678465537, 10583.629572964986, 10704.036636702656, 10956.34261944286, 10998.0, 10761.192910531741, 10811.729706757314, 10820.08029317509, 10822.02601765837, 10822.67531974042, 43907.34138987918, 44033.339499907524, 44047.55952440466, 44114.55885441136, 44165.0, 3261.836908154583, 3343.180920674426, 3430.2110514581536, 3437.1922598189403, 3514.5431093957623, 33229.0, 33560.83219583886, 34183.316333673436, 34208.65791342079, 34235.486467703005, 4200.188482714139, 4212.262854000538, 4238.724482908632, 4320.1143765527995, 4339.5877391648055, 393431.0, 395975.0, 396618.0, 398874.0, 398881.0, 61136.08295875565, 61495.69252153711, 61505.38494615086, 61517.69241153765, 61538.0, 62996.0, 63399.0, 63587.0, 63742.0, 63765.36234637594, 17184.742228866577, 17397.391091311743, 17447.0, 17454.38909638182, 17465.126743662768, 12191.14661973671, 13123.146995445266, 13280.203187808762, 13295.468181272641, 13486.325683715972, 17162.742558861628, 17304.567385815204, 17337.393191238247, 17415.82584174142, 17418.738718919227, 6334.0, 6367.363263673596, 6415.101885736, 6470.611763294218, 6493.675316234169, 930.5347326336831, 1040.6357774778767, 1107.617871834216, 1139.9373034483183, 1178.522698307187, 32466.837665811992, 32714.836425818194, 33154.50268245978, 33206.55018568849, 33546.832265838515, 1115.341948250536, 1134.2513940799033, 1144.9427528623535, 1147.8363285207445, 1218.713602303458, 17204.913975430292, 17262.482125536255, 17316.65366692659, 17331.393401230896, 17428.825711742975, 536080.0, 538421.0, 538943.0, 540315.0, 540634.0, 58707.706461468275, 58748.0, 58888.0, 59010.40989590049, 59010.704946474994, 1232.1067226261068, 1239.5723475400973, 1356.3760670091867, 1366.3236697834636, 1367.09771550776, 29887.850560747058, 33942.0, 34258.828705856315, 34290.14274643154, 34395.14012149716, 50302.49697502978, 50780.492195077575, 50785.74607126941, 50913.49086509088, 51087.48912510827, 407769.0, 408092.0, 408767.0, 409305.0, 409821.0, 35611.64388356187, 40825.183496329315, 41250.79374603108, 41885.58114418817, 41980.79009604932, 47695.523044770496, 48313.516864830905, 48390.51609484001, 48899.26651100307, 49437.50562494329, 40112.39831402473, 40593.59406406016, 40781.79609101936, 41716.3742543856, 42738.78630606827, 41276.793616031726, 41343.07812670255, 41924.37113443362, 42302.36546451867, 42607.786961064994, 40886.79556602198, 41322.58677413187, 42030.789846050575, 42102.0, 42141.78929105335, 34302.82848585841, 36601.81699091488, 36705.44941825821, 37002.97162814499, 37418.812905935294, 28119.71880281171, 28147.802287865215, 28439.0, 28706.712932870403, 28895.42209155847], "value": 21034.9523993123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.46837566721433, 397.3225650266296, 403.1996486973358, 405.18962075848304, 416.0659319826987, 13437.798433023512, 18637.16132774025, 19874.90062549687, 19904.90047549762, 20271.290504832334, 15170.241487925614, 15508.53474395767, 15568.0, 18591.44225673232, 19442.805571944275, 5405.729713514309, 5586.720663966806, 5786.334571524287, 5788.450097240777, 5794.826155215329, 5648.830535083934, 5750.769969201227, 5753.827385178452, 5760.6255593386295, 5761.279840019997, 3915.236528876856, 5722.399148089453, 6191.288001879774, 6395.328490508499, 6443.29123796382, 5434.266374039494, 6493.610383377012, 6496.3503649634895, 6496.772612958547, 6499.577527460724, 5459.590530710173, 5571.9721401392735, 5583.302087239095, 5586.301712285965, 5586.832395028156, 12914.935425322907, 13538.526151584745, 13607.183568985893, 13669.043166978316, 13672.632736726348, 2154.5798569278995, 2199.571083638691, 2227.3429338345063, 2550.1705401760987, 2560.8719564021912, 9896.752581185456, 9996.450195239258, 10005.349652272578, 10042.096211341015, 10137.239707022003, 1836.7704036995376, 1903.4670292318035, 1918.1279549943267, 1926.1621194780316, 1957.1877670766614, 80168.59915700443, 81155.5942220285, 82653.9999999994, 87986.5600671999, 89554.5522272391, 10649.84025239622, 10809.83785243222, 10900.0, 10959.0, 11047.613333533287, 15323.31045102973, 15334.156621385931, 15339.156346401054, 15346.846531534542, 15347.846521534642, 8142.715004974916, 8353.164683531599, 8387.329013678891, 8552.358573107042, 8557.058723540405, 8073.717419890276, 8141.837163256701, 8178.1821817817745, 8369.665213391518, 8373.120822313569, 4668.253079507263, 4691.62467002639, 4709.764511774466, 4757.452892917289, 4859.0, 1974.7827738948704, 1986.1757370691291, 1989.6172160348708, 1998.7701414337246, 2064.865783724053, 882.9205371516466, 980.2501086668705, 997.4912794474725, 1047.8585390972273, 1058.2856571813995, 19032.809671903105, 19464.22143114288, 19500.414987550113, 19509.414717558495, 19582.31461898827, 1006.3257617396362, 1020.3877673395903, 1027.8869324374314, 1072.973175670599, 1083.5936523803573, 10353.223508236912, 10831.404272764916, 10934.179936504794, 10947.124230061576, 10956.835647465294, 473558.0, 476742.0, 478302.0, 508675.0, 512838.0, 91131.54434227919, 94859.52570237104, 95569.0, 95799.52100239454, 97102.0, 964.1948972607811, 995.7098673051952, 1008.1581879131007, 1012.7366884610054, 1020.1481762728057, 14776.77834832457, 16508.504744857673, 17062.402815901383, 17087.743683845, 17198.39805606848, 41548.0, 43105.35341969936, 43539.0, 44290.11419771522, 45163.77418112889, 57117.42882571121, 59364.51588710317, 61079.0, 61666.0, 62552.374476254656, 8033.357331413356, 8224.712135075244, 8228.876566851382, 8315.376346773895, 8345.123762004901, 10519.316244444086, 12078.275303481467, 12411.937940310241, 12421.93789031049, 12925.935370323088, 10433.895661043292, 10742.83885741699, 10884.292520986111, 10918.672439826818, 11223.158263130135, 9686.370385924893, 9784.80430391374, 10241.948790256001, 10375.11811496001, 10760.0, 9792.0, 10833.133349331876, 10944.1791865612, 11293.378864162221, 11344.092472602008, 7586.848263034819, 7929.920700792918, 8017.599120044091, 8096.230858068474, 8153.103158652425, 9198.908010919806, 11056.447177641247, 11306.31345177682, 11319.490622921823, 11515.078793696652], "value": 8976.334280467512, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.049625014365, 1460.5180290504131, 1535.1019653502701, 1626.4713967960408, 1801.7927938287094, 8668.739937801869, 8911.242544383727, 9035.954820225897, 9260.351775375726, 9281.582328795204, 9118.0, 9223.538823058838, 9224.677136300232, 9227.815443691123, 9228.953855230715, 2356.564035653401, 2367.9526409471887, 2380.1788383007834, 2389.7371289158177, 2396.6524853896176, 2310.7573704760925, 2376.989779343781, 2377.346229786805, 2380.27401642499, 2390.0320370249988, 2335.509542995973, 2339.1579031548713, 2352.4824538601565, 2355.034435881289, 2360.775726305998, 2315.7568455312203, 2325.93022209334, 2356.1046802215133, 2357.1749887539395, 2358.481134150484, 2282.4978504729097, 2334.7665233476687, 2364.243442098529, 2365.846219995695, 2366.9526609467885, 7987.920120798775, 8138.593070346518, 8999.865002024975, 9077.092290770936, 9127.680531181442, 4821.903561928777, 4938.827141050082, 5235.450277720861, 5301.893962120775, 5333.866653333659, 3465.289615628815, 3526.3299973005305, 3532.0993146747414, 3590.263995880864, 3598.8200589970397, 1112.104755671684, 1113.3653817324127, 1123.7696272264166, 1125.364402528838, 1146.3694967767779, 12875.227486350848, 12999.155054921495, 13025.413856376486, 13037.282949437777, 13038.152520086163, 4480.686351955332, 4731.243001119804, 4748.334367988606, 4839.056384005085, 4889.755512224375, 10391.0, 10576.99518545737, 10607.204459665556, 10867.130629549774, 10884.238103332691, 5276.788928442896, 5325.227841962894, 5326.707031113326, 5334.093204155303, 5338.839834804962, 4726.598239149642, 4826.879328016757, 4854.126257273654, 4859.975700121477, 4862.3922009748785, 3897.2595206910596, 3931.9803400983383, 3991.201759648024, 4029.1135950090934, 4170.436991006236, 1240.925544467335, 1253.091508656217, 1254.8368712067372, 1266.290877108822, 1278.654763213927, 987.9407235565889, 1006.1950439648399, 1012.4026824173773, 1027.1936529824052, 1043.4261156363968, 6258.3428739982555, 6288.811335659938, 6289.433950944437, 6395.072714456378, 6471.482281417475, 503.8009986055487, 507.9441261461236, 508.59566644517696, 510.2983397827987, 511.74157050689905, 4315.525292217853, 4338.219120558329, 4338.392625032435, 4408.493023302297, 4457.509673935864, 11155.163362747826, 11298.60454884075, 11412.486438110305, 11434.199606027665, 11437.0, 10723.517441715141, 11118.22172447937, 11147.052500537384, 11463.942680286546, 11466.827997580043, 8421.326293896596, 8542.316614670812, 8547.487150770849, 8593.398462107592, 8595.914040859636, 6200.131981522681, 6342.23893132827, 6440.162778838721, 6623.205215374186, 6667.766628167991, 10408.895911041096, 10474.895251047392, 10540.367577945348, 10668.30656007357, 10798.56805727762, 10626.8405973912, 10722.356658600509, 10744.0, 10753.0, 10771.461426928465, 6833.794986150423, 7329.816754581178, 7549.698012079675, 8195.590220489072, 8199.795005124919, 8956.865647015169, 8998.505082220541, 8998.64005439775, 9000.774980625274, 9029.503377314311, 7769.417293702882, 7865.134835168013, 7897.13131555517, 8066.677332906853, 8111.1888811118415, 7598.240175982358, 7696.884546731691, 7741.0, 7761.262680045386, 7837.333826624801, 7331.376832969044, 7403.851922961619, 7440.813979650552, 7450.031495905498, 7451.44114191427, 5444.26502422168, 5481.287432633732, 5483.0, 5620.381758006698, 5696.487316141567, 5514.696691681996, 5529.33647962231, 5544.473275038865, 5597.132444471114, 5712.285964254468], "value": 4698.556277687113, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.82945209586825, 321.4278584120267, 322.22665602553883, 325.72801710571673, 330.64455710111633, 5419.756110975006, 5446.645968012076, 5451.727413629317, 5473.78104875805, 5504.779808807642, 5382.569394448445, 5396.703181325026, 5415.431379705134, 5440.455954404558, 5453.127499600065, 3988.3419235826054, 4078.9401352317186, 4210.473690788652, 4226.661867050629, 4241.321388577828, 4218.1563687262515, 4233.576642335757, 4236.872893813191, 4256.808443620044, 4258.659307255412, 4154.626083652471, 4155.729877557964, 4186.769727664977, 4204.726692764976, 4212.431321771567, 3990.521137463494, 4014.1570270243137, 4157.750534967911, 4166.0, 4170.311898536738, 3684.373656478405, 3685.3919103347916, 3687.631236876318, 3688.944665830015, 3692.667659910594, 5233.607479439057, 5236.29310043147, 5239.768654366221, 5278.4721527846905, 5334.786608535654, 4727.432708075053, 4760.509231434074, 4778.5699287064335, 4780.856574302742, 4789.544993225638, 5566.693831839248, 5577.358603760538, 5578.553715702734, 5596.1605759136455, 5663.745131469093, 3922.8626998055215, 4047.0, 4066.2680717470844, 4109.753414795122, 4115.115250221217, 5785.103308987113, 5834.562407819388, 5842.88985092831, 5864.149698293723, 5867.383924687889, 4077.918441631151, 4078.225137223918, 4098.426220329156, 4099.200655872076, 4109.0, 4104.651104656137, 4159.7920103994675, 4172.248995180836, 4173.706151093171, 4204.579542045771, 4735.692180008288, 4778.491292071691, 4793.880152996203, 4807.18277892759, 4813.663043586986, 5605.607607467438, 5643.238162848045, 5663.490285874291, 5669.206311116447, 5680.6591604503865, 1399.531157062375, 1414.3140576820233, 1424.302091974925, 1429.1925062339953, 1437.7268319019354, 918.5682729117304, 924.4591913730409, 925.833349997007, 928.4150984879483, 941.8022215334856, 5346.8663283417445, 5462.657187535919, 5471.616986810965, 5477.233187353773, 5477.808276710296, 5771.220885180447, 5785.421457854265, 5798.797042103591, 5856.941430585724, 5857.941420585739, 5275.63070585063, 5466.398696143421, 5472.960137573848, 5488.862778430492, 5512.779488820483, 3047.3295874907485, 3058.990533124064, 3071.2782496113396, 3086.5678804967324, 3093.1957691000503, 5877.529797616266, 6025.535317192632, 6038.939610603926, 6059.121427393004, 6106.328303886569, 5923.437273459014, 5924.229850119457, 5929.814037192493, 5943.70281485924, 5983.581149319593, 5995.52035837132, 6016.368281330485, 6023.1567580537885, 6027.276726792813, 6075.088736689532, 5693.459121383462, 5719.0832675336715, 5759.337676167294, 5783.913241301468, 5873.588848780544, 5673.687947162945, 5709.486146246858, 5717.056685646821, 5730.656160630376, 5774.1338799178775, 5734.455226753452, 5996.760129594767, 6043.54673399488, 6045.546584006129, 6067.696615169312, 4072.775997320176, 4106.876793696194, 4113.321301985139, 4119.97940010298, 4125.834966601423, 5800.477956983892, 5805.970970145122, 5873.970630146822, 5878.853028674317, 5888.852778680567, 5529.806456773994, 5727.427257274239, 5768.846230753782, 5791.667916379172, 5800.50695690871, 5694.0, 5694.14587811815, 5694.430556944438, 5694.572907032072, 5717.628354156966, 5494.587905906993, 5695.430456954271, 5708.0, 5734.0, 5759.625624334405, 5575.77696892136, 5657.6888271143835, 5661.235733175969, 5664.915026274527, 5667.603267771216, 5560.443955604407, 5563.13771365439, 5564.749586268546, 5574.5261652758345, 5657.43425657431], "value": 4307.713294234833, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.9402506761857, 654.4796886475252, 696.8571442854216, 710.1549156503763, 730.2729045806667, 14305.928470357647, 15452.45916392928, 15549.06705597665, 15564.221788910538, 15656.3737450502, 13775.793363099561, 13981.0, 14151.575452736408, 14154.858451415483, 14156.009079364449, 799.1329407592768, 799.6521513141773, 799.7161007842219, 806.2219957740779, 807.4630370803409, 660.0989649128928, 682.9248782633931, 683.1221879884349, 684.7637565040053, 818.1327792539927, 841.8316336732647, 864.6584599083359, 865.7446053414258, 871.1071152069117, 873.5413907698446, 832.0680837462021, 836.9246767790897, 836.9539675317855, 838.6016642095017, 838.9077201507829, 501.8644965859234, 613.8680183760468, 614.118739608663, 614.1218058176805, 617.9351168127372, 10854.45727713619, 11356.886431135665, 13416.195028298236, 13672.65818354539, 13762.036657433984, 13192.142510736867, 13221.405036773273, 13750.0, 13937.930310348384, 13979.930100349535, 11101.111911047097, 11576.826347604709, 11643.243189192675, 11797.292162470194, 11916.702082447922, 3731.626837316274, 3795.0512371907025, 3829.215010922782, 3920.5687374388795, 3924.4309575111733, 70740.99999999949, 84231.0, 84233.0, 84616.15383846144, 84751.57624211902, 10707.250492465608, 10743.83884241737, 10782.73043173927, 10883.401412922207, 11194.66416007521, 19101.426957191306, 19285.132169052427, 19341.323053693053, 19348.70976935347, 19349.226030958605, 8278.875816862752, 8455.0, 8555.230029297392, 8675.089115642893, 8700.08649091849, 4331.566843315706, 4565.840195593139, 4570.588647021717, 4573.382593349922, 4858.101251268456, 3370.983145084259, 3436.1581412554083, 3461.671141241578, 3465.757396982187, 3466.445368740989, 625.1466747889099, 638.7413097695348, 642.5983760149907, 658.9769358072444, 662.4998126414526, 588.0238803586027, 639.597053856077, 662.6885363878969, 687.6974131382176, 719.4855678190014, 9307.208887244524, 9356.625734970525, 9396.342256042011, 9510.90489095114, 9986.550605222783, 649.6264647827518, 697.0728930522394, 719.126261592168, 726.1939247435342, 727.5670975769409, 4425.181341451842, 4496.235639941153, 4521.909561808746, 4525.434320709911, 4581.289900065495, 115761.0, 115914.0, 116176.41911790556, 116225.0, 119876.0, 99074.50462747784, 100385.49807250917, 101631.0, 102191.4890425558, 104165.0, 89788.5510572456, 89927.0, 92183.5390823055, 92605.0, 95440.99999999862, 8144.470609410369, 8344.37417193725, 8443.620037098222, 8533.66160199722, 8843.646254149762, 47012.7649361751, 50415.49584504108, 51571.742141289054, 51612.74193629008, 53941.460585395216, 70715.8069450968, 72027.0, 77620.61189694016, 78726.6063669678, 79512.60243698745, 10745.838812417664, 11007.449627518752, 11376.260543064674, 11662.825057623973, 12050.879491204976, 13120.803187952379, 13276.203427793977, 13294.20234785916, 13460.0, 13577.321133943065, 12240.204386714835, 12354.196977196454, 12402.9003093265, 12591.307478088793, 12786.61640150797, 12040.819387709367, 12137.332446715516, 12229.143959923076, 12513.624591262276, 12697.873021269668, 12328.32194229326, 12485.0, 12485.500579977062, 12863.292518911176, 13145.93427032897, 9351.438913665203, 9367.297452690938, 9600.807983840145, 9800.0, 9999.3000489965, 9078.863817042882, 9986.950065249628, 10055.899441005497, 10133.847992279974, 10184.439855807705], "value": 7221.804065673979, "unit": "score"}], "name": "dromaeo_css", "value": 7271.807620884031, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 110.0, 111.0, 112.0, 110.0, 112.0, 110.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 118.0, 172.0, 118.0, 119.0, 143.0, 120.0, 151.0, 117.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 159.0, 161.0, 159.0, 162.0, 161.0, 159.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 110.0, 74.0, 76.0, 73.0, 75.0, 112.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 120.0, 83.0, 83.0, 84.0, 130.0, 83.0, 83.0, 129.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 148.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 52.0, 52.0, 53.0, 53.0, 53.0, 52.0, 52.0, 51.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 62.0, 61.0, 62.0, 62.0, 63.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 74.0, 75.0, 75.0, 78.0, 80.0, 79.0, 75.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 129.0, 122.0, 126.0, 128.0, 128.0, 120.0, 121.0, 211.0, 120.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 165.0, 160.0, 161.0, 163.0, 165.0, 160.0, 157.0, 158.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 63.0, 63.0, 62.0, 63.0, 62.0, 61.0, 62.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1486.3999999999999, "alertThreshold": 2.0}]} 05:50:32 INFO - Return code: 0 05:50:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:50:32 INFO - # TBPL SUCCESS # 05:50:32 INFO - Running post-action listener: _resource_record_post_action 05:50:32 INFO - [mozharness: 2016-07-20 12:50:32.989514Z] Finished run-tests step (success) 05:50:32 INFO - Running post-run listener: _resource_record_post_run 05:50:33 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 7761920; Write bytes: 427073536; Read time: 1744; Write time: 354748 05:50:33 INFO - TinderboxPrint: CPU usage
13.0% 05:50:33 INFO - TinderboxPrint: I/O read bytes / time
7,761,920 / 1,744 05:50:33 INFO - TinderboxPrint: I/O write bytes / time
427,073,536 / 354,748 05:50:33 INFO - TinderboxPrint: CPU idle
8,296.9 (87.0%) 05:50:33 INFO - TinderboxPrint: CPU user
1,194.8 (12.5%) 05:50:33 INFO - TinderboxPrint: Swap in / out
0 / 0 05:50:33 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 4624384; Read time: 0; Write time: 704 05:50:33 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 5705728; Write bytes: 420188160; Read time: 1444; Write time: 353592 05:50:33 INFO - Running post-run listener: _upload_blobber_files 05:50:33 INFO - Blob upload gear active. 05:50:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:50:33 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 05:50:33 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'] 05:50:33 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 05:50:34 INFO - (blobuploader) - INFO - Open directory for files ... 05:50:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:50:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:51:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:00 INFO - (blobuploader) - INFO - Done attempting. 05:51:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:51:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:51:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:01 INFO - (blobuploader) - INFO - Done attempting. 05:51:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:51:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:51:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:02 INFO - (blobuploader) - INFO - Done attempting. 05:51:02 INFO - (blobuploader) - INFO - Iteration through files over. 05:51:02 INFO - Return code: 0 05:51:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:51:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:51:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/316109d22743ca838ffc242b676c96bd9ab7540892723df42543854eb9409101497d4b249f4487735be13f0107960133fe957adc4d1c95ba5ef4ae07a6606148", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3752ef40911771609b897ee4797cdf201543a2f1e4c0c74326e3df61614de798938ece2d136f56c3466f0417d17a1b822d3ccfd92bb2ce8c79848db706c9de3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba62127d556bbf4b0828fb70aff849363fccf0a9f161b0772db7f4247bb33af78fa390ec896661b6994c64eb7301c5e89d32292d2ba40a365b816196ee6be62a"} 05:51:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:51:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:51:02 INFO - Contents: 05:51:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/316109d22743ca838ffc242b676c96bd9ab7540892723df42543854eb9409101497d4b249f4487735be13f0107960133fe957adc4d1c95ba5ef4ae07a6606148", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3752ef40911771609b897ee4797cdf201543a2f1e4c0c74326e3df61614de798938ece2d136f56c3466f0417d17a1b822d3ccfd92bb2ce8c79848db706c9de3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba62127d556bbf4b0828fb70aff849363fccf0a9f161b0772db7f4247bb33af78fa390ec896661b6994c64eb7301c5e89d32292d2ba40a365b816196ee6be62a"} 05:51:02 INFO - Running post-run listener: copy_logs_to_upload_dir 05:51:02 INFO - Copying logs to upload dir... 05:51:02 INFO - mkdir: /builds/slave/test/build/upload/logs 05:51:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.210822 ========= master_lag: -0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-20 05:51:02.609832) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 05:51:02.613757) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737 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/316109d22743ca838ffc242b676c96bd9ab7540892723df42543854eb9409101497d4b249f4487735be13f0107960133fe957adc4d1c95ba5ef4ae07a6606148", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3752ef40911771609b897ee4797cdf201543a2f1e4c0c74326e3df61614de798938ece2d136f56c3466f0417d17a1b822d3ccfd92bb2ce8c79848db706c9de3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba62127d556bbf4b0828fb70aff849363fccf0a9f161b0772db7f4247bb33af78fa390ec896661b6994c64eb7301c5e89d32292d2ba40a365b816196ee6be62a"} build_url:https://queue.taskcluster.net/v1/task/J_Nqahx5S5GUT_YikbDSiA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011141 build_url: 'https://queue.taskcluster.net/v1/task/J_Nqahx5S5GUT_YikbDSiA/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/316109d22743ca838ffc242b676c96bd9ab7540892723df42543854eb9409101497d4b249f4487735be13f0107960133fe957adc4d1c95ba5ef4ae07a6606148", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3752ef40911771609b897ee4797cdf201543a2f1e4c0c74326e3df61614de798938ece2d136f56c3466f0417d17a1b822d3ccfd92bb2ce8c79848db706c9de3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba62127d556bbf4b0828fb70aff849363fccf0a9f161b0772db7f4247bb33af78fa390ec896661b6994c64eb7301c5e89d32292d2ba40a365b816196ee6be62a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 05:51:02.640828) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 05:51:02.641175) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469017401.408994-910589737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004373 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 05:51:02.726295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 05:51:02.726618) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 05:51:02.726917) ========= ========= Total master_lag: 0.07 =========