builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1468056324.33 results: success (0) buildid: 20160708233021 builduid: 10d500cb1d874b6fb6b25848e724f7ae revision: 95c5d3617db2355aed67724a9d8180d9c6cd0467 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.330905) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.331345) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.331660) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.371483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.371783) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-09 02:25:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2016-07-09 02:25:25 (47.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168592 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.565349) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.565639) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019202 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.614891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.615223) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 95c5d3617db2355aed67724a9d8180d9c6cd0467 --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 95c5d3617db2355aed67724a9d8180d9c6cd0467 --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=97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-09 02:25:25,506 truncating revision to first 12 chars 2016-07-09 02:25:25,506 Setting DEBUG logging. 2016-07-09 02:25:25,506 attempt 1/10 2016-07-09 02:25:25,506 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/95c5d3617db2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-09 02:25:26,009 unpacking tar archive at: fx-team-95c5d3617db2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.832967 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:25.462338) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:25.462718) ========= script_repo_revision: 95c5d3617db2355aed67724a9d8180d9c6cd0467 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:25.463121) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:25.463386) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:25.472694) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-09 02:25:25.473033) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:25:26 INFO - MultiFileLogger online at 20160709 02:25:26 in /builds/slave/test 02:25:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:25:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:25:26 INFO - {'append_to_log': False, 02:25:26 INFO - 'base_work_dir': '/builds/slave/test', 02:25:26 INFO - 'blob_upload_branch': 'Fx-Team', 02:25:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:25:26 INFO - 'branch': 'Fx-Team', 02:25:26 INFO - 'buildbot_json_path': 'buildprops.json', 02:25:26 INFO - 'config_files': ('talos/linux_config.py',), 02:25:26 INFO - 'default_actions': ('clobber', 02:25:26 INFO - 'read-buildbot-config', 02:25:26 INFO - 'download-and-extract', 02:25:26 INFO - 'populate-webroot', 02:25:26 INFO - 'create-virtualenv', 02:25:26 INFO - 'install', 02:25:26 INFO - 'run-tests'), 02:25:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:25:26 INFO - 'download_minidump_stackwalk': True, 02:25:26 INFO - 'download_symbols': 'ondemand', 02:25:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:25:26 INFO - 'tooltool.py': '/tools/tooltool.py', 02:25:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:25:26 INFO - '/tools/misc-python/virtualenv.py')}, 02:25:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:25:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:25:26 INFO - 'installer_path': 'installer.exe', 02:25:26 INFO - 'log_level': 'info', 02:25:26 INFO - 'log_name': 'talos', 02:25:26 INFO - 'log_to_console': True, 02:25:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:25:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:25:26 INFO - 'opt_config_files': (), 02:25:26 INFO - 'pip_index': False, 02:25:26 INFO - 'sps_profile': False, 02:25:26 INFO - 'sps_profile_interval': 0, 02:25:26 INFO - 'suite': 'dromaeojs-e10s', 02:25:26 INFO - 'system_bits': '32', 02:25:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:25:26 INFO - 'title': 'talos-linux64-ix-068', 02:25:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:25:26 INFO - 'use_talos_json': True, 02:25:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:25:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:25:26 INFO - 'work_dir': 'build'} 02:25:26 INFO - ##### 02:25:26 INFO - ##### Running clobber step. 02:25:26 INFO - ##### 02:25:26 INFO - Running pre-action listener: _resource_record_pre_action 02:25:26 INFO - Running main action method: clobber 02:25:26 INFO - rmtree: /builds/slave/test/build 02:25:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:25:26 INFO - Running post-action listener: _resource_record_post_action 02:25:26 INFO - ##### 02:25:26 INFO - ##### Finished clobber step (success) 02:25:26 INFO - ##### 02:25:26 INFO - ##### 02:25:26 INFO - ##### Running read-buildbot-config step. 02:25:26 INFO - ##### 02:25:26 INFO - Running pre-action listener: _resource_record_pre_action 02:25:26 INFO - Running main action method: read_buildbot_config 02:25:26 INFO - Using buildbot properties: 02:25:26 INFO - { 02:25:26 INFO - "project": "", 02:25:26 INFO - "product": "firefox", 02:25:26 INFO - "script_repo_revision": "production", 02:25:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:25:26 INFO - "repository": "", 02:25:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:25:26 INFO - "buildid": "20160708233021", 02:25:26 INFO - "pgo_build": "True", 02:25:26 INFO - "basedir": "/builds/slave/test", 02:25:26 INFO - "buildnumber": 559, 02:25:26 INFO - "slavename": "talos-linux64-ix-068", 02:25:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:25:26 INFO - "platform": "ubuntu64_hw", 02:25:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:25:26 INFO - "branch": "fx-team", 02:25:26 INFO - "repo_path": "integration/fx-team", 02:25:26 INFO - "revision": "95c5d3617db2355aed67724a9d8180d9c6cd0467", 02:25:26 INFO - "stage_platform": "linux64-pgo", 02:25:26 INFO - "builduid": "10d500cb1d874b6fb6b25848e724f7ae", 02:25:26 INFO - "slavebuilddir": "test" 02:25:26 INFO - } 02:25:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:25:26 INFO - Running post-action listener: _resource_record_post_action 02:25:26 INFO - ##### 02:25:26 INFO - ##### Finished read-buildbot-config step (success) 02:25:26 INFO - ##### 02:25:26 INFO - ##### 02:25:26 INFO - ##### Running download-and-extract step. 02:25:26 INFO - ##### 02:25:26 INFO - Running pre-action listener: _resource_record_pre_action 02:25:26 INFO - Running main action method: download_and_extract 02:25:26 INFO - mkdir: /builds/slave/test/build/tests 02:25: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')]} 02:25:26 INFO - https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:25:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:25:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:25:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:28 INFO - Downloaded 1361 bytes. 02:25:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:25:28 INFO - Using the following test package requirements: 02:25:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:25:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:25:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:25:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:28 INFO - u'jsshell-linux-x86_64.zip'], 02:25:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:25:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:25:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:25:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:25:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:25:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:25:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:28 INFO - https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:25:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:25:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:25:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:29 INFO - Downloaded 24305234 bytes. 02:25:29 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'] 02:25:29 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 02:25:31 INFO - Return code: 0 02:25:31 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 02:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:31 INFO - https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:25:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:25:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:25:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:34 INFO - Downloaded 24305234 bytes. 02:25:34 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'] 02:25:34 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 02:25:36 INFO - Return code: 0 02:25: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')]} 02:25:36 INFO - https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:25:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:25:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:25:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:37 INFO - Downloaded 14403333 bytes. 02:25:37 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'] 02:25:37 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 02:25:37 INFO - Return code: 0 02:25: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')]} 02:25:37 INFO - https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:25:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:25:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:25:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:39 INFO - Downloaded 60461554 bytes. 02:25:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:25:39 INFO - mkdir: /builds/slave/test/properties 02:25:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:25:39 INFO - Writing to file /builds/slave/test/properties/build_url 02:25:39 INFO - Contents: 02:25:39 INFO - build_url:https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:25:39 INFO - Running post-action listener: _resource_record_post_action 02:25:39 INFO - Running post-action listener: set_extra_try_arguments 02:25:39 INFO - ##### 02:25:39 INFO - ##### Finished download-and-extract step (success) 02:25:39 INFO - ##### 02:25:39 INFO - ##### 02:25:39 INFO - ##### Running populate-webroot step. 02:25:39 INFO - ##### 02:25:39 INFO - Running pre-action listener: _resource_record_pre_action 02:25:39 INFO - Running main action method: populate_webroot 02:25:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:25:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:25:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:25:39 INFO - '--tppagecycles', 02:25:39 INFO - '7'], 02:25:39 INFO - 'tests': ['tsvgm']}}, 02:25:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:25:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:25:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:25:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:25:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:25:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:25:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:39 INFO - 'talos_options': ['--disable-e10s'], 02:25:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:25:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:25:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:39 INFO - 'talos_options': ['--disable-e10s'], 02:25:39 INFO - 'tests': ['damp', 'tps']}, 02:25:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:39 INFO - 'tests': ['damp', 'tps']}, 02:25:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:25:39 INFO - 'tests': ['dromaeo_dom']}, 02:25:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:25:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:25:39 INFO - 'tests': ['basic_compositor_video']}, 02:25:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:25:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:25:39 INFO - 'tests': ['a11yr', 02:25:39 INFO - 'ts_paint', 02:25:39 INFO - 'tpaint', 02:25:39 INFO - 'sessionrestore', 02:25:39 INFO - 'sessionrestore_no_auto_restore', 02:25:39 INFO - 'tabpaint']}, 02:25:39 INFO - 'other-e10s': {'tests': ['a11yr', 02:25:39 INFO - 'ts_paint', 02:25:39 INFO - 'tpaint', 02:25:39 INFO - 'sessionrestore', 02:25:39 INFO - 'sessionrestore_no_auto_restore', 02:25:39 INFO - 'tabpaint']}, 02:25:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:25:39 INFO - 'ts_paint', 02:25:39 INFO - 'tpaint', 02:25:39 INFO - 'sessionrestore', 02:25:39 INFO - 'sessionrestore_no_auto_restore', 02:25:39 INFO - 'tabpaint']}, 02:25:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:25:39 INFO - 'ts_paint', 02:25:39 INFO - 'tpaint', 02:25:39 INFO - 'sessionrestore', 02:25:39 INFO - 'sessionrestore_no_auto_restore', 02:25:39 INFO - 'tabpaint']}, 02:25:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:25:39 INFO - 'tests': ['a11yr', 02:25:39 INFO - 'ts_paint', 02:25:39 INFO - 'tpaint', 02:25:39 INFO - 'sessionrestore', 02:25:39 INFO - 'sessionrestore_no_auto_restore', 02:25:39 INFO - 'tabpaint']}, 02:25:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:25:39 INFO - 'tests': ['a11yr', 02:25:39 INFO - 'ts_paint', 02:25:39 INFO - 'tpaint', 02:25:39 INFO - 'sessionrestore', 02:25:39 INFO - 'sessionrestore_no_auto_restore', 02:25:39 INFO - 'tabpaint']}, 02:25:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:25:39 INFO - 'tests': ['tsvgx', 02:25:39 INFO - 'tsvgr_opacity', 02:25:39 INFO - 'tart', 02:25:39 INFO - 'tscrollx', 02:25:39 INFO - 'cart']}, 02:25:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:25:39 INFO - 'tsvgr_opacity', 02:25:39 INFO - 'tart', 02:25:39 INFO - 'tscrollx', 02:25:39 INFO - 'cart']}, 02:25:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:39 INFO - 'talos_options': ['--disable-e10s'], 02:25:39 INFO - 'tests': ['tp5o']}, 02:25:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:39 INFO - 'tests': ['tp5o']}, 02:25:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:39 INFO - 'talos_options': ['--disable-e10s', 02:25:39 INFO - '--xperf_path', 02:25:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:25:39 INFO - 'tests': ['tp5n']}, 02:25:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:39 INFO - 'talos_options': ['--xperf_path', 02:25:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:25:39 INFO - 'tests': ['tp5n']}}, 02:25:39 INFO - 'talos.zip': {'path': '', 02:25:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:25:39 INFO - Running post-action listener: _resource_record_post_action 02:25:39 INFO - ##### 02:25:39 INFO - ##### Finished populate-webroot step (success) 02:25:39 INFO - ##### 02:25:39 INFO - ##### 02:25:39 INFO - ##### Running create-virtualenv step. 02:25:39 INFO - ##### 02:25:39 INFO - Running pre-action listener: _resource_record_pre_action 02:25:39 INFO - Running main action method: create_virtualenv 02:25:39 INFO - Creating virtualenv /builds/slave/test/build/venv 02:25:39 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 02:25:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:25:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:25:40 INFO - Using real prefix '/usr' 02:25:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:25:40 INFO - Installing distribute.............................................................................................................................................................................................done. 02:25:42 INFO - Installing pip.................done. 02:25:42 INFO - Return code: 0 02:25:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:25:42 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')]} 02:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:42 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')]} 02:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:42 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 0x164e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d3b0>, '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 0x190e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', '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 02:25:42 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 02:25:42 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 02:25:42 INFO - Using env: {'DISPLAY': ':0', 02:25:42 INFO - 'HOME': '/home/cltbld', 02:25:42 INFO - 'LANG': 'en_US.UTF-8', 02:25:42 INFO - 'LANGUAGE': 'en_US:en', 02:25:42 INFO - 'LOGNAME': 'cltbld', 02:25:42 INFO - 'MAIL': '/var/mail/cltbld', 02:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:42 INFO - 'MOZ_NO_REMOTE': '1', 02:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:42 INFO - 'NO_EM_RESTART': '1', 02:25:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:42 INFO - 'PWD': '/builds/slave/test', 02:25:42 INFO - 'SHELL': '/bin/bash', 02:25:42 INFO - 'SHLVL': '1', 02:25:42 INFO - 'TERM': 'linux', 02:25:42 INFO - 'TMOUT': '86400', 02:25:42 INFO - 'USER': 'cltbld', 02:25:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', 02:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:42 INFO - '_': '/tools/buildbot/bin/python'} 02:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:42 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 02:25:42 INFO - Cleaning up... 02:25:42 INFO - Return code: 0 02:25:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:25:42 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')]} 02:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:42 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')]} 02:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:42 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 0x164e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d3b0>, '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 0x190e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', '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 02:25:42 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 02:25:42 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 02:25:42 INFO - Using env: {'DISPLAY': ':0', 02:25:42 INFO - 'HOME': '/home/cltbld', 02:25:42 INFO - 'LANG': 'en_US.UTF-8', 02:25:42 INFO - 'LANGUAGE': 'en_US:en', 02:25:42 INFO - 'LOGNAME': 'cltbld', 02:25:42 INFO - 'MAIL': '/var/mail/cltbld', 02:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:42 INFO - 'MOZ_NO_REMOTE': '1', 02:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:42 INFO - 'NO_EM_RESTART': '1', 02:25:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:42 INFO - 'PWD': '/builds/slave/test', 02:25:42 INFO - 'SHELL': '/bin/bash', 02:25:42 INFO - 'SHLVL': '1', 02:25:42 INFO - 'TERM': 'linux', 02:25:42 INFO - 'TMOUT': '86400', 02:25:42 INFO - 'USER': 'cltbld', 02:25:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', 02:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:42 INFO - '_': '/tools/buildbot/bin/python'} 02:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:43 INFO - Downloading/unpacking psutil>=3.1.1 02:25:43 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 02:25:43 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 02:25:43 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 02:25:43 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 02:25:43 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 02:25:43 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 02:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:25:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:25:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:25:45 INFO - Installing collected packages: psutil 02:25:45 INFO - Running setup.py install for psutil 02:25:45 INFO - building 'psutil._psutil_linux' extension 02:25:45 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 02:25:45 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 02:25:45 INFO - building 'psutil._psutil_posix' extension 02:25:45 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 02:25:45 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 02:25:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:25:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:25:45 INFO - Successfully installed psutil 02:25:45 INFO - Cleaning up... 02:25:45 INFO - Return code: 0 02:25:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:45 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 0x164e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d3b0>, '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 0x190e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', '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 02:25:45 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 02:25:45 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 02:25:45 INFO - Using env: {'DISPLAY': ':0', 02:25:45 INFO - 'HOME': '/home/cltbld', 02:25:45 INFO - 'LANG': 'en_US.UTF-8', 02:25:45 INFO - 'LANGUAGE': 'en_US:en', 02:25:45 INFO - 'LOGNAME': 'cltbld', 02:25:45 INFO - 'MAIL': '/var/mail/cltbld', 02:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:45 INFO - 'MOZ_NO_REMOTE': '1', 02:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:45 INFO - 'NO_EM_RESTART': '1', 02:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:45 INFO - 'PWD': '/builds/slave/test', 02:25:45 INFO - 'SHELL': '/bin/bash', 02:25:45 INFO - 'SHLVL': '1', 02:25:45 INFO - 'TERM': 'linux', 02:25:45 INFO - 'TMOUT': '86400', 02:25:45 INFO - 'USER': 'cltbld', 02:25:45 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', 02:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:45 INFO - '_': '/tools/buildbot/bin/python'} 02:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:25:45 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 02:25:45 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 02:25:45 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 02:25:45 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 02:25:45 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 02:25:45 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 02:25:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:25:47 INFO - Installing collected packages: mozsystemmonitor 02:25:47 INFO - Running setup.py install for mozsystemmonitor 02:25:47 INFO - Successfully installed mozsystemmonitor 02:25:47 INFO - Cleaning up... 02:25:47 INFO - Return code: 0 02:25:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d3b0>, '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 0x190e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', '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 02:25:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:25:47 INFO - Using env: {'DISPLAY': ':0', 02:25:47 INFO - 'HOME': '/home/cltbld', 02:25:47 INFO - 'LANG': 'en_US.UTF-8', 02:25:47 INFO - 'LANGUAGE': 'en_US:en', 02:25:47 INFO - 'LOGNAME': 'cltbld', 02:25:47 INFO - 'MAIL': '/var/mail/cltbld', 02:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:47 INFO - 'MOZ_NO_REMOTE': '1', 02:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:47 INFO - 'NO_EM_RESTART': '1', 02:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:47 INFO - 'PWD': '/builds/slave/test', 02:25:47 INFO - 'SHELL': '/bin/bash', 02:25:47 INFO - 'SHLVL': '1', 02:25:47 INFO - 'TERM': 'linux', 02:25:47 INFO - 'TMOUT': '86400', 02:25:47 INFO - 'USER': 'cltbld', 02:25:47 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', 02:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:47 INFO - '_': '/tools/buildbot/bin/python'} 02:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:48 INFO - Downloading/unpacking jsonschema==2.5.1 02:25:48 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 02:25:48 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 02:25:48 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 02:25:48 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 02:25:48 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 02:25:48 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 02:25:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:25:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:25:50 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 02:25:50 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 02:25:50 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 02:25:50 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 02:25:50 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 02:25:50 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 02:25:50 INFO - Downloading functools32-3.2.3-2.tar.gz 02:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:25:50 INFO - warning: no files found matching '*.txt' 02:25:50 INFO - no previously-included directories found matching 'build' 02:25:50 INFO - no previously-included directories found matching 'dist' 02:25:50 INFO - no previously-included directories found matching '.git*' 02:25:50 INFO - Installing collected packages: jsonschema, functools32 02:25:50 INFO - Running setup.py install for functools32 02:25:50 INFO - warning: no files found matching '*.txt' 02:25:50 INFO - no previously-included directories found matching 'build' 02:25:50 INFO - no previously-included directories found matching 'dist' 02:25:50 INFO - no previously-included directories found matching '.git*' 02:25:50 INFO - Successfully installed jsonschema functools32 02:25:50 INFO - Cleaning up... 02:25:50 INFO - Return code: 0 02:25:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:50 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 0x164e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d3b0>, '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 0x190e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', '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 02:25:50 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 02:25:50 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 02:25:50 INFO - Using env: {'DISPLAY': ':0', 02:25:50 INFO - 'HOME': '/home/cltbld', 02:25:50 INFO - 'LANG': 'en_US.UTF-8', 02:25:50 INFO - 'LANGUAGE': 'en_US:en', 02:25:50 INFO - 'LOGNAME': 'cltbld', 02:25:50 INFO - 'MAIL': '/var/mail/cltbld', 02:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:50 INFO - 'MOZ_NO_REMOTE': '1', 02:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:50 INFO - 'NO_EM_RESTART': '1', 02:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:50 INFO - 'PWD': '/builds/slave/test', 02:25:50 INFO - 'SHELL': '/bin/bash', 02:25:50 INFO - 'SHLVL': '1', 02:25:50 INFO - 'TERM': 'linux', 02:25:50 INFO - 'TMOUT': '86400', 02:25:50 INFO - 'USER': 'cltbld', 02:25:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', 02:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:50 INFO - '_': '/tools/buildbot/bin/python'} 02:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:50 INFO - Downloading/unpacking blobuploader==1.2.4 02:25:50 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 02:25:50 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 02:25:50 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 02:25:50 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 02:25:50 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 02:25:50 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 02:25:52 INFO - Downloading blobuploader-1.2.4.tar.gz 02:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:25:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:25:52 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 02:25:52 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 02:25:52 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 02:25:52 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 02:25:52 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 02:25:52 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 02:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:25:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:25:53 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 02:25:53 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 02:25:53 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 02:25:53 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 02:25:53 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 02:25:53 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 02:25:53 INFO - Downloading docopt-0.6.1.tar.gz 02:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:25:53 INFO - Installing collected packages: blobuploader, requests, docopt 02:25:53 INFO - Running setup.py install for blobuploader 02:25:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:25:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:25:53 INFO - Running setup.py install for requests 02:25:53 INFO - Running setup.py install for docopt 02:25:53 INFO - Successfully installed blobuploader requests docopt 02:25:53 INFO - Cleaning up... 02:25:53 INFO - Return code: 0 02:25:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:25:53 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')]} 02:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:53 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')]} 02:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:53 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 0x164e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d3b0>, '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 0x190e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', '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 02:25:53 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 02:25:53 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 02:25:53 INFO - Using env: {'DISPLAY': ':0', 02:25:53 INFO - 'HOME': '/home/cltbld', 02:25:53 INFO - 'LANG': 'en_US.UTF-8', 02:25:53 INFO - 'LANGUAGE': 'en_US:en', 02:25:53 INFO - 'LOGNAME': 'cltbld', 02:25:53 INFO - 'MAIL': '/var/mail/cltbld', 02:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:53 INFO - 'MOZ_NO_REMOTE': '1', 02:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:53 INFO - 'NO_EM_RESTART': '1', 02:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:53 INFO - 'PWD': '/builds/slave/test', 02:25:53 INFO - 'SHELL': '/bin/bash', 02:25:53 INFO - 'SHLVL': '1', 02:25:53 INFO - 'TERM': 'linux', 02:25:53 INFO - 'TMOUT': '86400', 02:25:53 INFO - 'USER': 'cltbld', 02:25:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', 02:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:53 INFO - '_': '/tools/buildbot/bin/python'} 02:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:25:54 INFO - Running setup.py (path:/tmp/pip-bTY6SZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:25:54 INFO - Running setup.py (path:/tmp/pip-MYbRGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:25:54 INFO - Running setup.py (path:/tmp/pip-zndyAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:25:54 INFO - Running setup.py (path:/tmp/pip-dqlUUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:25:54 INFO - Running setup.py (path:/tmp/pip-xmWXBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:25:54 INFO - Running setup.py (path:/tmp/pip-3xmWQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:25:54 INFO - Running setup.py (path:/tmp/pip-k3qlT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:25:54 INFO - Running setup.py (path:/tmp/pip-WrCVkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:25:54 INFO - Running setup.py (path:/tmp/pip-xjeazc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:25:54 INFO - Running setup.py (path:/tmp/pip-OmmR6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:25:54 INFO - Running setup.py (path:/tmp/pip-ufMw42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:25:55 INFO - Running setup.py (path:/tmp/pip-ZOM2AF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:25:55 INFO - Running setup.py (path:/tmp/pip-vIlmjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:25:55 INFO - Running setup.py (path:/tmp/pip-cYAIV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:25:55 INFO - Running setup.py (path:/tmp/pip-CxInt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:25:55 INFO - Running setup.py (path:/tmp/pip-a07L9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:25:55 INFO - Running setup.py (path:/tmp/pip-0qlvQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:25:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:25:55 INFO - Running setup.py install for manifestparser 02:25:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:25:55 INFO - Running setup.py install for mozcrash 02:25:55 INFO - Running setup.py install for mozdebug 02:25:55 INFO - Running setup.py install for mozdevice 02:25:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:25:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:25:55 INFO - Running setup.py install for mozfile 02:25:55 INFO - Running setup.py install for mozhttpd 02:25:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:25:56 INFO - Running setup.py install for mozinfo 02:25:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:25:56 INFO - Running setup.py install for mozInstall 02:25:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:25:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:25:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:25:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:25:56 INFO - Running setup.py install for mozleak 02:25:56 INFO - Running setup.py install for mozlog 02:25:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:25:56 INFO - Running setup.py install for moznetwork 02:25:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:25:56 INFO - Running setup.py install for mozprocess 02:25:56 INFO - Running setup.py install for mozprofile 02:25:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:25:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:25:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:25:56 INFO - Running setup.py install for mozrunner 02:25:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:25:56 INFO - Running setup.py install for mozscreenshot 02:25:57 INFO - Running setup.py install for moztest 02:25:57 INFO - Running setup.py install for mozversion 02:25:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:25:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:25:57 INFO - Cleaning up... 02:25:57 INFO - Return code: 0 02:25:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:25:57 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')]} 02:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:57 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')]} 02:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:57 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 0x164e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d3b0>, '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 0x190e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', '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 02:25:57 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 02:25:57 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 02:25:57 INFO - Using env: {'DISPLAY': ':0', 02:25:57 INFO - 'HOME': '/home/cltbld', 02:25:57 INFO - 'LANG': 'en_US.UTF-8', 02:25:57 INFO - 'LANGUAGE': 'en_US:en', 02:25:57 INFO - 'LOGNAME': 'cltbld', 02:25:57 INFO - 'MAIL': '/var/mail/cltbld', 02:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:57 INFO - 'MOZ_NO_REMOTE': '1', 02:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:57 INFO - 'NO_EM_RESTART': '1', 02:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:57 INFO - 'PWD': '/builds/slave/test', 02:25:57 INFO - 'SHELL': '/bin/bash', 02:25:57 INFO - 'SHLVL': '1', 02:25:57 INFO - 'TERM': 'linux', 02:25:57 INFO - 'TMOUT': '86400', 02:25:57 INFO - 'USER': 'cltbld', 02:25:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', 02:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:57 INFO - '_': '/tools/buildbot/bin/python'} 02:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:25:57 INFO - Running setup.py (path:/tmp/pip-mQ5hYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:25:57 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)) 02:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:25:57 INFO - Running setup.py (path:/tmp/pip-94qU_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:25:57 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)) 02:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:25:57 INFO - Running setup.py (path:/tmp/pip-RXdoaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:25:57 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)) 02:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:25:57 INFO - Running setup.py (path:/tmp/pip-BpQKGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:25:57 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)) 02:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:25:57 INFO - Running setup.py (path:/tmp/pip-NYHxYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:25:57 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)) 02:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:25:57 INFO - Running setup.py (path:/tmp/pip-PEhBED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:25:57 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)) 02:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:25:57 INFO - Running setup.py (path:/tmp/pip-9jf30I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:25:57 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)) 02:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:25:57 INFO - Running setup.py (path:/tmp/pip-nW7a6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:25:58 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)) 02:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:25:58 INFO - Running setup.py (path:/tmp/pip-A0QMWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:25:58 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)) 02:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:25:58 INFO - Running setup.py (path:/tmp/pip-9mXojM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:25:58 INFO - Running setup.py (path:/tmp/pip-LQGGJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:25:58 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)) 02:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:25:58 INFO - Running setup.py (path:/tmp/pip-c6IAOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:25:58 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)) 02:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:25:58 INFO - Running setup.py (path:/tmp/pip-XApXDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:25:58 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)) 02:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:25:58 INFO - Running setup.py (path:/tmp/pip-I5l5HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:25:58 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)) 02:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:25:58 INFO - Running setup.py (path:/tmp/pip-Y3zIdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:25:58 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)) 02:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:25:58 INFO - Running setup.py (path:/tmp/pip-iA6Wna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:25:58 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)) 02:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:25:58 INFO - Running setup.py (path:/tmp/pip-7wXFqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:25:58 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)) 02:25:58 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)) 02:25:58 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)) 02:25:58 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)) 02:25:58 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)) 02:25:58 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)) 02:25:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:25:58 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 02:25:58 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 02:25:58 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 02:25:58 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 02:25:58 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 02:25:58 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 02:26:00 INFO - Downloading blessings-1.6.tar.gz 02:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:26:00 INFO - Installing collected packages: blessings 02:26:00 INFO - Running setup.py install for blessings 02:26:00 INFO - Successfully installed blessings 02:26:00 INFO - Cleaning up... 02:26:00 INFO - Return code: 0 02:26:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:26:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:01 INFO - Reading from file tmpfile_stdout 02:26:01 INFO - Current package versions: 02:26:01 INFO - argparse == 1.2.1 02:26:01 INFO - blessings == 1.6 02:26:01 INFO - blobuploader == 1.2.4 02:26:01 INFO - docopt == 0.6.1 02:26:01 INFO - functools32 == 3.2.3-2 02:26:01 INFO - jsonschema == 2.5.1 02:26:01 INFO - manifestparser == 1.1 02:26:01 INFO - mozInstall == 1.12 02:26:01 INFO - mozcrash == 0.17 02:26:01 INFO - mozdebug == 0.1 02:26:01 INFO - mozdevice == 0.48 02:26:01 INFO - mozfile == 1.2 02:26:01 INFO - mozhttpd == 0.7 02:26:01 INFO - mozinfo == 0.9 02:26:01 INFO - mozleak == 0.1 02:26:01 INFO - mozlog == 3.2 02:26:01 INFO - moznetwork == 0.27 02:26:01 INFO - mozprocess == 0.23 02:26:01 INFO - mozprofile == 0.28 02:26:01 INFO - mozrunner == 6.12 02:26:01 INFO - mozscreenshot == 0.1 02:26:01 INFO - mozsystemmonitor == 0.3 02:26:01 INFO - moztest == 0.7 02:26:01 INFO - mozversion == 1.4 02:26:01 INFO - psutil == 3.1.1 02:26:01 INFO - requests == 1.2.3 02:26:01 INFO - wsgiref == 0.1.2 02:26:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:01 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 0x164e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d3b0>, '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 0x190e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', '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 02:26:01 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 02:26:01 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 02:26:01 INFO - Using env: {'DISPLAY': ':0', 02:26:01 INFO - 'HOME': '/home/cltbld', 02:26:01 INFO - 'LANG': 'en_US.UTF-8', 02:26:01 INFO - 'LANGUAGE': 'en_US:en', 02:26:01 INFO - 'LOGNAME': 'cltbld', 02:26:01 INFO - 'MAIL': '/var/mail/cltbld', 02:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:01 INFO - 'MOZ_NO_REMOTE': '1', 02:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:01 INFO - 'NO_EM_RESTART': '1', 02:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:01 INFO - 'PWD': '/builds/slave/test', 02:26:01 INFO - 'SHELL': '/bin/bash', 02:26:01 INFO - 'SHLVL': '1', 02:26:01 INFO - 'TERM': 'linux', 02:26:01 INFO - 'TMOUT': '86400', 02:26:01 INFO - 'USER': 'cltbld', 02:26:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', 02:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:01 INFO - '_': '/tools/buildbot/bin/python'} 02:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:01 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)) 02:26:01 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)) 02:26:01 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)) 02:26:01 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)) 02:26:01 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)) 02:26:01 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)) 02:26:01 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)) 02:26:01 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)) 02:26:01 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)) 02:26:01 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)) 02:26:01 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)) 02:26:01 INFO - Cleaning up... 02:26:01 INFO - Return code: 0 02:26:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d3b0>, '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 0x190e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', '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 02:26:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:26:01 INFO - Using env: {'DISPLAY': ':0', 02:26:01 INFO - 'HOME': '/home/cltbld', 02:26:01 INFO - 'LANG': 'en_US.UTF-8', 02:26:01 INFO - 'LANGUAGE': 'en_US:en', 02:26:01 INFO - 'LOGNAME': 'cltbld', 02:26:01 INFO - 'MAIL': '/var/mail/cltbld', 02:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:01 INFO - 'MOZ_NO_REMOTE': '1', 02:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:01 INFO - 'NO_EM_RESTART': '1', 02:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:01 INFO - 'PWD': '/builds/slave/test', 02:26:01 INFO - 'SHELL': '/bin/bash', 02:26:01 INFO - 'SHLVL': '1', 02:26:01 INFO - 'TERM': 'linux', 02:26:01 INFO - 'TMOUT': '86400', 02:26:01 INFO - 'USER': 'cltbld', 02:26:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', 02:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:01 INFO - '_': '/tools/buildbot/bin/python'} 02:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:26:01 INFO - Cleaning up... 02:26:01 INFO - Return code: 0 02:26:01 INFO - Running post-action listener: _resource_record_post_action 02:26:01 INFO - Running post-action listener: _start_resource_monitoring 02:26:01 INFO - Starting resource monitoring. 02:26:01 INFO - ##### 02:26:01 INFO - ##### Finished create-virtualenv step (success) 02:26:01 INFO - ##### 02:26:01 INFO - ##### 02:26:01 INFO - ##### Running install step. 02:26:01 INFO - ##### 02:26:01 INFO - Running pre-action listener: _resource_record_pre_action 02:26:01 INFO - Running main action method: install 02:26:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:01 INFO - Reading from file tmpfile_stdout 02:26:01 INFO - Detecting whether we're running mozinstall >=1.0... 02:26:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:26:01 INFO - Reading from file tmpfile_stdout 02:26:01 INFO - Output received: 02:26:01 INFO - Usage: mozinstall [options] installer 02:26:01 INFO - Options: 02:26:01 INFO - -h, --help show this help message and exit 02:26:01 INFO - -d DEST, --destination=DEST 02:26:01 INFO - Directory to install application into. [default: 02:26:01 INFO - "/builds/slave/test"] 02:26:01 INFO - --app=APP Application being installed. [default: firefox] 02:26:01 INFO - mkdir: /builds/slave/test/build/application 02:26:01 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'] 02:26:01 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 02:26:19 INFO - Reading from file tmpfile_stdout 02:26:19 INFO - Output received: 02:26:19 INFO - /builds/slave/test/build/application/firefox/firefox 02:26:19 INFO - Running post-action listener: _resource_record_post_action 02:26:19 INFO - ##### 02:26:19 INFO - ##### Finished install step (success) 02:26:19 INFO - ##### 02:26:19 INFO - ##### 02:26:19 INFO - ##### Running run-tests step. 02:26:19 INFO - ##### 02:26:19 INFO - Running pre-action listener: _resource_record_pre_action 02:26:19 INFO - Running main action method: run_tests 02:26:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:26:19 INFO - Python 2.7.3 02:26:19 INFO - Return code: 0 02:26:19 INFO - grabbing minidump binary from tooltool 02:26:19 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')]} 02:26:19 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 0x190d3b0>, '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 0x190e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:26:19 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 02:26:19 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 02:26:19 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 02:26:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:26:19 INFO - Return code: 0 02:26:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:26:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:26:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:26:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:26:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:26:19 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:26:19 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:26:19 INFO - Using env: {'DISPLAY': ':0', 02:26:19 INFO - 'HOME': '/home/cltbld', 02:26:19 INFO - 'LANG': 'en_US.UTF-8', 02:26:19 INFO - 'LANGUAGE': 'en_US:en', 02:26:19 INFO - 'LOGNAME': 'cltbld', 02:26:19 INFO - 'MAIL': '/var/mail/cltbld', 02:26:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:26:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:19 INFO - 'MOZ_NO_REMOTE': '1', 02:26:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:19 INFO - 'NO_EM_RESTART': '1', 02:26:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:19 INFO - 'PWD': '/builds/slave/test', 02:26:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:26:19 INFO - 'SHELL': '/bin/bash', 02:26:19 INFO - 'SHLVL': '1', 02:26:19 INFO - 'TERM': 'linux', 02:26:19 INFO - 'TMOUT': '86400', 02:26:19 INFO - 'USER': 'cltbld', 02:26:19 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037', 02:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:19 INFO - '_': '/tools/buildbot/bin/python'} 02:26:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:26:19 INFO - mozversion application_buildid: 20160708233021 02:26:19 INFO - mozversion application_changeset: 95c5d3617db2355aed67724a9d8180d9c6cd0467 02:26:19 INFO - mozversion application_display_name: Nightly 02:26:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:26:19 INFO - mozversion application_name: Firefox 02:26:19 INFO - mozversion application_remotingname: firefox 02:26:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:26:19 INFO - mozversion application_vendor: Mozilla 02:26:19 INFO - mozversion application_version: 50.0a1 02:26:19 INFO - mozversion platform_buildid: 20160708233021 02:26:19 INFO - mozversion platform_changeset: 95c5d3617db2355aed67724a9d8180d9c6cd0467 02:26:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:26:19 INFO - mozversion platform_version: 50.0a1 02:26:19 INFO - using testdate: 1468056379 02:26:19 INFO - actual date: 1468056379 02:26:19 INFO - starting webserver on 'localhost:51876' 02:26:19 INFO - SUITE-START | Running 2 tests 02:26:19 INFO - TEST-START | dromaeo_css 02:26:19 INFO - operating with platform_type : linux_ 02:26:19 INFO - Initialising browser for dromaeo_css test... 02:26:19 INFO - TEST-INFO | started process 22281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaky7pq/profile http://localhost:51876/getInfo.html) 02:26:23 INFO - PROCESS | 22281 | __metrics Screen width/height:1600/1200 02:26:23 INFO - PROCESS | 22281 | colorDepth:24 02:26:23 INFO - PROCESS | 22281 | Browser inner width/height: 1024/697 02:26:23 INFO - PROCESS | 22281 | __metrics 02:26:24 ERROR - PROCESS | 22281 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 02:26:25 INFO - TEST-INFO | 22281: exit 0 02:26:25 INFO - Browser initialized. 02:26:25 INFO - Running cycle 1/1 for dromaeo_css test... 02:26:25 INFO - TEST-INFO | started process 22402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaky7pq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:37 INFO - PROCESS | 22402 | RSS: Main: 167964672 02:26:37 INFO - PROCESS | 22402 | 02:27:26 INFO - PROCESS | 22402 | 1468056446777 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] 02:29:34 INFO - PROCESS | 22402 | Cycle 1(1): loaded http://localhost:51876/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51876/tests/dromaeo/cssquery-ext.html) 02:29:35 INFO - PROCESS | 22402 | RSS: Main: 171630592 02:29:35 INFO - PROCESS | 22402 | 02:32:37 INFO - PROCESS | 22402 | Cycle 1(1): loaded http://localhost:51876/tests/dromaeo/cssquery-ext.html (next: http://localhost:51876/tests/dromaeo/cssquery-jquery.html) 02:32:38 INFO - PROCESS | 22402 | RSS: Main: 168747008 02:32:38 INFO - PROCESS | 22402 | 02:35:40 INFO - PROCESS | 22402 | Cycle 1(1): loaded http://localhost:51876/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51876/tests/dromaeo/cssquery-mootools.html) 02:35:40 INFO - PROCESS | 22402 | RSS: Main: 172163072 02:35:40 INFO - PROCESS | 22402 | 02:38:42 INFO - PROCESS | 22402 | Cycle 1(1): loaded http://localhost:51876/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51876/tests/dromaeo/cssquery-prototype.html) 02:38:43 INFO - PROCESS | 22402 | RSS: Main: 167514112 02:38:43 INFO - PROCESS | 22402 | 02:41:45 INFO - PROCESS | 22402 | Cycle 1(1): loaded http://localhost:51876/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51876/tests/dromaeo/cssquery-yui.html) 02:41:46 INFO - PROCESS | 22402 | RSS: Main: 169299968 02:41:46 INFO - PROCESS | 22402 | 02:44:48 INFO - PROCESS | 22402 | Cycle 1(1): loaded http://localhost:51876/tests/dromaeo/cssquery-yui.html (next: http://localhost:51876/tests/dromaeo/cssquery-dojo.html) 02:44:49 INFO - PROCESS | 22402 | RSS: Main: 170209280 02:44:49 INFO - PROCESS | 22402 | 02:44:49 INFO - PROCESS | 22402 | __start_tp_report 02:44:49 INFO - PROCESS | 22402 | _x_x_mozilla_page_load 02:44:49 INFO - PROCESS | 22402 | _x_x_mozilla_page_load_details 02:44:49 INFO - PROCESS | 22402 | |i|pagename|runs| 02:44:49 INFO - PROCESS | 22402 | |0;dojo.html;3056.465118604245;3100.1164668069605;3111;3122.953155702665;3136.9215769605744;5494.725263736812;5562.16567514873;5564.415736347686;5578.967890940179;5603.41164177761;5279.234510995903;5496.835094947158;5529.585281103923;5547.805826796063;5584.1902924075985;4947.925781113287;4978.775955082012;5081.84754457365;5082.288479612857;5171.301874246985;137.56387588163298;4956;4967.900641987158;4984.900301993958;5021.648484606079;4969.875753106165;4970.552650261494;4974.552290293873;5013.373328333958;5023.995200959805;5015.222640490693;5019.347484826985;5025.7235852028125;5032.949670503322;5052.848414547533;4921.8523444296725;4997.225430058346;5000.42495113063;5053.5957123430035;5056.873578160538;5499.120140777456;5517.420670829545;5537.252470916415;5545.223668686347;5560.77756889724;5788.768449262025;5949.940500594982;5981.132735753292;5989.161517387569;6005.729742161613;5903.468687818117;5936.317323507808;5947.434993675637;6018.789342372996;6019.849503762397;5584.553235741131;5588.329400471929;5594.104943209108;5596.944030559683;5602.271704678406;5915.467607915222;5930.970345148246;6014.939850601526;6053.243344581927;6079.574429789872;5713.200151978726;5811.9709401453565;5816.941830581724;5833.066709326487;5833.67914764692;5981.820545383645;5988.401159883977;5991.071383935497;5991.191189189403;5997.670128142907;5789.8552536186935;5842.328132264759;5852.912206316909;5911.527077833763;5948.791792287249;5833.7083145842535;5890.646561206341;5892.322382925932;5893.968555502855;5905.734241959122;4441.68908176431;4454.309582014793;4470.128324976598;4473.038296766211;4526.32105184225;3913.3151698452657;3936.8622098226424;3987.5414327352146;4012.996750812297;4021.4973128358956;5581.6930068845795;5584.776608935597;5661.745221465044;5679.062954612443;5691.800786972519;6011.278646562353;6017.729202185912;6018.428249316308;6020.909686354708;6028.125921741411;5560.972195138998;5572.192032155396;5588.6646801192055;5613.214150019001;5683.687397193194;4934.1611925972675;4935.531124543163;4970.403551573762;4988.451270360258;5044.268581055726;5970.373110823301;6132.386761323921;6136.8772624547255;6140.969295153585;6148.077788331786;5855.209546711139;5872.0898260769645;5882.382349853204;5890.322612899486;6005.90991135142;6095.512359011357;6124.8775024500155;6129.8467538310115;6139.662318572521;6141.570090093651;5761.91357129635;5801.3908539602735;5809.970950145223;5826.329972053099;5836.153757705194;5804.73878675469;5881.882362352814;5896.145058966512;5899.46904778572;5925.466707996301;5780.826575202751;5788.797392091256;5809.738561764815;5824.184614154106;5834.066549352084;5677.687727175045;5760.279965004374;5797.768089276382;5820.854478637899;5822.126680997884;5749.597528172988;5756.683382414008;5788.594798364074;5806.883862322646;5836.124581312837;5866.853328666817;5869.295684517885;5915.053591425351;5930.229070220844;5937.050071988461;5589.804356847653;5687.5449964001955;5689.573282003784;5691.971540142273;5700.429957004432 02:44:49 INFO - PROCESS | 22402 | |1;ext.html;562.1848319936094;587.1193210184723;595.9463648271654;620.4849974521148;637.1303171171347;39446.80276598617;43475.13049739007;43576;43590.78204608973;43734.56265437345;42369.15261694764;42892.142157156835;42905.35641965373;42906.356404653954;42914;8722.171393717586;8886.289096872235;8939.150780675825;8939.374243802937;8939.418937769024;8864.689735859247;8956.19394254517;8961.417507862001;8962.37263391563;8963.462192268486;8967.551622418885;8973.46159230445;8981.461112333249;8985.865212021825;8997.95501022494;8868.113188681113;8885.2447541959;8885.911140888573;8918.420302680337;8942.284617230605;8851.247643950272;8872;8891.644334226623;8895.644174233023;8899.065598112235;40828;41019;41089.589104108876;41227.793861030805;41244.175116497805;3445.5176275321473;3575.4994300797907;3647.3070116677745;3779.3008293465796;4184.221705775064;32802.343953121046;33247;33376.83311583451;33401.16497087568;35105;4512.932306015412;4553.567411095941;4553.908921821579;4597.2184728595885;4687.95312046882;393825;394737;396690;397477;398073;35833.283334333166;37006.814965925536;37053.44419833705;61068;61421.692891535255;36735;36762.080947976516;36788;36901.815490922374;36980.630193698256;15365.846341536666;15482.5355239343;15508.302126404338;15532.378704851906;15535.689286214438;12910.935445322713;12917.612471625866;12956.740865182643;12985;13026.088173827931;8261.710840120568;8301.377396695152;8345.66617335312;8391.454555453998;8409.285210757032;3297.2797442110354;3328.517364982064;3335.8999230023137;3338.332333533303;3373.7469689773366;1021.7292417509366;1051.3481641382239;1064.7807862690968;1133.365315423349;1182.9526818927147;32280.677193228235;32384.83807580947;32456.675433245837;32747;33111;1082.5561519777011;1141.1270378160714;1182.2079206931376;1195.557643671847;1217.4156404925686;16274.430394936357;16418.67162656764;16598.66802663964;16636.916815415847;17031.123796498578;582676;586423;588172;597580;597807;58798.70600647055;59512.107318390255;59556.70221648864;59717.22262219012;59986;1355.7017456159629;1395.2535393564394;1403.8034675145489;1427.7786943023848;1431.2986636548017;30295;30318.393632127674;30721.692783072776;31093.689063109985;31114.53328200124;50068.749656251486;50742;50820.49179508306;50841;50933.490665092875;508615;512193;512615;513751;515686;27635.723642763314;28537.42925141527;28574.85712571424;28617.713822861504;28738.568921465776;47041.29438058363;47047.764761175975;47211.29183062188;47778.522214777404;48191.5180848187;40695.52349241522;40824.38763418492;41214;41273.587264126974;42410;39842.60157398389;40996.59003410047;41857;42080.57919420767;42703;37331;37797.24405511929;40391.192176155724;41309.58690413057;44501.33248001218;35113.64886351206;37601.4359784598;37652.611264986284;38002.23995520019;38120;27782;28190.85904570464;28309.292267693472;28314.61795677979;28410.43179136447 02:44:49 INFO - PROCESS | 22402 | |2;jquery.html;389.8830350894731;396.1206122408256;397.14217290652186;400.86771365449425;417.6032768869573;14360.856391436082;18512.259509619616;19750.506237344074;20402.591948161047;20411;18663.440096797083;19327.130279137436;19479;19706.901465492654;20026.699599505984;5270.104082305998;5299.178627312754;5353;5370.91943620846;5375.946240537583;5151.793928242884;5230.189320655304;5263.131583288753;5267.683938963674;5319.361676598814;5288.814891478799;5336.706481143536;5361.544268737162;5375.16684913839;5392.137258038714;5156.37574164139;5346.27825243593;5348.224507446437;5348.411674715798;5364.865878353034;5041.59667226621;5218.973905130488;5227.921581176285;5236.423993360727;5240.292560504321;13496.595102146952;14016.369263383172;14029.579112626638;21170.5765884683;22532.549349012927;2367.2898130560934;2385.200957679162;2473.938151546208;2475.0718480569785;2696.9730302696917;10098.697039088838;10374.170066394745;10501.527431265611;10628.893711062869;10635.946820265926;1998.430447322506;2001.7097520859393;2005.1878989009474;2059.4439501334705;2072.699458578513;84772;86894;87945.56027219823;89172.5541372289;92137;11305.604303849326;11381.601643942422;11543.249688770204;11617.53529858813;12330.445129969174;15746.9212653936;15855;15911.602209944844;15941;15942.043477391162;8344.541050242295;8408.87386689188;8552.315814734806;8611.181937715906;8666.956665216634;8001.919980800234;8126;8141.796455088552;8237.258646721824;8400.705975290835;4765.761711914391;4816.181249187646;4886.364772579542;4902.142125128088;5100.591952643779;1937.6124775045048;1964.7445832041742;1987.9006049697457;2041.397787652646;2046.2326627514683;955.8900726416551;999.6701088640731;1024.1653052761976;1050.642781454294;1054.7574057966558;19801.702974455395;20165.41278461456;20177.39467815968;20213;20381.796182038288;1015.5734591471452;1017;1022.9437380943971;1043.7860238651058;1072.1851392941421;10943.890561094446;11296;11479.311241325548;11505.482253298622;11532;470605;523061;526612;533415;533705;75737.6213118942;88336.55831720929;89608.55195723979;96984.51507742557;101529.49235253777;1015.7663737340305;1020.5254556631054;1021.9897801021895;1033.0186322993186;1052.0846863228887;17970.550736231176;18332.17505212242;18352;18411.171497282387;18649.9742514163;42474.78762606167;42619.36070959;45064.324035138845;45081.520516371915;45242;61783;62787.6860615694;63179;64196.358036419035;64315.356846430936;7458.47790654649;7847.136814950237;8516.233538981522;8607.354448416268;8627.87058194115;13958.790618140532;14282.57152285433;14479.638009049437;14539.200343981183;14734.77897831512;12470.314132722424;12687.365631718561;12890.35548222604;12970.092093553361;13052.673683157996;12286.631401057983;12314.199577027464;12579.811302830647;12603.621891343275;12618.305993170463;12229.571964981184;12550.49798008106;12625.431855566705;12659.683507912376;12788.872111278768;8031.237032481905;8035.598220089089;8324.209200125979;8339.291160251447;8383.119772423808;11630.302181869114;12098;12101.939490302491;12665.556705515262;12769.936150319189 02:44:49 INFO - PROCESS | 22402 | |3;mootools.html;1533.8312785593587;1553.8290788013317;1715.8198389169138;1797.4697464248045;1850.1766713812358;7944.920550794491;8360.205780450862;8645.092265312145;9261.120193581615;9293.349465537414;8364.456310339823;8655.221030107288;8694.521801300925;8711.520866352348;8723.956380218106;2270.8523945943502;2291.40423489893;2303.6544518322216;2311.2835021143414;2317.8725170115636;2269.375921621551;2270.545890821834;2320.825938054644;2332.8367014309006;2345.1205797825814;2277.3281881844896;2277.9316620501327;2282.8972696228625;2315.641075633271;2318.385627808632;2282.954340913189;2298.8620682759006;2299.2527428585777;2303.884805759714;2308.653701944705;2262.151693115082;2266.8073213776847;2276.1350686739097;2278.8063014643776;2285.1544928376443;8613.741587752378;8705.738827835175;8733.34499912509;8748.956255218684;8823.470591764515;5318.5213330800025;5399.676019438846;5401.378841433247;5403.2705584745945;5447.891042179134;3525.1539630488755;3554.48459973305;3617.981910090433;3644.5079914211506;3715.1269451678836;1178.298912147271;1196.4914911162807;1212.0727643352843;1212.3938030984507;1214.2410993129295;12744.044196685192;12812.42344094518;12838.422270997735;12865.935670321589;12909.806352904714;4520.977395113069;4631.768411579475;4759.190937540627;4806.303086052503;4838.467768545457;10516.57933682644;10674.573017079385;10697.679069627924;10768.78462430747;10769.62306319275;5365.275687782178;5382.4886635769535;5408.621396502286;5411.161270003156;5418.349798024262;4125.8968525787095;4712;4870;4932.778024988884;4968.627352948543;3988.700847436454;4008.518977722692;4087.5708050654252;4111.198316328347;4238.152369526107;1248.6878280429892;1250.531050855929;1255.6358655989843;1271.2436100520176;1280.8527019392889;979.7893452907659;992.4491906991689;994.0953732103751;998.9810393398838;1003.5484032185545;5862.589618726648;5905.291365036223;5943.257092863392;6015.398460154037;6069.635821850703;445.83949778079864;446.4263421503417;449.1869715814386;449.60210213960227;450.71830106183637;4023.75857448554;4163.770992595436;4190.895227619334;4210.136921930997;4235.597618226264;11055.11559075272;11090.55637774496;11259.831102533468;11286.097112231002;11359.261647992855;10599.36403815758;11046.392448415254;11200.495977681025;11215.775684486265;11235.606753763579;8528.275096616733;8645.95677021611;8688.348373871984;8719.346049046348;8728.738137855875;6055.697215139314;6205.348438413902;6243.500519958483;6361.14124593174;6394.808155755335;10551.894481055091;10580.629677961235;10634.627788027381;10688.465576720977;10719.839202411815;10097.141742951932;10544.683659490227;11112.22214444981;11113;11120.165987550805;7276.345128938421;7787.299143076923;7919.683212671429;8085.070216924893;8219.753407397788;8907.688230911886;8949.463032218087;8978.595963181542;9038;9042.728718138467;7887.974563306733;8098.959505202436;8229.05365882931;8260.586970651564;8363.581820909052;7618.69525218985;7648.694052238071;7685.38516918634;7825.608719564113;7836.686532538634;6743.1908171019795;6957.408620267334;6972.58164510131;7074.823129421806;7078.327558881898;5417.5665946723375;5420.647657902224;5465.152901300305;5507.228987941771;5531.280933478622;5081.949180508148;5188.299579556862;5202.4017238016595;5209.114450543341;5277.20841873722 02:44:49 INFO - PROCESS | 22402 | |4;prototype.html;327.2326394604653;331.2893842707393;333.86979078159516;338.59030573006663;340.555574974658;5538.695371754552;5571.721413929307;5679.318481782187;5760.164776107462;5798.971005144979;5605.1872478490595;5605.663660180392;5638.238837756901;5653.632513886594;5687.516561092312;4426.826890873921;4440.400545926307;4443.311286750559;4450.799714012877;4465.240909045454;4194.496660400756;4417.558244175573;4423.690341676084;4427.601515863572;4490.193628981886;4327.17783621111;4376.540463251361;4378.868633940987;4380.430544029272;4391.165678521071;4331.696781225315;4364.869053928372;4378.584034516716;4426.9154057255855;4437.511873693891;3793.108619474421;3844.461775351453;3873.5158105236846;3881.4177873318945;3911.550171730259;5439.48324909133;5484.177373393983;5494.587905907033;5527.309086364205;5530.861728456781;4976.676516026447;4984.4330169962495;4993.975030124862;5011.84964451067;5033.245013248005;5663.546916246732;5869.8239052828485;5909.8227053188475;5926.555508336849;5927.2590926134235;4188.371744238359;4210.726302790309;4214.7471151731;4219.97890010548;4226.239276930151;6099.847503812396;6154.199954005995;6170.598911070811;6182.5363097767395;6185.474234690012;4172.687048471377;4264.829406823755;4289.1421715657;4294.141171765659;4295.849645262463;4313.331433627793;4342.413774140514;4347.56524347569;4350.303951367766;4362.912741745147;4974.129527332702;4974.37820272466;4985.651004429655;4993.550580447777;4999.175136102575;5609.831705048855;5687.260656114679;5897.528197744256;5962.612430192024;5995.370486098984;1486.8587484188986;1499.9400023998917;1501.797257370263;1504.8638278099963;1505.8945873788948;911.7766147293955;949.9952500237592;950.8114856429463;954.3367359685091;966.6032582917757;5033.1695270280725;5043.621728370314;5081.695098294114;5099.617528685363;5111.667741596784;5356.8660783479945;5362.973185134049;5388.703621300788;5415.350157981067;5439.755211015514;5060.51925067118;5127.974360128175;5148.974255128775;5363.704996225245;5785.190073389729;3205.743540516753;3212.180893872094;3215.646278909318;3233.9191520212185;3253.4957081652383;6170.50635949123;6299.04729533846;6320.408632460669;6342.873142537123;6421.458849875996;6163.907541386883;6195.845103872439;6208.678357078941;6209.640336672036;6226.6575338355915;6353.856305864989;6384.457321127663;6398.616083035033;6398.680065996775;6410.391012853772;5832.591718579659;5984.162217289496;6019.217501724747;6032.366601506778;6053.243344581927;5941.58408911372;6004.877463718929;6008.699565021644;6013.9699301503215;6019.247594050744;6105.572609917263;6243.8468573370155;6249.437550620466;6315.873682526416;6323.905141422974;4250.978745106255;4279.026076876541;4298.656107511454;4308.482982042175;4316.352547117957;5836.270466191726;5918.408159184047;6094.202210348047;6104.412852658252;6119.388061193845;5911.290645122613;5923.844850254159;5930.673812940329;5931.584789064724;5948.73230704628;5892.587518873637;5925.466707996301;5968.522518198447;5968.522518198447;5972.970135149297;5656.60403771732;5764.57887687164;5832.212651292191;5839.532837373085;5900.29196496406;5942.078977758454;5978.192943952685;6024.789132380346;6033.944059789607;6037.245344331958;5676.77292908279;5811.94188058114;5823.213866128019;5835.533157347317;5894.93677212972 02:44:49 INFO - PROCESS | 22402 | |5;yui.html;715.713714514194;749.67014513614;781.8201813582874;782.7338704840353;795.968161273549;14963.476278330247;15269.312880920357;15458.768118478232;16066.75899861503;16085.356585736572;13298.069135160518;13479.595612131627;13494.122882012662;13513.72972540551;13584.796228056586;670.587588632992;796.6972550430828;804.1717031457594;817.1542453560565;822.6585966823761;820.167529957091;820.9507429554246;825.7233826668073;828.6022709099636;831.1688311688312;858.5192292316292;865.8960924689046;868.0668281597276;871.0418539606445;871.6905498548019;855.0252711908429;858.7509622209552;859.2224037246302;860.931125509964;861.7543999960012;624.4785604020648;632.4560877645222;634.0837489827202;634.6033728919425;637.1112298343785;14370.065945713495;14378.496752613608;14400.783988240184;14513;14513.346899389553;14988.775168372484;15100.244987750679;15214.923925380413;15345.539633811004;15566;12282.570110046196;12607.684807879785;12633.2420054797;12633.620991370273;12711;3913.3151698452943;3968.0476685595536;3968.3849003404516;4054.0270335119358;4086.7547947123267;74186.25813741848;79093;79995.60002199952;80125.59937200334;81063.59468202622;11575.88424115748;11577.479013444416;11664.358460284597;11706.531738730526;11754.949518162019;20232.494187645425;20766.273180438613;22741.772582273967;22807.201747938743;22864.885675571517;8587.313014958789;8868.201861832466;8928.241099506486;8978.730638080868;9143.908560914306;4847.466778654345;4872.366592342973;4890;4918.458969513351;4969.006198760262;3496.4580490024086;3617.963820361763;3624.7462677612316;3628.4738712886483;3636.6726994570085;664.2261765043767;680.1532092544813;681.7477533312607;686.5811854768588;706.6643344411466;689.7585844954226;797.9880301795478;807.935365170785;809.1665584448028;813.0893399392718;9954.30319877616;10232.386056836614;10376.688699339033;10399.27205095636;10483.431559268029;668.6222284409293;759.5290919629865;763.8719443877313;771.7646117934084;787.5078076202374;4745.715257084586;5060.468650791688;5091.847244582668;5107;5160.277561141368;101874.49062754787;116978.41510792391;118427.40786296013;120713;122026;93952.53023734974;98966.99999999856;99521.50239248757;100022.4998875001;100548;81094.59452702817;84086.57956710177;88092;90743.54628226948;90997.54501227583;10193.286469947032;10666.73333166646;10771.676849694522;10817.621383251548;10885.945570272099;50972.490275096774;52762;53302.73348633232;53811.19283210833;55188;75606.24393755992;77304.2269577297;77382;79221.20778792138;81915.5904220475;13723.588292351245;13774.65563360884;13866.4453421862;13918.860811391756;14269.357878895682;15121.773173402187;15151;15257.923710381378;15431.537053888402;16149.19254037317;13729.725405492034;14184.432622695389;14372.425102995763;14652.706945861237;14987.250637468302;14774.409023639364;14800.703985920436;14923.477678281208;15310.923445382701;15558.533244002698;13886.72226555443;14773.96582239276;14842.554723358317;14969.850301496846;15339.463118790789;11766.411244570489;12193.69515762113;12205.206661567325;12464;12518.874811251771;12114.546254449522;12414.62756117318;12567.18313309632;12765.744685106432;12871.549495767604 02:44:49 INFO - PROCESS | 22402 | __end_tp_report 02:44:49 INFO - PROCESS | 22402 | __start_cc_report 02:44:49 INFO - PROCESS | 22402 | _x_x_mozilla_cycle_collect,369 02:44:49 INFO - PROCESS | 22402 | __end_cc_report 02:44:49 INFO - PROCESS | 22402 | __startTimestamp1468057489162__endTimestamp 02:44:49 INFO - PROCESS | 22402 | 02:44:49 INFO - PROCESS | 22402 | ------- Summary: start ------- 02:44:49 INFO - PROCESS | 22402 | Number of tests: 6 02:44:49 INFO - PROCESS | 22402 | 02:44:49 INFO - PROCESS | 22402 | [#0] dojo.html Cycles:165 Average:5462.88 Median:5749.60 stddev:771.05 (13.4%) stddev-sans-first:749.95 02:44:49 INFO - PROCESS | 22402 | Values: 3056.5 3100.1 3111.0 3123.0 3136.9 5494.7 5562.2 5564.4 5579.0 5603.4 5279.2 5496.8 5529.6 5547.8 5584.2 4947.9 4978.8 5081.8 5082.3 5171.3 137.6 4956.0 4967.9 4984.9 5021.6 4969.9 4970.6 4974.6 5013.4 5024.0 5015.2 5019.3 5025.7 5032.9 5052.8 4921.9 4997.2 5000.4 5053.6 5056.9 5499.1 5517.4 5537.3 5545.2 5560.8 5788.8 5949.9 5981.1 5989.2 6005.7 5903.5 5936.3 5947.4 6018.8 6019.8 5584.6 5588.3 5594.1 5596.9 5602.3 5915.5 5931.0 6014.9 6053.2 6079.6 5713.2 5812.0 5816.9 5833.1 5833.7 5981.8 5988.4 5991.1 5991.2 5997.7 5789.9 5842.3 5852.9 5911.5 5948.8 5833.7 5890.6 5892.3 5894.0 5905.7 4441.7 4454.3 4470.1 4473.0 4526.3 3913.3 3936.9 3987.5 4013.0 4021.5 5581.7 5584.8 5661.7 5679.1 5691.8 6011.3 6017.7 6018.4 6020.9 6028.1 5561.0 5572.2 5588.7 5613.2 5683.7 4934.2 4935.5 4970.4 4988.5 5044.3 5970.4 6132.4 6136.9 6141.0 6148.1 5855.2 5872.1 5882.4 5890.3 6005.9 6095.5 6124.9 6129.8 6139.7 6141.6 5761.9 5801.4 5810.0 5826.3 5836.2 5804.7 5881.9 5896.1 5899.5 5925.5 5780.8 5788.8 5809.7 5824.2 5834.1 5677.7 5760.3 5797.8 5820.9 5822.1 5749.6 5756.7 5788.6 5806.9 5836.1 5866.9 5869.3 5915.1 5930.2 5937.1 5589.8 5687.5 5689.6 5692.0 5700.4 02:44:49 INFO - PROCESS | 22402 | 02:44:49 INFO - PROCESS | 22402 | [#1] ext.html Cycles:180 Average:63738.68 Median:41007.80 stddev:134948.26 (329.1%) stddev-sans-first:135243.47 02:44:49 INFO - PROCESS | 22402 | Values: 562.2 587.1 595.9 620.5 637.1 39446.8 43475.1 43576.0 43590.8 43734.6 42369.2 42892.1 42905.4 42906.4 42914.0 8722.2 8886.3 8939.2 8939.4 8939.4 8864.7 8956.2 8961.4 8962.4 8963.5 8967.6 8973.5 8981.5 8985.9 8998.0 8868.1 8885.2 8885.9 8918.4 8942.3 8851.2 8872.0 8891.6 8895.6 8899.1 40828.0 41019.0 41089.6 41227.8 41244.2 3445.5 3575.5 3647.3 3779.3 4184.2 32802.3 33247.0 33376.8 33401.2 35105.0 4512.9 4553.6 4553.9 4597.2 4688.0 393825.0 394737.0 396690.0 397477.0 398073.0 35833.3 37006.8 37053.4 61068.0 61421.7 36735.0 36762.1 36788.0 36901.8 36980.6 15365.8 15482.5 15508.3 15532.4 15535.7 12910.9 12917.6 12956.7 12985.0 13026.1 8261.7 8301.4 8345.7 8391.5 8409.3 3297.3 3328.5 3335.9 3338.3 3373.7 1021.7 1051.3 1064.8 1133.4 1183.0 32280.7 32384.8 32456.7 32747.0 33111.0 1082.6 1141.1 1182.2 1195.6 1217.4 16274.4 16418.7 16598.7 16636.9 17031.1 582676.0 586423.0 588172.0 597580.0 597807.0 58798.7 59512.1 59556.7 59717.2 59986.0 1355.7 1395.3 1403.8 1427.8 1431.3 30295.0 30318.4 30721.7 31093.7 31114.5 50068.7 50742.0 50820.5 50841.0 50933.5 508615.0 512193.0 512615.0 513751.0 515686.0 27635.7 28537.4 28574.9 28617.7 28738.6 47041.3 47047.8 47211.3 47778.5 48191.5 40695.5 40824.4 41214.0 41273.6 42410.0 39842.6 40996.6 41857.0 42080.6 42703.0 37331.0 37797.2 40391.2 41309.6 44501.3 35113.6 37601.4 37652.6 38002.2 38120.0 27782.0 28190.9 28309.3 28314.6 28410.4 02:44:49 INFO - PROCESS | 22402 | 02:44:49 INFO - PROCESS | 22402 | [#2] jquery.html Cycles:180 Average:30149.96 Median:2066.07 stddev:85435.49 (4135.2%) stddev-sans-first:85645.94 02:44:49 INFO - PROCESS | 22402 | Values: 389.9 396.1 397.1 400.9 417.6 14360.9 18512.3 19750.5 20402.6 20411.0 18663.4 19327.1 19479.0 19706.9 20026.7 5270.1 5299.2 5353.0 5370.9 5375.9 5151.8 5230.2 5263.1 5267.7 5319.4 5288.8 5336.7 5361.5 5375.2 5392.1 5156.4 5346.3 5348.2 5348.4 5364.9 5041.6 5219.0 5227.9 5236.4 5240.3 13496.6 14016.4 14029.6 21170.6 22532.5 2367.3 2385.2 2473.9 2475.1 2697.0 10098.7 10374.2 10501.5 10628.9 10635.9 1998.4 2001.7 2005.2 2059.4 2072.7 84772.0 86894.0 87945.6 89172.6 92137.0 11305.6 11381.6 11543.2 11617.5 12330.4 15746.9 15855.0 15911.6 15941.0 15942.0 8344.5 8408.9 8552.3 8611.2 8667.0 8001.9 8126.0 8141.8 8237.3 8400.7 4765.8 4816.2 4886.4 4902.1 5100.6 1937.6 1964.7 1987.9 2041.4 2046.2 955.9 999.7 1024.2 1050.6 1054.8 19801.7 20165.4 20177.4 20213.0 20381.8 1015.6 1017.0 1022.9 1043.8 1072.2 10943.9 11296.0 11479.3 11505.5 11532.0 470605.0 523061.0 526612.0 533415.0 533705.0 75737.6 88336.6 89608.6 96984.5 101529.5 1015.8 1020.5 1022.0 1033.0 1052.1 17970.6 18332.2 18352.0 18411.2 18650.0 42474.8 42619.4 45064.3 45081.5 45242.0 61783.0 62787.7 63179.0 64196.4 64315.4 7458.5 7847.1 8516.2 8607.4 8627.9 13958.8 14282.6 14479.6 14539.2 14734.8 12470.3 12687.4 12890.4 12970.1 13052.7 12286.6 12314.2 12579.8 12603.6 12618.3 12229.6 12550.5 12625.4 12659.7 12788.9 8031.2 8035.6 8324.2 8339.3 8383.1 11630.3 12098.0 12101.9 12665.6 12769.9 02:44:49 INFO - PROCESS | 22402 | 02:44:49 INFO - PROCESS | 22402 | [#3] mootools.html Cycles:180 Average:5935.18 Median:450.16 stddev:3435.96 (763.3%) stddev-sans-first:3429.68 02:44:49 INFO - PROCESS | 22402 | Values: 1533.8 1553.8 1715.8 1797.5 1850.2 7944.9 8360.2 8645.1 9261.1 9293.3 8364.5 8655.2 8694.5 8711.5 8724.0 2270.9 2291.4 2303.7 2311.3 2317.9 2269.4 2270.5 2320.8 2332.8 2345.1 2277.3 2277.9 2282.9 2315.6 2318.4 2283.0 2298.9 2299.3 2303.9 2308.7 2262.2 2266.8 2276.1 2278.8 2285.2 8613.7 8705.7 8733.3 8749.0 8823.5 5318.5 5399.7 5401.4 5403.3 5447.9 3525.2 3554.5 3618.0 3644.5 3715.1 1178.3 1196.5 1212.1 1212.4 1214.2 12744.0 12812.4 12838.4 12865.9 12909.8 4521.0 4631.8 4759.2 4806.3 4838.5 10516.6 10674.6 10697.7 10768.8 10769.6 5365.3 5382.5 5408.6 5411.2 5418.3 4125.9 4712.0 4870.0 4932.8 4968.6 3988.7 4008.5 4087.6 4111.2 4238.2 1248.7 1250.5 1255.6 1271.2 1280.9 979.8 992.4 994.1 999.0 1003.5 5862.6 5905.3 5943.3 6015.4 6069.6 445.8 446.4 449.2 449.6 450.7 4023.8 4163.8 4190.9 4210.1 4235.6 11055.1 11090.6 11259.8 11286.1 11359.3 10599.4 11046.4 11200.5 11215.8 11235.6 8528.3 8646.0 8688.3 8719.3 8728.7 6055.7 6205.3 6243.5 6361.1 6394.8 10551.9 10580.6 10634.6 10688.5 10719.8 10097.1 10544.7 11112.2 11113.0 11120.2 7276.3 7787.3 7919.7 8085.1 8219.8 8907.7 8949.5 8978.6 9038.0 9042.7 7888.0 8099.0 8229.1 8260.6 8363.6 7618.7 7648.7 7685.4 7825.6 7836.7 6743.2 6957.4 6972.6 7074.8 7078.3 5417.6 5420.6 5465.2 5507.2 5531.3 5081.9 5188.3 5202.4 5209.1 5277.2 02:44:49 INFO - PROCESS | 22402 | 02:44:49 INFO - PROCESS | 22402 | [#4] prototype.html Cycles:180 Average:4933.37 Median:5588.45 stddev:1459.79 (26.1%) stddev-sans-first:1422.36 02:44:49 INFO - PROCESS | 22402 | Values: 327.2 331.3 333.9 338.6 340.6 5538.7 5571.7 5679.3 5760.2 5799.0 5605.2 5605.7 5638.2 5653.6 5687.5 4426.8 4440.4 4443.3 4450.8 4465.2 4194.5 4417.6 4423.7 4427.6 4490.2 4327.2 4376.5 4378.9 4380.4 4391.2 4331.7 4364.9 4378.6 4426.9 4437.5 3793.1 3844.5 3873.5 3881.4 3911.6 5439.5 5484.2 5494.6 5527.3 5530.9 4976.7 4984.4 4994.0 5011.8 5033.2 5663.5 5869.8 5909.8 5926.6 5927.3 4188.4 4210.7 4214.7 4220.0 4226.2 6099.8 6154.2 6170.6 6182.5 6185.5 4172.7 4264.8 4289.1 4294.1 4295.8 4313.3 4342.4 4347.6 4350.3 4362.9 4974.1 4974.4 4985.7 4993.6 4999.2 5609.8 5687.3 5897.5 5962.6 5995.4 1486.9 1499.9 1501.8 1504.9 1505.9 911.8 950.0 950.8 954.3 966.6 5033.2 5043.6 5081.7 5099.6 5111.7 5356.9 5363.0 5388.7 5415.4 5439.8 5060.5 5128.0 5149.0 5363.7 5785.2 3205.7 3212.2 3215.6 3233.9 3253.5 6170.5 6299.0 6320.4 6342.9 6421.5 6163.9 6195.8 6208.7 6209.6 6226.7 6353.9 6384.5 6398.6 6398.7 6410.4 5832.6 5984.2 6019.2 6032.4 6053.2 5941.6 6004.9 6008.7 6014.0 6019.2 6105.6 6243.8 6249.4 6315.9 6323.9 4251.0 4279.0 4298.7 4308.5 4316.4 5836.3 5918.4 6094.2 6104.4 6119.4 5911.3 5923.8 5930.7 5931.6 5948.7 5892.6 5925.5 5968.5 5968.5 5973.0 5656.6 5764.6 5832.2 5839.5 5900.3 5942.1 5978.2 6024.8 6033.9 6037.2 5676.8 5811.9 5823.2 5835.5 5894.9 02:44:49 INFO - PROCESS | 22402 | 02:44:49 INFO - PROCESS | 22402 | [#5] yui.html Cycles:180 Average:21374.91 Median:3774.99 stddev:30353.45 (804.1%) stddev-sans-first:30398.96 02:44:49 INFO - PROCESS | 22402 | Values: 715.7 749.7 781.8 782.7 796.0 14963.5 15269.3 15458.8 16066.8 16085.4 13298.1 13479.6 13494.1 13513.7 13584.8 670.6 796.7 804.2 817.2 822.7 820.2 821.0 825.7 828.6 831.2 858.5 865.9 868.1 871.0 871.7 855.0 858.8 859.2 860.9 861.8 624.5 632.5 634.1 634.6 637.1 14370.1 14378.5 14400.8 14513.0 14513.3 14988.8 15100.2 15214.9 15345.5 15566.0 12282.6 12607.7 12633.2 12633.6 12711.0 3913.3 3968.0 3968.4 4054.0 4086.8 74186.3 79093.0 79995.6 80125.6 81063.6 11575.9 11577.5 11664.4 11706.5 11754.9 20232.5 20766.3 22741.8 22807.2 22864.9 8587.3 8868.2 8928.2 8978.7 9143.9 4847.5 4872.4 4890.0 4918.5 4969.0 3496.5 3618.0 3624.7 3628.5 3636.7 664.2 680.2 681.7 686.6 706.7 689.8 798.0 807.9 809.2 813.1 9954.3 10232.4 10376.7 10399.3 10483.4 668.6 759.5 763.9 771.8 787.5 4745.7 5060.5 5091.8 5107.0 5160.3 101874.5 116978.4 118427.4 120713.0 122026.0 93952.5 98967.0 99521.5 100022.5 100548.0 81094.6 84086.6 88092.0 90743.5 90997.5 10193.3 10666.7 10771.7 10817.6 10885.9 50972.5 52762.0 53302.7 53811.2 55188.0 75606.2 77304.2 77382.0 79221.2 81915.6 13723.6 13774.7 13866.4 13918.9 14269.4 15121.8 15151.0 15257.9 15431.5 16149.2 13729.7 14184.4 14372.4 14652.7 14987.3 14774.4 14800.7 14923.5 15310.9 15558.5 13886.7 14774.0 14842.6 14969.9 15339.5 11766.4 12193.7 12205.2 12464.0 12518.9 12114.5 12414.6 12567.2 12765.7 12871.5 02:44:49 INFO - PROCESS | 22402 | -------- Summary: end -------- 02:44:49 INFO - PROCESS | 22402 | 02:44:49 INFO - TEST-INFO | 22402: exit 0 02:44:49 INFO - TEST-OK | dromaeo_css | took 1110566ms 02:44:49 INFO - TEST-START | kraken 02:44:49 INFO - operating with platform_type : linux_ 02:44:49 INFO - Initialising browser for kraken test... 02:44:49 INFO - TEST-INFO | started process 22652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphm7ui5/profile http://localhost:51876/getInfo.html) 02:44:54 INFO - PROCESS | 22652 | __metrics Screen width/height:1600/1200 02:44:54 INFO - PROCESS | 22652 | colorDepth:24 02:44:54 INFO - PROCESS | 22652 | Browser inner width/height: 1024/697 02:44:54 INFO - PROCESS | 22652 | __metrics 02:44:55 ERROR - PROCESS | 22652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 02:44:55 INFO - TEST-INFO | 22652: exit 0 02:44:55 INFO - Browser initialized. 02:44:55 INFO - Running cycle 1/1 for kraken test... 02:44:55 INFO - TEST-INFO | started process 22773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphm7ui5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:07 INFO - PROCESS | 22773 | RSS: Main: 167718912 02:45:07 INFO - PROCESS | 22773 | 02:45:10 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51876/tests/kraken/driver.html?testName=audio-beat-detection) 02:45:11 INFO - PROCESS | 22773 | RSS: Main: 173236224 02:45:11 INFO - PROCESS | 22773 | 02:45:13 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51876/tests/kraken/driver.html?testName=audio-dft) 02:45:14 INFO - PROCESS | 22773 | RSS: Main: 172351488 02:45:14 INFO - PROCESS | 22773 | 02:45:17 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51876/tests/kraken/driver.html?testName=audio-fft) 02:45:17 INFO - PROCESS | 22773 | RSS: Main: 167415808 02:45:17 INFO - PROCESS | 22773 | 02:45:20 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51876/tests/kraken/driver.html?testName=audio-oscillator) 02:45:20 INFO - PROCESS | 22773 | RSS: Main: 168497152 02:45:20 INFO - PROCESS | 22773 | 02:45:22 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51876/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:45:23 INFO - PROCESS | 22773 | RSS: Main: 168808448 02:45:23 INFO - PROCESS | 22773 | 02:45:26 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51876/tests/kraken/driver.html?testName=imaging-darkroom) 02:45:27 INFO - PROCESS | 22773 | RSS: Main: 168443904 02:45:27 INFO - PROCESS | 22773 | 02:45:30 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51876/tests/kraken/driver.html?testName=imaging-desaturate) 02:45:31 INFO - PROCESS | 22773 | RSS: Main: 165990400 02:45:31 INFO - PROCESS | 22773 | 02:45:34 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51876/tests/kraken/driver.html?testName=json-parse-financial) 02:45:34 INFO - PROCESS | 22773 | RSS: Main: 167370752 02:45:34 INFO - PROCESS | 22773 | 02:45:36 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51876/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:45:37 INFO - PROCESS | 22773 | RSS: Main: 168017920 02:45:37 INFO - PROCESS | 22773 | 02:45:38 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:45:39 INFO - PROCESS | 22773 | RSS: Main: 168067072 02:45:39 INFO - PROCESS | 22773 | 02:45:41 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:45:42 INFO - PROCESS | 22773 | RSS: Main: 168665088 02:45:42 INFO - PROCESS | 22773 | 02:45:44 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:45:45 INFO - PROCESS | 22773 | RSS: Main: 168812544 02:45:45 INFO - PROCESS | 22773 | 02:45:48 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:45:48 INFO - PROCESS | 22773 | RSS: Main: 169074688 02:45:48 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51876/tests/kraken/driver.html?testName=ai-astar) 02:45:50 INFO - PROCESS | 22773 | RSS: Main: 169250816 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | __start_tp_report 02:45:50 INFO - PROCESS | 22773 | _x_x_mozilla_page_load 02:45:50 INFO - PROCESS | 22773 | _x_x_mozilla_page_load_details 02:45:50 INFO - PROCESS | 22773 | |i|pagename|runs| 02:45:50 INFO - PROCESS | 22773 | |0;ai-astar;103;110;107;111;112;112;115;114;112;112 02:45:50 INFO - PROCESS | 22773 | |1;audio-beat-detection;163;123;144;186;122;155;145;119;188;124 02:45:50 INFO - PROCESS | 22773 | |2;audio-dft;165;166;164;164;164;166;175;166;162;163 02:45:50 INFO - PROCESS | 22773 | |3;audio-fft;74;76;76;161;77;76;77;75;176;75 02:45:50 INFO - PROCESS | 22773 | |4;audio-oscillator;85;83;154;85;84;84;140;85;84;135 02:45:50 INFO - PROCESS | 22773 | |5;imaging-gaussian-blur;118;117;117;117;117;118;117;118;118;118 02:45:50 INFO - PROCESS | 22773 | |6;imaging-darkroom;147;148;147;149;150;148;147;147;148;148 02:45:50 INFO - PROCESS | 22773 | |7;imaging-desaturate;96;96;96;95;96;95;96;98;96;95 02:45:50 INFO - PROCESS | 22773 | |8;json-parse-financial;55;53;54;54;53;61;52;54;53;54 02:45:50 INFO - PROCESS | 22773 | |9;json-stringify-tinderbox;64;63;62;62;62;62;62;63;65;63 02:45:50 INFO - PROCESS | 22773 | |10;stanford-crypto-aes;76;77;76;76;75;76;77;75;80;75 02:45:50 INFO - PROCESS | 22773 | |11;stanford-crypto-ccm;123;127;125;129;121;130;125;126;170;135 02:45:50 INFO - PROCESS | 22773 | |12;stanford-crypto-pbkdf2;161;157;156;163;164;159;160;171;158;161 02:45:50 INFO - PROCESS | 22773 | |13;stanford-crypto-sha256-iterative;67;63;65;68;63;63;63;64;65;64 02:45:50 INFO - PROCESS | 22773 | __end_tp_report 02:45:50 INFO - PROCESS | 22773 | __start_cc_report 02:45:50 INFO - PROCESS | 22773 | _x_x_mozilla_cycle_collect,931 02:45:50 INFO - PROCESS | 22773 | __end_cc_report 02:45:50 INFO - PROCESS | 22773 | __startTimestamp1468057550684__endTimestamp 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | ------- Summary: start ------- 02:45:50 INFO - PROCESS | 22773 | Number of tests: 14 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.49 (3.1%) stddev-sans-first:2.29 02:45:50 INFO - PROCESS | 22773 | Values: 103.0 110.0 107.0 111.0 112.0 112.0 115.0 114.0 112.0 112.0 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:150.00 stddev:25.92 (17.3%) stddev-sans-first:26.83 02:45:50 INFO - PROCESS | 22773 | Values: 163.0 123.0 144.0 186.0 122.0 155.0 145.0 119.0 188.0 124.0 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.50 stddev:3.60 (2.2%) stddev-sans-first:3.81 02:45:50 INFO - PROCESS | 22773 | Values: 165.0 166.0 164.0 164.0 164.0 166.0 175.0 166.0 162.0 163.0 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.00 stddev:39.28 (51.7%) stddev-sans-first:40.97 02:45:50 INFO - PROCESS | 22773 | Values: 74.0 76.0 76.0 161.0 77.0 76.0 77.0 75.0 176.0 75.0 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:84.00 stddev:28.75 (34.2%) stddev-sans-first:29.83 02:45:50 INFO - PROCESS | 22773 | Values: 85.0 83.0 154.0 85.0 84.0 84.0 140.0 85.0 84.0 135.0 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 02:45:50 INFO - PROCESS | 22773 | Values: 118.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 02:45:50 INFO - PROCESS | 22773 | Values: 147.0 148.0 147.0 149.0 150.0 148.0 147.0 147.0 148.0 148.0 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 02:45:50 INFO - PROCESS | 22773 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 98.0 96.0 95.0 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:2.50 (4.6%) stddev-sans-first:2.64 02:45:50 INFO - PROCESS | 22773 | Values: 55.0 53.0 54.0 54.0 53.0 61.0 52.0 54.0 53.0 54.0 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:1.03 (1.6%) stddev-sans-first:1.00 02:45:50 INFO - PROCESS | 22773 | Values: 64.0 63.0 62.0 62.0 62.0 62.0 62.0 63.0 65.0 63.0 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:1.49 (2.0%) stddev-sans-first:1.58 02:45:50 INFO - PROCESS | 22773 | Values: 76.0 77.0 76.0 76.0 75.0 76.0 77.0 75.0 80.0 75.0 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:128.00 stddev:14.22 (11.1%) stddev-sans-first:14.77 02:45:50 INFO - PROCESS | 22773 | Values: 123.0 127.0 125.0 129.0 121.0 130.0 125.0 126.0 170.0 135.0 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.00 stddev:4.32 (2.7%) stddev-sans-first:4.58 02:45:50 INFO - PROCESS | 22773 | Values: 161.0 157.0 156.0 163.0 164.0 159.0 160.0 171.0 158.0 161.0 02:45:50 INFO - PROCESS | 22773 | 02:45:50 INFO - PROCESS | 22773 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.50 stddev:1.78 (2.8%) stddev-sans-first:1.64 02:45:50 INFO - PROCESS | 22773 | Values: 67.0 63.0 65.0 68.0 63.0 63.0 63.0 64.0 65.0 64.0 02:45:50 INFO - PROCESS | 22773 | -------- Summary: end -------- 02:45:50 INFO - PROCESS | 22773 | 02:45:51 INFO - TEST-INFO | 22773: exit 0 02:45:51 INFO - TEST-OK | kraken | took 61717ms 02:45:51 INFO - SUITE-END | took 1172s 02:45:51 INFO - Completed test suite (00:19:32) 02:45:51 INFO - javascript benchmark 02:45:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7350.015401999995, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.465118604245, 3100.1164668069605, 3111.0, 3122.953155702665, 3136.9215769605744, 5494.725263736812, 5562.16567514873, 5564.415736347686, 5578.967890940179, 5603.41164177761, 5279.234510995903, 5496.835094947158, 5529.585281103923, 5547.805826796063, 5584.1902924075985, 4947.925781113287, 4978.775955082012, 5081.84754457365, 5082.288479612857, 5171.301874246985, 137.56387588163298, 4956.0, 4967.900641987158, 4984.900301993958, 5021.648484606079, 4969.875753106165, 4970.552650261494, 4974.552290293873, 5013.373328333958, 5023.995200959805, 5015.222640490693, 5019.347484826985, 5025.7235852028125, 5032.949670503322, 5052.848414547533, 4921.8523444296725, 4997.225430058346, 5000.42495113063, 5053.5957123430035, 5056.873578160538, 5499.120140777456, 5517.420670829545, 5537.252470916415, 5545.223668686347, 5560.77756889724, 5788.768449262025, 5949.940500594982, 5981.132735753292, 5989.161517387569, 6005.729742161613, 5903.468687818117, 5936.317323507808, 5947.434993675637, 6018.789342372996, 6019.849503762397, 5584.553235741131, 5588.329400471929, 5594.104943209108, 5596.944030559683, 5602.271704678406, 5915.467607915222, 5930.970345148246, 6014.939850601526, 6053.243344581927, 6079.574429789872, 5713.200151978726, 5811.9709401453565, 5816.941830581724, 5833.066709326487, 5833.67914764692, 5981.820545383645, 5988.401159883977, 5991.071383935497, 5991.191189189403, 5997.670128142907, 5789.8552536186935, 5842.328132264759, 5852.912206316909, 5911.527077833763, 5948.791792287249, 5833.7083145842535, 5890.646561206341, 5892.322382925932, 5893.968555502855, 5905.734241959122, 4441.68908176431, 4454.309582014793, 4470.128324976598, 4473.038296766211, 4526.32105184225, 3913.3151698452657, 3936.8622098226424, 3987.5414327352146, 4012.996750812297, 4021.4973128358956, 5581.6930068845795, 5584.776608935597, 5661.745221465044, 5679.062954612443, 5691.800786972519, 6011.278646562353, 6017.729202185912, 6018.428249316308, 6020.909686354708, 6028.125921741411, 5560.972195138998, 5572.192032155396, 5588.6646801192055, 5613.214150019001, 5683.687397193194, 4934.1611925972675, 4935.531124543163, 4970.403551573762, 4988.451270360258, 5044.268581055726, 5970.373110823301, 6132.386761323921, 6136.8772624547255, 6140.969295153585, 6148.077788331786, 5855.209546711139, 5872.0898260769645, 5882.382349853204, 5890.322612899486, 6005.90991135142, 6095.512359011357, 6124.8775024500155, 6129.8467538310115, 6139.662318572521, 6141.570090093651, 5761.91357129635, 5801.3908539602735, 5809.970950145223, 5826.329972053099, 5836.153757705194, 5804.73878675469, 5881.882362352814, 5896.145058966512, 5899.46904778572, 5925.466707996301, 5780.826575202751, 5788.797392091256, 5809.738561764815, 5824.184614154106, 5834.066549352084, 5677.687727175045, 5760.279965004374, 5797.768089276382, 5820.854478637899, 5822.126680997884, 5749.597528172988, 5756.683382414008, 5788.594798364074, 5806.883862322646, 5836.124581312837, 5866.853328666817, 5869.295684517885, 5915.053591425351, 5930.229070220844, 5937.050071988461, 5589.804356847653, 5687.5449964001955, 5689.573282003784, 5691.971540142273, 5700.429957004432], "value": 5410.356804852515, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.1848319936094, 587.1193210184723, 595.9463648271654, 620.4849974521148, 637.1303171171347, 39446.80276598617, 43475.13049739007, 43576.0, 43590.78204608973, 43734.56265437345, 42369.15261694764, 42892.142157156835, 42905.35641965373, 42906.356404653954, 42914.0, 8722.171393717586, 8886.289096872235, 8939.150780675825, 8939.374243802937, 8939.418937769024, 8864.689735859247, 8956.19394254517, 8961.417507862001, 8962.37263391563, 8963.462192268486, 8967.551622418885, 8973.46159230445, 8981.461112333249, 8985.865212021825, 8997.95501022494, 8868.113188681113, 8885.2447541959, 8885.911140888573, 8918.420302680337, 8942.284617230605, 8851.247643950272, 8872.0, 8891.644334226623, 8895.644174233023, 8899.065598112235, 40828.0, 41019.0, 41089.589104108876, 41227.793861030805, 41244.175116497805, 3445.5176275321473, 3575.4994300797907, 3647.3070116677745, 3779.3008293465796, 4184.221705775064, 32802.343953121046, 33247.0, 33376.83311583451, 33401.16497087568, 35105.0, 4512.932306015412, 4553.567411095941, 4553.908921821579, 4597.2184728595885, 4687.95312046882, 393825.0, 394737.0, 396690.0, 397477.0, 398073.0, 35833.283334333166, 37006.814965925536, 37053.44419833705, 61068.0, 61421.692891535255, 36735.0, 36762.080947976516, 36788.0, 36901.815490922374, 36980.630193698256, 15365.846341536666, 15482.5355239343, 15508.302126404338, 15532.378704851906, 15535.689286214438, 12910.935445322713, 12917.612471625866, 12956.740865182643, 12985.0, 13026.088173827931, 8261.710840120568, 8301.377396695152, 8345.66617335312, 8391.454555453998, 8409.285210757032, 3297.2797442110354, 3328.517364982064, 3335.8999230023137, 3338.332333533303, 3373.7469689773366, 1021.7292417509366, 1051.3481641382239, 1064.7807862690968, 1133.365315423349, 1182.9526818927147, 32280.677193228235, 32384.83807580947, 32456.675433245837, 32747.0, 33111.0, 1082.5561519777011, 1141.1270378160714, 1182.2079206931376, 1195.557643671847, 1217.4156404925686, 16274.430394936357, 16418.67162656764, 16598.66802663964, 16636.916815415847, 17031.123796498578, 582676.0, 586423.0, 588172.0, 597580.0, 597807.0, 58798.70600647055, 59512.107318390255, 59556.70221648864, 59717.22262219012, 59986.0, 1355.7017456159629, 1395.2535393564394, 1403.8034675145489, 1427.7786943023848, 1431.2986636548017, 30295.0, 30318.393632127674, 30721.692783072776, 31093.689063109985, 31114.53328200124, 50068.749656251486, 50742.0, 50820.49179508306, 50841.0, 50933.490665092875, 508615.0, 512193.0, 512615.0, 513751.0, 515686.0, 27635.723642763314, 28537.42925141527, 28574.85712571424, 28617.713822861504, 28738.568921465776, 47041.29438058363, 47047.764761175975, 47211.29183062188, 47778.522214777404, 48191.5180848187, 40695.52349241522, 40824.38763418492, 41214.0, 41273.587264126974, 42410.0, 39842.60157398389, 40996.59003410047, 41857.0, 42080.57919420767, 42703.0, 37331.0, 37797.24405511929, 40391.192176155724, 41309.58690413057, 44501.33248001218, 35113.64886351206, 37601.4359784598, 37652.611264986284, 38002.23995520019, 38120.0, 27782.0, 28190.85904570464, 28309.292267693472, 28314.61795677979, 28410.43179136447], "value": 19160.35069812936, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.8830350894731, 396.1206122408256, 397.14217290652186, 400.86771365449425, 417.6032768869573, 14360.856391436082, 18512.259509619616, 19750.506237344074, 20402.591948161047, 20411.0, 18663.440096797083, 19327.130279137436, 19479.0, 19706.901465492654, 20026.699599505984, 5270.104082305998, 5299.178627312754, 5353.0, 5370.91943620846, 5375.946240537583, 5151.793928242884, 5230.189320655304, 5263.131583288753, 5267.683938963674, 5319.361676598814, 5288.814891478799, 5336.706481143536, 5361.544268737162, 5375.16684913839, 5392.137258038714, 5156.37574164139, 5346.27825243593, 5348.224507446437, 5348.411674715798, 5364.865878353034, 5041.59667226621, 5218.973905130488, 5227.921581176285, 5236.423993360727, 5240.292560504321, 13496.595102146952, 14016.369263383172, 14029.579112626638, 21170.5765884683, 22532.549349012927, 2367.2898130560934, 2385.200957679162, 2473.938151546208, 2475.0718480569785, 2696.9730302696917, 10098.697039088838, 10374.170066394745, 10501.527431265611, 10628.893711062869, 10635.946820265926, 1998.430447322506, 2001.7097520859393, 2005.1878989009474, 2059.4439501334705, 2072.699458578513, 84772.0, 86894.0, 87945.56027219823, 89172.5541372289, 92137.0, 11305.604303849326, 11381.601643942422, 11543.249688770204, 11617.53529858813, 12330.445129969174, 15746.9212653936, 15855.0, 15911.602209944844, 15941.0, 15942.043477391162, 8344.541050242295, 8408.87386689188, 8552.315814734806, 8611.181937715906, 8666.956665216634, 8001.919980800234, 8126.0, 8141.796455088552, 8237.258646721824, 8400.705975290835, 4765.761711914391, 4816.181249187646, 4886.364772579542, 4902.142125128088, 5100.591952643779, 1937.6124775045048, 1964.7445832041742, 1987.9006049697457, 2041.397787652646, 2046.2326627514683, 955.8900726416551, 999.6701088640731, 1024.1653052761976, 1050.642781454294, 1054.7574057966558, 19801.702974455395, 20165.41278461456, 20177.39467815968, 20213.0, 20381.796182038288, 1015.5734591471452, 1017.0, 1022.9437380943971, 1043.7860238651058, 1072.1851392941421, 10943.890561094446, 11296.0, 11479.311241325548, 11505.482253298622, 11532.0, 470605.0, 523061.0, 526612.0, 533415.0, 533705.0, 75737.6213118942, 88336.55831720929, 89608.55195723979, 96984.51507742557, 101529.49235253777, 1015.7663737340305, 1020.5254556631054, 1021.9897801021895, 1033.0186322993186, 1052.0846863228887, 17970.550736231176, 18332.17505212242, 18352.0, 18411.171497282387, 18649.9742514163, 42474.78762606167, 42619.36070959, 45064.324035138845, 45081.520516371915, 45242.0, 61783.0, 62787.6860615694, 63179.0, 64196.358036419035, 64315.356846430936, 7458.47790654649, 7847.136814950237, 8516.233538981522, 8607.354448416268, 8627.87058194115, 13958.790618140532, 14282.57152285433, 14479.638009049437, 14539.200343981183, 14734.77897831512, 12470.314132722424, 12687.365631718561, 12890.35548222604, 12970.092093553361, 13052.673683157996, 12286.631401057983, 12314.199577027464, 12579.811302830647, 12603.621891343275, 12618.305993170463, 12229.571964981184, 12550.49798008106, 12625.431855566705, 12659.683507912376, 12788.872111278768, 8031.237032481905, 8035.598220089089, 8324.209200125979, 8339.291160251447, 8383.119772423808, 11630.302181869114, 12098.0, 12101.939490302491, 12665.556705515262, 12769.936150319189], "value": 9338.630504890587, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1533.8312785593587, 1553.8290788013317, 1715.8198389169138, 1797.4697464248045, 1850.1766713812358, 7944.920550794491, 8360.205780450862, 8645.092265312145, 9261.120193581615, 9293.349465537414, 8364.456310339823, 8655.221030107288, 8694.521801300925, 8711.520866352348, 8723.956380218106, 2270.8523945943502, 2291.40423489893, 2303.6544518322216, 2311.2835021143414, 2317.8725170115636, 2269.375921621551, 2270.545890821834, 2320.825938054644, 2332.8367014309006, 2345.1205797825814, 2277.3281881844896, 2277.9316620501327, 2282.8972696228625, 2315.641075633271, 2318.385627808632, 2282.954340913189, 2298.8620682759006, 2299.2527428585777, 2303.884805759714, 2308.653701944705, 2262.151693115082, 2266.8073213776847, 2276.1350686739097, 2278.8063014643776, 2285.1544928376443, 8613.741587752378, 8705.738827835175, 8733.34499912509, 8748.956255218684, 8823.470591764515, 5318.5213330800025, 5399.676019438846, 5401.378841433247, 5403.2705584745945, 5447.891042179134, 3525.1539630488755, 3554.48459973305, 3617.981910090433, 3644.5079914211506, 3715.1269451678836, 1178.298912147271, 1196.4914911162807, 1212.0727643352843, 1212.3938030984507, 1214.2410993129295, 12744.044196685192, 12812.42344094518, 12838.422270997735, 12865.935670321589, 12909.806352904714, 4520.977395113069, 4631.768411579475, 4759.190937540627, 4806.303086052503, 4838.467768545457, 10516.57933682644, 10674.573017079385, 10697.679069627924, 10768.78462430747, 10769.62306319275, 5365.275687782178, 5382.4886635769535, 5408.621396502286, 5411.161270003156, 5418.349798024262, 4125.8968525787095, 4712.0, 4870.0, 4932.778024988884, 4968.627352948543, 3988.700847436454, 4008.518977722692, 4087.5708050654252, 4111.198316328347, 4238.152369526107, 1248.6878280429892, 1250.531050855929, 1255.6358655989843, 1271.2436100520176, 1280.8527019392889, 979.7893452907659, 992.4491906991689, 994.0953732103751, 998.9810393398838, 1003.5484032185545, 5862.589618726648, 5905.291365036223, 5943.257092863392, 6015.398460154037, 6069.635821850703, 445.83949778079864, 446.4263421503417, 449.1869715814386, 449.60210213960227, 450.71830106183637, 4023.75857448554, 4163.770992595436, 4190.895227619334, 4210.136921930997, 4235.597618226264, 11055.11559075272, 11090.55637774496, 11259.831102533468, 11286.097112231002, 11359.261647992855, 10599.36403815758, 11046.392448415254, 11200.495977681025, 11215.775684486265, 11235.606753763579, 8528.275096616733, 8645.95677021611, 8688.348373871984, 8719.346049046348, 8728.738137855875, 6055.697215139314, 6205.348438413902, 6243.500519958483, 6361.14124593174, 6394.808155755335, 10551.894481055091, 10580.629677961235, 10634.627788027381, 10688.465576720977, 10719.839202411815, 10097.141742951932, 10544.683659490227, 11112.22214444981, 11113.0, 11120.165987550805, 7276.345128938421, 7787.299143076923, 7919.683212671429, 8085.070216924893, 8219.753407397788, 8907.688230911886, 8949.463032218087, 8978.595963181542, 9038.0, 9042.728718138467, 7887.974563306733, 8098.959505202436, 8229.05365882931, 8260.586970651564, 8363.581820909052, 7618.69525218985, 7648.694052238071, 7685.38516918634, 7825.608719564113, 7836.686532538634, 6743.1908171019795, 6957.408620267334, 6972.58164510131, 7074.823129421806, 7078.327558881898, 5417.5665946723375, 5420.647657902224, 5465.152901300305, 5507.228987941771, 5531.280933478622, 5081.949180508148, 5188.299579556862, 5202.4017238016595, 5209.114450543341, 5277.20841873722], "value": 4648.617093626884, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.2326394604653, 331.2893842707393, 333.86979078159516, 338.59030573006663, 340.555574974658, 5538.695371754552, 5571.721413929307, 5679.318481782187, 5760.164776107462, 5798.971005144979, 5605.1872478490595, 5605.663660180392, 5638.238837756901, 5653.632513886594, 5687.516561092312, 4426.826890873921, 4440.400545926307, 4443.311286750559, 4450.799714012877, 4465.240909045454, 4194.496660400756, 4417.558244175573, 4423.690341676084, 4427.601515863572, 4490.193628981886, 4327.17783621111, 4376.540463251361, 4378.868633940987, 4380.430544029272, 4391.165678521071, 4331.696781225315, 4364.869053928372, 4378.584034516716, 4426.9154057255855, 4437.511873693891, 3793.108619474421, 3844.461775351453, 3873.5158105236846, 3881.4177873318945, 3911.550171730259, 5439.48324909133, 5484.177373393983, 5494.587905907033, 5527.309086364205, 5530.861728456781, 4976.676516026447, 4984.4330169962495, 4993.975030124862, 5011.84964451067, 5033.245013248005, 5663.546916246732, 5869.8239052828485, 5909.8227053188475, 5926.555508336849, 5927.2590926134235, 4188.371744238359, 4210.726302790309, 4214.7471151731, 4219.97890010548, 4226.239276930151, 6099.847503812396, 6154.199954005995, 6170.598911070811, 6182.5363097767395, 6185.474234690012, 4172.687048471377, 4264.829406823755, 4289.1421715657, 4294.141171765659, 4295.849645262463, 4313.331433627793, 4342.413774140514, 4347.56524347569, 4350.303951367766, 4362.912741745147, 4974.129527332702, 4974.37820272466, 4985.651004429655, 4993.550580447777, 4999.175136102575, 5609.831705048855, 5687.260656114679, 5897.528197744256, 5962.612430192024, 5995.370486098984, 1486.8587484188986, 1499.9400023998917, 1501.797257370263, 1504.8638278099963, 1505.8945873788948, 911.7766147293955, 949.9952500237592, 950.8114856429463, 954.3367359685091, 966.6032582917757, 5033.1695270280725, 5043.621728370314, 5081.695098294114, 5099.617528685363, 5111.667741596784, 5356.8660783479945, 5362.973185134049, 5388.703621300788, 5415.350157981067, 5439.755211015514, 5060.51925067118, 5127.974360128175, 5148.974255128775, 5363.704996225245, 5785.190073389729, 3205.743540516753, 3212.180893872094, 3215.646278909318, 3233.9191520212185, 3253.4957081652383, 6170.50635949123, 6299.04729533846, 6320.408632460669, 6342.873142537123, 6421.458849875996, 6163.907541386883, 6195.845103872439, 6208.678357078941, 6209.640336672036, 6226.6575338355915, 6353.856305864989, 6384.457321127663, 6398.616083035033, 6398.680065996775, 6410.391012853772, 5832.591718579659, 5984.162217289496, 6019.217501724747, 6032.366601506778, 6053.243344581927, 5941.58408911372, 6004.877463718929, 6008.699565021644, 6013.9699301503215, 6019.247594050744, 6105.572609917263, 6243.8468573370155, 6249.437550620466, 6315.873682526416, 6323.905141422974, 4250.978745106255, 4279.026076876541, 4298.656107511454, 4308.482982042175, 4316.352547117957, 5836.270466191726, 5918.408159184047, 6094.202210348047, 6104.412852658252, 6119.388061193845, 5911.290645122613, 5923.844850254159, 5930.673812940329, 5931.584789064724, 5948.73230704628, 5892.587518873637, 5925.466707996301, 5968.522518198447, 5968.522518198447, 5972.970135149297, 5656.60403771732, 5764.57887687164, 5832.212651292191, 5839.532837373085, 5900.29196496406, 5942.078977758454, 5978.192943952685, 6024.789132380346, 6033.944059789607, 6037.245344331958, 5676.77292908279, 5811.94188058114, 5823.213866128019, 5835.533157347317, 5894.93677212972], "value": 4460.318506368896, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.713714514194, 749.67014513614, 781.8201813582874, 782.7338704840353, 795.968161273549, 14963.476278330247, 15269.312880920357, 15458.768118478232, 16066.75899861503, 16085.356585736572, 13298.069135160518, 13479.595612131627, 13494.122882012662, 13513.72972540551, 13584.796228056586, 670.587588632992, 796.6972550430828, 804.1717031457594, 817.1542453560565, 822.6585966823761, 820.167529957091, 820.9507429554246, 825.7233826668073, 828.6022709099636, 831.1688311688312, 858.5192292316292, 865.8960924689046, 868.0668281597276, 871.0418539606445, 871.6905498548019, 855.0252711908429, 858.7509622209552, 859.2224037246302, 860.931125509964, 861.7543999960012, 624.4785604020648, 632.4560877645222, 634.0837489827202, 634.6033728919425, 637.1112298343785, 14370.065945713495, 14378.496752613608, 14400.783988240184, 14513.0, 14513.346899389553, 14988.775168372484, 15100.244987750679, 15214.923925380413, 15345.539633811004, 15566.0, 12282.570110046196, 12607.684807879785, 12633.2420054797, 12633.620991370273, 12711.0, 3913.3151698452943, 3968.0476685595536, 3968.3849003404516, 4054.0270335119358, 4086.7547947123267, 74186.25813741848, 79093.0, 79995.60002199952, 80125.59937200334, 81063.59468202622, 11575.88424115748, 11577.479013444416, 11664.358460284597, 11706.531738730526, 11754.949518162019, 20232.494187645425, 20766.273180438613, 22741.772582273967, 22807.201747938743, 22864.885675571517, 8587.313014958789, 8868.201861832466, 8928.241099506486, 8978.730638080868, 9143.908560914306, 4847.466778654345, 4872.366592342973, 4890.0, 4918.458969513351, 4969.006198760262, 3496.4580490024086, 3617.963820361763, 3624.7462677612316, 3628.4738712886483, 3636.6726994570085, 664.2261765043767, 680.1532092544813, 681.7477533312607, 686.5811854768588, 706.6643344411466, 689.7585844954226, 797.9880301795478, 807.935365170785, 809.1665584448028, 813.0893399392718, 9954.30319877616, 10232.386056836614, 10376.688699339033, 10399.27205095636, 10483.431559268029, 668.6222284409293, 759.5290919629865, 763.8719443877313, 771.7646117934084, 787.5078076202374, 4745.715257084586, 5060.468650791688, 5091.847244582668, 5107.0, 5160.277561141368, 101874.49062754787, 116978.41510792391, 118427.40786296013, 120713.0, 122026.0, 93952.53023734974, 98966.99999999856, 99521.50239248757, 100022.4998875001, 100548.0, 81094.59452702817, 84086.57956710177, 88092.0, 90743.54628226948, 90997.54501227583, 10193.286469947032, 10666.73333166646, 10771.676849694522, 10817.621383251548, 10885.945570272099, 50972.490275096774, 52762.0, 53302.73348633232, 53811.19283210833, 55188.0, 75606.24393755992, 77304.2269577297, 77382.0, 79221.20778792138, 81915.5904220475, 13723.588292351245, 13774.65563360884, 13866.4453421862, 13918.860811391756, 14269.357878895682, 15121.773173402187, 15151.0, 15257.923710381378, 15431.537053888402, 16149.19254037317, 13729.725405492034, 14184.432622695389, 14372.425102995763, 14652.706945861237, 14987.250637468302, 14774.409023639364, 14800.703985920436, 14923.477678281208, 15310.923445382701, 15558.533244002698, 13886.72226555443, 14773.96582239276, 14842.554723358317, 14969.850301496846, 15339.463118790789, 11766.411244570489, 12193.69515762113, 12205.206661567325, 12464.0, 12518.874811251771, 12114.546254449522, 12414.62756117318, 12567.18313309632, 12765.744685106432, 12871.549495767604], "value": 7853.916845697401, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 107.0, 111.0, 112.0, 112.0, 115.0, 114.0, 112.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 123.0, 144.0, 186.0, 122.0, 155.0, 145.0, 119.0, 188.0, 124.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 164.0, 164.0, 164.0, 166.0, 175.0, 166.0, 162.0, 163.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 161.0, 77.0, 76.0, 77.0, 75.0, 176.0, 75.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 154.0, 85.0, 84.0, 84.0, 140.0, 85.0, 84.0, 135.0], "value": 101.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 149.0, 150.0, 148.0, 147.0, 147.0, 148.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 98.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 53.0, 61.0, 52.0, 54.0, 53.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 65.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 76.0, 75.0, 76.0, 77.0, 75.0, 80.0, 75.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 127.0, 125.0, 129.0, 121.0, 130.0, 125.0, 126.0, 170.0, 135.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 157.0, 156.0, 163.0, 164.0, 159.0, 160.0, 171.0, 158.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 65.0, 68.0, 63.0, 63.0, 63.0, 64.0, 65.0, 64.0], "value": 64.5, "unit": "score"}]}]} 02:45:51 INFO - Return code: 0 02:45:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:45:52 ERROR - # TBPL SUCCESS # 02:45:52 INFO - Running post-action listener: _resource_record_post_action 02:45:52 INFO - ##### 02:45:52 INFO - ##### Finished run-tests step (success) 02:45:52 INFO - ##### 02:45:52 INFO - Running post-run listener: _resource_record_post_run 02:45:52 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 562798592; Read time: 16; Write time: 636284 02:45:52 INFO - TinderboxPrint: CPU usage
13.3% 02:45:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:45:52 INFO - TinderboxPrint: I/O write bytes / time
562,798,592 / 636,284 02:45:52 INFO - TinderboxPrint: CPU idle
8,229.4 (86.7%) 02:45:52 INFO - TinderboxPrint: CPU user
1,209.6 (12.7%) 02:45:52 INFO - TinderboxPrint: Swap in / out
0 / 0 02:45:52 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 267026432; Read time: 0; Write time: 397208 02:45:52 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 295772160; Read time: 0; Write time: 239076 02:45:52 INFO - Running post-run listener: _upload_blobber_files 02:45:52 INFO - Blob upload gear active. 02:45:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:45:52 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 02:45:52 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'] 02:45:52 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 02:45:53 INFO - (blobuploader) - INFO - Open directory for files ... 02:45:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:45:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:45:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:45:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:45:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:45:53 INFO - (blobuploader) - INFO - Done attempting. 02:45:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:45:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:45:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:45:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:45:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:45:57 INFO - (blobuploader) - INFO - Done attempting. 02:45:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:45:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:45:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:45:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:45:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:45:58 INFO - (blobuploader) - INFO - Done attempting. 02:45:58 INFO - (blobuploader) - INFO - Iteration through files over. 02:45:58 INFO - Return code: 0 02:45:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:45:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:45:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/697f427f7ad7e9c8da303585c146d24a31498a603896aea6e97c9f2531006955111b86ee1432b415156ddffb3388ff6da6b9d507caff4610be5ac80f29714314", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36ae9d5c0dc9513fa717351a0f9a81544450296529557943ccac28a4d59ad57499e28cb3cfde13c643d64976a0976d7edeaca726cb227395a3e0dc8babd366ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e17c6285b7293fd1fe67a41b9c91d28a35eebdc351a07db69a9e80d0b86d6fd192772e820e23a92ed1518b83e334eeb2fd5cbaa2963657988285a2e85b64b9b"} 02:45:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:45:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:45:58 INFO - Contents: 02:45:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/697f427f7ad7e9c8da303585c146d24a31498a603896aea6e97c9f2531006955111b86ee1432b415156ddffb3388ff6da6b9d507caff4610be5ac80f29714314", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36ae9d5c0dc9513fa717351a0f9a81544450296529557943ccac28a4d59ad57499e28cb3cfde13c643d64976a0976d7edeaca726cb227395a3e0dc8babd366ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e17c6285b7293fd1fe67a41b9c91d28a35eebdc351a07db69a9e80d0b86d6fd192772e820e23a92ed1518b83e334eeb2fd5cbaa2963657988285a2e85b64b9b"} 02:45:58 INFO - Running post-run listener: copy_logs_to_upload_dir 02:45:58 INFO - Copying logs to upload dir... 02:45:58 INFO - mkdir: /builds/slave/test/build/upload/logs 02:45:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.859140 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-09 02:45:57.328998) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 02:45:57.334022) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/697f427f7ad7e9c8da303585c146d24a31498a603896aea6e97c9f2531006955111b86ee1432b415156ddffb3388ff6da6b9d507caff4610be5ac80f29714314", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36ae9d5c0dc9513fa717351a0f9a81544450296529557943ccac28a4d59ad57499e28cb3cfde13c643d64976a0976d7edeaca726cb227395a3e0dc8babd366ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e17c6285b7293fd1fe67a41b9c91d28a35eebdc351a07db69a9e80d0b86d6fd192772e820e23a92ed1518b83e334eeb2fd5cbaa2963657988285a2e85b64b9b"} build_url:https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011463 build_url: 'https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/697f427f7ad7e9c8da303585c146d24a31498a603896aea6e97c9f2531006955111b86ee1432b415156ddffb3388ff6da6b9d507caff4610be5ac80f29714314", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36ae9d5c0dc9513fa717351a0f9a81544450296529557943ccac28a4d59ad57499e28cb3cfde13c643d64976a0976d7edeaca726cb227395a3e0dc8babd366ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e17c6285b7293fd1fe67a41b9c91d28a35eebdc351a07db69a9e80d0b86d6fd192772e820e23a92ed1518b83e334eeb2fd5cbaa2963657988285a2e85b64b9b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 02:45:57.360146) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:45:57.360472) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468056010.751727-706041037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:45:57.442410) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 02:45:57.442769) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 02:45:57.443140) ========= ========= Total master_lag: 0.16 =========