builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1467733680.31 results: success (0) buildid: 20160701173001 builduid: becdb80e363c4c4a932883e791e4ea2f revision: 1bbc4c035fd893b9ea1039c08bd28f34b8b66574 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 08:48:00.306258) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 08:48:00.306696) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 08:48:00.306970) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 08:48:00.322007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:48:00.322370) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 08:48:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.4M=0s 2016-07-05 08:48:01 (67.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095487 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:48:00.432302) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:48:00.432609) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015197 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:48:00.481850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:48:00.482206) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1bbc4c035fd893b9ea1039c08bd28f34b8b66574 --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 1bbc4c035fd893b9ea1039c08bd28f34b8b66574 --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=2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 08:48:01,442 truncating revision to first 12 chars 2016-07-05 08:48:01,443 Setting DEBUG logging. 2016-07-05 08:48:01,443 attempt 1/10 2016-07-05 08:48:01,443 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1bbc4c035fd8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 08:48:01,820 unpacking tar archive at: fx-team-1bbc4c035fd8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.776331 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:48:01.273327) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 08:48:01.273656) ========= script_repo_revision: 1bbc4c035fd893b9ea1039c08bd28f34b8b66574 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 08:48:01.274090) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 08:48:01.274428) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 08:48:01.286670) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-05 08:48:01.287079) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:48:02 INFO - MultiFileLogger online at 20160705 08:48:02 in /builds/slave/test 08:48:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:48:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:48:02 INFO - {'append_to_log': False, 08:48:02 INFO - 'base_work_dir': '/builds/slave/test', 08:48:02 INFO - 'blob_upload_branch': 'Fx-Team', 08:48:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:48:02 INFO - 'branch': 'Fx-Team', 08:48:02 INFO - 'buildbot_json_path': 'buildprops.json', 08:48:02 INFO - 'config_files': ('talos/linux_config.py',), 08:48:02 INFO - 'default_actions': ('clobber', 08:48:02 INFO - 'read-buildbot-config', 08:48:02 INFO - 'download-and-extract', 08:48:02 INFO - 'populate-webroot', 08:48:02 INFO - 'create-virtualenv', 08:48:02 INFO - 'install', 08:48:02 INFO - 'run-tests'), 08:48:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:48:02 INFO - 'download_minidump_stackwalk': True, 08:48:02 INFO - 'download_symbols': 'ondemand', 08:48:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:48:02 INFO - 'tooltool.py': '/tools/tooltool.py', 08:48:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:48:02 INFO - '/tools/misc-python/virtualenv.py')}, 08:48:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:48:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:48:02 INFO - 'installer_path': 'installer.exe', 08:48:02 INFO - 'log_level': 'info', 08:48:02 INFO - 'log_name': 'talos', 08:48:02 INFO - 'log_to_console': True, 08:48:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:48:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:48:02 INFO - 'opt_config_files': (), 08:48:02 INFO - 'pip_index': False, 08:48:02 INFO - 'sps_profile': False, 08:48:02 INFO - 'sps_profile_interval': 0, 08:48:02 INFO - 'suite': 'dromaeojs', 08:48:02 INFO - 'system_bits': '32', 08:48:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:48:02 INFO - 'title': 'talos-linux64-ix-012', 08:48:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:48:02 INFO - 'use_talos_json': True, 08:48:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:48:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:48:02 INFO - 'work_dir': 'build'} 08:48:02 INFO - ##### 08:48:02 INFO - ##### Running clobber step. 08:48:02 INFO - ##### 08:48:02 INFO - Running pre-action listener: _resource_record_pre_action 08:48:02 INFO - Running main action method: clobber 08:48:02 INFO - rmtree: /builds/slave/test/build 08:48:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:48:02 INFO - Running post-action listener: _resource_record_post_action 08:48:02 INFO - ##### 08:48:02 INFO - ##### Finished clobber step (success) 08:48:02 INFO - ##### 08:48:02 INFO - ##### 08:48:02 INFO - ##### Running read-buildbot-config step. 08:48:02 INFO - ##### 08:48:02 INFO - Running pre-action listener: _resource_record_pre_action 08:48:02 INFO - Running main action method: read_buildbot_config 08:48:02 INFO - Using buildbot properties: 08:48:02 INFO - { 08:48:02 INFO - "project": "", 08:48:02 INFO - "product": "firefox", 08:48:02 INFO - "script_repo_revision": "production", 08:48:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:48:02 INFO - "repository": "", 08:48:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:48:02 INFO - "buildid": "20160701173001", 08:48:02 INFO - "pgo_build": "True", 08:48:02 INFO - "basedir": "/builds/slave/test", 08:48:02 INFO - "buildnumber": 1299, 08:48:02 INFO - "slavename": "talos-linux64-ix-012", 08:48:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:48:02 INFO - "platform": "ubuntu64_hw", 08:48:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:48:02 INFO - "branch": "fx-team", 08:48:02 INFO - "repo_path": "integration/fx-team", 08:48:02 INFO - "revision": "1bbc4c035fd893b9ea1039c08bd28f34b8b66574", 08:48:02 INFO - "stage_platform": "linux64-pgo", 08:48:02 INFO - "builduid": "becdb80e363c4c4a932883e791e4ea2f", 08:48:02 INFO - "slavebuilddir": "test" 08:48:02 INFO - } 08:48:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:48:02 INFO - Running post-action listener: _resource_record_post_action 08:48:02 INFO - ##### 08:48:02 INFO - ##### Finished read-buildbot-config step (success) 08:48:02 INFO - ##### 08:48:02 INFO - ##### 08:48:02 INFO - ##### Running download-and-extract step. 08:48:02 INFO - ##### 08:48:02 INFO - Running pre-action listener: _resource_record_pre_action 08:48:02 INFO - Running main action method: download_and_extract 08:48:02 INFO - mkdir: /builds/slave/test/build/tests 08:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:02 INFO - https://queue.taskcluster.net/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:48:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:48:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:48:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/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 08:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/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 08:48:03 INFO - Downloaded 1361 bytes. 08:48:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:48:03 INFO - Using the following test package requirements: 08:48:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:48:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:48:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:48:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:03 INFO - u'jsshell-linux-x86_64.zip'], 08:48:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:48:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:48:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:48:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:48:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:48:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:48:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:03 INFO - https://queue.taskcluster.net/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:48:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:48:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:48:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/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 08:48:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/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 08:48:04 INFO - Downloaded 24271016 bytes. 08:48:04 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'] 08:48:04 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 08:48:05 INFO - Return code: 0 08:48:05 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 08:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:05 INFO - https://queue.taskcluster.net/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:48:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:48:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:48:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/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 08:48:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/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 08:48:06 INFO - Downloaded 24271016 bytes. 08:48:06 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'] 08:48:06 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 08:48:08 INFO - Return code: 0 08:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:08 INFO - https://queue.taskcluster.net/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:48:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:48:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:48:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/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 08:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/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 08:48:09 INFO - Downloaded 14405242 bytes. 08:48:09 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'] 08:48:09 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 08:48:09 INFO - Return code: 0 08:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:09 INFO - https://queue.taskcluster.net/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:48:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:48:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:48:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/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 08:48:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RH2klQWZSFegk10zPuLSWw/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 08:48:10 INFO - Downloaded 60332245 bytes. 08:48:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:48:10 INFO - mkdir: /builds/slave/test/properties 08:48:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:48:10 INFO - Writing to file /builds/slave/test/properties/build_url 08:48:10 INFO - Contents: 08:48:10 INFO - build_url:https://queue.taskcluster.net/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:48:11 INFO - Running post-action listener: _resource_record_post_action 08:48:11 INFO - Running post-action listener: set_extra_try_arguments 08:48:11 INFO - ##### 08:48:11 INFO - ##### Finished download-and-extract step (success) 08:48:11 INFO - ##### 08:48:11 INFO - ##### 08:48:11 INFO - ##### Running populate-webroot step. 08:48:11 INFO - ##### 08:48:11 INFO - Running pre-action listener: _resource_record_pre_action 08:48:11 INFO - Running main action method: populate_webroot 08:48:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:48:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:48:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:48:11 INFO - '--tppagecycles', 08:48:11 INFO - '7'], 08:48:11 INFO - 'tests': ['tsvgm']}}, 08:48:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:48:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:48:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:48:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:48:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['damp', 'tps']}, 08:48:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'tests': ['damp', 'tps']}, 08:48:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['dromaeo_dom']}, 08:48:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:48:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['basic_compositor_video']}, 08:48:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:48:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'other-e10s': {'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['tsvgx', 08:48:11 INFO - 'tsvgr_opacity', 08:48:11 INFO - 'tart', 08:48:11 INFO - 'tscrollx', 08:48:11 INFO - 'cart']}, 08:48:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:48:11 INFO - 'tsvgr_opacity', 08:48:11 INFO - 'tart', 08:48:11 INFO - 'tscrollx', 08:48:11 INFO - 'cart']}, 08:48:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['tp5o']}, 08:48:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'tests': ['tp5o']}, 08:48:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'talos_options': ['--disable-e10s', 08:48:11 INFO - '--xperf_path', 08:48:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:11 INFO - 'tests': ['tp5n']}, 08:48:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'talos_options': ['--xperf_path', 08:48:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:11 INFO - 'tests': ['tp5n']}}, 08:48:11 INFO - 'talos.zip': {'path': '', 08:48:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:48:11 INFO - Running post-action listener: _resource_record_post_action 08:48:11 INFO - ##### 08:48:11 INFO - ##### Finished populate-webroot step (success) 08:48:11 INFO - ##### 08:48:11 INFO - ##### 08:48:11 INFO - ##### Running create-virtualenv step. 08:48:11 INFO - ##### 08:48:11 INFO - Running pre-action listener: _resource_record_pre_action 08:48:11 INFO - Running main action method: create_virtualenv 08:48:11 INFO - Creating virtualenv /builds/slave/test/build/venv 08:48:11 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 08:48:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:48:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:48:11 INFO - Using real prefix '/usr' 08:48:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:48:12 INFO - Installing distribute.............................................................................................................................................................................................done. 08:48:14 INFO - Installing pip.................done. 08:48:14 INFO - Return code: 0 08:48:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c43b0>, '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 0x29c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c5740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', '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 08:48:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:48:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:48:14 INFO - Using env: {'DISPLAY': ':0', 08:48:14 INFO - 'HOME': '/home/cltbld', 08:48:14 INFO - 'LANG': 'en_US.UTF-8', 08:48:14 INFO - 'LANGUAGE': 'en_US:en', 08:48:14 INFO - 'LOGNAME': 'cltbld', 08:48:14 INFO - 'MAIL': '/var/mail/cltbld', 08:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:14 INFO - 'MOZ_NO_REMOTE': '1', 08:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:14 INFO - 'NO_EM_RESTART': '1', 08:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:14 INFO - 'PWD': '/builds/slave/test', 08:48:14 INFO - 'SHELL': '/bin/bash', 08:48:14 INFO - 'SHLVL': '1', 08:48:14 INFO - 'TERM': 'linux', 08:48:14 INFO - 'TMOUT': '86400', 08:48:14 INFO - 'USER': 'cltbld', 08:48:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', 08:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:14 INFO - '_': '/tools/buildbot/bin/python'} 08:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:14 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 08:48:14 INFO - Cleaning up... 08:48:14 INFO - Return code: 0 08:48:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2705030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c43b0>, '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 0x29c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c5740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', '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 08:48:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:48:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:48:14 INFO - Using env: {'DISPLAY': ':0', 08:48:14 INFO - 'HOME': '/home/cltbld', 08:48:14 INFO - 'LANG': 'en_US.UTF-8', 08:48:14 INFO - 'LANGUAGE': 'en_US:en', 08:48:14 INFO - 'LOGNAME': 'cltbld', 08:48:14 INFO - 'MAIL': '/var/mail/cltbld', 08:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:14 INFO - 'MOZ_NO_REMOTE': '1', 08:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:14 INFO - 'NO_EM_RESTART': '1', 08:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:14 INFO - 'PWD': '/builds/slave/test', 08:48:14 INFO - 'SHELL': '/bin/bash', 08:48:14 INFO - 'SHLVL': '1', 08:48:14 INFO - 'TERM': 'linux', 08:48:14 INFO - 'TMOUT': '86400', 08:48:14 INFO - 'USER': 'cltbld', 08:48:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', 08:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:14 INFO - '_': '/tools/buildbot/bin/python'} 08:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:14 INFO - Downloading/unpacking psutil>=3.1.1 08:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:16 INFO - Installing collected packages: psutil 08:48:16 INFO - Running setup.py install for psutil 08:48:16 INFO - building 'psutil._psutil_linux' extension 08:48:16 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 08:48:16 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 08:48:16 INFO - building 'psutil._psutil_posix' extension 08:48:16 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 08:48:17 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 08:48:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:17 INFO - Successfully installed psutil 08:48:17 INFO - Cleaning up... 08:48:17 INFO - Return code: 0 08:48:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:48:17 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')]} 08:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:17 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')]} 08:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:17 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 0x2705030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c43b0>, '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 0x29c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c5740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', '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 08:48:17 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 08:48:17 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 08:48:17 INFO - Using env: {'DISPLAY': ':0', 08:48:17 INFO - 'HOME': '/home/cltbld', 08:48:17 INFO - 'LANG': 'en_US.UTF-8', 08:48:17 INFO - 'LANGUAGE': 'en_US:en', 08:48:17 INFO - 'LOGNAME': 'cltbld', 08:48:17 INFO - 'MAIL': '/var/mail/cltbld', 08:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:17 INFO - 'MOZ_NO_REMOTE': '1', 08:48:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:17 INFO - 'NO_EM_RESTART': '1', 08:48:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:17 INFO - 'PWD': '/builds/slave/test', 08:48:17 INFO - 'SHELL': '/bin/bash', 08:48:17 INFO - 'SHLVL': '1', 08:48:17 INFO - 'TERM': 'linux', 08:48:17 INFO - 'TMOUT': '86400', 08:48:17 INFO - 'USER': 'cltbld', 08:48:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', 08:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:17 INFO - '_': '/tools/buildbot/bin/python'} 08:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:48:19 INFO - Installing collected packages: mozsystemmonitor 08:48:19 INFO - Running setup.py install for mozsystemmonitor 08:48:19 INFO - Successfully installed mozsystemmonitor 08:48:19 INFO - Cleaning up... 08:48:19 INFO - Return code: 0 08:48:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:48: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')]} 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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')]} 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:19 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 0x2705030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c43b0>, '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 0x29c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c5740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', '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 08:48:19 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 08:48:19 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 08:48:19 INFO - Using env: {'DISPLAY': ':0', 08:48:19 INFO - 'HOME': '/home/cltbld', 08:48:19 INFO - 'LANG': 'en_US.UTF-8', 08:48:19 INFO - 'LANGUAGE': 'en_US:en', 08:48:19 INFO - 'LOGNAME': 'cltbld', 08:48:19 INFO - 'MAIL': '/var/mail/cltbld', 08:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:19 INFO - 'MOZ_NO_REMOTE': '1', 08:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:19 INFO - 'NO_EM_RESTART': '1', 08:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:19 INFO - 'PWD': '/builds/slave/test', 08:48:19 INFO - 'SHELL': '/bin/bash', 08:48:19 INFO - 'SHLVL': '1', 08:48:19 INFO - 'TERM': 'linux', 08:48:19 INFO - 'TMOUT': '86400', 08:48:19 INFO - 'USER': 'cltbld', 08:48:19 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', 08:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:19 INFO - '_': '/tools/buildbot/bin/python'} 08:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:19 INFO - Downloading/unpacking jsonschema==2.5.1 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:48:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:21 INFO - Downloading functools32-3.2.3-2.tar.gz 08:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:48:21 INFO - warning: no files found matching '*.txt' 08:48:21 INFO - no previously-included directories found matching 'build' 08:48:21 INFO - no previously-included directories found matching 'dist' 08:48:21 INFO - no previously-included directories found matching '.git*' 08:48:21 INFO - Installing collected packages: jsonschema, functools32 08:48:21 INFO - Running setup.py install for functools32 08:48:21 INFO - warning: no files found matching '*.txt' 08:48:21 INFO - no previously-included directories found matching 'build' 08:48:21 INFO - no previously-included directories found matching 'dist' 08:48:21 INFO - no previously-included directories found matching '.git*' 08:48:22 INFO - Successfully installed jsonschema functools32 08:48:22 INFO - Cleaning up... 08:48:22 INFO - Return code: 0 08:48:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:48:22 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')]} 08:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:22 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')]} 08:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:22 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 0x2705030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c43b0>, '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 0x29c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c5740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', '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 08:48:22 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 08:48:22 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 08:48:22 INFO - Using env: {'DISPLAY': ':0', 08:48:22 INFO - 'HOME': '/home/cltbld', 08:48:22 INFO - 'LANG': 'en_US.UTF-8', 08:48:22 INFO - 'LANGUAGE': 'en_US:en', 08:48:22 INFO - 'LOGNAME': 'cltbld', 08:48:22 INFO - 'MAIL': '/var/mail/cltbld', 08:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:22 INFO - 'MOZ_NO_REMOTE': '1', 08:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:22 INFO - 'NO_EM_RESTART': '1', 08:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:22 INFO - 'PWD': '/builds/slave/test', 08:48:22 INFO - 'SHELL': '/bin/bash', 08:48:22 INFO - 'SHLVL': '1', 08:48:22 INFO - 'TERM': 'linux', 08:48:22 INFO - 'TMOUT': '86400', 08:48:22 INFO - 'USER': 'cltbld', 08:48:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', 08:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:22 INFO - '_': '/tools/buildbot/bin/python'} 08:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:22 INFO - Downloading/unpacking blobuploader==1.2.4 08:48:22 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 08:48:22 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 08:48:22 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 08:48:22 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 08:48:22 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 08:48:22 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 08:48:24 INFO - Downloading blobuploader-1.2.4.tar.gz 08:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:48:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:48:24 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 08:48:24 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 08:48:24 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 08:48:24 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 08:48:24 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 08:48:24 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 08:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:48:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:48:24 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 08:48:24 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 08:48:24 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 08:48:24 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 08:48:24 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 08:48:24 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 08:48:24 INFO - Downloading docopt-0.6.1.tar.gz 08:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:48:24 INFO - Installing collected packages: blobuploader, requests, docopt 08:48:24 INFO - Running setup.py install for blobuploader 08:48:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:48:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:48:25 INFO - Running setup.py install for requests 08:48:25 INFO - Running setup.py install for docopt 08:48:25 INFO - Successfully installed blobuploader requests docopt 08:48:25 INFO - Cleaning up... 08:48:25 INFO - Return code: 0 08:48:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:25 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')]} 08:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:25 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')]} 08:48:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:25 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 0x2705030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c43b0>, '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 0x29c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c5740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', '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 08:48:25 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 08:48:25 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 08:48:25 INFO - Using env: {'DISPLAY': ':0', 08:48:25 INFO - 'HOME': '/home/cltbld', 08:48:25 INFO - 'LANG': 'en_US.UTF-8', 08:48:25 INFO - 'LANGUAGE': 'en_US:en', 08:48:25 INFO - 'LOGNAME': 'cltbld', 08:48:25 INFO - 'MAIL': '/var/mail/cltbld', 08:48:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:25 INFO - 'MOZ_NO_REMOTE': '1', 08:48:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:25 INFO - 'NO_EM_RESTART': '1', 08:48:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:25 INFO - 'PWD': '/builds/slave/test', 08:48:25 INFO - 'SHELL': '/bin/bash', 08:48:25 INFO - 'SHLVL': '1', 08:48:25 INFO - 'TERM': 'linux', 08:48:25 INFO - 'TMOUT': '86400', 08:48:25 INFO - 'USER': 'cltbld', 08:48:25 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', 08:48:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:25 INFO - '_': '/tools/buildbot/bin/python'} 08:48:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:25 INFO - Running setup.py (path:/tmp/pip-RL5tFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:25 INFO - Running setup.py (path:/tmp/pip-fv2hyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:25 INFO - Running setup.py (path:/tmp/pip-Onr7lX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:26 INFO - Running setup.py (path:/tmp/pip-bW1gMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:26 INFO - Running setup.py (path:/tmp/pip-LN5bb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:26 INFO - Running setup.py (path:/tmp/pip-wbh6Iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:26 INFO - Running setup.py (path:/tmp/pip-NFYp6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:26 INFO - Running setup.py (path:/tmp/pip-OgOpHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:26 INFO - Running setup.py (path:/tmp/pip-250GpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:26 INFO - Running setup.py (path:/tmp/pip-Yw2ZKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:26 INFO - Running setup.py (path:/tmp/pip-k4YEzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:26 INFO - Running setup.py (path:/tmp/pip-oTGQAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:26 INFO - Running setup.py (path:/tmp/pip-mYZQKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:26 INFO - Running setup.py (path:/tmp/pip-UKcm0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:26 INFO - Running setup.py (path:/tmp/pip-cLtR4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:26 INFO - Running setup.py (path:/tmp/pip-fBA_sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:26 INFO - Running setup.py (path:/tmp/pip-laZwWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:48:27 INFO - Running setup.py install for manifestparser 08:48:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:48:27 INFO - Running setup.py install for mozcrash 08:48:27 INFO - Running setup.py install for mozdebug 08:48:27 INFO - Running setup.py install for mozdevice 08:48:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:48:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:48:27 INFO - Running setup.py install for mozfile 08:48:27 INFO - Running setup.py install for mozhttpd 08:48:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:48:27 INFO - Running setup.py install for mozinfo 08:48:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:48:27 INFO - Running setup.py install for mozInstall 08:48:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:48:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:48:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:48:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:48:27 INFO - Running setup.py install for mozleak 08:48:27 INFO - Running setup.py install for mozlog 08:48:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Running setup.py install for moznetwork 08:48:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Running setup.py install for mozprocess 08:48:28 INFO - Running setup.py install for mozprofile 08:48:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Running setup.py install for mozrunner 08:48:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Running setup.py install for mozscreenshot 08:48:28 INFO - Running setup.py install for moztest 08:48:28 INFO - Running setup.py install for mozversion 08:48:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:48:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:48:28 INFO - Cleaning up... 08:48:28 INFO - Return code: 0 08:48:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48: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')]} 08:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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')]} 08:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:28 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 0x2705030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c43b0>, '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 0x29c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c5740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', '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 08:48:28 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 08:48:28 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 08:48:28 INFO - Using env: {'DISPLAY': ':0', 08:48:28 INFO - 'HOME': '/home/cltbld', 08:48:28 INFO - 'LANG': 'en_US.UTF-8', 08:48:28 INFO - 'LANGUAGE': 'en_US:en', 08:48:28 INFO - 'LOGNAME': 'cltbld', 08:48:28 INFO - 'MAIL': '/var/mail/cltbld', 08:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:28 INFO - 'MOZ_NO_REMOTE': '1', 08:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:28 INFO - 'NO_EM_RESTART': '1', 08:48:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:28 INFO - 'PWD': '/builds/slave/test', 08:48:28 INFO - 'SHELL': '/bin/bash', 08:48:28 INFO - 'SHLVL': '1', 08:48:28 INFO - 'TERM': 'linux', 08:48:28 INFO - 'TMOUT': '86400', 08:48:28 INFO - 'USER': 'cltbld', 08:48:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', 08:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:28 INFO - '_': '/tools/buildbot/bin/python'} 08:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:29 INFO - Running setup.py (path:/tmp/pip-cw1bId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:29 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)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:29 INFO - Running setup.py (path:/tmp/pip-cg7Vjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:29 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)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:29 INFO - Running setup.py (path:/tmp/pip-OSvgpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:29 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)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:29 INFO - Running setup.py (path:/tmp/pip-a3Pp6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:29 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)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:29 INFO - Running setup.py (path:/tmp/pip-HVAYX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:29 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)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:29 INFO - Running setup.py (path:/tmp/pip-zs7ZjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:29 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)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:29 INFO - Running setup.py (path:/tmp/pip-tJTjIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:29 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)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:29 INFO - Running setup.py (path:/tmp/pip-YremFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:29 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)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:29 INFO - Running setup.py (path:/tmp/pip-BJvbaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:29 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)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:29 INFO - Running setup.py (path:/tmp/pip-bDBOS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:29 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)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:29 INFO - Running setup.py (path:/tmp/pip-PKQhmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:29 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)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:29 INFO - Running setup.py (path:/tmp/pip-A0axOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:29 INFO - Running setup.py (path:/tmp/pip-6VeEX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:29 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)) 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:29 INFO - Running setup.py (path:/tmp/pip-h_HxoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:30 INFO - Running setup.py (path:/tmp/pip-1eMC2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:30 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)) 08:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:30 INFO - Running setup.py (path:/tmp/pip-iT2PVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:30 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)) 08:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:30 INFO - Running setup.py (path:/tmp/pip-NVYF4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:30 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)) 08:48:30 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)) 08:48:30 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)) 08:48:30 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)) 08:48:30 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)) 08:48:30 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)) 08:48:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:30 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 08:48:30 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 08:48:30 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 08:48:30 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 08:48:30 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 08:48:30 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 08:48:32 INFO - Downloading blessings-1.6.tar.gz 08:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:48:32 INFO - Installing collected packages: blessings 08:48:32 INFO - Running setup.py install for blessings 08:48:32 INFO - Successfully installed blessings 08:48:32 INFO - Cleaning up... 08:48:32 INFO - Return code: 0 08:48:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:32 INFO - Reading from file tmpfile_stdout 08:48:32 INFO - Current package versions: 08:48:32 INFO - argparse == 1.2.1 08:48:32 INFO - blessings == 1.6 08:48:32 INFO - blobuploader == 1.2.4 08:48:32 INFO - docopt == 0.6.1 08:48:32 INFO - functools32 == 3.2.3-2 08:48:32 INFO - jsonschema == 2.5.1 08:48:32 INFO - manifestparser == 1.1 08:48:32 INFO - mozInstall == 1.12 08:48:32 INFO - mozcrash == 0.17 08:48:32 INFO - mozdebug == 0.1 08:48:32 INFO - mozdevice == 0.48 08:48:32 INFO - mozfile == 1.2 08:48:32 INFO - mozhttpd == 0.7 08:48:32 INFO - mozinfo == 0.9 08:48:32 INFO - mozleak == 0.1 08:48:32 INFO - mozlog == 3.2 08:48:32 INFO - moznetwork == 0.27 08:48:32 INFO - mozprocess == 0.22 08:48:32 INFO - mozprofile == 0.28 08:48:32 INFO - mozrunner == 6.11 08:48:32 INFO - mozscreenshot == 0.1 08:48:32 INFO - mozsystemmonitor == 0.3 08:48:32 INFO - moztest == 0.7 08:48:32 INFO - mozversion == 1.4 08:48:32 INFO - psutil == 3.1.1 08:48:32 INFO - requests == 1.2.3 08:48:32 INFO - wsgiref == 0.1.2 08:48:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:32 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 0x2705030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c43b0>, '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 0x29c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c5740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', '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 08:48:32 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 08:48:32 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 08:48:32 INFO - Using env: {'DISPLAY': ':0', 08:48:32 INFO - 'HOME': '/home/cltbld', 08:48:32 INFO - 'LANG': 'en_US.UTF-8', 08:48:32 INFO - 'LANGUAGE': 'en_US:en', 08:48:32 INFO - 'LOGNAME': 'cltbld', 08:48:32 INFO - 'MAIL': '/var/mail/cltbld', 08:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:32 INFO - 'MOZ_NO_REMOTE': '1', 08:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:32 INFO - 'NO_EM_RESTART': '1', 08:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:32 INFO - 'PWD': '/builds/slave/test', 08:48:32 INFO - 'SHELL': '/bin/bash', 08:48:32 INFO - 'SHLVL': '1', 08:48:32 INFO - 'TERM': 'linux', 08:48:32 INFO - 'TMOUT': '86400', 08:48:32 INFO - 'USER': 'cltbld', 08:48:32 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', 08:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:32 INFO - '_': '/tools/buildbot/bin/python'} 08:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:32 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)) 08:48:32 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)) 08:48:32 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)) 08:48:32 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)) 08:48:32 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)) 08:48:32 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)) 08:48:32 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)) 08:48:32 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)) 08:48:32 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)) 08:48:32 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)) 08:48:32 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)) 08:48:32 INFO - Cleaning up... 08:48:32 INFO - Return code: 0 08:48:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:32 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 0x2705030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c43b0>, '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 0x29c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c5740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', '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 08:48:32 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 08:48:32 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 08:48:32 INFO - Using env: {'DISPLAY': ':0', 08:48:32 INFO - 'HOME': '/home/cltbld', 08:48:32 INFO - 'LANG': 'en_US.UTF-8', 08:48:32 INFO - 'LANGUAGE': 'en_US:en', 08:48:32 INFO - 'LOGNAME': 'cltbld', 08:48:32 INFO - 'MAIL': '/var/mail/cltbld', 08:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:32 INFO - 'MOZ_NO_REMOTE': '1', 08:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:32 INFO - 'NO_EM_RESTART': '1', 08:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:32 INFO - 'PWD': '/builds/slave/test', 08:48:32 INFO - 'SHELL': '/bin/bash', 08:48:32 INFO - 'SHLVL': '1', 08:48:32 INFO - 'TERM': 'linux', 08:48:32 INFO - 'TMOUT': '86400', 08:48:32 INFO - 'USER': 'cltbld', 08:48:32 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', 08:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:32 INFO - '_': '/tools/buildbot/bin/python'} 08:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:48:33 INFO - Cleaning up... 08:48:33 INFO - Return code: 0 08:48:33 INFO - Running post-action listener: _resource_record_post_action 08:48:33 INFO - Running post-action listener: _start_resource_monitoring 08:48:33 INFO - Starting resource monitoring. 08:48:33 INFO - ##### 08:48:33 INFO - ##### Finished create-virtualenv step (success) 08:48:33 INFO - ##### 08:48:33 INFO - ##### 08:48:33 INFO - ##### Running install step. 08:48:33 INFO - ##### 08:48:33 INFO - Running pre-action listener: _resource_record_pre_action 08:48:33 INFO - Running main action method: install 08:48:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:33 INFO - Reading from file tmpfile_stdout 08:48:33 INFO - Detecting whether we're running mozinstall >=1.0... 08:48:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:48:33 INFO - Reading from file tmpfile_stdout 08:48:33 INFO - Output received: 08:48:33 INFO - Usage: mozinstall [options] installer 08:48:33 INFO - Options: 08:48:33 INFO - -h, --help show this help message and exit 08:48:33 INFO - -d DEST, --destination=DEST 08:48:33 INFO - Directory to install application into. [default: 08:48:33 INFO - "/builds/slave/test"] 08:48:33 INFO - --app=APP Application being installed. [default: firefox] 08:48:33 INFO - mkdir: /builds/slave/test/build/application 08:48:33 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'] 08:48:33 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 08:48:50 INFO - Reading from file tmpfile_stdout 08:48:50 INFO - Output received: 08:48:50 INFO - /builds/slave/test/build/application/firefox/firefox 08:48:50 INFO - Running post-action listener: _resource_record_post_action 08:48:50 INFO - ##### 08:48:50 INFO - ##### Finished install step (success) 08:48:50 INFO - ##### 08:48:50 INFO - ##### 08:48:50 INFO - ##### Running run-tests step. 08:48:50 INFO - ##### 08:48:50 INFO - Running pre-action listener: _resource_record_pre_action 08:48:50 INFO - Running main action method: run_tests 08:48:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:48:50 INFO - Python 2.7.3 08:48:50 INFO - Return code: 0 08:48:50 INFO - grabbing minidump binary from tooltool 08:48: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')]} 08:48:50 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 0x29c43b0>, '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 0x29c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c5740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:48:50 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 08:48:50 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 08:48:50 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 08:48:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:48:50 INFO - Return code: 0 08:48:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:48:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:48:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:48:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:48:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:48:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:48:50 INFO - Using env: {'DISPLAY': ':0', 08:48:50 INFO - 'HOME': '/home/cltbld', 08:48:50 INFO - 'LANG': 'en_US.UTF-8', 08:48:50 INFO - 'LANGUAGE': 'en_US:en', 08:48:50 INFO - 'LOGNAME': 'cltbld', 08:48:50 INFO - 'MAIL': '/var/mail/cltbld', 08:48:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:48:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:50 INFO - 'MOZ_NO_REMOTE': '1', 08:48:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:50 INFO - 'NO_EM_RESTART': '1', 08:48:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:50 INFO - 'PWD': '/builds/slave/test', 08:48:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:48:50 INFO - 'SHELL': '/bin/bash', 08:48:50 INFO - 'SHLVL': '1', 08:48:50 INFO - 'TERM': 'linux', 08:48:50 INFO - 'TMOUT': '86400', 08:48:50 INFO - 'USER': 'cltbld', 08:48:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085', 08:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:50 INFO - '_': '/tools/buildbot/bin/python'} 08:48:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:48:50 INFO - mozversion application_buildid: 20160701173001 08:48:50 INFO - mozversion application_changeset: 1bbc4c035fd893b9ea1039c08bd28f34b8b66574 08:48:50 INFO - mozversion application_display_name: Nightly 08:48:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:48:50 INFO - mozversion application_name: Firefox 08:48:50 INFO - mozversion application_remotingname: firefox 08:48:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:48:50 INFO - mozversion application_vendor: Mozilla 08:48:50 INFO - mozversion application_version: 50.0a1 08:48:50 INFO - mozversion platform_buildid: 20160701173001 08:48:50 INFO - mozversion platform_changeset: 1bbc4c035fd893b9ea1039c08bd28f34b8b66574 08:48:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:48:50 INFO - mozversion platform_version: 50.0a1 08:48:50 INFO - using testdate: 1467733730 08:48:50 INFO - actual date: 1467733730 08:48:50 INFO - starting webserver on 'localhost:43449' 08:48:50 INFO - SUITE-START | Running 2 tests 08:48:50 INFO - TEST-START | dromaeo_css 08:48:50 INFO - operating with platform_type : linux_ 08:48:50 INFO - Initialising browser for dromaeo_css test... 08:48:50 INFO - TEST-INFO | started process 4866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTxeFF7/profile http://localhost:43449/getInfo.html) 08:48:54 INFO - PROCESS | 4866 | __metrics Screen width/height:1600/1200 08:48:54 INFO - PROCESS | 4866 | colorDepth:24 08:48:54 INFO - PROCESS | 4866 | Browser inner width/height: 1024/697 08:48:54 INFO - PROCESS | 4866 | __metrics 08:48:55 INFO - PROCESS | 4866 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:48:56 INFO - TEST-INFO | 4866: exit 0 08:48:56 INFO - Browser initialized. 08:48:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:48:56 INFO - TEST-INFO | started process 4948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTxeFF7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:07 INFO - PROCESS | 4948 | RSS: Main: 157368320 08:49:07 INFO - PROCESS | 4948 | 08:49:58 INFO - PROCESS | 4948 | 1467733798724 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] 08:52:07 INFO - PROCESS | 4948 | Cycle 1(1): loaded http://localhost:43449/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43449/tests/dromaeo/cssquery-ext.html) 08:52:08 INFO - PROCESS | 4948 | RSS: Main: 243281920 08:52:08 INFO - PROCESS | 4948 | 08:55:10 INFO - PROCESS | 4948 | Cycle 1(1): loaded http://localhost:43449/tests/dromaeo/cssquery-ext.html (next: http://localhost:43449/tests/dromaeo/cssquery-jquery.html) 08:55:11 INFO - PROCESS | 4948 | RSS: Main: 247742464 08:55:11 INFO - PROCESS | 4948 | 08:58:13 INFO - PROCESS | 4948 | Cycle 1(1): loaded http://localhost:43449/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43449/tests/dromaeo/cssquery-mootools.html) 08:58:13 INFO - PROCESS | 4948 | RSS: Main: 243060736 08:58:13 INFO - PROCESS | 4948 | 09:01:15 INFO - PROCESS | 4948 | Cycle 1(1): loaded http://localhost:43449/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43449/tests/dromaeo/cssquery-prototype.html) 09:01:16 INFO - PROCESS | 4948 | RSS: Main: 245846016 09:01:16 INFO - PROCESS | 4948 | 09:04:19 INFO - PROCESS | 4948 | Cycle 1(1): loaded http://localhost:43449/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43449/tests/dromaeo/cssquery-yui.html) 09:04:19 INFO - PROCESS | 4948 | RSS: Main: 232644608 09:04:19 INFO - PROCESS | 4948 | 09:07:22 INFO - PROCESS | 4948 | Cycle 1(1): loaded http://localhost:43449/tests/dromaeo/cssquery-yui.html (next: http://localhost:43449/tests/dromaeo/cssquery-dojo.html) 09:07:22 INFO - PROCESS | 4948 | RSS: Main: 310382592 09:07:22 INFO - PROCESS | 4948 | 09:07:22 INFO - PROCESS | 4948 | __start_tp_report 09:07:22 INFO - PROCESS | 4948 | _x_x_mozilla_page_load 09:07:22 INFO - PROCESS | 4948 | _x_x_mozilla_page_load_details 09:07:22 INFO - PROCESS | 4948 | |i|pagename|runs| 09:07:22 INFO - PROCESS | 4948 | |0;dojo.html;3096.272375991642;3105.8602362893666;3144.638366587843;3148.275896543796;3172.508261219512;5197.038547868638;5252.448492908247;5328.413874473809;5420.512153906147;5470.699111548864;5292.761825717842;5334.5999050071305;5366.973165134169;5397.541208997231;5401.216823560591;4847.563719265274;4861.61107111432;4936.851894443154;4949.950500495003;5003.624728145385;4913.975430122862;4949.653524253304;4960.702357858522;4969.304297398367;4980.825671101512;4685.0395668887795;4785.617150627942;4829.565339119461;4850.53919877611;4908.779104940269;4851.175300198975;4854.514548545118;4855.368802055746;4917.631177661654;4970.90058198834;4896.46138924718;4909.459959404463;4914.606831453475;4933.161362568372;4952.380952380952;5082.593392528589;5158.690478571298;5192.091384007784;5197.896042079137;5283.841484755463;5550.250716153308;5627.465390787868;5645.520130788888;5651.604387692863;5674.858128546819;5511.862203444906;5624.072028115356;5653.378128405872;5714.628549144292;5717.313922329347;5206.583473322125;5263.368395792491;5271.710055946883;5335.626506144533;5348.465153484621;5852.824415267549;5853.502452291517;5854.0340843760305;5857.47282744555;5864.472197502245;5452.781888724407;5618.606697531133;5620.887582248332;5625.128105143709;5628.887422251532;5497.972510137503;5533.474319939599;5534.916976245359;5568.916466253009;5618.887622247532;5563.360213575491;5565.220869078251;5569.164625306155;5569.610127291051;5570.164475328652;5429.267048948342;5570.888582228333;5583.916241256385;5591.189277554813;5594.24477695514;4351.216780979454;4370.147821174904;4370.956290437119;4423.137488189772;4435.489918659331;3878.1855810279594;3881.126746482019;3890.8443662253194;3908.413737939332;3939.1727737175515;5166.173412254021;5303.628745987744;5346.545543628835;5434.130539113802;5469.890602187934;5643.1535269709875;5668.914966275509;5702.087665973508;5702.116171993348;5749.597528173072;5452.836414907559;5461.808836690697;5461.863453413617;5463.644863083887;5470.097433923438;4724.385829842098;4826.638002149853;4863.829765958175;4887.560119589254;4918.336024636628;5932.228810254639;5935.584509084409;5935.851603709942;5943.257092863392;5975.163477113208;5728.255326807655;5742.224799651994;5746.454086861741;5746.569007324384;5748.109043098327;5722.055860782924;5772.04761214395;5817.156512305776;5820.388859169726;5925.466707996301;5516.641418307797;5535.0313695104005;5543;5548.500634942713;5550.47270509301;5610.579206559606;5647.29408823897;5673.290838645169;5673.602847800615;5678.261825962599;5400.135978243462;5497.422770609029;5525.834224973257;5548.805791797267;5597.160425936142;5573.136163894603;5578.386377498553;5580.386157522588;5581.832545023656;5583.804566840141;5211.114110601131;5471.945280547144;5508.118701007819;5523.696196709219;5567.331920169444;5374.919376209438;5399.05516534597;5401.675899445889;5422.349318081855;5490.615656903979;5306.602004849729;5309.46905309466;5315.521603055744;5315.787368505371;5315.867103322448 09:07:22 INFO - PROCESS | 4948 | |1;ext.html;611.5230120506005;634.3086036220519;634.3149398649459;644.484412470024;645.6481217736333;43648.3452748209;45626;45628.315575266395;49238.261426078636;49303.260451093265;46954;47326.05347893049;47333;47381.289280660734;47452.52547474524;8966.103389661046;9099.135582119688;9099.590518426687;9103.681371152012;9110.316726245557;8917.821643567126;8984.595693193822;8998.28013758901;9002.459852408843;9008.68469603564;9080.273578113734;9100.681476148337;9112.544372781367;9112.681056163035;9119.908800912006;9020.639174433014;9020.729378118667;9039.638414463414;9054.185123338932;9055.909440905572;8935.106489351077;8992.325575581792;8996.505192214425;9002;9003.954980225122;44111.77944110291;44400.555994440285;44402.333964990554;44452.555474445166;44549.55450445486;3327.783694059878;3733.3653278942375;3850.9229815403537;4060.614241647039;4312.439382880206;33574;33771.83114084414;33816.32367352639;33823;34803.129921751904;4339.696221264513;4357.411749413852;4388.912221755579;4400.053988392511;4407.228734971367;362779;362817;363161;363343.18328408455;364667;60236.397636023954;60241.39758602445;60631;60667;60733.392666073654;54381;61201;62027.379726203064;62093.68953155205;67949.3205067953;15574.143422111665;15677.529674109795;15687.607809804618;15709.921450392674;15717.528474145794;11768.293902365886;11931.940340298243;12013;12050.698732531582;12064.155509114278;17141.57146071358;17461.563460913323;17589.912050439667;18371.632567348846;18406.447806565826;5825.854353641193;5853.180554722342;5866.67733274674;5972.223610930551;6108.3280839107665;981.7447463659357;1042.4631314872847;1054.3884546962743;1106.3970136275589;1161.285809227319;32690.673093269237;33040;33143;33257.66742332546;33436.627679248515;1113.5100555755441;1125.2629527659396;1131.8472006279212;1167.0080431633214;1184.798584240681;16959.236834342486;17071.231794569274;17239.31042758301;17278;17361;535801;539503;540389;540427;541317;57276.713616431654;58680.70659646674;58702.706486467294;58731.412685872594;58797.70601146967;1232.3406977267118;1348.2045593100117;1351.6012776231034;1368.049205801978;1378.6829029323312;31928;34322;34353.65646343504;34374.14064648404;34639;45160.54839451564;45185.548144518136;45615;45626;45732.54267457416;419965;420969;421054;421195;421690;36849.26301474009;37093.62906370902;41141.79429102835;42139.15721685488;46940;48810.755946220044;48960.75519622379;49481.25778113403;50237;50736;39499.60500394959;42240.78879605582;42242.36636450517;42976.35535467033;43053;41326.1734765297;41355;42377.57622423736;42564.57435425606;42824.357634634885;41054.178916422105;42331.7883410581;42375;43006.569934300256;43031.354529681455;35760.821195893855;36358.8182059088;36566.26867462689;37689.24621507609;38451.230975380895;28188.43623127485;28738;28759.8562007197;28895.711042890143;28913.855430722713 09:07:22 INFO - PROCESS | 4948 | |2;jquery.html;394.54036048004076;398.14796335841305;398.20359281437146;400.8556919508977;416.3920675813312;13279.60961194495;18897.149628266725;20344.69482957755;20371.1851525939;21162.470938226554;15212.619684507892;19691.113899874505;19759.901200493976;20278.49303767403;20555.177792888306;5787.971060144693;5942.465178133967;5958.612690175147;5965.970170149143;5981.312149102865;5849.649021058729;5927;5935.851603709899;5944.821655350346;5973.701314934257;4267.679924005696;6325.209348831396;6581.848176569105;6624.006399040159;6709.798706038827;5760.481556659879;6084.300305464884;6680.632565208912;6697.330266973312;6730.966345168292;5922.2597175353085;5931.525477961753;5968.850778730523;5971.940280597182;5973.940260597382;14784.778228326584;23864.64203036956;24061.879690601436;24376.878115609485;24789.62815557768;2332.5684748321614;2458.8770561471856;2605.9218223453136;2996.8801247950273;3069.2633767895545;10349.120324772404;10512.579496820195;10793.946030269877;10856.240063195579;11046.392448415334;1942.7647727953056;1951.1805041882444;1984.9305274315475;2069.1516478244;2170.934871953844;83907;86354;86666.56666716689;88668.11331886663;90893.54553227258;10481.475926203659;10684.465776711133;11162.330260184415;11224.270422422516;11598.420078996185;16056.839431605767;16138.35446582147;16199.352025918832;16222.83777162237;16232.918835405748;7844.4901081429525;8025.839483210303;8034.517928924283;8067.959660201662;8103.959480202561;7461.888071678821;8096;8121.187881211831;8265.421420500506;8279.710210142737;4542.250528662799;4700.95299047012;4942.876428089255;4966.6771659842;4974.552290293891;1925.7015162649811;1988.5426351939136;2045.9386218413472;2067.080149333562;2089.3105275259127;890.528020149322;1030.902064303905;1035.404642330663;1043.7025447747355;1105.1545567640762;20172.29396971128;20454.97725113768;20524.38426847197;20534;20821.895890520755;1003.82934901067;1025.9538320775582;1026.199564339816;1055.6516349604613;1073.822819234833;11108.777824443467;11527.30836149817;11544.88455115455;11579.826302605468;11588.304701717923;485850.5612079037;488289;491903;497201;497291;59398.40601593929;60562.09156862651;92915.53542232246;96133;96192.51903740436;898.9190972812478;899.9595018224064;924.2421214604094;925.7870689741262;1054.4727636181756;18233.361832335806;18433.90783046076;18446.631067378847;18530.44408667742;18951.810481895005;43667.78166109149;44458;44842.327365090205;45187.77406112949;45468.772656136505;61944.380556193864;62542;62569.68715156395;62814.68592657008;62867.68566157323;8870.112988701077;8995.595198215966;9031.909680903107;9105.954470227607;9160.954195228982;8659.787659578782;12580.308083055153;13305.201687898758;14616.269186540843;14713.822894168656;12382.380880956096;12404;12735.363231838186;12763.936180319039;12984.545540906023;11991.942882214553;12185.939070304592;12340.568080117153;12500.374981251083;12629.431675574437;12518.248905065726;12558.811617825557;12788.168769029984;12794.104412691022;12925.28910909909;7975.641096150571;8253.628586713492;9046.773830654023;9150.450972941644;9223.492707900861;11541.480633371351;11791.823122652995;11984.221025633306;12524.624261272176;12793.104482686123 09:07:22 INFO - PROCESS | 4948 | |3;mootools.html;1442.8268607767066;1495.8354580996088;1605.2696023309395;1725.8446739793417;1777.200259883053;7938.483998540105;8962.283017358612;9023.323250756186;9605.991370906051;9616.711498655033;9015.14356136166;9339.533023348838;9396;9422.905770942289;9441.952790236057;2346.073301046086;2356.2460012795914;2371.9407014824596;2372.086746602562;2373.4778348763243;2053.4763635273057;2115.904784284703;2118.0892216346965;2330.906763729449;2374.726906405768;2420.4553975355493;2441.279822452381;2441.853488790678;2442.658027876099;2445.8043356531525;2315.2591170825344;2320.025589252518;2328.8136949044037;2352.1297120065683;2399.472116134448;2320.918767843117;2329.196427232602;2333.288347054148;2334;2335.100986120339;9377.484238366887;9427.575759090858;9447.433154010781;9450.385724927857;9463.148316651534;5523.28197334348;5608.46719561641;5673.801416950429;5704.2299289595785;5717.342505611867;3461.6019157796923;3483.9477407838904;3528.894133176009;3532.2935412917263;3569.5364900390714;1162.9360385178811;1169.5263418315596;1193.922395044328;1214.5688280660415;1220.8046712525954;13637.454501819915;13666.52167174144;13695.383707733175;13698.178109313472;13712.65718357039;4919.827806026843;4924.704517728947;5032.119379108642;5085.516875896784;5158.3552055993005;11142.49858756358;11164.776704465865;11177.944110279397;11224.102071834397;11227.382493962747;5609.214709940612;5612.074007788669;5616.634918730351;5625.493705566519;5632.605717599728;5071.7971281149075;5126.436092029874;5139.563137133386;5174.327337446108;5177.948220517822;3669.486271921933;4051.47330846988;4221.810018549173;4279.122779830127;4280.850170244026;1361.4894414594528;1381.2127087559995;1385.5427708856053;1389.958301250964;1405.6556143744847;881.0836729800935;941.0589410589411;944.7401964459829;962.1725316228038;997.1175509673991;5708.514776243983;5868.647881127146;5984.880302393928;6031.457168854824;6160.10678451622;932.5290728182224;968.9903100969041;971.4754032822196;982.5283863745442;1016.8017236638784;4063.4717486726536;4081.673466122703;4086.8773936781945;4176.4570605821045;4204.600562946515;11698.47356868943;12058.457369418396;12080.637580872588;12154.75690486203;12172.756544869053;11917.523299068114;12016.63950081499;12035.157538972187;12040.337781421931;12049.457774400173;8371.58142092893;8686.478811271343;8699.391042627081;8774.473531588124;8871;6051.939480605138;6061.424164704346;6077.574569780073;6140.969295153495;6273.597155356723;10281.2803103785;10728.839067413839;10826.729331766453;10831.945840270748;10841.512131953923;10533.9473302633;10848.511816968097;10859.239853210516;10920.945395272973;10937.562497500328;8157.510549367057;8492.57537123129;8565.61454734526;8634.654613815377;8644.049154593116;8028.43800933929;8884.466931984101;9187.127222913812;9190.58642361082;9363.953180234328;8222.136675648972;8276.29651479631;8282.668693252203;8288.792780180544;8381.58092095405;8219.83560328802;8262.256396924306;8262.462939908886;8309.335253179852;8409.20112589303;7433.033705618235;7472.402207823252;7477.850442991001;7491.8501629966;7499.512531685423;5159.716215608028;5242.344706911636;5326.760295786777;5360.088784906653;5385.4076051635075;5321.521063104185;5424.105022671215;5457.154141108134;5571.498565129158;5600.691961942132 09:07:22 INFO - PROCESS | 4948 | |4;prototype.html;338.0618782877515;339.843671910921;342.73780557873215;345.54215664244884;347.5603361747389;5292.3913749918775;5367.973160134194;5370.489803468669;5376.8118115865955;5385.380681221661;5272.947270527303;5274.81538146165;5345.33183352081;5353.812616558421;5354;3958.8020598970006;3996.42051902474;4121.113960498492;4128.463299771026;4131.710780245384;4078.449409329747;4108.116754897696;4112.6298633123015;4142.9378559321485;4148.875533733993;3971.4439978403047;4087.4073259377374;4094.263032654121;4117.711760176789;4131.97934010331;4046.2918989176924;4116.876493705194;4154.293770059097;4175.582441755831;4192;3710.684591809699;3717.4052151655605;3722.683571896392;3724.404095344732;3746.606606306326;5205.817796377147;5211.472435868601;5222.791088356461;5225.686458812445;5239.580833533309;4497.123061003105;4761.6905351028745;4764.190087685067;4792.993471371016;4793.49668284832;5552.222688823568;5557.3886872444;5570.610057295991;5575.832725018256;5579.944200557983;4001.13975495267;4011.65900898424;4013.8394464221396;4019.8995025124314;4049.696272779524;5485.341758988947;5681.715914204315;5682.7442765075675;5682.914756278659;5693.459121383462;4010.21800748857;4018.2566225248424;4020.733468957269;4029.8589549365634;4030.5969403059457;4067.877963661095;4075.225707115698;4083.816228269735;4094.385842123705;4098.979505102515;4539.251023581138;4632.420947381577;4667.996380778149;4671.719696818202;4697.459792123881;5466.617336786387;5472.398036216013;5510.228568000483;5523.337199536081;5526.530244929226;1411.1180512179888;1415.6673181802269;1425.6222101143205;1427.3719563392074;1429.6497358147321;888.822235552892;908.1281969309537;920.9033051529627;925.1257561604353;934.5187228577288;5225.425203227642;5228.477152284817;5244.842654720364;5247.501487358695;5249.370075590878;5475.7262136893;5501.174823776466;5503.147012213113;5509.3664228613425;5513.09034009392;5109.412417571953;5189.948100519022;5215.295935048795;5246.580273578104;5389.299391079213;2966.9406611867644;2970.613820203403;2977.7766667500023;2989.9850500747793;2997.5803387525766;5693.971530142323;5751.763370875282;5755.280589926259;5805.941940580625;5818.592698511148;5575.358833734092;5707.971460142673;5710.7430165642645;5730.971345143247;5748.683822389725;5749.9425005750245;5758.769649213985;5792.391798861143;5801.9419805802245;5806.709664516842;5410.729463526729;5619.353774316006;5645.520130788929;5646.322441307069;5649.192258477247;5591.860203494945;5602.13166959122;5602.691851948182;5618.269624948731;5618.915716264178;5815.9709201453725;5828.542864283929;5852.151438041375;5855.151003104611;5879.617824841372;3862.8990737639638;4005.2790497710694;4008.719389642697;4017.337139371971;4121.340585506305;5396.379416367168;5584.385717570983;5610.803621873215;5645.463680950304;5656;5484.012877681896;5526.972365138148;5547.694876781816;5548.306461692288;5593.720313984366;5494.642848214853;5498.752556135064;5534.667919924817;5536.446355364593;5552;5259.237410575522;5451.454854514517;5459.836204913859;5467.824417750203;5494.9725251375085;5499.50504454585;5518;5546.140348246028;5559.694216818114;5574.9442505574425;5275.393329766973;5477.863053423696;5477.972610136924;5485.286912701324;5488.067028605067 09:07:22 INFO - PROCESS | 4948 | |5;yui.html;755.0674916478149;780.1223623423648;809.4617079642038;840.2605706977859;876.0976194519645;15985.440509582168;16545.172741362912;16566.088865112415;16585.41951031714;16698.415555455562;12172.939135304334;15023.474178403758;15159.696806063872;15181.544553663407;15217.315220815062;783.5220515485549;806.9596520173997;808.5027707959592;818.9672413103468;822.4201937633984;804.5896592737716;808.0989696488402;811.0227176252602;811.1482942909951;812.2851890336525;678.7183318922641;845.4166625028741;856.387682806793;857.2584714222215;857.5926434943415;795.9960200198991;799.5402643479964;799.6521513141773;800.1118758178417;838;583.1922786940077;586.2847326261996;586.7799575159315;586.9618474799124;590.8375196820866;14201.78697319541;14210.857891421058;14231;14243.643908902257;14245.786313205206;14424.495142669955;14804.333804978694;14853.777193342108;14869.776953345709;14895.553133405907;13704.931475342559;13818.101823381548;13833.515826946008;13987.090839095528;13995.020348575605;4512.34570987205;4512.4133862597655;4561.6806823522365;4590.954090459086;4594.127115848011;80766;81426;81649.18350816476;81764;82368.58815705944;11752.001079908303;11886.64340069782;11892.702682433008;12034.63896083119;12097.334646594521;21833.781662183173;22090;22099.889500552395;22193.22323718662;22243.44391390196;8680.30557555394;8702.869456958151;8836.64653413869;8842.425242359355;8915;4793.760311984387;4823.27650852368;4830.2996065571;4877.878053048631;4917.164082106051;3422.349753546818;3436.621971583124;3526.153723106436;3529.382358087376;3529.541159649229;542.8914217156585;579.7738881836087;614.9600275982046;646.4828137489989;646.8298857333579;606.8968275393194;702.1363722621103;716.358858821352;717.3472140352254;786.2530595933771;10509.264351495322;10579.259451838298;10622.946885265525;10771.138308935266;11053.392063436588;652.2499126005038;684.5310961991051;720.2725247499958;751.4326683354033;791.386675326615;5076.873078173001;5147.6911385317;5193.195054766517;5212.400573934046;5212.50481204285;73563;94579.52710236405;129059;130669;131670;113551;114830;115186.42406787912;118502;118735.40632296783;95358.5232073849;99172.50413747886;100946;101770.49114754378;102913;9875.506224688594;9937.950310248403;10016.799664006825;10055.346402483816;10148;55674.16488752591;56457.94275715535;56936.86126277369;58237;58293.4170658288;75579.62210188914;80858;86212.56893715743;88202.11797881938;88615;13186.802197966847;13371.130876492996;13483;13507.324633768469;13536.72926541444;14039.719205615625;14461.276936153361;14590.270486475421;14772.48296309624;14796;13780;14019.299035048003;14184;14754.63113422173;14784.112953222411;13871.72256554843;14306.141631502143;14658.267086645837;14704.55886323412;14719;13585.52450664222;13912.652183695489;14602.707945841235;14613.342399592257;14650;10551.208659350734;10663.146948243966;10712.89287107119;10717.678469645924;11048;11491.770164596828;11768.764624707286;11874;11985.574671993048;12063.457144428347 09:07:22 INFO - PROCESS | 4948 | __end_tp_report 09:07:22 INFO - PROCESS | 4948 | __start_cc_report 09:07:22 INFO - PROCESS | 4948 | _x_x_mozilla_cycle_collect,757 09:07:22 INFO - PROCESS | 4948 | __end_cc_report 09:07:22 INFO - PROCESS | 4948 | __startTimestamp1467734842844__endTimestamp 09:07:22 INFO - PROCESS | 4948 | 09:07:22 INFO - PROCESS | 4948 | ------- Summary: start ------- 09:07:22 INFO - PROCESS | 4948 | Number of tests: 6 09:07:22 INFO - PROCESS | 4948 | 09:07:22 INFO - PROCESS | 4948 | [#0] dojo.html Cycles:165 Average:5266.39 Median:5461.81 stddev:573.89 (10.5%) stddev-sans-first:549.82 09:07:22 INFO - PROCESS | 4948 | Values: 3096.3 3105.9 3144.6 3148.3 3172.5 5197.0 5252.4 5328.4 5420.5 5470.7 5292.8 5334.6 5367.0 5397.5 5401.2 4847.6 4861.6 4936.9 4950.0 5003.6 4914.0 4949.7 4960.7 4969.3 4980.8 4685.0 4785.6 4829.6 4850.5 4908.8 4851.2 4854.5 4855.4 4917.6 4970.9 4896.5 4909.5 4914.6 4933.2 4952.4 5082.6 5158.7 5192.1 5197.9 5283.8 5550.3 5627.5 5645.5 5651.6 5674.9 5511.9 5624.1 5653.4 5714.6 5717.3 5206.6 5263.4 5271.7 5335.6 5348.5 5852.8 5853.5 5854.0 5857.5 5864.5 5452.8 5618.6 5620.9 5625.1 5628.9 5498.0 5533.5 5534.9 5568.9 5618.9 5563.4 5565.2 5569.2 5569.6 5570.2 5429.3 5570.9 5583.9 5591.2 5594.2 4351.2 4370.1 4371.0 4423.1 4435.5 3878.2 3881.1 3890.8 3908.4 3939.2 5166.2 5303.6 5346.5 5434.1 5469.9 5643.2 5668.9 5702.1 5702.1 5749.6 5452.8 5461.8 5461.9 5463.6 5470.1 4724.4 4826.6 4863.8 4887.6 4918.3 5932.2 5935.6 5935.9 5943.3 5975.2 5728.3 5742.2 5746.5 5746.6 5748.1 5722.1 5772.0 5817.2 5820.4 5925.5 5516.6 5535.0 5543.0 5548.5 5550.5 5610.6 5647.3 5673.3 5673.6 5678.3 5400.1 5497.4 5525.8 5548.8 5597.2 5573.1 5578.4 5580.4 5581.8 5583.8 5211.1 5471.9 5508.1 5523.7 5567.3 5374.9 5399.1 5401.7 5422.3 5490.6 5306.6 5309.5 5315.5 5315.8 5315.9 09:07:22 INFO - PROCESS | 4948 | 09:07:22 INFO - PROCESS | 4948 | [#1] ext.html Cycles:180 Average:61051.30 Median:43042.18 stddev:118417.01 (275.1%) stddev-sans-first:118662.25 09:07:22 INFO - PROCESS | 4948 | Values: 611.5 634.3 634.3 644.5 645.6 43648.3 45626.0 45628.3 49238.3 49303.3 46954.0 47326.1 47333.0 47381.3 47452.5 8966.1 9099.1 9099.6 9103.7 9110.3 8917.8 8984.6 8998.3 9002.5 9008.7 9080.3 9100.7 9112.5 9112.7 9119.9 9020.6 9020.7 9039.6 9054.2 9055.9 8935.1 8992.3 8996.5 9002.0 9004.0 44111.8 44400.6 44402.3 44452.6 44549.6 3327.8 3733.4 3850.9 4060.6 4312.4 33574.0 33771.8 33816.3 33823.0 34803.1 4339.7 4357.4 4388.9 4400.1 4407.2 362779.0 362817.0 363161.0 363343.2 364667.0 60236.4 60241.4 60631.0 60667.0 60733.4 54381.0 61201.0 62027.4 62093.7 67949.3 15574.1 15677.5 15687.6 15709.9 15717.5 11768.3 11931.9 12013.0 12050.7 12064.2 17141.6 17461.6 17589.9 18371.6 18406.4 5825.9 5853.2 5866.7 5972.2 6108.3 981.7 1042.5 1054.4 1106.4 1161.3 32690.7 33040.0 33143.0 33257.7 33436.6 1113.5 1125.3 1131.8 1167.0 1184.8 16959.2 17071.2 17239.3 17278.0 17361.0 535801.0 539503.0 540389.0 540427.0 541317.0 57276.7 58680.7 58702.7 58731.4 58797.7 1232.3 1348.2 1351.6 1368.0 1378.7 31928.0 34322.0 34353.7 34374.1 34639.0 45160.5 45185.5 45615.0 45626.0 45732.5 419965.0 420969.0 421054.0 421195.0 421690.0 36849.3 37093.6 41141.8 42139.2 46940.0 48810.8 48960.8 49481.3 50237.0 50736.0 39499.6 42240.8 42242.4 42976.4 43053.0 41326.2 41355.0 42377.6 42564.6 42824.4 41054.2 42331.8 42375.0 43006.6 43031.4 35760.8 36358.8 36566.3 37689.2 38451.2 28188.4 28738.0 28759.9 28895.7 28913.9 09:07:22 INFO - PROCESS | 4948 | 09:07:22 INFO - PROCESS | 4948 | [#2] jquery.html Cycles:180 Average:29391.60 Median:13697.77 stddev:81095.47 (592.0%) stddev-sans-first:81293.74 09:07:22 INFO - PROCESS | 4948 | Values: 394.5 398.1 398.2 400.9 416.4 13279.6 18897.1 20344.7 20371.2 21162.5 15212.6 19691.1 19759.9 20278.5 20555.2 5788.0 5942.5 5958.6 5966.0 5981.3 5849.6 5927.0 5935.9 5944.8 5973.7 4267.7 6325.2 6581.8 6624.0 6709.8 5760.5 6084.3 6680.6 6697.3 6731.0 5922.3 5931.5 5968.9 5971.9 5973.9 14784.8 23864.6 24061.9 24376.9 24789.6 2332.6 2458.9 2605.9 2996.9 3069.3 10349.1 10512.6 10793.9 10856.2 11046.4 1942.8 1951.2 1984.9 2069.2 2170.9 83907.0 86354.0 86666.6 88668.1 90893.5 10481.5 10684.5 11162.3 11224.3 11598.4 16056.8 16138.4 16199.4 16222.8 16232.9 7844.5 8025.8 8034.5 8068.0 8104.0 7461.9 8096.0 8121.2 8265.4 8279.7 4542.3 4701.0 4942.9 4966.7 4974.6 1925.7 1988.5 2045.9 2067.1 2089.3 890.5 1030.9 1035.4 1043.7 1105.2 20172.3 20455.0 20524.4 20534.0 20821.9 1003.8 1026.0 1026.2 1055.7 1073.8 11108.8 11527.3 11544.9 11579.8 11588.3 485850.6 488289.0 491903.0 497201.0 497291.0 59398.4 60562.1 92915.5 96133.0 96192.5 898.9 900.0 924.2 925.8 1054.5 18233.4 18433.9 18446.6 18530.4 18951.8 43667.8 44458.0 44842.3 45187.8 45468.8 61944.4 62542.0 62569.7 62814.7 62867.7 8870.1 8995.6 9031.9 9106.0 9161.0 8659.8 12580.3 13305.2 14616.3 14713.8 12382.4 12404.0 12735.4 12763.9 12984.5 11991.9 12185.9 12340.6 12500.4 12629.4 12518.2 12558.8 12788.2 12794.1 12925.3 7975.6 8253.6 9046.8 9150.5 9223.5 11541.5 11791.8 11984.2 12524.6 12793.1 09:07:22 INFO - PROCESS | 4948 | 09:07:22 INFO - PROCESS | 4948 | [#3] mootools.html Cycles:180 Average:6171.61 Median:5105.98 stddev:3616.21 (70.8%) stddev-sans-first:3608.90 09:07:22 INFO - PROCESS | 4948 | Values: 1442.8 1495.8 1605.3 1725.8 1777.2 7938.5 8962.3 9023.3 9606.0 9616.7 9015.1 9339.5 9396.0 9422.9 9442.0 2346.1 2356.2 2371.9 2372.1 2373.5 2053.5 2115.9 2118.1 2330.9 2374.7 2420.5 2441.3 2441.9 2442.7 2445.8 2315.3 2320.0 2328.8 2352.1 2399.5 2320.9 2329.2 2333.3 2334.0 2335.1 9377.5 9427.6 9447.4 9450.4 9463.1 5523.3 5608.5 5673.8 5704.2 5717.3 3461.6 3483.9 3528.9 3532.3 3569.5 1162.9 1169.5 1193.9 1214.6 1220.8 13637.5 13666.5 13695.4 13698.2 13712.7 4919.8 4924.7 5032.1 5085.5 5158.4 11142.5 11164.8 11177.9 11224.1 11227.4 5609.2 5612.1 5616.6 5625.5 5632.6 5071.8 5126.4 5139.6 5174.3 5177.9 3669.5 4051.5 4221.8 4279.1 4280.9 1361.5 1381.2 1385.5 1390.0 1405.7 881.1 941.1 944.7 962.2 997.1 5708.5 5868.6 5984.9 6031.5 6160.1 932.5 969.0 971.5 982.5 1016.8 4063.5 4081.7 4086.9 4176.5 4204.6 11698.5 12058.5 12080.6 12154.8 12172.8 11917.5 12016.6 12035.2 12040.3 12049.5 8371.6 8686.5 8699.4 8774.5 8871.0 6051.9 6061.4 6077.6 6141.0 6273.6 10281.3 10728.8 10826.7 10831.9 10841.5 10533.9 10848.5 10859.2 10920.9 10937.6 8157.5 8492.6 8565.6 8634.7 8644.0 8028.4 8884.5 9187.1 9190.6 9364.0 8222.1 8276.3 8282.7 8288.8 8381.6 8219.8 8262.3 8262.5 8309.3 8409.2 7433.0 7472.4 7477.9 7491.9 7499.5 5159.7 5242.3 5326.8 5360.1 5385.4 5321.5 5424.1 5457.2 5571.5 5600.7 09:07:22 INFO - PROCESS | 4948 | 09:07:22 INFO - PROCESS | 4948 | [#4] prototype.html Cycles:180 Average:4644.46 Median:5353.91 stddev:1357.10 (25.3%) stddev-sans-first:1321.86 09:07:22 INFO - PROCESS | 4948 | Values: 338.1 339.8 342.7 345.5 347.6 5292.4 5368.0 5370.5 5376.8 5385.4 5272.9 5274.8 5345.3 5353.8 5354.0 3958.8 3996.4 4121.1 4128.5 4131.7 4078.4 4108.1 4112.6 4142.9 4148.9 3971.4 4087.4 4094.3 4117.7 4132.0 4046.3 4116.9 4154.3 4175.6 4192.0 3710.7 3717.4 3722.7 3724.4 3746.6 5205.8 5211.5 5222.8 5225.7 5239.6 4497.1 4761.7 4764.2 4793.0 4793.5 5552.2 5557.4 5570.6 5575.8 5579.9 4001.1 4011.7 4013.8 4019.9 4049.7 5485.3 5681.7 5682.7 5682.9 5693.5 4010.2 4018.3 4020.7 4029.9 4030.6 4067.9 4075.2 4083.8 4094.4 4099.0 4539.3 4632.4 4668.0 4671.7 4697.5 5466.6 5472.4 5510.2 5523.3 5526.5 1411.1 1415.7 1425.6 1427.4 1429.6 888.8 908.1 920.9 925.1 934.5 5225.4 5228.5 5244.8 5247.5 5249.4 5475.7 5501.2 5503.1 5509.4 5513.1 5109.4 5189.9 5215.3 5246.6 5389.3 2966.9 2970.6 2977.8 2990.0 2997.6 5694.0 5751.8 5755.3 5805.9 5818.6 5575.4 5708.0 5710.7 5731.0 5748.7 5749.9 5758.8 5792.4 5801.9 5806.7 5410.7 5619.4 5645.5 5646.3 5649.2 5591.9 5602.1 5602.7 5618.3 5618.9 5816.0 5828.5 5852.2 5855.2 5879.6 3862.9 4005.3 4008.7 4017.3 4121.3 5396.4 5584.4 5610.8 5645.5 5656.0 5484.0 5527.0 5547.7 5548.3 5593.7 5494.6 5498.8 5534.7 5536.4 5552.0 5259.2 5451.5 5459.8 5467.8 5495.0 5499.5 5518.0 5546.1 5559.7 5574.9 5275.4 5477.9 5478.0 5485.3 5488.1 09:07:22 INFO - PROCESS | 4948 | 09:07:22 INFO - PROCESS | 4948 | [#5] yui.html Cycles:180 Average:22400.62 Median:3481.39 stddev:32958.90 (946.7%) stddev-sans-first:33011.29 09:07:22 INFO - PROCESS | 4948 | Values: 755.1 780.1 809.5 840.3 876.1 15985.4 16545.2 16566.1 16585.4 16698.4 12172.9 15023.5 15159.7 15181.5 15217.3 783.5 807.0 808.5 819.0 822.4 804.6 808.1 811.0 811.1 812.3 678.7 845.4 856.4 857.3 857.6 796.0 799.5 799.7 800.1 838.0 583.2 586.3 586.8 587.0 590.8 14201.8 14210.9 14231.0 14243.6 14245.8 14424.5 14804.3 14853.8 14869.8 14895.6 13704.9 13818.1 13833.5 13987.1 13995.0 4512.3 4512.4 4561.7 4591.0 4594.1 80766.0 81426.0 81649.2 81764.0 82368.6 11752.0 11886.6 11892.7 12034.6 12097.3 21833.8 22090.0 22099.9 22193.2 22243.4 8680.3 8702.9 8836.6 8842.4 8915.0 4793.8 4823.3 4830.3 4877.9 4917.2 3422.3 3436.6 3526.2 3529.4 3529.5 542.9 579.8 615.0 646.5 646.8 606.9 702.1 716.4 717.3 786.3 10509.3 10579.3 10622.9 10771.1 11053.4 652.2 684.5 720.3 751.4 791.4 5076.9 5147.7 5193.2 5212.4 5212.5 73563.0 94579.5 129059.0 130669.0 131670.0 113551.0 114830.0 115186.4 118502.0 118735.4 95358.5 99172.5 100946.0 101770.5 102913.0 9875.5 9938.0 10016.8 10055.3 10148.0 55674.2 56457.9 56936.9 58237.0 58293.4 75579.6 80858.0 86212.6 88202.1 88615.0 13186.8 13371.1 13483.0 13507.3 13536.7 14039.7 14461.3 14590.3 14772.5 14796.0 13780.0 14019.3 14184.0 14754.6 14784.1 13871.7 14306.1 14658.3 14704.6 14719.0 13585.5 13912.7 14602.7 14613.3 14650.0 10551.2 10663.1 10712.9 10717.7 11048.0 11491.8 11768.8 11874.0 11985.6 12063.5 09:07:22 INFO - PROCESS | 4948 | -------- Summary: end -------- 09:07:22 INFO - PROCESS | 4948 | 09:07:23 INFO - TEST-INFO | 4948: exit 0 09:07:23 INFO - TEST-OK | dromaeo_css | took 1112813ms 09:07:23 INFO - TEST-START | kraken 09:07:23 INFO - operating with platform_type : linux_ 09:07:23 INFO - Initialising browser for kraken test... 09:07:23 INFO - TEST-INFO | started process 5130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG7fmOj/profile http://localhost:43449/getInfo.html) 09:07:27 INFO - PROCESS | 5130 | __metrics Screen width/height:1600/1200 09:07:27 INFO - PROCESS | 5130 | colorDepth:24 09:07:27 INFO - PROCESS | 5130 | Browser inner width/height: 1024/697 09:07:27 INFO - PROCESS | 5130 | __metrics 09:07:27 INFO - PROCESS | 5130 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:07:28 INFO - TEST-INFO | 5130: exit 0 09:07:28 INFO - Browser initialized. 09:07:28 INFO - Running cycle 1/1 for kraken test... 09:07:28 INFO - TEST-INFO | started process 5213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG7fmOj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:40 INFO - PROCESS | 5213 | RSS: Main: 157290496 09:07:40 INFO - PROCESS | 5213 | 09:07:42 INFO - PROCESS | 5213 | Cycle 1(1): loaded http://localhost:43449/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43449/tests/kraken/driver.html?testName=audio-beat-detection) 09:07:43 INFO - PROCESS | 5213 | RSS: Main: 216117248 09:07:43 INFO - PROCESS | 5213 | 09:07:46 INFO - PROCESS | 5213 | Cycle 1(1): loaded http://localhost:43449/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43449/tests/kraken/driver.html?testName=audio-dft) 09:07:46 INFO - PROCESS | 5213 | RSS: Main: 203558912 09:07:46 INFO - PROCESS | 5213 | 09:07:50 INFO - PROCESS | 5213 | Cycle 1(1): loaded http://localhost:43449/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43449/tests/kraken/driver.html?testName=audio-fft) 09:07:50 INFO - PROCESS | 5213 | RSS: Main: 268840960 09:07:50 INFO - PROCESS | 5213 | 09:07:52 INFO - PROCESS | 5213 | Cycle 1(1): loaded http://localhost:43449/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43449/tests/kraken/driver.html?testName=audio-oscillator) 09:07:53 INFO - PROCESS | 5213 | RSS: Main: 179769344 09:07:53 INFO - PROCESS | 5213 | 09:07:55 INFO - PROCESS | 5213 | Cycle 1(1): loaded http://localhost:43449/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43449/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:07:56 INFO - PROCESS | 5213 | RSS: Main: 185319424 09:07:56 INFO - PROCESS | 5213 | 09:07:59 INFO - PROCESS | 5213 | Cycle 1(1): loaded http://localhost:43449/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43449/tests/kraken/driver.html?testName=imaging-darkroom) 09:07:59 INFO - PROCESS | 5213 | RSS: Main: 219152384 09:07:59 INFO - PROCESS | 5213 | 09:08:03 INFO - PROCESS | 5213 | Cycle 1(1): loaded http://localhost:43449/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43449/tests/kraken/driver.html?testName=imaging-desaturate) 09:08:03 INFO - PROCESS | 5213 | RSS: Main: 221097984 09:08:03 INFO - PROCESS | 5213 | 09:08:06 INFO - PROCESS | 5213 | Cycle 1(1): loaded http://localhost:43449/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43449/tests/kraken/driver.html?testName=json-parse-financial) 09:08:07 INFO - PROCESS | 5213 | RSS: Main: 220987392 09:08:07 INFO - PROCESS | 5213 | 09:08:08 INFO - PROCESS | 5213 | Cycle 1(1): loaded http://localhost:43449/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43449/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:08:09 INFO - PROCESS | 5213 | RSS: Main: 208863232 09:08:09 INFO - PROCESS | 5213 | 09:08:11 INFO - PROCESS | 5213 | Cycle 1(1): loaded http://localhost:43449/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43449/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:08:11 INFO - PROCESS | 5213 | RSS: Main: 211816448 09:08:11 INFO - PROCESS | 5213 | 09:08:13 INFO - PROCESS | 5213 | Cycle 1(1): loaded http://localhost:43449/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43449/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:08:14 INFO - PROCESS | 5213 | RSS: Main: 210665472 09:08:14 INFO - PROCESS | 5213 | 09:08:16 INFO - PROCESS | 5213 | Cycle 1(1): loaded http://localhost:43449/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:08:17 INFO - PROCESS | 5213 | RSS: Main: 223260672 09:08:17 INFO - PROCESS | 5213 | 09:08:20 INFO - PROCESS | 5213 | Cycle 1(1): loaded http://localhost:43449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:08:20 INFO - PROCESS | 5213 | RSS: Main: 224215040 09:08:20 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | Cycle 1(1): loaded http://localhost:43449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43449/tests/kraken/driver.html?testName=ai-astar) 09:08:22 INFO - PROCESS | 5213 | RSS: Main: 266493952 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | __start_tp_report 09:08:22 INFO - PROCESS | 5213 | _x_x_mozilla_page_load 09:08:22 INFO - PROCESS | 5213 | _x_x_mozilla_page_load_details 09:08:22 INFO - PROCESS | 5213 | |i|pagename|runs| 09:08:22 INFO - PROCESS | 5213 | |0;ai-astar;106;112;111;110;112;111;110;111;110;111 09:08:22 INFO - PROCESS | 5213 | |1;audio-beat-detection;145;124;123;170;123;122;146;121;154;122 09:08:22 INFO - PROCESS | 5213 | |2;audio-dft;161;160;160;161;161;159;161;164;161;160 09:08:22 INFO - PROCESS | 5213 | |3;audio-fft;74;76;76;119;78;87;76;76;101;76 09:08:22 INFO - PROCESS | 5213 | |4;audio-oscillator;84;84;113;84;84;84;116;85;85;125 09:08:22 INFO - PROCESS | 5213 | |5;imaging-gaussian-blur;117;118;116;117;117;116;117;117;117;117 09:08:22 INFO - PROCESS | 5213 | |6;imaging-darkroom;146;147;147;146;146;149;146;147;147;146 09:08:22 INFO - PROCESS | 5213 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;95 09:08:22 INFO - PROCESS | 5213 | |8;json-parse-financial;53;53;53;52;53;53;52;53;52;55 09:08:22 INFO - PROCESS | 5213 | |9;json-stringify-tinderbox;60;60;59;59;60;60;60;59;60;60 09:08:22 INFO - PROCESS | 5213 | |10;stanford-crypto-aes;75;76;75;75;74;83;74;75;74;80 09:08:22 INFO - PROCESS | 5213 | |11;stanford-crypto-ccm;123;122;127;119;130;121;127;118;154;128 09:08:22 INFO - PROCESS | 5213 | |12;stanford-crypto-pbkdf2;157;156;156;157;153;158;154;155;154;158 09:08:22 INFO - PROCESS | 5213 | |13;stanford-crypto-sha256-iterative;65;61;67;63;62;64;62;62;62;65 09:08:22 INFO - PROCESS | 5213 | __end_tp_report 09:08:22 INFO - PROCESS | 5213 | __start_cc_report 09:08:22 INFO - PROCESS | 5213 | _x_x_mozilla_cycle_collect,1641 09:08:22 INFO - PROCESS | 5213 | __end_cc_report 09:08:22 INFO - PROCESS | 5213 | __startTimestamp1467734902645__endTimestamp 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | ------- Summary: start ------- 09:08:22 INFO - PROCESS | 5213 | Number of tests: 14 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.71 (1.5%) stddev-sans-first:0.78 09:08:22 INFO - PROCESS | 5213 | Values: 106.0 112.0 111.0 110.0 112.0 111.0 110.0 111.0 110.0 111.0 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:134.50 stddev:17.48 (13.0%) stddev-sans-first:18.16 09:08:22 INFO - PROCESS | 5213 | Values: 145.0 124.0 123.0 170.0 123.0 122.0 146.0 121.0 154.0 122.0 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.39 09:08:22 INFO - PROCESS | 5213 | Values: 161.0 160.0 160.0 161.0 161.0 159.0 161.0 164.0 161.0 160.0 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | [#3] audio-fft Cycles:10 Average:83.90 Median:76.00 stddev:14.83 (19.5%) stddev-sans-first:15.29 09:08:22 INFO - PROCESS | 5213 | Values: 74.0 76.0 76.0 119.0 78.0 87.0 76.0 76.0 101.0 76.0 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:84.00 stddev:16.55 (19.7%) stddev-sans-first:17.13 09:08:22 INFO - PROCESS | 5213 | Values: 84.0 84.0 113.0 84.0 84.0 84.0 116.0 85.0 85.0 125.0 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 09:08:22 INFO - PROCESS | 5213 | Values: 117.0 118.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 09:08:22 INFO - PROCESS | 5213 | Values: 146.0 147.0 147.0 146.0 146.0 149.0 146.0 147.0 147.0 146.0 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:08:22 INFO - PROCESS | 5213 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.88 (1.7%) stddev-sans-first:0.93 09:08:22 INFO - PROCESS | 5213 | Values: 53.0 53.0 53.0 52.0 53.0 53.0 52.0 53.0 52.0 55.0 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 09:08:22 INFO - PROCESS | 5213 | Values: 60.0 60.0 59.0 59.0 60.0 60.0 60.0 59.0 60.0 60.0 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:75.00 stddev:3.00 (4.0%) stddev-sans-first:3.15 09:08:22 INFO - PROCESS | 5213 | Values: 75.0 76.0 75.0 75.0 74.0 83.0 74.0 75.0 74.0 80.0 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:127.00 stddev:10.33 (8.1%) stddev-sans-first:10.86 09:08:22 INFO - PROCESS | 5213 | Values: 123.0 122.0 127.0 119.0 130.0 121.0 127.0 118.0 154.0 128.0 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.80 Median:156.50 stddev:1.75 (1.1%) stddev-sans-first:1.80 09:08:22 INFO - PROCESS | 5213 | Values: 157.0 156.0 156.0 157.0 153.0 158.0 154.0 155.0 154.0 158.0 09:08:22 INFO - PROCESS | 5213 | 09:08:22 INFO - PROCESS | 5213 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.89 (3.0%) stddev-sans-first:1.90 09:08:22 INFO - PROCESS | 5213 | Values: 65.0 61.0 67.0 63.0 62.0 64.0 62.0 62.0 62.0 65.0 09:08:22 INFO - PROCESS | 5213 | -------- Summary: end -------- 09:08:22 INFO - PROCESS | 5213 | 09:08:23 INFO - TEST-INFO | 5213: exit 0 09:08:23 INFO - TEST-OK | kraken | took 60044ms 09:08:23 INFO - SUITE-END | took 1172s 09:08:23 INFO - Completed test suite (00:19:33) 09:08:23 INFO - javascript benchmark 09:08:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.272375991642, 3105.8602362893666, 3144.638366587843, 3148.275896543796, 3172.508261219512, 5197.038547868638, 5252.448492908247, 5328.413874473809, 5420.512153906147, 5470.699111548864, 5292.761825717842, 5334.5999050071305, 5366.973165134169, 5397.541208997231, 5401.216823560591, 4847.563719265274, 4861.61107111432, 4936.851894443154, 4949.950500495003, 5003.624728145385, 4913.975430122862, 4949.653524253304, 4960.702357858522, 4969.304297398367, 4980.825671101512, 4685.0395668887795, 4785.617150627942, 4829.565339119461, 4850.53919877611, 4908.779104940269, 4851.175300198975, 4854.514548545118, 4855.368802055746, 4917.631177661654, 4970.90058198834, 4896.46138924718, 4909.459959404463, 4914.606831453475, 4933.161362568372, 4952.380952380952, 5082.593392528589, 5158.690478571298, 5192.091384007784, 5197.896042079137, 5283.841484755463, 5550.250716153308, 5627.465390787868, 5645.520130788888, 5651.604387692863, 5674.858128546819, 5511.862203444906, 5624.072028115356, 5653.378128405872, 5714.628549144292, 5717.313922329347, 5206.583473322125, 5263.368395792491, 5271.710055946883, 5335.626506144533, 5348.465153484621, 5852.824415267549, 5853.502452291517, 5854.0340843760305, 5857.47282744555, 5864.472197502245, 5452.781888724407, 5618.606697531133, 5620.887582248332, 5625.128105143709, 5628.887422251532, 5497.972510137503, 5533.474319939599, 5534.916976245359, 5568.916466253009, 5618.887622247532, 5563.360213575491, 5565.220869078251, 5569.164625306155, 5569.610127291051, 5570.164475328652, 5429.267048948342, 5570.888582228333, 5583.916241256385, 5591.189277554813, 5594.24477695514, 4351.216780979454, 4370.147821174904, 4370.956290437119, 4423.137488189772, 4435.489918659331, 3878.1855810279594, 3881.126746482019, 3890.8443662253194, 3908.413737939332, 3939.1727737175515, 5166.173412254021, 5303.628745987744, 5346.545543628835, 5434.130539113802, 5469.890602187934, 5643.1535269709875, 5668.914966275509, 5702.087665973508, 5702.116171993348, 5749.597528173072, 5452.836414907559, 5461.808836690697, 5461.863453413617, 5463.644863083887, 5470.097433923438, 4724.385829842098, 4826.638002149853, 4863.829765958175, 4887.560119589254, 4918.336024636628, 5932.228810254639, 5935.584509084409, 5935.851603709942, 5943.257092863392, 5975.163477113208, 5728.255326807655, 5742.224799651994, 5746.454086861741, 5746.569007324384, 5748.109043098327, 5722.055860782924, 5772.04761214395, 5817.156512305776, 5820.388859169726, 5925.466707996301, 5516.641418307797, 5535.0313695104005, 5543.0, 5548.500634942713, 5550.47270509301, 5610.579206559606, 5647.29408823897, 5673.290838645169, 5673.602847800615, 5678.261825962599, 5400.135978243462, 5497.422770609029, 5525.834224973257, 5548.805791797267, 5597.160425936142, 5573.136163894603, 5578.386377498553, 5580.386157522588, 5581.832545023656, 5583.804566840141, 5211.114110601131, 5471.945280547144, 5508.118701007819, 5523.696196709219, 5567.331920169444, 5374.919376209438, 5399.05516534597, 5401.675899445889, 5422.349318081855, 5490.615656903979, 5306.602004849729, 5309.46905309466, 5315.521603055744, 5315.787368505371, 5315.867103322448], "value": 5229.4396180743115, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.5230120506005, 634.3086036220519, 634.3149398649459, 644.484412470024, 645.6481217736333, 43648.3452748209, 45626.0, 45628.315575266395, 49238.261426078636, 49303.260451093265, 46954.0, 47326.05347893049, 47333.0, 47381.289280660734, 47452.52547474524, 8966.103389661046, 9099.135582119688, 9099.590518426687, 9103.681371152012, 9110.316726245557, 8917.821643567126, 8984.595693193822, 8998.28013758901, 9002.459852408843, 9008.68469603564, 9080.273578113734, 9100.681476148337, 9112.544372781367, 9112.681056163035, 9119.908800912006, 9020.639174433014, 9020.729378118667, 9039.638414463414, 9054.185123338932, 9055.909440905572, 8935.106489351077, 8992.325575581792, 8996.505192214425, 9002.0, 9003.954980225122, 44111.77944110291, 44400.555994440285, 44402.333964990554, 44452.555474445166, 44549.55450445486, 3327.783694059878, 3733.3653278942375, 3850.9229815403537, 4060.614241647039, 4312.439382880206, 33574.0, 33771.83114084414, 33816.32367352639, 33823.0, 34803.129921751904, 4339.696221264513, 4357.411749413852, 4388.912221755579, 4400.053988392511, 4407.228734971367, 362779.0, 362817.0, 363161.0, 363343.18328408455, 364667.0, 60236.397636023954, 60241.39758602445, 60631.0, 60667.0, 60733.392666073654, 54381.0, 61201.0, 62027.379726203064, 62093.68953155205, 67949.3205067953, 15574.143422111665, 15677.529674109795, 15687.607809804618, 15709.921450392674, 15717.528474145794, 11768.293902365886, 11931.940340298243, 12013.0, 12050.698732531582, 12064.155509114278, 17141.57146071358, 17461.563460913323, 17589.912050439667, 18371.632567348846, 18406.447806565826, 5825.854353641193, 5853.180554722342, 5866.67733274674, 5972.223610930551, 6108.3280839107665, 981.7447463659357, 1042.4631314872847, 1054.3884546962743, 1106.3970136275589, 1161.285809227319, 32690.673093269237, 33040.0, 33143.0, 33257.66742332546, 33436.627679248515, 1113.5100555755441, 1125.2629527659396, 1131.8472006279212, 1167.0080431633214, 1184.798584240681, 16959.236834342486, 17071.231794569274, 17239.31042758301, 17278.0, 17361.0, 535801.0, 539503.0, 540389.0, 540427.0, 541317.0, 57276.713616431654, 58680.70659646674, 58702.706486467294, 58731.412685872594, 58797.70601146967, 1232.3406977267118, 1348.2045593100117, 1351.6012776231034, 1368.049205801978, 1378.6829029323312, 31928.0, 34322.0, 34353.65646343504, 34374.14064648404, 34639.0, 45160.54839451564, 45185.548144518136, 45615.0, 45626.0, 45732.54267457416, 419965.0, 420969.0, 421054.0, 421195.0, 421690.0, 36849.26301474009, 37093.62906370902, 41141.79429102835, 42139.15721685488, 46940.0, 48810.755946220044, 48960.75519622379, 49481.25778113403, 50237.0, 50736.0, 39499.60500394959, 42240.78879605582, 42242.36636450517, 42976.35535467033, 43053.0, 41326.1734765297, 41355.0, 42377.57622423736, 42564.57435425606, 42824.357634634885, 41054.178916422105, 42331.7883410581, 42375.0, 43006.569934300256, 43031.354529681455, 35760.821195893855, 36358.8182059088, 36566.26867462689, 37689.24621507609, 38451.230975380895, 28188.43623127485, 28738.0, 28759.8562007197, 28895.711042890143, 28913.855430722713], "value": 20532.27913637395, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.54036048004076, 398.14796335841305, 398.20359281437146, 400.8556919508977, 416.3920675813312, 13279.60961194495, 18897.149628266725, 20344.69482957755, 20371.1851525939, 21162.470938226554, 15212.619684507892, 19691.113899874505, 19759.901200493976, 20278.49303767403, 20555.177792888306, 5787.971060144693, 5942.465178133967, 5958.612690175147, 5965.970170149143, 5981.312149102865, 5849.649021058729, 5927.0, 5935.851603709899, 5944.821655350346, 5973.701314934257, 4267.679924005696, 6325.209348831396, 6581.848176569105, 6624.006399040159, 6709.798706038827, 5760.481556659879, 6084.300305464884, 6680.632565208912, 6697.330266973312, 6730.966345168292, 5922.2597175353085, 5931.525477961753, 5968.850778730523, 5971.940280597182, 5973.940260597382, 14784.778228326584, 23864.64203036956, 24061.879690601436, 24376.878115609485, 24789.62815557768, 2332.5684748321614, 2458.8770561471856, 2605.9218223453136, 2996.8801247950273, 3069.2633767895545, 10349.120324772404, 10512.579496820195, 10793.946030269877, 10856.240063195579, 11046.392448415334, 1942.7647727953056, 1951.1805041882444, 1984.9305274315475, 2069.1516478244, 2170.934871953844, 83907.0, 86354.0, 86666.56666716689, 88668.11331886663, 90893.54553227258, 10481.475926203659, 10684.465776711133, 11162.330260184415, 11224.270422422516, 11598.420078996185, 16056.839431605767, 16138.35446582147, 16199.352025918832, 16222.83777162237, 16232.918835405748, 7844.4901081429525, 8025.839483210303, 8034.517928924283, 8067.959660201662, 8103.959480202561, 7461.888071678821, 8096.0, 8121.187881211831, 8265.421420500506, 8279.710210142737, 4542.250528662799, 4700.95299047012, 4942.876428089255, 4966.6771659842, 4974.552290293891, 1925.7015162649811, 1988.5426351939136, 2045.9386218413472, 2067.080149333562, 2089.3105275259127, 890.528020149322, 1030.902064303905, 1035.404642330663, 1043.7025447747355, 1105.1545567640762, 20172.29396971128, 20454.97725113768, 20524.38426847197, 20534.0, 20821.895890520755, 1003.82934901067, 1025.9538320775582, 1026.199564339816, 1055.6516349604613, 1073.822819234833, 11108.777824443467, 11527.30836149817, 11544.88455115455, 11579.826302605468, 11588.304701717923, 485850.5612079037, 488289.0, 491903.0, 497201.0, 497291.0, 59398.40601593929, 60562.09156862651, 92915.53542232246, 96133.0, 96192.51903740436, 898.9190972812478, 899.9595018224064, 924.2421214604094, 925.7870689741262, 1054.4727636181756, 18233.361832335806, 18433.90783046076, 18446.631067378847, 18530.44408667742, 18951.810481895005, 43667.78166109149, 44458.0, 44842.327365090205, 45187.77406112949, 45468.772656136505, 61944.380556193864, 62542.0, 62569.68715156395, 62814.68592657008, 62867.68566157323, 8870.112988701077, 8995.595198215966, 9031.909680903107, 9105.954470227607, 9160.954195228982, 8659.787659578782, 12580.308083055153, 13305.201687898758, 14616.269186540843, 14713.822894168656, 12382.380880956096, 12404.0, 12735.363231838186, 12763.936180319039, 12984.545540906023, 11991.942882214553, 12185.939070304592, 12340.568080117153, 12500.374981251083, 12629.431675574437, 12518.248905065726, 12558.811617825557, 12788.168769029984, 12794.104412691022, 12925.28910909909, 7975.641096150571, 8253.628586713492, 9046.773830654023, 9150.450972941644, 9223.492707900861, 11541.480633371351, 11791.823122652995, 11984.221025633306, 12524.624261272176, 12793.104482686123], "value": 9531.497514966679, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.8268607767066, 1495.8354580996088, 1605.2696023309395, 1725.8446739793417, 1777.200259883053, 7938.483998540105, 8962.283017358612, 9023.323250756186, 9605.991370906051, 9616.711498655033, 9015.14356136166, 9339.533023348838, 9396.0, 9422.905770942289, 9441.952790236057, 2346.073301046086, 2356.2460012795914, 2371.9407014824596, 2372.086746602562, 2373.4778348763243, 2053.4763635273057, 2115.904784284703, 2118.0892216346965, 2330.906763729449, 2374.726906405768, 2420.4553975355493, 2441.279822452381, 2441.853488790678, 2442.658027876099, 2445.8043356531525, 2315.2591170825344, 2320.025589252518, 2328.8136949044037, 2352.1297120065683, 2399.472116134448, 2320.918767843117, 2329.196427232602, 2333.288347054148, 2334.0, 2335.100986120339, 9377.484238366887, 9427.575759090858, 9447.433154010781, 9450.385724927857, 9463.148316651534, 5523.28197334348, 5608.46719561641, 5673.801416950429, 5704.2299289595785, 5717.342505611867, 3461.6019157796923, 3483.9477407838904, 3528.894133176009, 3532.2935412917263, 3569.5364900390714, 1162.9360385178811, 1169.5263418315596, 1193.922395044328, 1214.5688280660415, 1220.8046712525954, 13637.454501819915, 13666.52167174144, 13695.383707733175, 13698.178109313472, 13712.65718357039, 4919.827806026843, 4924.704517728947, 5032.119379108642, 5085.516875896784, 5158.3552055993005, 11142.49858756358, 11164.776704465865, 11177.944110279397, 11224.102071834397, 11227.382493962747, 5609.214709940612, 5612.074007788669, 5616.634918730351, 5625.493705566519, 5632.605717599728, 5071.7971281149075, 5126.436092029874, 5139.563137133386, 5174.327337446108, 5177.948220517822, 3669.486271921933, 4051.47330846988, 4221.810018549173, 4279.122779830127, 4280.850170244026, 1361.4894414594528, 1381.2127087559995, 1385.5427708856053, 1389.958301250964, 1405.6556143744847, 881.0836729800935, 941.0589410589411, 944.7401964459829, 962.1725316228038, 997.1175509673991, 5708.514776243983, 5868.647881127146, 5984.880302393928, 6031.457168854824, 6160.10678451622, 932.5290728182224, 968.9903100969041, 971.4754032822196, 982.5283863745442, 1016.8017236638784, 4063.4717486726536, 4081.673466122703, 4086.8773936781945, 4176.4570605821045, 4204.600562946515, 11698.47356868943, 12058.457369418396, 12080.637580872588, 12154.75690486203, 12172.756544869053, 11917.523299068114, 12016.63950081499, 12035.157538972187, 12040.337781421931, 12049.457774400173, 8371.58142092893, 8686.478811271343, 8699.391042627081, 8774.473531588124, 8871.0, 6051.939480605138, 6061.424164704346, 6077.574569780073, 6140.969295153495, 6273.597155356723, 10281.2803103785, 10728.839067413839, 10826.729331766453, 10831.945840270748, 10841.512131953923, 10533.9473302633, 10848.511816968097, 10859.239853210516, 10920.945395272973, 10937.562497500328, 8157.510549367057, 8492.57537123129, 8565.61454734526, 8634.654613815377, 8644.049154593116, 8028.43800933929, 8884.466931984101, 9187.127222913812, 9190.58642361082, 9363.953180234328, 8222.136675648972, 8276.29651479631, 8282.668693252203, 8288.792780180544, 8381.58092095405, 8219.83560328802, 8262.256396924306, 8262.462939908886, 8309.335253179852, 8409.20112589303, 7433.033705618235, 7472.402207823252, 7477.850442991001, 7491.8501629966, 7499.512531685423, 5159.716215608028, 5242.344706911636, 5326.760295786777, 5360.088784906653, 5385.4076051635075, 5321.521063104185, 5424.105022671215, 5457.154141108134, 5571.498565129158, 5600.691961942132], "value": 4878.735494434728, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.0618782877515, 339.843671910921, 342.73780557873215, 345.54215664244884, 347.5603361747389, 5292.3913749918775, 5367.973160134194, 5370.489803468669, 5376.8118115865955, 5385.380681221661, 5272.947270527303, 5274.81538146165, 5345.33183352081, 5353.812616558421, 5354.0, 3958.8020598970006, 3996.42051902474, 4121.113960498492, 4128.463299771026, 4131.710780245384, 4078.449409329747, 4108.116754897696, 4112.6298633123015, 4142.9378559321485, 4148.875533733993, 3971.4439978403047, 4087.4073259377374, 4094.263032654121, 4117.711760176789, 4131.97934010331, 4046.2918989176924, 4116.876493705194, 4154.293770059097, 4175.582441755831, 4192.0, 3710.684591809699, 3717.4052151655605, 3722.683571896392, 3724.404095344732, 3746.606606306326, 5205.817796377147, 5211.472435868601, 5222.791088356461, 5225.686458812445, 5239.580833533309, 4497.123061003105, 4761.6905351028745, 4764.190087685067, 4792.993471371016, 4793.49668284832, 5552.222688823568, 5557.3886872444, 5570.610057295991, 5575.832725018256, 5579.944200557983, 4001.13975495267, 4011.65900898424, 4013.8394464221396, 4019.8995025124314, 4049.696272779524, 5485.341758988947, 5681.715914204315, 5682.7442765075675, 5682.914756278659, 5693.459121383462, 4010.21800748857, 4018.2566225248424, 4020.733468957269, 4029.8589549365634, 4030.5969403059457, 4067.877963661095, 4075.225707115698, 4083.816228269735, 4094.385842123705, 4098.979505102515, 4539.251023581138, 4632.420947381577, 4667.996380778149, 4671.719696818202, 4697.459792123881, 5466.617336786387, 5472.398036216013, 5510.228568000483, 5523.337199536081, 5526.530244929226, 1411.1180512179888, 1415.6673181802269, 1425.6222101143205, 1427.3719563392074, 1429.6497358147321, 888.822235552892, 908.1281969309537, 920.9033051529627, 925.1257561604353, 934.5187228577288, 5225.425203227642, 5228.477152284817, 5244.842654720364, 5247.501487358695, 5249.370075590878, 5475.7262136893, 5501.174823776466, 5503.147012213113, 5509.3664228613425, 5513.09034009392, 5109.412417571953, 5189.948100519022, 5215.295935048795, 5246.580273578104, 5389.299391079213, 2966.9406611867644, 2970.613820203403, 2977.7766667500023, 2989.9850500747793, 2997.5803387525766, 5693.971530142323, 5751.763370875282, 5755.280589926259, 5805.941940580625, 5818.592698511148, 5575.358833734092, 5707.971460142673, 5710.7430165642645, 5730.971345143247, 5748.683822389725, 5749.9425005750245, 5758.769649213985, 5792.391798861143, 5801.9419805802245, 5806.709664516842, 5410.729463526729, 5619.353774316006, 5645.520130788929, 5646.322441307069, 5649.192258477247, 5591.860203494945, 5602.13166959122, 5602.691851948182, 5618.269624948731, 5618.915716264178, 5815.9709201453725, 5828.542864283929, 5852.151438041375, 5855.151003104611, 5879.617824841372, 3862.8990737639638, 4005.2790497710694, 4008.719389642697, 4017.337139371971, 4121.340585506305, 5396.379416367168, 5584.385717570983, 5610.803621873215, 5645.463680950304, 5656.0, 5484.012877681896, 5526.972365138148, 5547.694876781816, 5548.306461692288, 5593.720313984366, 5494.642848214853, 5498.752556135064, 5534.667919924817, 5536.446355364593, 5552.0, 5259.237410575522, 5451.454854514517, 5459.836204913859, 5467.824417750203, 5494.9725251375085, 5499.50504454585, 5518.0, 5546.140348246028, 5559.694216818114, 5574.9442505574425, 5275.393329766973, 5477.863053423696, 5477.972610136924, 5485.286912701324, 5488.067028605067], "value": 4213.36075044461, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.0674916478149, 780.1223623423648, 809.4617079642038, 840.2605706977859, 876.0976194519645, 15985.440509582168, 16545.172741362912, 16566.088865112415, 16585.41951031714, 16698.415555455562, 12172.939135304334, 15023.474178403758, 15159.696806063872, 15181.544553663407, 15217.315220815062, 783.5220515485549, 806.9596520173997, 808.5027707959592, 818.9672413103468, 822.4201937633984, 804.5896592737716, 808.0989696488402, 811.0227176252602, 811.1482942909951, 812.2851890336525, 678.7183318922641, 845.4166625028741, 856.387682806793, 857.2584714222215, 857.5926434943415, 795.9960200198991, 799.5402643479964, 799.6521513141773, 800.1118758178417, 838.0, 583.1922786940077, 586.2847326261996, 586.7799575159315, 586.9618474799124, 590.8375196820866, 14201.78697319541, 14210.857891421058, 14231.0, 14243.643908902257, 14245.786313205206, 14424.495142669955, 14804.333804978694, 14853.777193342108, 14869.776953345709, 14895.553133405907, 13704.931475342559, 13818.101823381548, 13833.515826946008, 13987.090839095528, 13995.020348575605, 4512.34570987205, 4512.4133862597655, 4561.6806823522365, 4590.954090459086, 4594.127115848011, 80766.0, 81426.0, 81649.18350816476, 81764.0, 82368.58815705944, 11752.001079908303, 11886.64340069782, 11892.702682433008, 12034.63896083119, 12097.334646594521, 21833.781662183173, 22090.0, 22099.889500552395, 22193.22323718662, 22243.44391390196, 8680.30557555394, 8702.869456958151, 8836.64653413869, 8842.425242359355, 8915.0, 4793.760311984387, 4823.27650852368, 4830.2996065571, 4877.878053048631, 4917.164082106051, 3422.349753546818, 3436.621971583124, 3526.153723106436, 3529.382358087376, 3529.541159649229, 542.8914217156585, 579.7738881836087, 614.9600275982046, 646.4828137489989, 646.8298857333579, 606.8968275393194, 702.1363722621103, 716.358858821352, 717.3472140352254, 786.2530595933771, 10509.264351495322, 10579.259451838298, 10622.946885265525, 10771.138308935266, 11053.392063436588, 652.2499126005038, 684.5310961991051, 720.2725247499958, 751.4326683354033, 791.386675326615, 5076.873078173001, 5147.6911385317, 5193.195054766517, 5212.400573934046, 5212.50481204285, 73563.0, 94579.52710236405, 129059.0, 130669.0, 131670.0, 113551.0, 114830.0, 115186.42406787912, 118502.0, 118735.40632296783, 95358.5232073849, 99172.50413747886, 100946.0, 101770.49114754378, 102913.0, 9875.506224688594, 9937.950310248403, 10016.799664006825, 10055.346402483816, 10148.0, 55674.16488752591, 56457.94275715535, 56936.86126277369, 58237.0, 58293.4170658288, 75579.62210188914, 80858.0, 86212.56893715743, 88202.11797881938, 88615.0, 13186.802197966847, 13371.130876492996, 13483.0, 13507.324633768469, 13536.72926541444, 14039.719205615625, 14461.276936153361, 14590.270486475421, 14772.48296309624, 14796.0, 13780.0, 14019.299035048003, 14184.0, 14754.63113422173, 14784.112953222411, 13871.72256554843, 14306.141631502143, 14658.267086645837, 14704.55886323412, 14719.0, 13585.52450664222, 13912.652183695489, 14602.707945841235, 14613.342399592257, 14650.0, 10551.208659350734, 10663.146948243966, 10712.89287107119, 10717.678469645924, 11048.0, 11491.770164596828, 11768.764624707286, 11874.0, 11985.574671993048, 12063.457144428347], "value": 7850.626879002509, "unit": "score"}], "name": "dromaeo_css", "value": 7407.241669880439, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 111.0, 110.0, 112.0, 111.0, 110.0, 111.0, 110.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 123.0, 170.0, 123.0, 122.0, 146.0, 121.0, 154.0, 122.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 161.0, 159.0, 161.0, 164.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 119.0, 78.0, 87.0, 76.0, 76.0, 101.0, 76.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 113.0, 84.0, 84.0, 84.0, 116.0, 85.0, 85.0, 125.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 149.0, 146.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 52.0, 53.0, 53.0, 52.0, 53.0, 52.0, 55.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 75.0, 74.0, 83.0, 74.0, 75.0, 74.0, 80.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 127.0, 119.0, 130.0, 121.0, 127.0, 118.0, 154.0, 128.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 156.0, 157.0, 153.0, 158.0, 154.0, 155.0, 154.0, 158.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 67.0, 63.0, 62.0, 64.0, 62.0, 62.0, 62.0, 65.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1477.6999999999998, "alertThreshold": 2.0}]} 09:08:23 INFO - Return code: 0 09:08:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:08:23 INFO - # TBPL SUCCESS # 09:08:23 INFO - Running post-action listener: _resource_record_post_action 09:08:23 INFO - ##### 09:08:23 INFO - ##### Finished run-tests step (success) 09:08:23 INFO - ##### 09:08:23 INFO - Running post-run listener: _resource_record_post_run 09:08:24 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 560136192; Read time: 0; Write time: 428408 09:08:24 INFO - TinderboxPrint: CPU usage
12.9% 09:08:24 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:08:24 INFO - TinderboxPrint: I/O write bytes / time
560,136,192 / 428,408 09:08:24 INFO - TinderboxPrint: CPU idle
8,268.7 (87.1%) 09:08:24 INFO - TinderboxPrint: CPU user
1,189.0 (12.5%) 09:08:24 INFO - TinderboxPrint: Swap in / out
0 / 0 09:08:24 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 260558848; Read time: 0; Write time: 254604 09:08:24 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 299577344; Read time: 0; Write time: 173804 09:08:24 INFO - Running post-run listener: _upload_blobber_files 09:08:24 INFO - Blob upload gear active. 09:08:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:08:24 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 09:08:24 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'] 09:08:24 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 09:08:24 INFO - (blobuploader) - INFO - Open directory for files ... 09:08:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:08:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:08:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:25 INFO - (blobuploader) - INFO - Done attempting. 09:08:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:08:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:08:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:29 INFO - (blobuploader) - INFO - Done attempting. 09:08:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:08:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:08:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:30 INFO - (blobuploader) - INFO - Done attempting. 09:08:30 INFO - (blobuploader) - INFO - Iteration through files over. 09:08:30 INFO - Return code: 0 09:08:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:08:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:08:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1471e21888a25cb5bdd81102d71314ef8313b0186a1e0a165edf690979ddae76dcf1160d0c6cd34bf9c38b8a68e770d7ba549d1b2a81a967e579871bbad0d690", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aba0ba0875c3eccca4031895db1803c97b7abecfafe91703b99bf830619f65f6b2470528db4fc0daa3bd46be1a2adda032639ddace4c1836bb906e5ccb32d928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f9168939b4c94316469c31dd40d75b06f54f2f36639678dbfe97fe0c362002ffe0b37a04c61d80311c75104710a49c3007629d040e3b1c1cf5a11b2b510869"} 09:08:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:08:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:08:30 INFO - Contents: 09:08:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1471e21888a25cb5bdd81102d71314ef8313b0186a1e0a165edf690979ddae76dcf1160d0c6cd34bf9c38b8a68e770d7ba549d1b2a81a967e579871bbad0d690", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aba0ba0875c3eccca4031895db1803c97b7abecfafe91703b99bf830619f65f6b2470528db4fc0daa3bd46be1a2adda032639ddace4c1836bb906e5ccb32d928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f9168939b4c94316469c31dd40d75b06f54f2f36639678dbfe97fe0c362002ffe0b37a04c61d80311c75104710a49c3007629d040e3b1c1cf5a11b2b510869"} 09:08:30 INFO - Running post-run listener: copy_logs_to_upload_dir 09:08:30 INFO - Copying logs to upload dir... 09:08:30 INFO - mkdir: /builds/slave/test/build/upload/logs 09:08:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.565568 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-05 09:08:29.867441) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 09:08:29.871495) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1471e21888a25cb5bdd81102d71314ef8313b0186a1e0a165edf690979ddae76dcf1160d0c6cd34bf9c38b8a68e770d7ba549d1b2a81a967e579871bbad0d690", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aba0ba0875c3eccca4031895db1803c97b7abecfafe91703b99bf830619f65f6b2470528db4fc0daa3bd46be1a2adda032639ddace4c1836bb906e5ccb32d928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f9168939b4c94316469c31dd40d75b06f54f2f36639678dbfe97fe0c362002ffe0b37a04c61d80311c75104710a49c3007629d040e3b1c1cf5a11b2b510869"} build_url:https://queue.taskcluster.net/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011466 build_url: 'https://queue.taskcluster.net/v1/task/RH2klQWZSFegk10zPuLSWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1471e21888a25cb5bdd81102d71314ef8313b0186a1e0a165edf690979ddae76dcf1160d0c6cd34bf9c38b8a68e770d7ba549d1b2a81a967e579871bbad0d690", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aba0ba0875c3eccca4031895db1803c97b7abecfafe91703b99bf830619f65f6b2470528db4fc0daa3bd46be1a2adda032639ddace4c1836bb906e5ccb32d928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f9168939b4c94316469c31dd40d75b06f54f2f36639678dbfe97fe0c362002ffe0b37a04c61d80311c75104710a49c3007629d040e3b1c1cf5a11b2b510869"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 09:08:29.897197) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:08:29.897519) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467733680.486777-1149484085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:08:29.980738) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 09:08:29.981038) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 09:08:29.981302) ========= ========= Total master_lag: 0.17 =========