builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1467752840.29 results: success (0) buildid: 20160705113033 builduid: a120524ced3c4b15b08c7932a58c8c61 revision: 3db27bf874fa9e5057b7bcb96f325699bb7f1688 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 14:07:20.285936) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 14:07:20.287037) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 14:07:20.287738) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 14:07:20.304664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:07:20.305333) ========= 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=33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 14:07:20-- 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% 226M=0s 2016-07-05 14:07:20 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125931 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:07:20.447237) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:07:20.447593) ========= 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=33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014922 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:07:20.499859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:07:20.500691) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3db27bf874fa9e5057b7bcb96f325699bb7f1688 --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 3db27bf874fa9e5057b7bcb96f325699bb7f1688 --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=33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 14:07:20,574 truncating revision to first 12 chars 2016-07-05 14:07:20,574 Setting DEBUG logging. 2016-07-05 14:07:20,574 attempt 1/10 2016-07-05 14:07:20,575 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3db27bf874fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 14:07:21,210 unpacking tar archive at: fx-team-3db27bf874fa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.940955 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:07:21.456837) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 14:07:21.457235) ========= script_repo_revision: 3db27bf874fa9e5057b7bcb96f325699bb7f1688 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 14:07:21.457748) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 14:07:21.458075) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 14:07:21.467823) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-05 14:07:21.468146) ========= /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=33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:07:21 INFO - MultiFileLogger online at 20160705 14:07:21 in /builds/slave/test 14:07:21 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 14:07:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:07:21 INFO - {'append_to_log': False, 14:07:21 INFO - 'base_work_dir': '/builds/slave/test', 14:07:21 INFO - 'blob_upload_branch': 'Fx-Team', 14:07:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:07:21 INFO - 'branch': 'Fx-Team', 14:07:21 INFO - 'buildbot_json_path': 'buildprops.json', 14:07:21 INFO - 'config_files': ('talos/linux_config.py',), 14:07:21 INFO - 'default_actions': ('clobber', 14:07:21 INFO - 'read-buildbot-config', 14:07:21 INFO - 'download-and-extract', 14:07:21 INFO - 'populate-webroot', 14:07:21 INFO - 'create-virtualenv', 14:07:21 INFO - 'install', 14:07:21 INFO - 'run-tests'), 14:07:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:07:21 INFO - 'download_minidump_stackwalk': True, 14:07:21 INFO - 'download_symbols': 'ondemand', 14:07:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:07:21 INFO - 'tooltool.py': '/tools/tooltool.py', 14:07:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:07:21 INFO - '/tools/misc-python/virtualenv.py')}, 14:07:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:07:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:07:21 INFO - 'installer_path': 'installer.exe', 14:07:21 INFO - 'log_level': 'info', 14:07:21 INFO - 'log_name': 'talos', 14:07:21 INFO - 'log_to_console': True, 14:07:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:07:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:07:21 INFO - 'opt_config_files': (), 14:07:21 INFO - 'pip_index': False, 14:07:21 INFO - 'sps_profile': False, 14:07:21 INFO - 'sps_profile_interval': 0, 14:07:21 INFO - 'suite': 'dromaeojs', 14:07:21 INFO - 'system_bits': '32', 14:07:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:07:21 INFO - 'title': 'talos-linux64-ix-063', 14:07:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:07:21 INFO - 'use_talos_json': True, 14:07:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:07:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:07:21 INFO - 'work_dir': 'build'} 14:07:21 INFO - ##### 14:07:21 INFO - ##### Running clobber step. 14:07:21 INFO - ##### 14:07:21 INFO - Running pre-action listener: _resource_record_pre_action 14:07:21 INFO - Running main action method: clobber 14:07:21 INFO - rmtree: /builds/slave/test/build 14:07:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:07:22 INFO - Running post-action listener: _resource_record_post_action 14:07:22 INFO - ##### 14:07:22 INFO - ##### Finished clobber step (success) 14:07:22 INFO - ##### 14:07:22 INFO - ##### 14:07:22 INFO - ##### Running read-buildbot-config step. 14:07:22 INFO - ##### 14:07:22 INFO - Running pre-action listener: _resource_record_pre_action 14:07:22 INFO - Running main action method: read_buildbot_config 14:07:22 INFO - Using buildbot properties: 14:07:22 INFO - { 14:07:22 INFO - "project": "", 14:07:22 INFO - "product": "firefox", 14:07:22 INFO - "script_repo_revision": "production", 14:07:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:07:22 INFO - "repository": "", 14:07:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:07:22 INFO - "buildid": "20160705113033", 14:07:22 INFO - "pgo_build": "True", 14:07:22 INFO - "basedir": "/builds/slave/test", 14:07:22 INFO - "buildnumber": 860, 14:07:22 INFO - "slavename": "talos-linux64-ix-063", 14:07:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:07:22 INFO - "platform": "ubuntu64_hw", 14:07:22 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:07:22 INFO - "branch": "fx-team", 14:07:22 INFO - "repo_path": "integration/fx-team", 14:07:22 INFO - "revision": "3db27bf874fa9e5057b7bcb96f325699bb7f1688", 14:07:22 INFO - "stage_platform": "linux64-pgo", 14:07:22 INFO - "builduid": "a120524ced3c4b15b08c7932a58c8c61", 14:07:22 INFO - "slavebuilddir": "test" 14:07:22 INFO - } 14:07:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:07:22 INFO - Running post-action listener: _resource_record_post_action 14:07:22 INFO - ##### 14:07:22 INFO - ##### Finished read-buildbot-config step (success) 14:07:22 INFO - ##### 14:07:22 INFO - ##### 14:07:22 INFO - ##### Running download-and-extract step. 14:07:22 INFO - ##### 14:07:22 INFO - Running pre-action listener: _resource_record_pre_action 14:07:22 INFO - Running main action method: download_and_extract 14:07:22 INFO - mkdir: /builds/slave/test/build/tests 14:07: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')]} 14:07:22 INFO - https://queue.taskcluster.net/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:07:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:07:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:07:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:07:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:07:23 INFO - Downloaded 1361 bytes. 14:07:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:07:23 INFO - Using the following test package requirements: 14:07:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:07:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:07:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:07:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'jsshell-linux-x86_64.zip'], 14:07:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:07:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:07:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:07:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:07:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:07:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:07:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:23 INFO - https://queue.taskcluster.net/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:07:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:07:25 INFO - Downloaded 24299962 bytes. 14:07:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:07:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:07:26 INFO - Return code: 0 14:07:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:26 INFO - https://queue.taskcluster.net/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:07:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:07:27 INFO - Downloaded 24299962 bytes. 14:07:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:07:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:07:28 INFO - Return code: 0 14:07: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')]} 14:07:28 INFO - https://queue.taskcluster.net/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:07:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:07:29 INFO - Downloaded 14403333 bytes. 14:07:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:07:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:07:30 INFO - Return code: 0 14:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:30 INFO - https://queue.taskcluster.net/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:07:32 INFO - Downloaded 60381758 bytes. 14:07:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:32 INFO - mkdir: /builds/slave/test/properties 14:07:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:07:32 INFO - Writing to file /builds/slave/test/properties/build_url 14:07:32 INFO - Contents: 14:07:32 INFO - build_url:https://queue.taskcluster.net/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:33 INFO - Running post-action listener: _resource_record_post_action 14:07:33 INFO - Running post-action listener: set_extra_try_arguments 14:07:33 INFO - ##### 14:07:33 INFO - ##### Finished download-and-extract step (success) 14:07:33 INFO - ##### 14:07:33 INFO - ##### 14:07:33 INFO - ##### Running populate-webroot step. 14:07:33 INFO - ##### 14:07:33 INFO - Running pre-action listener: _resource_record_pre_action 14:07:33 INFO - Running main action method: populate_webroot 14:07:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:07:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:07:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:07:33 INFO - '--tppagecycles', 14:07:33 INFO - '7'], 14:07:33 INFO - 'tests': ['tsvgm']}}, 14:07:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:07:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:07:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:07:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:07:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:07:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:07:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:33 INFO - 'talos_options': ['--disable-e10s'], 14:07:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:33 INFO - 'talos_options': ['--disable-e10s'], 14:07:33 INFO - 'tests': ['damp', 'tps']}, 14:07:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:33 INFO - 'tests': ['damp', 'tps']}, 14:07:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:07:33 INFO - 'tests': ['dromaeo_dom']}, 14:07:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:07:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:07:33 INFO - 'tests': ['basic_compositor_video']}, 14:07:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:07:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:07:33 INFO - 'tests': ['a11yr', 14:07:33 INFO - 'ts_paint', 14:07:33 INFO - 'tpaint', 14:07:33 INFO - 'sessionrestore', 14:07:33 INFO - 'sessionrestore_no_auto_restore', 14:07:33 INFO - 'tabpaint']}, 14:07:33 INFO - 'other-e10s': {'tests': ['a11yr', 14:07:33 INFO - 'ts_paint', 14:07:33 INFO - 'tpaint', 14:07:33 INFO - 'sessionrestore', 14:07:33 INFO - 'sessionrestore_no_auto_restore', 14:07:33 INFO - 'tabpaint']}, 14:07:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:07:33 INFO - 'ts_paint', 14:07:33 INFO - 'tpaint', 14:07:33 INFO - 'sessionrestore', 14:07:33 INFO - 'sessionrestore_no_auto_restore', 14:07:33 INFO - 'tabpaint']}, 14:07:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:07:33 INFO - 'ts_paint', 14:07:33 INFO - 'tpaint', 14:07:33 INFO - 'sessionrestore', 14:07:33 INFO - 'sessionrestore_no_auto_restore', 14:07:33 INFO - 'tabpaint']}, 14:07:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:07:33 INFO - 'tests': ['a11yr', 14:07:33 INFO - 'ts_paint', 14:07:33 INFO - 'tpaint', 14:07:33 INFO - 'sessionrestore', 14:07:33 INFO - 'sessionrestore_no_auto_restore', 14:07:33 INFO - 'tabpaint']}, 14:07:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:07:33 INFO - 'tests': ['a11yr', 14:07:33 INFO - 'ts_paint', 14:07:33 INFO - 'tpaint', 14:07:33 INFO - 'sessionrestore', 14:07:33 INFO - 'sessionrestore_no_auto_restore', 14:07:33 INFO - 'tabpaint']}, 14:07:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:07:33 INFO - 'tests': ['tsvgx', 14:07:33 INFO - 'tsvgr_opacity', 14:07:33 INFO - 'tart', 14:07:33 INFO - 'tscrollx', 14:07:33 INFO - 'cart']}, 14:07:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:07:33 INFO - 'tsvgr_opacity', 14:07:33 INFO - 'tart', 14:07:33 INFO - 'tscrollx', 14:07:33 INFO - 'cart']}, 14:07:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:33 INFO - 'talos_options': ['--disable-e10s'], 14:07:33 INFO - 'tests': ['tp5o']}, 14:07:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:33 INFO - 'tests': ['tp5o']}, 14:07:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:33 INFO - 'talos_options': ['--disable-e10s', 14:07:33 INFO - '--xperf_path', 14:07:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:33 INFO - 'tests': ['tp5n']}, 14:07:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:33 INFO - 'talos_options': ['--xperf_path', 14:07:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:33 INFO - 'tests': ['tp5n']}}, 14:07:33 INFO - 'talos.zip': {'path': '', 14:07:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:07:33 INFO - Running post-action listener: _resource_record_post_action 14:07:33 INFO - ##### 14:07:33 INFO - ##### Finished populate-webroot step (success) 14:07:33 INFO - ##### 14:07:33 INFO - ##### 14:07:33 INFO - ##### Running create-virtualenv step. 14:07:33 INFO - ##### 14:07:33 INFO - Running pre-action listener: _resource_record_pre_action 14:07:33 INFO - Running main action method: create_virtualenv 14:07:33 INFO - Creating virtualenv /builds/slave/test/build/venv 14:07:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:07:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:07:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:07:33 INFO - Using real prefix '/usr' 14:07:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:07:33 INFO - Installing distribute.............................................................................................................................................................................................done. 14:07:48 INFO - Installing pip.................done. 14:07:48 INFO - Return code: 0 14:07:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:48 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 0x1c40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f01180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff3b0>, '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 0x1f002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f00740>, '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': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:07:48 INFO - Using env: {'DISPLAY': ':0', 14:07:48 INFO - 'HOME': '/home/cltbld', 14:07:48 INFO - 'LANG': 'en_US.UTF-8', 14:07:48 INFO - 'LANGUAGE': 'en_US:en', 14:07:48 INFO - 'LOGNAME': 'cltbld', 14:07:48 INFO - 'MAIL': '/var/mail/cltbld', 14:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:48 INFO - 'MOZ_NO_REMOTE': '1', 14:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:48 INFO - 'NO_EM_RESTART': '1', 14:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:48 INFO - 'PWD': '/builds/slave/test', 14:07:48 INFO - 'SHELL': '/bin/bash', 14:07:48 INFO - 'SHLVL': '1', 14:07:48 INFO - 'TERM': 'linux', 14:07:48 INFO - 'TMOUT': '86400', 14:07:48 INFO - 'USER': 'cltbld', 14:07:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 14:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:48 INFO - '_': '/tools/buildbot/bin/python'} 14:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:07:48 INFO - Cleaning up... 14:07:48 INFO - Return code: 0 14:07:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:48 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 0x1c40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f01180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff3b0>, '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 0x1f002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f00740>, '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': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:07:48 INFO - Using env: {'DISPLAY': ':0', 14:07:48 INFO - 'HOME': '/home/cltbld', 14:07:48 INFO - 'LANG': 'en_US.UTF-8', 14:07:48 INFO - 'LANGUAGE': 'en_US:en', 14:07:48 INFO - 'LOGNAME': 'cltbld', 14:07:48 INFO - 'MAIL': '/var/mail/cltbld', 14:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:48 INFO - 'MOZ_NO_REMOTE': '1', 14:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:48 INFO - 'NO_EM_RESTART': '1', 14:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:48 INFO - 'PWD': '/builds/slave/test', 14:07:48 INFO - 'SHELL': '/bin/bash', 14:07:48 INFO - 'SHLVL': '1', 14:07:48 INFO - 'TERM': 'linux', 14:07:48 INFO - 'TMOUT': '86400', 14:07:48 INFO - 'USER': 'cltbld', 14:07:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 14:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:48 INFO - '_': '/tools/buildbot/bin/python'} 14:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:48 INFO - Downloading/unpacking psutil>=3.1.1 14:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:07:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:50 INFO - Installing collected packages: psutil 14:07:50 INFO - Running setup.py install for psutil 14:07:50 INFO - building 'psutil._psutil_linux' extension 14:07:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:07:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:07:50 INFO - building 'psutil._psutil_posix' extension 14:07:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:07:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:07:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:51 INFO - Successfully installed psutil 14:07:51 INFO - Cleaning up... 14:07:51 INFO - Return code: 0 14:07:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:51 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 0x1c40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f01180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff3b0>, '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 0x1f002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f00740>, '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': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:07:51 INFO - Using env: {'DISPLAY': ':0', 14:07:51 INFO - 'HOME': '/home/cltbld', 14:07:51 INFO - 'LANG': 'en_US.UTF-8', 14:07:51 INFO - 'LANGUAGE': 'en_US:en', 14:07:51 INFO - 'LOGNAME': 'cltbld', 14:07:51 INFO - 'MAIL': '/var/mail/cltbld', 14:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:51 INFO - 'MOZ_NO_REMOTE': '1', 14:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:51 INFO - 'NO_EM_RESTART': '1', 14:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:51 INFO - 'PWD': '/builds/slave/test', 14:07:51 INFO - 'SHELL': '/bin/bash', 14:07:51 INFO - 'SHLVL': '1', 14:07:51 INFO - 'TERM': 'linux', 14:07:51 INFO - 'TMOUT': '86400', 14:07:51 INFO - 'USER': 'cltbld', 14:07:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 14:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:51 INFO - '_': '/tools/buildbot/bin/python'} 14:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:07:53 INFO - Installing collected packages: mozsystemmonitor 14:07:53 INFO - Running setup.py install for mozsystemmonitor 14:07:53 INFO - Successfully installed mozsystemmonitor 14:07:53 INFO - Cleaning up... 14:07:53 INFO - Return code: 0 14:07:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:53 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 0x1c40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f01180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff3b0>, '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 0x1f002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f00740>, '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': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:07:53 INFO - Using env: {'DISPLAY': ':0', 14:07:53 INFO - 'HOME': '/home/cltbld', 14:07:53 INFO - 'LANG': 'en_US.UTF-8', 14:07:53 INFO - 'LANGUAGE': 'en_US:en', 14:07:53 INFO - 'LOGNAME': 'cltbld', 14:07:53 INFO - 'MAIL': '/var/mail/cltbld', 14:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:53 INFO - 'MOZ_NO_REMOTE': '1', 14:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:53 INFO - 'NO_EM_RESTART': '1', 14:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:53 INFO - 'PWD': '/builds/slave/test', 14:07:53 INFO - 'SHELL': '/bin/bash', 14:07:53 INFO - 'SHLVL': '1', 14:07:53 INFO - 'TERM': 'linux', 14:07:53 INFO - 'TMOUT': '86400', 14:07:53 INFO - 'USER': 'cltbld', 14:07:53 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 14:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:53 INFO - '_': '/tools/buildbot/bin/python'} 14:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:53 INFO - Downloading/unpacking jsonschema==2.5.1 14:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:07:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:55 INFO - Downloading functools32-3.2.3-2.tar.gz 14:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:07:55 INFO - warning: no files found matching '*.txt' 14:07:55 INFO - no previously-included directories found matching 'build' 14:07:55 INFO - no previously-included directories found matching 'dist' 14:07:55 INFO - no previously-included directories found matching '.git*' 14:07:55 INFO - Installing collected packages: jsonschema, functools32 14:07:56 INFO - Running setup.py install for functools32 14:07:56 INFO - warning: no files found matching '*.txt' 14:07:56 INFO - no previously-included directories found matching 'build' 14:07:56 INFO - no previously-included directories found matching 'dist' 14:07:56 INFO - no previously-included directories found matching '.git*' 14:07:56 INFO - Successfully installed jsonschema functools32 14:07:56 INFO - Cleaning up... 14:07:56 INFO - Return code: 0 14:07:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f01180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff3b0>, '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 0x1f002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f00740>, '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': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:07:56 INFO - Using env: {'DISPLAY': ':0', 14:07:56 INFO - 'HOME': '/home/cltbld', 14:07:56 INFO - 'LANG': 'en_US.UTF-8', 14:07:56 INFO - 'LANGUAGE': 'en_US:en', 14:07:56 INFO - 'LOGNAME': 'cltbld', 14:07:56 INFO - 'MAIL': '/var/mail/cltbld', 14:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:56 INFO - 'MOZ_NO_REMOTE': '1', 14:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:56 INFO - 'NO_EM_RESTART': '1', 14:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:56 INFO - 'PWD': '/builds/slave/test', 14:07:56 INFO - 'SHELL': '/bin/bash', 14:07:56 INFO - 'SHLVL': '1', 14:07:56 INFO - 'TERM': 'linux', 14:07:56 INFO - 'TMOUT': '86400', 14:07:56 INFO - 'USER': 'cltbld', 14:07:56 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 14:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:56 INFO - '_': '/tools/buildbot/bin/python'} 14:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:56 INFO - Downloading/unpacking blobuploader==1.2.4 14:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:58 INFO - Downloading blobuploader-1.2.4.tar.gz 14:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:07:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:07:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:58 INFO - Downloading docopt-0.6.1.tar.gz 14:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:07:59 INFO - Installing collected packages: blobuploader, requests, docopt 14:07:59 INFO - Running setup.py install for blobuploader 14:07:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:07:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:07:59 INFO - Running setup.py install for requests 14:07:59 INFO - Running setup.py install for docopt 14:07:59 INFO - Successfully installed blobuploader requests docopt 14:07:59 INFO - Cleaning up... 14:07:59 INFO - Return code: 0 14:07:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:59 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 0x1c40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f01180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff3b0>, '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 0x1f002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f00740>, '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': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:59 INFO - Using env: {'DISPLAY': ':0', 14:07:59 INFO - 'HOME': '/home/cltbld', 14:07:59 INFO - 'LANG': 'en_US.UTF-8', 14:07:59 INFO - 'LANGUAGE': 'en_US:en', 14:07:59 INFO - 'LOGNAME': 'cltbld', 14:07:59 INFO - 'MAIL': '/var/mail/cltbld', 14:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:59 INFO - 'MOZ_NO_REMOTE': '1', 14:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:59 INFO - 'NO_EM_RESTART': '1', 14:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:59 INFO - 'PWD': '/builds/slave/test', 14:07:59 INFO - 'SHELL': '/bin/bash', 14:07:59 INFO - 'SHLVL': '1', 14:07:59 INFO - 'TERM': 'linux', 14:07:59 INFO - 'TMOUT': '86400', 14:07:59 INFO - 'USER': 'cltbld', 14:07:59 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 14:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:59 INFO - '_': '/tools/buildbot/bin/python'} 14:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:07:59 INFO - Running setup.py (path:/tmp/pip-_29FwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:07:59 INFO - Running setup.py (path:/tmp/pip-njIyMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:07:59 INFO - Running setup.py (path:/tmp/pip-wIsw2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:00 INFO - Running setup.py (path:/tmp/pip-BprjHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:00 INFO - Running setup.py (path:/tmp/pip-IETGAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:00 INFO - Running setup.py (path:/tmp/pip-9Ke9FK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:00 INFO - Running setup.py (path:/tmp/pip-Y1rQnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:00 INFO - Running setup.py (path:/tmp/pip-vxSN70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:00 INFO - Running setup.py (path:/tmp/pip-xfJBj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:00 INFO - Running setup.py (path:/tmp/pip-Lo9hPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:00 INFO - Running setup.py (path:/tmp/pip-0FSQ3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:00 INFO - Running setup.py (path:/tmp/pip-s65yh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:00 INFO - Running setup.py (path:/tmp/pip-BoTNJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:00 INFO - Running setup.py (path:/tmp/pip-ypWRuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:00 INFO - Running setup.py (path:/tmp/pip-8R5HiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:00 INFO - Running setup.py (path:/tmp/pip-OaHdse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:00 INFO - Running setup.py (path:/tmp/pip-HgoY2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:08:01 INFO - Running setup.py install for manifestparser 14:08:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:08:01 INFO - Running setup.py install for mozcrash 14:08:01 INFO - Running setup.py install for mozdebug 14:08:01 INFO - Running setup.py install for mozdevice 14:08:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:08:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:08:01 INFO - Running setup.py install for mozfile 14:08:01 INFO - Running setup.py install for mozhttpd 14:08:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:08:01 INFO - Running setup.py install for mozinfo 14:08:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:08:01 INFO - Running setup.py install for mozInstall 14:08:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:08:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:08:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:08:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:08:01 INFO - Running setup.py install for mozleak 14:08:01 INFO - Running setup.py install for mozlog 14:08:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Running setup.py install for moznetwork 14:08:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Running setup.py install for mozprocess 14:08:02 INFO - Running setup.py install for mozprofile 14:08:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Running setup.py install for mozrunner 14:08:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Running setup.py install for mozscreenshot 14:08:02 INFO - Running setup.py install for moztest 14:08:02 INFO - Running setup.py install for mozversion 14:08:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:08:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:08:02 INFO - Cleaning up... 14:08:02 INFO - Return code: 0 14:08:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08: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')]} 14:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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')]} 14:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:02 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 0x1c40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f01180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff3b0>, '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 0x1f002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f00740>, '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': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:08:02 INFO - Using env: {'DISPLAY': ':0', 14:08:02 INFO - 'HOME': '/home/cltbld', 14:08:02 INFO - 'LANG': 'en_US.UTF-8', 14:08:02 INFO - 'LANGUAGE': 'en_US:en', 14:08:02 INFO - 'LOGNAME': 'cltbld', 14:08:02 INFO - 'MAIL': '/var/mail/cltbld', 14:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:02 INFO - 'MOZ_NO_REMOTE': '1', 14:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:02 INFO - 'NO_EM_RESTART': '1', 14:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:02 INFO - 'PWD': '/builds/slave/test', 14:08:02 INFO - 'SHELL': '/bin/bash', 14:08:02 INFO - 'SHLVL': '1', 14:08:02 INFO - 'TERM': 'linux', 14:08:02 INFO - 'TMOUT': '86400', 14:08:02 INFO - 'USER': 'cltbld', 14:08:02 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 14:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:02 INFO - '_': '/tools/buildbot/bin/python'} 14:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:03 INFO - Running setup.py (path:/tmp/pip-V8cTvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:03 INFO - Running setup.py (path:/tmp/pip-dWhYvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:03 INFO - Running setup.py (path:/tmp/pip-rwBQvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:03 INFO - Running setup.py (path:/tmp/pip-TDZw52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:03 INFO - Running setup.py (path:/tmp/pip-FOj69A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:03 INFO - Running setup.py (path:/tmp/pip-42ikbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:03 INFO - Running setup.py (path:/tmp/pip-JSMD2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:03 INFO - Running setup.py (path:/tmp/pip-U9tLCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:03 INFO - Running setup.py (path:/tmp/pip-TJSeqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:03 INFO - Running setup.py (path:/tmp/pip-SNprwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:03 INFO - Running setup.py (path:/tmp/pip-2PWqaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:03 INFO - Running setup.py (path:/tmp/pip-NByGqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:04 INFO - Running setup.py (path:/tmp/pip-l0y1ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:04 INFO - Running setup.py (path:/tmp/pip-XJYvWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:04 INFO - Running setup.py (path:/tmp/pip-HKnWip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:04 INFO - Running setup.py (path:/tmp/pip-3TuG2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:04 INFO - Running setup.py (path:/tmp/pip-V_MCB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:08:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:06 INFO - Downloading blessings-1.6.tar.gz 14:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:08:06 INFO - Installing collected packages: blessings 14:08:06 INFO - Running setup.py install for blessings 14:08:06 INFO - Successfully installed blessings 14:08:06 INFO - Cleaning up... 14:08:07 INFO - Return code: 0 14:08:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:08:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:07 INFO - Reading from file tmpfile_stdout 14:08:07 INFO - Current package versions: 14:08:07 INFO - argparse == 1.2.1 14:08:07 INFO - blessings == 1.6 14:08:07 INFO - blobuploader == 1.2.4 14:08:07 INFO - docopt == 0.6.1 14:08:07 INFO - functools32 == 3.2.3-2 14:08:07 INFO - jsonschema == 2.5.1 14:08:07 INFO - manifestparser == 1.1 14:08:07 INFO - mozInstall == 1.12 14:08:07 INFO - mozcrash == 0.17 14:08:07 INFO - mozdebug == 0.1 14:08:07 INFO - mozdevice == 0.48 14:08:07 INFO - mozfile == 1.2 14:08:07 INFO - mozhttpd == 0.7 14:08:07 INFO - mozinfo == 0.9 14:08:07 INFO - mozleak == 0.1 14:08:07 INFO - mozlog == 3.2 14:08:07 INFO - moznetwork == 0.27 14:08:07 INFO - mozprocess == 0.22 14:08:07 INFO - mozprofile == 0.28 14:08:07 INFO - mozrunner == 6.11 14:08:07 INFO - mozscreenshot == 0.1 14:08:07 INFO - mozsystemmonitor == 0.3 14:08:07 INFO - moztest == 0.7 14:08:07 INFO - mozversion == 1.4 14:08:07 INFO - psutil == 3.1.1 14:08:07 INFO - requests == 1.2.3 14:08:07 INFO - wsgiref == 0.1.2 14:08:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:07 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 0x1c40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f01180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff3b0>, '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 0x1f002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f00740>, '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': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:08:07 INFO - Using env: {'DISPLAY': ':0', 14:08:07 INFO - 'HOME': '/home/cltbld', 14:08:07 INFO - 'LANG': 'en_US.UTF-8', 14:08:07 INFO - 'LANGUAGE': 'en_US:en', 14:08:07 INFO - 'LOGNAME': 'cltbld', 14:08:07 INFO - 'MAIL': '/var/mail/cltbld', 14:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:07 INFO - 'MOZ_NO_REMOTE': '1', 14:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:07 INFO - 'NO_EM_RESTART': '1', 14:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:07 INFO - 'PWD': '/builds/slave/test', 14:08:07 INFO - 'SHELL': '/bin/bash', 14:08:07 INFO - 'SHLVL': '1', 14:08:07 INFO - 'TERM': 'linux', 14:08:07 INFO - 'TMOUT': '86400', 14:08:07 INFO - 'USER': 'cltbld', 14:08:07 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 14:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:07 INFO - '_': '/tools/buildbot/bin/python'} 14:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:08:07 INFO - Cleaning up... 14:08:07 INFO - Return code: 0 14:08:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:07 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 0x1c40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f01180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff3b0>, '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 0x1f002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f00740>, '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': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:08:07 INFO - Using env: {'DISPLAY': ':0', 14:08:07 INFO - 'HOME': '/home/cltbld', 14:08:07 INFO - 'LANG': 'en_US.UTF-8', 14:08:07 INFO - 'LANGUAGE': 'en_US:en', 14:08:07 INFO - 'LOGNAME': 'cltbld', 14:08:07 INFO - 'MAIL': '/var/mail/cltbld', 14:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:07 INFO - 'MOZ_NO_REMOTE': '1', 14:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:07 INFO - 'NO_EM_RESTART': '1', 14:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:07 INFO - 'PWD': '/builds/slave/test', 14:08:07 INFO - 'SHELL': '/bin/bash', 14:08:07 INFO - 'SHLVL': '1', 14:08:07 INFO - 'TERM': 'linux', 14:08:07 INFO - 'TMOUT': '86400', 14:08:07 INFO - 'USER': 'cltbld', 14:08:07 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 14:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:07 INFO - '_': '/tools/buildbot/bin/python'} 14:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:08:07 INFO - Cleaning up... 14:08:07 INFO - Return code: 0 14:08:07 INFO - Running post-action listener: _resource_record_post_action 14:08:07 INFO - Running post-action listener: _start_resource_monitoring 14:08:07 INFO - Starting resource monitoring. 14:08:07 INFO - ##### 14:08:07 INFO - ##### Finished create-virtualenv step (success) 14:08:07 INFO - ##### 14:08:07 INFO - ##### 14:08:07 INFO - ##### Running install step. 14:08:07 INFO - ##### 14:08:07 INFO - Running pre-action listener: _resource_record_pre_action 14:08:07 INFO - Running main action method: install 14:08:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:08 INFO - Reading from file tmpfile_stdout 14:08:08 INFO - Detecting whether we're running mozinstall >=1.0... 14:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:08:08 INFO - Reading from file tmpfile_stdout 14:08:08 INFO - Output received: 14:08:08 INFO - Usage: mozinstall [options] installer 14:08:08 INFO - Options: 14:08:08 INFO - -h, --help show this help message and exit 14:08:08 INFO - -d DEST, --destination=DEST 14:08:08 INFO - Directory to install application into. [default: 14:08:08 INFO - "/builds/slave/test"] 14:08:08 INFO - --app=APP Application being installed. [default: firefox] 14:08:08 INFO - mkdir: /builds/slave/test/build/application 14:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:08:25 INFO - Reading from file tmpfile_stdout 14:08:25 INFO - Output received: 14:08:25 INFO - /builds/slave/test/build/application/firefox/firefox 14:08:25 INFO - Running post-action listener: _resource_record_post_action 14:08:25 INFO - ##### 14:08:25 INFO - ##### Finished install step (success) 14:08:25 INFO - ##### 14:08:25 INFO - ##### 14:08:25 INFO - ##### Running run-tests step. 14:08:25 INFO - ##### 14:08:25 INFO - Running pre-action listener: _resource_record_pre_action 14:08:25 INFO - Running main action method: run_tests 14:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:08:25 INFO - Python 2.7.3 14:08:25 INFO - Return code: 0 14:08:25 INFO - grabbing minidump binary from tooltool 14:08: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')]} 14:08:25 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 0x1eff3b0>, '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 0x1f002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f00740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:08:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:08:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:08:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:08:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:08:25 INFO - Return code: 0 14:08:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:08:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:08:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:08:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:08:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:08:25 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/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:08:25 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/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:08:25 INFO - Using env: {'DISPLAY': ':0', 14:08:25 INFO - 'HOME': '/home/cltbld', 14:08:25 INFO - 'LANG': 'en_US.UTF-8', 14:08:25 INFO - 'LANGUAGE': 'en_US:en', 14:08:25 INFO - 'LOGNAME': 'cltbld', 14:08:25 INFO - 'MAIL': '/var/mail/cltbld', 14:08:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:08:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:25 INFO - 'MOZ_NO_REMOTE': '1', 14:08:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:25 INFO - 'NO_EM_RESTART': '1', 14:08:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:25 INFO - 'PWD': '/builds/slave/test', 14:08:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:08:25 INFO - 'SHELL': '/bin/bash', 14:08:25 INFO - 'SHLVL': '1', 14:08:25 INFO - 'TERM': 'linux', 14:08:25 INFO - 'TMOUT': '86400', 14:08:25 INFO - 'USER': 'cltbld', 14:08:25 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500', 14:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:25 INFO - '_': '/tools/buildbot/bin/python'} 14:08:25 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/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:08:25 INFO - mozversion application_buildid: 20160705113033 14:08:25 INFO - mozversion application_changeset: 3db27bf874fa9e5057b7bcb96f325699bb7f1688 14:08:25 INFO - mozversion application_display_name: Nightly 14:08:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:08:25 INFO - mozversion application_name: Firefox 14:08:25 INFO - mozversion application_remotingname: firefox 14:08:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:08:25 INFO - mozversion application_vendor: Mozilla 14:08:25 INFO - mozversion application_version: 50.0a1 14:08:25 INFO - mozversion platform_buildid: 20160705113033 14:08:25 INFO - mozversion platform_changeset: 3db27bf874fa9e5057b7bcb96f325699bb7f1688 14:08:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:08:25 INFO - mozversion platform_version: 50.0a1 14:08:25 INFO - using testdate: 1467752905 14:08:25 INFO - actual date: 1467752905 14:08:25 INFO - starting webserver on 'localhost:41457' 14:08:25 INFO - SUITE-START | Running 2 tests 14:08:25 INFO - TEST-START | dromaeo_css 14:08:25 INFO - operating with platform_type : linux_ 14:08:25 INFO - Initialising browser for dromaeo_css test... 14:08:25 INFO - TEST-INFO | started process 3928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7P79h1/profile http://localhost:41457/getInfo.html) 14:08:45 INFO - PROCESS | 3928 | __metrics Screen width/height:1600/1200 14:08:45 INFO - PROCESS | 3928 | colorDepth:24 14:08:45 INFO - PROCESS | 3928 | Browser inner width/height: 1024/697 14:08:45 INFO - PROCESS | 3928 | __metrics 14:08:47 INFO - PROCESS | 3928 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:08:48 INFO - TEST-INFO | 3928: exit 0 14:08:48 INFO - Browser initialized. 14:08:48 INFO - Running cycle 1/1 for dromaeo_css test... 14:08:48 INFO - TEST-INFO | started process 4011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7P79h1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:00 INFO - PROCESS | 4011 | RSS: Main: 157478912 14:09:00 INFO - PROCESS | 4011 | 14:09:51 INFO - PROCESS | 4011 | 1467752991885 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:12:00 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:41457/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41457/tests/dromaeo/cssquery-ext.html) 14:12:01 INFO - PROCESS | 4011 | RSS: Main: 244883456 14:12:01 INFO - PROCESS | 4011 | 14:15:03 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:41457/tests/dromaeo/cssquery-ext.html (next: http://localhost:41457/tests/dromaeo/cssquery-jquery.html) 14:15:04 INFO - PROCESS | 4011 | RSS: Main: 246636544 14:15:04 INFO - PROCESS | 4011 | 14:18:06 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:41457/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41457/tests/dromaeo/cssquery-mootools.html) 14:18:06 INFO - PROCESS | 4011 | RSS: Main: 248979456 14:18:06 INFO - PROCESS | 4011 | 14:21:08 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:41457/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41457/tests/dromaeo/cssquery-prototype.html) 14:21:09 INFO - PROCESS | 4011 | RSS: Main: 237715456 14:21:09 INFO - PROCESS | 4011 | 14:24:11 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:41457/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41457/tests/dromaeo/cssquery-yui.html) 14:24:12 INFO - PROCESS | 4011 | RSS: Main: 208556032 14:24:12 INFO - PROCESS | 4011 | 14:27:15 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:41457/tests/dromaeo/cssquery-yui.html (next: http://localhost:41457/tests/dromaeo/cssquery-dojo.html) 14:27:15 INFO - PROCESS | 4011 | RSS: Main: 282034176 14:27:15 INFO - PROCESS | 4011 | 14:27:15 INFO - PROCESS | 4011 | __start_tp_report 14:27:15 INFO - PROCESS | 4011 | _x_x_mozilla_page_load 14:27:15 INFO - PROCESS | 4011 | _x_x_mozilla_page_load_details 14:27:15 INFO - PROCESS | 4011 | |i|pagename|runs| 14:27:15 INFO - PROCESS | 4011 | |0;dojo.html;2979.1956171833604;2997.4155039767256;3033.6662967073617;3089.3666798306344;3101.5812865263197;5064.746762661871;5206.271122042907;5257.947420525794;5291.973540132299;5322.520973112424;5180.2488639147305;5184.1705327147665;5261.0793111205485;5283.101872681644;5289.444608316129;4667.369905062816;4730.716157030572;4739.289106633998;4793.544613261734;4993.300937868701;4910.877228069309;4918.877028074291;4952.232403977389;4965.776540055706;4980.576650984671;4678.5789278964885;4731.33761273422;4775.856724298276;4792.329073929618;4892.510748925115;4773.71357718538;4774.952250477486;4781.474037855833;4832.589229915461;4860.8055677772845;4809.206480930642;4812.7352995585225;4814.831480898187;4814.927776083362;4819.325294458778;4702.4592171899985;5091.541761241506;5160.200168973815;5307.071262529081;5315.521603055744;5641.26663533738;5660;5672.68800215988;5689.886202275931;5692.345380281279;5506.504414602665;5753.108268218391;5753.482186603184;5763;5763.308402991668;5216.7913283468615;5273.997940391352;5289.047971365153;5297.973510132501;5340.385855626614;5827.213326200994;5844.15259787337;5848.2397288353095;5855.619384740064;5861.6189947653265;5408.080626293539;5515.972420137874;5641.830745077655;5646.85882852932;5655.1799989001365;5635.520980716603;5748.885022299614;5754.223179870748;5754.856128596735;5755.280589926259;5674;5674.290713660793;5676.744546495335;5678.063119585305;5734.311882574035;5480.342358916876;5585.888282234332;5693.886122277614;5694.572907031989;5711.971440142773;4332.696711230184;4342.761148136819;4355.237833379146;4384.12317536494;4384.4519435070615;3783.4703141560203;3808.485854409619;3813.9046523836573;3859.2281543691374;3863.5750067492554;5148.150555158357;5264.394594621667;5298.576113910878;5350.197470379474;5367.409584945653;5630.23991761107;5679.801206957736;5701.258836351248;5703.885922281531;5745.2818397700285;5365.517103460707;5376.704281264568;5377.946220537823;5385.192221166856;5390.865228369322;4785.856424307276;4909.4845041270155;4909.68087074339;4933.802647894116;4953.479884612136;5962.821115366546;5974.61165024272;5977.6114552553945;5985.251843519473;6015.39846015395;5773.826785196451;5775.162601422854;5789.594728368974;5790.131480277992;5795.420457954339;5676.886462270649;5841;5897.144913987534;5914.467697907037;5971.253593300838;5546.4453554644215;5565.30433695788;5568.136938774496;5570.359408668055;5582.972085139549;5638.7462564185535;5669.461401166883;5681.9147712783515;5683.77264909399;5691.174779656843;5382.542483888913;5400.0819860623005;5438.673679579238;5456.836294911159;5462.235287059894;5444.455554444524;5453.945460545344;5454.645448045864;5460.863478413072;5463.344398672185;5330.733463326741;5408.134698448387;5418.512333889968;5429.131338985743;5436.266104075899;5424.674519528841;5451.781928722807;5454;5496.80761173357;5538.833834984957;5373.462653734595;5382.381026182039;5382.703951282717;5383.703896285585;5389.62272640927 14:27:15 INFO - PROCESS | 4011 | |1;ext.html;612.6814056690521;625.7622103600631;626.9435750782434;634.6319134901756;642.8489305013323;41972.79013604931;43790.56209437905;43798.34302485465;43861.78069109658;47404.288935665994;44085.33871991915;44280.11439771203;44504;44531.3320300195;44582.777086114605;8559.914400855989;8684.826303473927;8687.261582765472;8688.913110868874;8692.434991725517;8914.242289405409;8994.415363001384;9003.729888103368;9007.774805629879;9013.459192448441;9056.003839577641;9100.180983711465;9115.544222788867;9117.407368521059;9127;9020.819583608323;9025.187733103987;9069.682561110329;9070.591823367964;9075.228605568534;8890.59992300348;8922.42004269727;8966.282697384193;8969.955150224272;8976.371653984224;41438.37842432366;41704.33182672689;41766.1646767066;41790.58209417897;41834.79082604598;3260.4620237660756;3361.6470270621476;3717.3494638438165;3816.5038544988975;3942.48747662802;31709.84145079283;32247.83876080628;32649;32674.6732532674;32679.509807352908;4309.870703878857;4439.356293337448;4496.3705081288645;4500.347449619787;4587.518310577375;335527;335653;336233;337299;337891;56456;56866.715666421405;57039.714801425725;57110.42889571134;57122.42877571171;42643.16211540976;42803.35794963078;42963.57036429658;42978.57021429808;43012.13975720468;14709.55871323862;14879.10725356482;14904.70190596182;14916.328765205591;14924.17917014553;12020.45907934145;12131;12132.332721700392;12143.332116733665;12151.939240303742;12662.430190641444;13713.382897769625;16418.343266269214;16467.423640172536;16800.07599582035;6052.515798736091;6190.690465476799;6373.585716928477;6399.424051835357;6427.357264273535;974.6198982396871;1063.2291588598205;1115.4701516779464;1139.6808893509665;1141.9885801142048;31507;31528.684713152576;31735.682643173273;32182.517262241086;32408.189795255308;1014.8122597319519;1100.7028102412303;1130.5873356225084;1147.9827802582968;1169.0238650726737;16453.753193702105;16614.75077873833;16756;16909.44646206651;17136;142077;142213;143126.2843685775;143246;143871;57050.714746426835;57416;57491.42508574944;57548.42451575514;57621.4237857616;1242.714175739585;1276.0875973678678;1334.1728128560355;1365.7405093032291;1381.86181381861;29868;33119.50320745239;33245.50131747977;33316;33343.166420839676;49071;49232.507674922796;49403.25895111504;49496;49542.256866147756;384574;392891;393121;394043;394753;34654.48018279778;39477.802610986764;39939.40090898581;40059.19881602293;40426;46314.53685463237;46589.534104658516;46758.76620616875;46865.297020544036;47104.7644761774;36735.448968266035;40354;40507.79746101251;40625;41190.58809411868;38880.6111938877;38903.41644875386;39817;40144.79927600343;40321;34698.47952280667;39764;39907.2018559633;40888.79555602203;41060;32875;35203.29593408066;36269.63730362662;36618.8169059153;36666.26667466582;26903.86548067247;27767.30581735473;27817;27964.44071118607;28242.43515129645 14:27:15 INFO - PROCESS | 4011 | |2;jquery.html;364.6572222111217;385.8032403474229;386.65201318813064;397.4237355834041;407.1795332405204;14818.851811481882;14823.925880370596;19050.80949190511;19685;19705.408837734874;19265.903670481628;19297.4210773677;19598;19604.117814698337;20216.898915505437;5595.328560572737;5632.859178520549;5763.193152958589;5818.883622327551;5828.358880523139;5740.7703691852275;5813.505852002585;5826.271716035496;5845.620034697731;5849.298084229898;5540.418256083114;5726.62776919501;5783;5790.507806836424;5792.855178620547;5692.288463942007;5708.543316534668;5763.337216220105;5786.334571524287;5791.247137872071;4960.280759289883;5127.077126117298;5138.3577052868395;5170.819021334235;5173.9741301293625;23770.64344034841;23929.760702392927;24043.759562404328;24393.14623988152;24398.634020489706;2505.987470062656;2525.898964041436;2551.9234422967343;2595.662563866704;3068.079576127153;14170.787438188436;14306.14163150204;14826.110433374031;15057.322420491104;15362.231888405535;1841.686913224755;1906.037451087192;1933.3426634944046;1993.182795054021;2001.4395969128668;57268.42731572672;62730.37269627291;69269.3073069273;70770.29229707689;74591.62704186498;10779.514921828537;10829.512671929782;11171.944140279247;11218.98918902823;11219.943900280447;15130.924345378202;15196.088234705952;15200.46798362052;15269.694606107816;15283.770743438858;7810.687572497037;8055.154208808108;8056.637451314705;8131.95934020338;8141.4708043978135;7690.500117492345;7720.382369410434;7824.21757824213;7896.801795272923;7909.406794490436;4035.6569691575955;4101.91796164075;4650.906981860411;4699.577038066591;4752.7623618818925;1857.7027675571844;1936.5061909213061;1942.9125689344014;1955.8533110016806;2016.6672499037788;921.5898924978454;933.0902370189146;936.817320622472;993.5082134343402;1029.8609687692215;19040;20125.597488050156;20197;20264;20303.390898273075;993.1855878179823;1014.1734486393566;1030.2755538727595;1061.2147011211648;1067.9893201068046;10479.161667066617;11146.498407571678;11208.15938804593;11282.717932051764;11296.604618838466;463638;464932;466660;471519;487814;57170.42829571734;61640;94276;96257;96887.51556242314;971.4171497101823;971.7376308396834;982.4252812104999;990.4008075114596;993.7888198757851;17496.562585935455;17560.20979055971;17875.748697591564;17983.640327193643;18140.818591813913;41800.581994179665;42471;42503;42701.35947960845;43297.78351108224;60755.39244607498;61113.388866112546;62171;62490.687546561974;64176.679116604115;7023.473239506955;7397.889031664637;8338.666453341799;8473.406861519634;9015;8250.628721707657;9765.951170244103;10165.84751228747;13730.656733581342;13944.093633913762;11730.12024098179;11798.41007949582;11800.940995294968;11925.105617078927;12037.638870833889;10912.836307455236;11036.558537658404;11086.667399978014;11207;11314.208005439541;11815;11907.76184476323;12093.879061209274;12242.143049986415;12349.814752778895;8450.492970421794;8498.957505212682;8673.653053877773;8717.389782715403;8738.825223495367;8522.616482258438;11749.118816088998;11929.522819087138;11951.94024029909;12303.446344914679 14:27:15 INFO - PROCESS | 4011 | |3;mootools.html;1266.2149467330246;1443.372133122092;1484.5323723027245;1587.2936543238263;1718.2869109319624;8253.876191857127;8611.655533778649;8626.611802468888;8777.868331975025;8798.604062817172;8637.740867773977;8817;8821.250193733524;8840.38117331787;8846.601902914368;1965.0960558143272;2022.817946384825;2032.2582257475988;2274.658801179824;2300.7929286364224;2006.7892871248528;2183.4977955070344;2269.50070984384;2272.3523795718224;2273.465735552144;2200.3838925101;2235.2400183937457;2248.4940888300084;2252.155441709359;2254.222293308814;1910.9426717198505;2159.36298791856;2164.2641501889434;2165.7834216578217;2168.913243470259;2139.6576547752284;2210.7568167501563;2212.9225477108225;2236.463248820288;2241.4396400899777;8762.518061506615;8807.955960220223;8828.470291782514;8831.3376496763;8832.293416526663;4903.2645103234445;5026.045051440251;5032.471590482984;5034.672746271481;5040.899182016339;3099.2251937015744;3157.2738270197983;3249.918752031218;3258.3483303339426;3263.9347213055607;981.9509024548744;1022.9079382855505;1029.3926583315804;1039.1998161415668;1042.4720053869337;12379.938100309531;12392.256464612152;12402.441890114966;12402.75194496114;12444.440000199922;4139.523954745183;4361.716488428242;4434.201843668171;4446.3108218226225;4452;10363.844542331872;10414.947925260325;10424.426656533811;10443.477826108665;10445.947770261251;5037.848864534069;5084.542391184737;5091.287219789158;5093.388793344749;5097.0315640028275;3970.920581588352;4527.841525546656;4679.976600116977;4681.67228294023;4681.882952926204;3810.466534685146;3868.903277418031;3944.4872166618156;3962.227365663726;3994.141259629194;1199.4542483170137;1207.849018872641;1211.6304527119137;1220.060553373915;1224.6203676860202;749.3667850666178;769.442154438028;840.5629072882067;845.0915266088856;858.2361698088706;5584.525315348241;5672.4894759471845;5895.145203945404;5920.145714413673;5961;437.8730168251235;446.11891514259725;446.4062796480738;451.9254323036728;457.6659038901554;3914.158455931988;3979.263836190314;4022.4368588397647;4030.2946984277633;4056.7971601419813;10439.791204176026;10714.250002499906;10748.623798167027;10851.78296434067;10861;10748.623798167027;10757.892421075845;10760.192985526117;10766.138708903269;10778.461076946278;8027.397945154137;8178.631961561744;8267.131951145044;8288;8291.709790157316;5605.719714014364;5608.551315894637;5748.281464816898;5757;5764.682942438206;9908.35595686278;9921.65274215399;9966.601335946481;10078.949605251926;10083.344582602107;10006;10122.949385253027;10139.442330671884;10401.84397234027;10433.061024507831;7615.847683046419;7727.188645192174;7924;7946.64240109208;7951.761447156595;8430.494170349799;8441.15588441151;8443.535605541754;8468.788280293042;8525.147485251426;7390.6674199660065;7687.9231207689445;7737.381009519338;7790.571518566307;7848.097468791162;7485.0643669541305;7546.811329716801;7615.238476152341;7718.112417072109;7764.34003109742;6715.764948226789;6730.216492629359;6750.763723269662;6770.796876093725;6774.593524388552;5058.317127187783;5155.793768249228;5185.507376799198;5284.603654725988;5304.443033481429;5121.334226550524;5197.974010129925;5231.084560202025;5271.525562699376;5318.468153184651 14:27:15 INFO - PROCESS | 4011 | |4;prototype.html;301.92602812310986;316.46675352031826;317.79343426772596;322.77405815928853;323.9643639199689;5002.774875130619;5223.033738758328;5232.45059268777;5259.342582177228;5270.7364631768405;5243.895122097565;5249.238860365254;5256.395514515832;5258.710770907599;5264.210368444736;4145.564715704861;4150.709450338478;4153.54311025787;4155.023569461174;4179.352200408926;3933.2920074386598;4174.916501669964;4175.434212170436;4179.578943159325;4181.080162364275;4026.9597304027025;4036.3138266494766;4050.6759459243335;4093.1609020150945;4102.897427564305;4030;4037.4751282333254;4049.2104039712267;4054.3715724062818;4064.5732198119067;3579.731520136;3583.426651735736;3583.498310236569;3594.1194407370363;3596.5863925648364;5010.949890501085;5034.597232221414;5127.308163214342;5141.948580514184;5162.328897243372;4647.88380290492;4651.767411629439;4660.300954856764;4666.486686464486;4673.462551806551;5468.808591699311;5474.72626368684;5475.67145971243;5485.780568777244;5489.231507588941;3771.1891943232336;3932.7247092703524;3939.3500072488005;3941.3102707026155;3948.368261078214;5286.365636123652;5444.428335024805;5610.803621873215;5655.1517272409055;5662.8301150965535;3964;3968.6825053995613;3978.5822488638855;3982.681385489154;3982.74112182713;3847.2110468632222;3923.450716899579;4015.13674559971;4020.296448121567;4041.191761647682;4594.724316540952;4598.356230127785;4617.58441740245;4621.936954500484;4625.306204069349;5478.698671573102;5479.342478902558;5480.80817171405;5494.36814766307;5495.3622261314795;1350.3653282956996;1372.5539199760117;1374.924379159156;1380.6134282400944;1383.9584812455441;878.872563478292;883.1918794303269;888.3470649072926;890.3856339125982;898.4429653614801;4695.201815691273;4710.152172608895;4727.527247275245;4740.605993973021;4741.336212930192;4995.525425084611;4997.425296090996;5007.774650140753;5008.323876276656;5015.517318927082;4437.29003359461;4673.813047478131;4705.529447055335;4716.268978308368;4764.523547645208;2595.8448490421583;2610.2299821552306;2630.2109367189764;2634.1570697376656;2659.7872170226337;5056.9633225188745;5102.464241254689;5108.693478391308;5111.539961403491;5130.97434512825;4676.883077923011;5003.774830132653;5026.4973502649445;5027;5029.924551131736;5018.888289260682;5040.647154699136;5064.4935506449065;5091.567216786615;5107.693538387709;4863.981447699165;4909.4354149273295;4933.802647894044;4952.47998960104;5314.441983591822;5299.569116338644;5562.22128901946;5583.916241256466;5593.860153496195;5597.580181486486;5754.395788442153;5768.798092066758;5804.245448091721;5819.079703697854;5822.7670893163795;3876.2865993805012;3983.2630963271886;3983.521977362735;3991.1419044905483;3997.92004159921;5602.607817452739;5604.467575580314;5608.691521966331;5620.269364982526;5620.550355971431;5423.620346575702;5425.918611220756;5452.509274165185;5456.208849716848;5467.507924286833;5199.76601052946;5395.78416863321;5406.2701535292235;5424.484673955968;5426.240326354393;5307;5332.173513105475;5350.946490535045;5356.437574054668;5360.195970604441;5333.573314134937;5404.297441332602;5439.891202176013;5464.91802622953;5478.91781623284;5407.756650950795;5409.241286943608;5413.864653383697;5420.864478388072;5426.70153141581 14:27:15 INFO - PROCESS | 4011 | |5;yui.html;681.237014543711;682.5563383800533;707.8548897476018;716.1390245967361;762.2149186338072;15029.549113526598;15396.923015384935;16019.679606407864;16084.597885052879;16095.678086438278;14435.639109022253;14606.415743370253;14633.341499632515;14647.487337943174;14697.92651036746;782.6908371193362;797.6211299632657;801.1747899663357;803.333233416263;804.111456840192;661.6790856434625;782.4757412533617;801.967921283148;806.2058872011064;810.9107998120202;838.9580520973957;840.9117042710519;842.2419822160043;842.7429633961639;843.0473564871686;834.3033566971617;834.6744769539885;834.92903103236;835.2357592802579;836.3727204596553;499.23022883876746;595.7289433307834;606.3966353478318;612.4334990134153;613.6808859393091;14815.629609259855;14849.70300593982;14884.479043233436;14914.850851491563;14936.32786524609;12932.676683082904;13103.934480327538;13669.726605467835;13679.14871093223;13843.723125537534;12250.509979600805;12616.179948303423;12696.301703406309;12841.486340546368;13418.060735748502;4425.645948324126;4425.9114817703785;4431.225441192474;4461.643068554507;4598.126355992351;78299;79980.60009699973;81078.59460702659;81272.18727812705;81885;10810.459477026117;10833.945830270799;10845.945770271099;10993.175511836644;11387.08903287735;20830.791692082887;20947.476313092295;21063.262785802424;21095.367138985854;21145;8434.62044208012;8540.829183416297;8548.658053677907;8628;8682.044975052739;4670.859874203779;4756.738379389098;4859.854204373874;4887.877803054952;5027.924581131286;3417.760756747004;3532.3818331791836;3541.8229088545468;3543.309054734302;3546.858125674996;653.2487639214846;676.100785954679;677.2110491277705;692.9099217101744;698.1656919980575;619.5291578400448;626.6866566716642;642.3031011352734;656.3108735827458;662.2285037930853;9596.856047159297;9743.220542356594;9800.607975680892;9898.752531186778;10055.949720251498;615.4799194680488;619.7242227208849;659.0575477067744;698.3400686351349;698.5703792167781;4514;4743.407074115736;4815.061063092663;4823.456493921912;5172.224166374998;75818;103925.96074039163;123799.3810030962;125266;130349.34825325813;65469.67265163739;105062.47468762608;107598.92401076046;107807;110538.44730776295;95430;98390.50804746074;100071;101481;102520.48739756254;9456.574454149717;9742;9925.702228932854;10227.795444090927;10296.433696146783;47840.521594783604;50152;52054;54308.45691543034;54749.45250547603;60029;71918.28081719116;72015.63992180006;73403.26596734178;74751.25248747443;12285.447154878231;12386.504539818307;12510.31193284378;12702;13147.408366623333;14040.368183431567;14168.574942751733;14210;14450.771684406944;14482.203478808766;12325.445354958869;12371.69070773202;12500.562480313145;12630.368481576068;13302.933485332898;12510.749785004431;12517.436715347649;12692.17500862441;13332.200067995951;13911.304434778018;12771.61685149447;12906.741865162832;13479;13585.660358491117;13606.047576669935;10301.381917084998;10343.689689309333;10498.580056797642;10635.468226588795;10826.837597436202;10643;10683.145348371956;10841.512131953923;10918.235723499596;10936.453177340942 14:27:15 INFO - PROCESS | 4011 | __end_tp_report 14:27:15 INFO - PROCESS | 4011 | __start_cc_report 14:27:15 INFO - PROCESS | 4011 | _x_x_mozilla_cycle_collect,850 14:27:15 INFO - PROCESS | 4011 | __end_cc_report 14:27:15 INFO - PROCESS | 4011 | __startTimestamp1467754035801__endTimestamp 14:27:15 INFO - PROCESS | 4011 | 14:27:15 INFO - PROCESS | 4011 | ------- Summary: start ------- 14:27:15 INFO - PROCESS | 4011 | Number of tests: 6 14:27:15 INFO - PROCESS | 4011 | 14:27:15 INFO - PROCESS | 4011 | [#0] dojo.html Cycles:165 Average:5252.55 Median:5400.08 stddev:609.47 (11.3%) stddev-sans-first:584.67 14:27:15 INFO - PROCESS | 4011 | Values: 2979.2 2997.4 3033.7 3089.4 3101.6 5064.7 5206.3 5257.9 5292.0 5322.5 5180.2 5184.2 5261.1 5283.1 5289.4 4667.4 4730.7 4739.3 4793.5 4993.3 4910.9 4918.9 4952.2 4965.8 4980.6 4678.6 4731.3 4775.9 4792.3 4892.5 4773.7 4775.0 4781.5 4832.6 4860.8 4809.2 4812.7 4814.8 4814.9 4819.3 4702.5 5091.5 5160.2 5307.1 5315.5 5641.3 5660.0 5672.7 5689.9 5692.3 5506.5 5753.1 5753.5 5763.0 5763.3 5216.8 5274.0 5289.0 5298.0 5340.4 5827.2 5844.2 5848.2 5855.6 5861.6 5408.1 5516.0 5641.8 5646.9 5655.2 5635.5 5748.9 5754.2 5754.9 5755.3 5674.0 5674.3 5676.7 5678.1 5734.3 5480.3 5585.9 5693.9 5694.6 5712.0 4332.7 4342.8 4355.2 4384.1 4384.5 3783.5 3808.5 3813.9 3859.2 3863.6 5148.2 5264.4 5298.6 5350.2 5367.4 5630.2 5679.8 5701.3 5703.9 5745.3 5365.5 5376.7 5377.9 5385.2 5390.9 4785.9 4909.5 4909.7 4933.8 4953.5 5962.8 5974.6 5977.6 5985.3 6015.4 5773.8 5775.2 5789.6 5790.1 5795.4 5676.9 5841.0 5897.1 5914.5 5971.3 5546.4 5565.3 5568.1 5570.4 5583.0 5638.7 5669.5 5681.9 5683.8 5691.2 5382.5 5400.1 5438.7 5456.8 5462.2 5444.5 5453.9 5454.6 5460.9 5463.3 5330.7 5408.1 5418.5 5429.1 5436.3 5424.7 5451.8 5454.0 5496.8 5538.8 5373.5 5382.4 5382.7 5383.7 5389.6 14:27:15 INFO - PROCESS | 4011 | 14:27:15 INFO - PROCESS | 4011 | [#1] ext.html Cycles:180 Average:47080.42 Median:40232.90 stddev:81683.76 (203.0%) stddev-sans-first:81838.40 14:27:15 INFO - PROCESS | 4011 | Values: 612.7 625.8 626.9 634.6 642.8 41972.8 43790.6 43798.3 43861.8 47404.3 44085.3 44280.1 44504.0 44531.3 44582.8 8559.9 8684.8 8687.3 8688.9 8692.4 8914.2 8994.4 9003.7 9007.8 9013.5 9056.0 9100.2 9115.5 9117.4 9127.0 9020.8 9025.2 9069.7 9070.6 9075.2 8890.6 8922.4 8966.3 8970.0 8976.4 41438.4 41704.3 41766.2 41790.6 41834.8 3260.5 3361.6 3717.3 3816.5 3942.5 31709.8 32247.8 32649.0 32674.7 32679.5 4309.9 4439.4 4496.4 4500.3 4587.5 335527.0 335653.0 336233.0 337299.0 337891.0 56456.0 56866.7 57039.7 57110.4 57122.4 42643.2 42803.4 42963.6 42978.6 43012.1 14709.6 14879.1 14904.7 14916.3 14924.2 12020.5 12131.0 12132.3 12143.3 12151.9 12662.4 13713.4 16418.3 16467.4 16800.1 6052.5 6190.7 6373.6 6399.4 6427.4 974.6 1063.2 1115.5 1139.7 1142.0 31507.0 31528.7 31735.7 32182.5 32408.2 1014.8 1100.7 1130.6 1148.0 1169.0 16453.8 16614.8 16756.0 16909.4 17136.0 142077.0 142213.0 143126.3 143246.0 143871.0 57050.7 57416.0 57491.4 57548.4 57621.4 1242.7 1276.1 1334.2 1365.7 1381.9 29868.0 33119.5 33245.5 33316.0 33343.2 49071.0 49232.5 49403.3 49496.0 49542.3 384574.0 392891.0 393121.0 394043.0 394753.0 34654.5 39477.8 39939.4 40059.2 40426.0 46314.5 46589.5 46758.8 46865.3 47104.8 36735.4 40354.0 40507.8 40625.0 41190.6 38880.6 38903.4 39817.0 40144.8 40321.0 34698.5 39764.0 39907.2 40888.8 41060.0 32875.0 35203.3 36269.6 36618.8 36666.3 26903.9 27767.3 27817.0 27964.4 28242.4 14:27:15 INFO - PROCESS | 4011 | 14:27:15 INFO - PROCESS | 4011 | [#2] jquery.html Cycles:180 Average:27985.75 Median:2216.54 stddev:77419.60 (3492.8%) stddev-sans-first:77609.00 14:27:15 INFO - PROCESS | 4011 | Values: 364.7 385.8 386.7 397.4 407.2 14818.9 14823.9 19050.8 19685.0 19705.4 19265.9 19297.4 19598.0 19604.1 20216.9 5595.3 5632.9 5763.2 5818.9 5828.4 5740.8 5813.5 5826.3 5845.6 5849.3 5540.4 5726.6 5783.0 5790.5 5792.9 5692.3 5708.5 5763.3 5786.3 5791.2 4960.3 5127.1 5138.4 5170.8 5174.0 23770.6 23929.8 24043.8 24393.1 24398.6 2506.0 2525.9 2551.9 2595.7 3068.1 14170.8 14306.1 14826.1 15057.3 15362.2 1841.7 1906.0 1933.3 1993.2 2001.4 57268.4 62730.4 69269.3 70770.3 74591.6 10779.5 10829.5 11171.9 11219.0 11219.9 15130.9 15196.1 15200.5 15269.7 15283.8 7810.7 8055.2 8056.6 8132.0 8141.5 7690.5 7720.4 7824.2 7896.8 7909.4 4035.7 4101.9 4650.9 4699.6 4752.8 1857.7 1936.5 1942.9 1955.9 2016.7 921.6 933.1 936.8 993.5 1029.9 19040.0 20125.6 20197.0 20264.0 20303.4 993.2 1014.2 1030.3 1061.2 1068.0 10479.2 11146.5 11208.2 11282.7 11296.6 463638.0 464932.0 466660.0 471519.0 487814.0 57170.4 61640.0 94276.0 96257.0 96887.5 971.4 971.7 982.4 990.4 993.8 17496.6 17560.2 17875.7 17983.6 18140.8 41800.6 42471.0 42503.0 42701.4 43297.8 60755.4 61113.4 62171.0 62490.7 64176.7 7023.5 7397.9 8338.7 8473.4 9015.0 8250.6 9766.0 10165.8 13730.7 13944.1 11730.1 11798.4 11800.9 11925.1 12037.6 10912.8 11036.6 11086.7 11207.0 11314.2 11815.0 11907.8 12093.9 12242.1 12349.8 8450.5 8499.0 8673.7 8717.4 8738.8 8522.6 11749.1 11929.5 11951.9 12303.4 14:27:15 INFO - PROCESS | 4011 | 14:27:15 INFO - PROCESS | 4011 | [#3] mootools.html Cycles:180 Average:5700.06 Median:2489.88 stddev:3352.49 (134.6%) stddev-sans-first:3345.34 14:27:15 INFO - PROCESS | 4011 | Values: 1266.2 1443.4 1484.5 1587.3 1718.3 8253.9 8611.7 8626.6 8777.9 8798.6 8637.7 8817.0 8821.3 8840.4 8846.6 1965.1 2022.8 2032.3 2274.7 2300.8 2006.8 2183.5 2269.5 2272.4 2273.5 2200.4 2235.2 2248.5 2252.2 2254.2 1910.9 2159.4 2164.3 2165.8 2168.9 2139.7 2210.8 2212.9 2236.5 2241.4 8762.5 8808.0 8828.5 8831.3 8832.3 4903.3 5026.0 5032.5 5034.7 5040.9 3099.2 3157.3 3249.9 3258.3 3263.9 982.0 1022.9 1029.4 1039.2 1042.5 12379.9 12392.3 12402.4 12402.8 12444.4 4139.5 4361.7 4434.2 4446.3 4452.0 10363.8 10414.9 10424.4 10443.5 10445.9 5037.8 5084.5 5091.3 5093.4 5097.0 3970.9 4527.8 4680.0 4681.7 4681.9 3810.5 3868.9 3944.5 3962.2 3994.1 1199.5 1207.8 1211.6 1220.1 1224.6 749.4 769.4 840.6 845.1 858.2 5584.5 5672.5 5895.1 5920.1 5961.0 437.9 446.1 446.4 451.9 457.7 3914.2 3979.3 4022.4 4030.3 4056.8 10439.8 10714.3 10748.6 10851.8 10861.0 10748.6 10757.9 10760.2 10766.1 10778.5 8027.4 8178.6 8267.1 8288.0 8291.7 5605.7 5608.6 5748.3 5757.0 5764.7 9908.4 9921.7 9966.6 10078.9 10083.3 10006.0 10122.9 10139.4 10401.8 10433.1 7615.8 7727.2 7924.0 7946.6 7951.8 8430.5 8441.2 8443.5 8468.8 8525.1 7390.7 7687.9 7737.4 7790.6 7848.1 7485.1 7546.8 7615.2 7718.1 7764.3 6715.8 6730.2 6750.8 6770.8 6774.6 5058.3 5155.8 5185.5 5284.6 5304.4 5121.3 5198.0 5231.1 5271.5 5318.5 14:27:15 INFO - PROCESS | 4011 | 14:27:15 INFO - PROCESS | 4011 | [#4] prototype.html Cycles:180 Average:4465.28 Median:5009.64 stddev:1300.44 (26.0%) stddev-sans-first:1265.98 14:27:15 INFO - PROCESS | 4011 | Values: 301.9 316.5 317.8 322.8 324.0 5002.8 5223.0 5232.5 5259.3 5270.7 5243.9 5249.2 5256.4 5258.7 5264.2 4145.6 4150.7 4153.5 4155.0 4179.4 3933.3 4174.9 4175.4 4179.6 4181.1 4027.0 4036.3 4050.7 4093.2 4102.9 4030.0 4037.5 4049.2 4054.4 4064.6 3579.7 3583.4 3583.5 3594.1 3596.6 5010.9 5034.6 5127.3 5141.9 5162.3 4647.9 4651.8 4660.3 4666.5 4673.5 5468.8 5474.7 5475.7 5485.8 5489.2 3771.2 3932.7 3939.4 3941.3 3948.4 5286.4 5444.4 5610.8 5655.2 5662.8 3964.0 3968.7 3978.6 3982.7 3982.7 3847.2 3923.5 4015.1 4020.3 4041.2 4594.7 4598.4 4617.6 4621.9 4625.3 5478.7 5479.3 5480.8 5494.4 5495.4 1350.4 1372.6 1374.9 1380.6 1384.0 878.9 883.2 888.3 890.4 898.4 4695.2 4710.2 4727.5 4740.6 4741.3 4995.5 4997.4 5007.8 5008.3 5015.5 4437.3 4673.8 4705.5 4716.3 4764.5 2595.8 2610.2 2630.2 2634.2 2659.8 5057.0 5102.5 5108.7 5111.5 5131.0 4676.9 5003.8 5026.5 5027.0 5029.9 5018.9 5040.6 5064.5 5091.6 5107.7 4864.0 4909.4 4933.8 4952.5 5314.4 5299.6 5562.2 5583.9 5593.9 5597.6 5754.4 5768.8 5804.2 5819.1 5822.8 3876.3 3983.3 3983.5 3991.1 3997.9 5602.6 5604.5 5608.7 5620.3 5620.6 5423.6 5425.9 5452.5 5456.2 5467.5 5199.8 5395.8 5406.3 5424.5 5426.2 5307.0 5332.2 5350.9 5356.4 5360.2 5333.6 5404.3 5439.9 5464.9 5478.9 5407.8 5409.2 5413.9 5420.9 5426.7 14:27:15 INFO - PROCESS | 4011 | 14:27:15 INFO - PROCESS | 4011 | [#5] yui.html Cycles:180 Average:21011.98 Median:4428.57 stddev:30946.83 (698.8%) stddev-sans-first:30995.99 14:27:15 INFO - PROCESS | 4011 | Values: 681.2 682.6 707.9 716.1 762.2 15029.5 15396.9 16019.7 16084.6 16095.7 14435.6 14606.4 14633.3 14647.5 14697.9 782.7 797.6 801.2 803.3 804.1 661.7 782.5 802.0 806.2 810.9 839.0 840.9 842.2 842.7 843.0 834.3 834.7 834.9 835.2 836.4 499.2 595.7 606.4 612.4 613.7 14815.6 14849.7 14884.5 14914.9 14936.3 12932.7 13103.9 13669.7 13679.1 13843.7 12250.5 12616.2 12696.3 12841.5 13418.1 4425.6 4425.9 4431.2 4461.6 4598.1 78299.0 79980.6 81078.6 81272.2 81885.0 10810.5 10833.9 10845.9 10993.2 11387.1 20830.8 20947.5 21063.3 21095.4 21145.0 8434.6 8540.8 8548.7 8628.0 8682.0 4670.9 4756.7 4859.9 4887.9 5027.9 3417.8 3532.4 3541.8 3543.3 3546.9 653.2 676.1 677.2 692.9 698.2 619.5 626.7 642.3 656.3 662.2 9596.9 9743.2 9800.6 9898.8 10055.9 615.5 619.7 659.1 698.3 698.6 4514.0 4743.4 4815.1 4823.5 5172.2 75818.0 103926.0 123799.4 125266.0 130349.3 65469.7 105062.5 107598.9 107807.0 110538.4 95430.0 98390.5 100071.0 101481.0 102520.5 9456.6 9742.0 9925.7 10227.8 10296.4 47840.5 50152.0 52054.0 54308.5 54749.5 60029.0 71918.3 72015.6 73403.3 74751.3 12285.4 12386.5 12510.3 12702.0 13147.4 14040.4 14168.6 14210.0 14450.8 14482.2 12325.4 12371.7 12500.6 12630.4 13302.9 12510.7 12517.4 12692.2 13332.2 13911.3 12771.6 12906.7 13479.0 13585.7 13606.0 10301.4 10343.7 10498.6 10635.5 10826.8 10643.0 10683.1 10841.5 10918.2 10936.5 14:27:15 INFO - PROCESS | 4011 | -------- Summary: end -------- 14:27:15 INFO - PROCESS | 4011 | 14:27:16 INFO - TEST-INFO | 4011: exit 0 14:27:16 INFO - TEST-OK | dromaeo_css | took 1131180ms 14:27:16 INFO - TEST-START | kraken 14:27:16 INFO - operating with platform_type : linux_ 14:27:16 INFO - Initialising browser for kraken test... 14:27:16 INFO - TEST-INFO | started process 4206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD2aSq6/profile http://localhost:41457/getInfo.html) 14:27:22 INFO - PROCESS | 4206 | __metrics Screen width/height:1600/1200 14:27:22 INFO - PROCESS | 4206 | colorDepth:24 14:27:22 INFO - PROCESS | 4206 | Browser inner width/height: 1024/697 14:27:22 INFO - PROCESS | 4206 | __metrics 14:27:24 INFO - PROCESS | 4206 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:27:25 INFO - PROCESS | 4206 | console.error: PushService: 14:27:25 INFO - PROCESS | 4206 | stateChangeProcessEnqueue: Error transitioning state 14:27:25 INFO - PROCESS | 4206 | UnknownError 14:27:26 INFO - TEST-INFO | 4206: exit 0 14:27:26 INFO - Browser initialized. 14:27:26 INFO - Running cycle 1/1 for kraken test... 14:27:26 INFO - TEST-INFO | started process 4292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD2aSq6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:27:37 INFO - PROCESS | 4292 | RSS: Main: 156733440 14:27:37 INFO - PROCESS | 4292 | 14:27:40 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:41457/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41457/tests/kraken/driver.html?testName=audio-beat-detection) 14:27:41 INFO - PROCESS | 4292 | RSS: Main: 216047616 14:27:41 INFO - PROCESS | 4292 | 14:27:43 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:41457/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41457/tests/kraken/driver.html?testName=audio-dft) 14:27:44 INFO - PROCESS | 4292 | RSS: Main: 203563008 14:27:44 INFO - PROCESS | 4292 | 14:27:47 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:41457/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41457/tests/kraken/driver.html?testName=audio-fft) 14:27:48 INFO - PROCESS | 4292 | RSS: Main: 269553664 14:27:48 INFO - PROCESS | 4292 | 14:27:50 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:41457/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41457/tests/kraken/driver.html?testName=audio-oscillator) 14:27:50 INFO - PROCESS | 4292 | RSS: Main: 179900416 14:27:50 INFO - PROCESS | 4292 | 14:27:53 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:41457/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41457/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:27:53 INFO - PROCESS | 4292 | RSS: Main: 184344576 14:27:53 INFO - PROCESS | 4292 | 14:27:56 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:41457/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41457/tests/kraken/driver.html?testName=imaging-darkroom) 14:27:57 INFO - PROCESS | 4292 | RSS: Main: 218689536 14:27:57 INFO - PROCESS | 4292 | 14:28:00 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:41457/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41457/tests/kraken/driver.html?testName=imaging-desaturate) 14:28:01 INFO - PROCESS | 4292 | RSS: Main: 221716480 14:28:01 INFO - PROCESS | 4292 | 14:28:04 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:41457/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41457/tests/kraken/driver.html?testName=json-parse-financial) 14:28:04 INFO - PROCESS | 4292 | RSS: Main: 221290496 14:28:04 INFO - PROCESS | 4292 | 14:28:06 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:41457/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41457/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:28:06 INFO - PROCESS | 4292 | RSS: Main: 209088512 14:28:06 INFO - PROCESS | 4292 | 14:28:08 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:41457/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41457/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:28:09 INFO - PROCESS | 4292 | RSS: Main: 210223104 14:28:09 INFO - PROCESS | 4292 | 14:28:11 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:41457/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41457/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:28:11 INFO - PROCESS | 4292 | RSS: Main: 213295104 14:28:11 INFO - PROCESS | 4292 | 14:28:14 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:41457/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41457/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:28:14 INFO - PROCESS | 4292 | RSS: Main: 225894400 14:28:14 INFO - PROCESS | 4292 | 14:28:17 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:41457/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41457/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:28:18 INFO - PROCESS | 4292 | RSS: Main: 227594240 14:28:18 INFO - PROCESS | 4292 | 14:28:19 INFO - PROCESS | 4292 | Cycle 1(1): loaded http://localhost:41457/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41457/tests/kraken/driver.html?testName=ai-astar) 14:28:20 INFO - PROCESS | 4292 | RSS: Main: 269897728 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | __start_tp_report 14:28:20 INFO - PROCESS | 4292 | _x_x_mozilla_page_load 14:28:20 INFO - PROCESS | 4292 | _x_x_mozilla_page_load_details 14:28:20 INFO - PROCESS | 4292 | |i|pagename|runs| 14:28:20 INFO - PROCESS | 4292 | |0;ai-astar;101;112;111;111;111;113;112;110;111;112 14:28:20 INFO - PROCESS | 4292 | |1;audio-beat-detection;141;116;120;172;118;120;144;115;153;121 14:28:20 INFO - PROCESS | 4292 | |2;audio-dft;160;159;159;162;159;160;162;161;168;160 14:28:20 INFO - PROCESS | 4292 | |3;audio-fft;75;75;75;125;75;75;74;75;97;74 14:28:20 INFO - PROCESS | 4292 | |4;audio-oscillator;84;83;108;92;83;84;119;84;84;124 14:28:20 INFO - PROCESS | 4292 | |5;imaging-gaussian-blur;118;117;117;116;117;117;118;117;116;117 14:28:20 INFO - PROCESS | 4292 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;146;146 14:28:20 INFO - PROCESS | 4292 | |7;imaging-desaturate;95;96;96;96;96;95;95;95;95;95 14:28:20 INFO - PROCESS | 4292 | |8;json-parse-financial;52;53;53;53;54;52;54;53;54;53 14:28:20 INFO - PROCESS | 4292 | |9;json-stringify-tinderbox;62;63;62;61;61;61;61;61;61;61 14:28:20 INFO - PROCESS | 4292 | |10;stanford-crypto-aes;77;77;76;75;76;84;75;85;76;84 14:28:20 INFO - PROCESS | 4292 | |11;stanford-crypto-ccm;124;118;122;126;117;118;127;126;194;121 14:28:20 INFO - PROCESS | 4292 | |12;stanford-crypto-pbkdf2;159;157;159;157;161;161;157;160;155;161 14:28:20 INFO - PROCESS | 4292 | |13;stanford-crypto-sha256-iterative;66;63;63;61;61;68;63;62;62;61 14:28:20 INFO - PROCESS | 4292 | __end_tp_report 14:28:20 INFO - PROCESS | 4292 | __start_cc_report 14:28:20 INFO - PROCESS | 4292 | _x_x_mozilla_cycle_collect,1694 14:28:20 INFO - PROCESS | 4292 | __end_cc_report 14:28:20 INFO - PROCESS | 4292 | __startTimestamp1467754100215__endTimestamp 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | ------- Summary: start ------- 14:28:20 INFO - PROCESS | 4292 | Number of tests: 14 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:3.41 (3.1%) stddev-sans-first:0.88 14:28:20 INFO - PROCESS | 4292 | Values: 101.0 112.0 111.0 111.0 111.0 113.0 112.0 110.0 111.0 112.0 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:131.00 stddev:19.48 (14.9%) stddev-sans-first:20.39 14:28:20 INFO - PROCESS | 4292 | Values: 141.0 116.0 120.0 172.0 118.0 120.0 144.0 115.0 153.0 121.0 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | [#2] audio-dft Cycles:10 Average:161.00 Median:160.50 stddev:2.71 (1.7%) stddev-sans-first:2.85 14:28:20 INFO - PROCESS | 4292 | Values: 160.0 159.0 159.0 162.0 159.0 160.0 162.0 161.0 168.0 160.0 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.00 stddev:16.65 (22.2%) stddev-sans-first:17.47 14:28:20 INFO - PROCESS | 4292 | Values: 75.0 75.0 75.0 125.0 75.0 75.0 74.0 75.0 97.0 74.0 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:84.00 stddev:16.21 (19.3%) stddev-sans-first:16.74 14:28:20 INFO - PROCESS | 4292 | Values: 84.0 83.0 108.0 92.0 83.0 84.0 119.0 84.0 84.0 124.0 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 14:28:20 INFO - PROCESS | 4292 | Values: 118.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 116.0 117.0 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 14:28:20 INFO - PROCESS | 4292 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:28:20 INFO - PROCESS | 4292 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.74 (1.4%) stddev-sans-first:0.67 14:28:20 INFO - PROCESS | 4292 | Values: 52.0 53.0 53.0 53.0 54.0 52.0 54.0 53.0 54.0 53.0 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 14:28:20 INFO - PROCESS | 4292 | Values: 62.0 63.0 62.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:77.00 stddev:4.09 (5.3%) stddev-sans-first:4.30 14:28:20 INFO - PROCESS | 4292 | Values: 77.0 77.0 76.0 75.0 76.0 84.0 75.0 85.0 76.0 84.0 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:125.00 stddev:23.02 (18.4%) stddev-sans-first:24.34 14:28:20 INFO - PROCESS | 4292 | Values: 124.0 118.0 122.0 126.0 117.0 118.0 127.0 126.0 194.0 121.0 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.50 stddev:2.11 (1.3%) stddev-sans-first:2.24 14:28:20 INFO - PROCESS | 4292 | Values: 159.0 157.0 159.0 157.0 161.0 161.0 157.0 160.0 155.0 161.0 14:28:20 INFO - PROCESS | 4292 | 14:28:20 INFO - PROCESS | 4292 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:2.31 (3.7%) stddev-sans-first:2.18 14:28:20 INFO - PROCESS | 4292 | Values: 66.0 63.0 63.0 61.0 61.0 68.0 63.0 62.0 62.0 61.0 14:28:20 INFO - PROCESS | 4292 | -------- Summary: end -------- 14:28:20 INFO - PROCESS | 4292 | 14:28:22 INFO - TEST-INFO | 4292: exit 0 14:28:22 INFO - TEST-OK | kraken | took 65445ms 14:28:22 INFO - SUITE-END | took 1196s 14:28:22 INFO - Completed test suite (00:19:56) 14:28:22 INFO - javascript benchmark 14:28:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2979.1956171833604, 2997.4155039767256, 3033.6662967073617, 3089.3666798306344, 3101.5812865263197, 5064.746762661871, 5206.271122042907, 5257.947420525794, 5291.973540132299, 5322.520973112424, 5180.2488639147305, 5184.1705327147665, 5261.0793111205485, 5283.101872681644, 5289.444608316129, 4667.369905062816, 4730.716157030572, 4739.289106633998, 4793.544613261734, 4993.300937868701, 4910.877228069309, 4918.877028074291, 4952.232403977389, 4965.776540055706, 4980.576650984671, 4678.5789278964885, 4731.33761273422, 4775.856724298276, 4792.329073929618, 4892.510748925115, 4773.71357718538, 4774.952250477486, 4781.474037855833, 4832.589229915461, 4860.8055677772845, 4809.206480930642, 4812.7352995585225, 4814.831480898187, 4814.927776083362, 4819.325294458778, 4702.4592171899985, 5091.541761241506, 5160.200168973815, 5307.071262529081, 5315.521603055744, 5641.26663533738, 5660.0, 5672.68800215988, 5689.886202275931, 5692.345380281279, 5506.504414602665, 5753.108268218391, 5753.482186603184, 5763.0, 5763.308402991668, 5216.7913283468615, 5273.997940391352, 5289.047971365153, 5297.973510132501, 5340.385855626614, 5827.213326200994, 5844.15259787337, 5848.2397288353095, 5855.619384740064, 5861.6189947653265, 5408.080626293539, 5515.972420137874, 5641.830745077655, 5646.85882852932, 5655.1799989001365, 5635.520980716603, 5748.885022299614, 5754.223179870748, 5754.856128596735, 5755.280589926259, 5674.0, 5674.290713660793, 5676.744546495335, 5678.063119585305, 5734.311882574035, 5480.342358916876, 5585.888282234332, 5693.886122277614, 5694.572907031989, 5711.971440142773, 4332.696711230184, 4342.761148136819, 4355.237833379146, 4384.12317536494, 4384.4519435070615, 3783.4703141560203, 3808.485854409619, 3813.9046523836573, 3859.2281543691374, 3863.5750067492554, 5148.150555158357, 5264.394594621667, 5298.576113910878, 5350.197470379474, 5367.409584945653, 5630.23991761107, 5679.801206957736, 5701.258836351248, 5703.885922281531, 5745.2818397700285, 5365.517103460707, 5376.704281264568, 5377.946220537823, 5385.192221166856, 5390.865228369322, 4785.856424307276, 4909.4845041270155, 4909.68087074339, 4933.802647894116, 4953.479884612136, 5962.821115366546, 5974.61165024272, 5977.6114552553945, 5985.251843519473, 6015.39846015395, 5773.826785196451, 5775.162601422854, 5789.594728368974, 5790.131480277992, 5795.420457954339, 5676.886462270649, 5841.0, 5897.144913987534, 5914.467697907037, 5971.253593300838, 5546.4453554644215, 5565.30433695788, 5568.136938774496, 5570.359408668055, 5582.972085139549, 5638.7462564185535, 5669.461401166883, 5681.9147712783515, 5683.77264909399, 5691.174779656843, 5382.542483888913, 5400.0819860623005, 5438.673679579238, 5456.836294911159, 5462.235287059894, 5444.455554444524, 5453.945460545344, 5454.645448045864, 5460.863478413072, 5463.344398672185, 5330.733463326741, 5408.134698448387, 5418.512333889968, 5429.131338985743, 5436.266104075899, 5424.674519528841, 5451.781928722807, 5454.0, 5496.80761173357, 5538.833834984957, 5373.462653734595, 5382.381026182039, 5382.703951282717, 5383.703896285585, 5389.62272640927], "value": 5210.862928089021, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.6814056690521, 625.7622103600631, 626.9435750782434, 634.6319134901756, 642.8489305013323, 41972.79013604931, 43790.56209437905, 43798.34302485465, 43861.78069109658, 47404.288935665994, 44085.33871991915, 44280.11439771203, 44504.0, 44531.3320300195, 44582.777086114605, 8559.914400855989, 8684.826303473927, 8687.261582765472, 8688.913110868874, 8692.434991725517, 8914.242289405409, 8994.415363001384, 9003.729888103368, 9007.774805629879, 9013.459192448441, 9056.003839577641, 9100.180983711465, 9115.544222788867, 9117.407368521059, 9127.0, 9020.819583608323, 9025.187733103987, 9069.682561110329, 9070.591823367964, 9075.228605568534, 8890.59992300348, 8922.42004269727, 8966.282697384193, 8969.955150224272, 8976.371653984224, 41438.37842432366, 41704.33182672689, 41766.1646767066, 41790.58209417897, 41834.79082604598, 3260.4620237660756, 3361.6470270621476, 3717.3494638438165, 3816.5038544988975, 3942.48747662802, 31709.84145079283, 32247.83876080628, 32649.0, 32674.6732532674, 32679.509807352908, 4309.870703878857, 4439.356293337448, 4496.3705081288645, 4500.347449619787, 4587.518310577375, 335527.0, 335653.0, 336233.0, 337299.0, 337891.0, 56456.0, 56866.715666421405, 57039.714801425725, 57110.42889571134, 57122.42877571171, 42643.16211540976, 42803.35794963078, 42963.57036429658, 42978.57021429808, 43012.13975720468, 14709.55871323862, 14879.10725356482, 14904.70190596182, 14916.328765205591, 14924.17917014553, 12020.45907934145, 12131.0, 12132.332721700392, 12143.332116733665, 12151.939240303742, 12662.430190641444, 13713.382897769625, 16418.343266269214, 16467.423640172536, 16800.07599582035, 6052.515798736091, 6190.690465476799, 6373.585716928477, 6399.424051835357, 6427.357264273535, 974.6198982396871, 1063.2291588598205, 1115.4701516779464, 1139.6808893509665, 1141.9885801142048, 31507.0, 31528.684713152576, 31735.682643173273, 32182.517262241086, 32408.189795255308, 1014.8122597319519, 1100.7028102412303, 1130.5873356225084, 1147.9827802582968, 1169.0238650726737, 16453.753193702105, 16614.75077873833, 16756.0, 16909.44646206651, 17136.0, 142077.0, 142213.0, 143126.2843685775, 143246.0, 143871.0, 57050.714746426835, 57416.0, 57491.42508574944, 57548.42451575514, 57621.4237857616, 1242.714175739585, 1276.0875973678678, 1334.1728128560355, 1365.7405093032291, 1381.86181381861, 29868.0, 33119.50320745239, 33245.50131747977, 33316.0, 33343.166420839676, 49071.0, 49232.507674922796, 49403.25895111504, 49496.0, 49542.256866147756, 384574.0, 392891.0, 393121.0, 394043.0, 394753.0, 34654.48018279778, 39477.802610986764, 39939.40090898581, 40059.19881602293, 40426.0, 46314.53685463237, 46589.534104658516, 46758.76620616875, 46865.297020544036, 47104.7644761774, 36735.448968266035, 40354.0, 40507.79746101251, 40625.0, 41190.58809411868, 38880.6111938877, 38903.41644875386, 39817.0, 40144.79927600343, 40321.0, 34698.47952280667, 39764.0, 39907.2018559633, 40888.79555602203, 41060.0, 32875.0, 35203.29593408066, 36269.63730362662, 36618.8169059153, 36666.26667466582, 26903.86548067247, 27767.30581735473, 27817.0, 27964.44071118607, 28242.43515129645], "value": 18996.469342706376, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.6572222111217, 385.8032403474229, 386.65201318813064, 397.4237355834041, 407.1795332405204, 14818.851811481882, 14823.925880370596, 19050.80949190511, 19685.0, 19705.408837734874, 19265.903670481628, 19297.4210773677, 19598.0, 19604.117814698337, 20216.898915505437, 5595.328560572737, 5632.859178520549, 5763.193152958589, 5818.883622327551, 5828.358880523139, 5740.7703691852275, 5813.505852002585, 5826.271716035496, 5845.620034697731, 5849.298084229898, 5540.418256083114, 5726.62776919501, 5783.0, 5790.507806836424, 5792.855178620547, 5692.288463942007, 5708.543316534668, 5763.337216220105, 5786.334571524287, 5791.247137872071, 4960.280759289883, 5127.077126117298, 5138.3577052868395, 5170.819021334235, 5173.9741301293625, 23770.64344034841, 23929.760702392927, 24043.759562404328, 24393.14623988152, 24398.634020489706, 2505.987470062656, 2525.898964041436, 2551.9234422967343, 2595.662563866704, 3068.079576127153, 14170.787438188436, 14306.14163150204, 14826.110433374031, 15057.322420491104, 15362.231888405535, 1841.686913224755, 1906.037451087192, 1933.3426634944046, 1993.182795054021, 2001.4395969128668, 57268.42731572672, 62730.37269627291, 69269.3073069273, 70770.29229707689, 74591.62704186498, 10779.514921828537, 10829.512671929782, 11171.944140279247, 11218.98918902823, 11219.943900280447, 15130.924345378202, 15196.088234705952, 15200.46798362052, 15269.694606107816, 15283.770743438858, 7810.687572497037, 8055.154208808108, 8056.637451314705, 8131.95934020338, 8141.4708043978135, 7690.500117492345, 7720.382369410434, 7824.21757824213, 7896.801795272923, 7909.406794490436, 4035.6569691575955, 4101.91796164075, 4650.906981860411, 4699.577038066591, 4752.7623618818925, 1857.7027675571844, 1936.5061909213061, 1942.9125689344014, 1955.8533110016806, 2016.6672499037788, 921.5898924978454, 933.0902370189146, 936.817320622472, 993.5082134343402, 1029.8609687692215, 19040.0, 20125.597488050156, 20197.0, 20264.0, 20303.390898273075, 993.1855878179823, 1014.1734486393566, 1030.2755538727595, 1061.2147011211648, 1067.9893201068046, 10479.161667066617, 11146.498407571678, 11208.15938804593, 11282.717932051764, 11296.604618838466, 463638.0, 464932.0, 466660.0, 471519.0, 487814.0, 57170.42829571734, 61640.0, 94276.0, 96257.0, 96887.51556242314, 971.4171497101823, 971.7376308396834, 982.4252812104999, 990.4008075114596, 993.7888198757851, 17496.562585935455, 17560.20979055971, 17875.748697591564, 17983.640327193643, 18140.818591813913, 41800.581994179665, 42471.0, 42503.0, 42701.35947960845, 43297.78351108224, 60755.39244607498, 61113.388866112546, 62171.0, 62490.687546561974, 64176.679116604115, 7023.473239506955, 7397.889031664637, 8338.666453341799, 8473.406861519634, 9015.0, 8250.628721707657, 9765.951170244103, 10165.84751228747, 13730.656733581342, 13944.093633913762, 11730.12024098179, 11798.41007949582, 11800.940995294968, 11925.105617078927, 12037.638870833889, 10912.836307455236, 11036.558537658404, 11086.667399978014, 11207.0, 11314.208005439541, 11815.0, 11907.76184476323, 12093.879061209274, 12242.143049986415, 12349.814752778895, 8450.492970421794, 8498.957505212682, 8673.653053877773, 8717.389782715403, 8738.825223495367, 8522.616482258438, 11749.118816088998, 11929.522819087138, 11951.94024029909, 12303.446344914679], "value": 9178.274732030934, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1266.2149467330246, 1443.372133122092, 1484.5323723027245, 1587.2936543238263, 1718.2869109319624, 8253.876191857127, 8611.655533778649, 8626.611802468888, 8777.868331975025, 8798.604062817172, 8637.740867773977, 8817.0, 8821.250193733524, 8840.38117331787, 8846.601902914368, 1965.0960558143272, 2022.817946384825, 2032.2582257475988, 2274.658801179824, 2300.7929286364224, 2006.7892871248528, 2183.4977955070344, 2269.50070984384, 2272.3523795718224, 2273.465735552144, 2200.3838925101, 2235.2400183937457, 2248.4940888300084, 2252.155441709359, 2254.222293308814, 1910.9426717198505, 2159.36298791856, 2164.2641501889434, 2165.7834216578217, 2168.913243470259, 2139.6576547752284, 2210.7568167501563, 2212.9225477108225, 2236.463248820288, 2241.4396400899777, 8762.518061506615, 8807.955960220223, 8828.470291782514, 8831.3376496763, 8832.293416526663, 4903.2645103234445, 5026.045051440251, 5032.471590482984, 5034.672746271481, 5040.899182016339, 3099.2251937015744, 3157.2738270197983, 3249.918752031218, 3258.3483303339426, 3263.9347213055607, 981.9509024548744, 1022.9079382855505, 1029.3926583315804, 1039.1998161415668, 1042.4720053869337, 12379.938100309531, 12392.256464612152, 12402.441890114966, 12402.75194496114, 12444.440000199922, 4139.523954745183, 4361.716488428242, 4434.201843668171, 4446.3108218226225, 4452.0, 10363.844542331872, 10414.947925260325, 10424.426656533811, 10443.477826108665, 10445.947770261251, 5037.848864534069, 5084.542391184737, 5091.287219789158, 5093.388793344749, 5097.0315640028275, 3970.920581588352, 4527.841525546656, 4679.976600116977, 4681.67228294023, 4681.882952926204, 3810.466534685146, 3868.903277418031, 3944.4872166618156, 3962.227365663726, 3994.141259629194, 1199.4542483170137, 1207.849018872641, 1211.6304527119137, 1220.060553373915, 1224.6203676860202, 749.3667850666178, 769.442154438028, 840.5629072882067, 845.0915266088856, 858.2361698088706, 5584.525315348241, 5672.4894759471845, 5895.145203945404, 5920.145714413673, 5961.0, 437.8730168251235, 446.11891514259725, 446.4062796480738, 451.9254323036728, 457.6659038901554, 3914.158455931988, 3979.263836190314, 4022.4368588397647, 4030.2946984277633, 4056.7971601419813, 10439.791204176026, 10714.250002499906, 10748.623798167027, 10851.78296434067, 10861.0, 10748.623798167027, 10757.892421075845, 10760.192985526117, 10766.138708903269, 10778.461076946278, 8027.397945154137, 8178.631961561744, 8267.131951145044, 8288.0, 8291.709790157316, 5605.719714014364, 5608.551315894637, 5748.281464816898, 5757.0, 5764.682942438206, 9908.35595686278, 9921.65274215399, 9966.601335946481, 10078.949605251926, 10083.344582602107, 10006.0, 10122.949385253027, 10139.442330671884, 10401.84397234027, 10433.061024507831, 7615.847683046419, 7727.188645192174, 7924.0, 7946.64240109208, 7951.761447156595, 8430.494170349799, 8441.15588441151, 8443.535605541754, 8468.788280293042, 8525.147485251426, 7390.6674199660065, 7687.9231207689445, 7737.381009519338, 7790.571518566307, 7848.097468791162, 7485.0643669541305, 7546.811329716801, 7615.238476152341, 7718.112417072109, 7764.34003109742, 6715.764948226789, 6730.216492629359, 6750.763723269662, 6770.796876093725, 6774.593524388552, 5058.317127187783, 5155.793768249228, 5185.507376799198, 5284.603654725988, 5304.443033481429, 5121.334226550524, 5197.974010129925, 5231.084560202025, 5271.525562699376, 5318.468153184651], "value": 4414.362484630019, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.92602812310986, 316.46675352031826, 317.79343426772596, 322.77405815928853, 323.9643639199689, 5002.774875130619, 5223.033738758328, 5232.45059268777, 5259.342582177228, 5270.7364631768405, 5243.895122097565, 5249.238860365254, 5256.395514515832, 5258.710770907599, 5264.210368444736, 4145.564715704861, 4150.709450338478, 4153.54311025787, 4155.023569461174, 4179.352200408926, 3933.2920074386598, 4174.916501669964, 4175.434212170436, 4179.578943159325, 4181.080162364275, 4026.9597304027025, 4036.3138266494766, 4050.6759459243335, 4093.1609020150945, 4102.897427564305, 4030.0, 4037.4751282333254, 4049.2104039712267, 4054.3715724062818, 4064.5732198119067, 3579.731520136, 3583.426651735736, 3583.498310236569, 3594.1194407370363, 3596.5863925648364, 5010.949890501085, 5034.597232221414, 5127.308163214342, 5141.948580514184, 5162.328897243372, 4647.88380290492, 4651.767411629439, 4660.300954856764, 4666.486686464486, 4673.462551806551, 5468.808591699311, 5474.72626368684, 5475.67145971243, 5485.780568777244, 5489.231507588941, 3771.1891943232336, 3932.7247092703524, 3939.3500072488005, 3941.3102707026155, 3948.368261078214, 5286.365636123652, 5444.428335024805, 5610.803621873215, 5655.1517272409055, 5662.8301150965535, 3964.0, 3968.6825053995613, 3978.5822488638855, 3982.681385489154, 3982.74112182713, 3847.2110468632222, 3923.450716899579, 4015.13674559971, 4020.296448121567, 4041.191761647682, 4594.724316540952, 4598.356230127785, 4617.58441740245, 4621.936954500484, 4625.306204069349, 5478.698671573102, 5479.342478902558, 5480.80817171405, 5494.36814766307, 5495.3622261314795, 1350.3653282956996, 1372.5539199760117, 1374.924379159156, 1380.6134282400944, 1383.9584812455441, 878.872563478292, 883.1918794303269, 888.3470649072926, 890.3856339125982, 898.4429653614801, 4695.201815691273, 4710.152172608895, 4727.527247275245, 4740.605993973021, 4741.336212930192, 4995.525425084611, 4997.425296090996, 5007.774650140753, 5008.323876276656, 5015.517318927082, 4437.29003359461, 4673.813047478131, 4705.529447055335, 4716.268978308368, 4764.523547645208, 2595.8448490421583, 2610.2299821552306, 2630.2109367189764, 2634.1570697376656, 2659.7872170226337, 5056.9633225188745, 5102.464241254689, 5108.693478391308, 5111.539961403491, 5130.97434512825, 4676.883077923011, 5003.774830132653, 5026.4973502649445, 5027.0, 5029.924551131736, 5018.888289260682, 5040.647154699136, 5064.4935506449065, 5091.567216786615, 5107.693538387709, 4863.981447699165, 4909.4354149273295, 4933.802647894044, 4952.47998960104, 5314.441983591822, 5299.569116338644, 5562.22128901946, 5583.916241256466, 5593.860153496195, 5597.580181486486, 5754.395788442153, 5768.798092066758, 5804.245448091721, 5819.079703697854, 5822.7670893163795, 3876.2865993805012, 3983.2630963271886, 3983.521977362735, 3991.1419044905483, 3997.92004159921, 5602.607817452739, 5604.467575580314, 5608.691521966331, 5620.269364982526, 5620.550355971431, 5423.620346575702, 5425.918611220756, 5452.509274165185, 5456.208849716848, 5467.507924286833, 5199.76601052946, 5395.78416863321, 5406.2701535292235, 5424.484673955968, 5426.240326354393, 5307.0, 5332.173513105475, 5350.946490535045, 5356.437574054668, 5360.195970604441, 5333.573314134937, 5404.297441332602, 5439.891202176013, 5464.91802622953, 5478.91781623284, 5407.756650950795, 5409.241286943608, 5413.864653383697, 5420.864478388072, 5426.70153141581], "value": 4048.089501433893, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.237014543711, 682.5563383800533, 707.8548897476018, 716.1390245967361, 762.2149186338072, 15029.549113526598, 15396.923015384935, 16019.679606407864, 16084.597885052879, 16095.678086438278, 14435.639109022253, 14606.415743370253, 14633.341499632515, 14647.487337943174, 14697.92651036746, 782.6908371193362, 797.6211299632657, 801.1747899663357, 803.333233416263, 804.111456840192, 661.6790856434625, 782.4757412533617, 801.967921283148, 806.2058872011064, 810.9107998120202, 838.9580520973957, 840.9117042710519, 842.2419822160043, 842.7429633961639, 843.0473564871686, 834.3033566971617, 834.6744769539885, 834.92903103236, 835.2357592802579, 836.3727204596553, 499.23022883876746, 595.7289433307834, 606.3966353478318, 612.4334990134153, 613.6808859393091, 14815.629609259855, 14849.70300593982, 14884.479043233436, 14914.850851491563, 14936.32786524609, 12932.676683082904, 13103.934480327538, 13669.726605467835, 13679.14871093223, 13843.723125537534, 12250.509979600805, 12616.179948303423, 12696.301703406309, 12841.486340546368, 13418.060735748502, 4425.645948324126, 4425.9114817703785, 4431.225441192474, 4461.643068554507, 4598.126355992351, 78299.0, 79980.60009699973, 81078.59460702659, 81272.18727812705, 81885.0, 10810.459477026117, 10833.945830270799, 10845.945770271099, 10993.175511836644, 11387.08903287735, 20830.791692082887, 20947.476313092295, 21063.262785802424, 21095.367138985854, 21145.0, 8434.62044208012, 8540.829183416297, 8548.658053677907, 8628.0, 8682.044975052739, 4670.859874203779, 4756.738379389098, 4859.854204373874, 4887.877803054952, 5027.924581131286, 3417.760756747004, 3532.3818331791836, 3541.8229088545468, 3543.309054734302, 3546.858125674996, 653.2487639214846, 676.100785954679, 677.2110491277705, 692.9099217101744, 698.1656919980575, 619.5291578400448, 626.6866566716642, 642.3031011352734, 656.3108735827458, 662.2285037930853, 9596.856047159297, 9743.220542356594, 9800.607975680892, 9898.752531186778, 10055.949720251498, 615.4799194680488, 619.7242227208849, 659.0575477067744, 698.3400686351349, 698.5703792167781, 4514.0, 4743.407074115736, 4815.061063092663, 4823.456493921912, 5172.224166374998, 75818.0, 103925.96074039163, 123799.3810030962, 125266.0, 130349.34825325813, 65469.67265163739, 105062.47468762608, 107598.92401076046, 107807.0, 110538.44730776295, 95430.0, 98390.50804746074, 100071.0, 101481.0, 102520.48739756254, 9456.574454149717, 9742.0, 9925.702228932854, 10227.795444090927, 10296.433696146783, 47840.521594783604, 50152.0, 52054.0, 54308.45691543034, 54749.45250547603, 60029.0, 71918.28081719116, 72015.63992180006, 73403.26596734178, 74751.25248747443, 12285.447154878231, 12386.504539818307, 12510.31193284378, 12702.0, 13147.408366623333, 14040.368183431567, 14168.574942751733, 14210.0, 14450.771684406944, 14482.203478808766, 12325.445354958869, 12371.69070773202, 12500.562480313145, 12630.368481576068, 13302.933485332898, 12510.749785004431, 12517.436715347649, 12692.17500862441, 13332.200067995951, 13911.304434778018, 12771.61685149447, 12906.741865162832, 13479.0, 13585.660358491117, 13606.047576669935, 10301.381917084998, 10343.689689309333, 10498.580056797642, 10635.468226588795, 10826.837597436202, 10643.0, 10683.145348371956, 10841.512131953923, 10918.235723499596, 10936.453177340942], "value": 7496.315111987429, "unit": "score"}], "name": "dromaeo_css", "value": 7039.785307833408, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 111.0, 111.0, 111.0, 113.0, 112.0, 110.0, 111.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 120.0, 172.0, 118.0, 120.0, 144.0, 115.0, 153.0, 121.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 159.0, 162.0, 159.0, 160.0, 162.0, 161.0, 168.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 125.0, 75.0, 75.0, 74.0, 75.0, 97.0, 74.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 108.0, 92.0, 83.0, 84.0, 119.0, 84.0, 84.0, 124.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 53.0, 54.0, 52.0, 54.0, 53.0, 54.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 75.0, 76.0, 84.0, 75.0, 85.0, 76.0, 84.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 118.0, 122.0, 126.0, 117.0, 118.0, 127.0, 126.0, 194.0, 121.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 159.0, 157.0, 161.0, 161.0, 157.0, 160.0, 155.0, 161.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 63.0, 61.0, 61.0, 68.0, 63.0, 62.0, 62.0, 61.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1482.4, "alertThreshold": 2.0}]} 14:28:22 INFO - Return code: 0 14:28:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:28:22 INFO - # TBPL SUCCESS # 14:28:22 INFO - Running post-action listener: _resource_record_post_action 14:28:22 INFO - ##### 14:28:22 INFO - ##### Finished run-tests step (success) 14:28:22 INFO - ##### 14:28:22 INFO - Running post-run listener: _resource_record_post_run 14:28:22 INFO - Total resource usage - Wall time: 1214s; CPU: 13.0%; Read bytes: 466944; Write bytes: 300998656; Read time: 552; Write time: 1149016 14:28:22 INFO - TinderboxPrint: CPU usage
13.1% 14:28:22 INFO - TinderboxPrint: I/O read bytes / time
466,944 / 552 14:28:22 INFO - TinderboxPrint: I/O write bytes / time
300,998,656 / 1,149,016 14:28:22 INFO - TinderboxPrint: CPU idle
8,417.3 (86.9%) 14:28:22 INFO - TinderboxPrint: CPU user
1,197.3 (12.4%) 14:28:22 INFO - TinderboxPrint: Swap in / out
0 / 0 14:28:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5136384; Read time: 0; Write time: 1216 14:28:22 INFO - run-tests - Wall time: 1197s; CPU: 13.0%; Read bytes: 462848; Write bytes: 295862272; Read time: 544; Write time: 1147800 14:28:23 INFO - Running post-run listener: _upload_blobber_files 14:28:23 INFO - Blob upload gear active. 14:28:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:28:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:28:23 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'] 14:28:23 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 14:28:23 INFO - (blobuploader) - INFO - Open directory for files ... 14:28:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:28:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:28:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:24 INFO - (blobuploader) - INFO - Done attempting. 14:28:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:28:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:28:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:28 INFO - (blobuploader) - INFO - Done attempting. 14:28:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:28:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:28:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:28 INFO - (blobuploader) - INFO - Done attempting. 14:28:28 INFO - (blobuploader) - INFO - Iteration through files over. 14:28:28 INFO - Return code: 0 14:28:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:28:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:28:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/382fe90e4ba1e8f8d143cd2e60c270eef4a1c84ec4b86d35f8032f7f919b3fcf3d67ccd8be7f5fbbe44b6c1ac646f9ea5a00b7976c8f04f3dc8c47375c27d103", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8015ec6c572de8ff89d86e642d3d71b9543233007d49e09faea965992a9e1a7c07601b9992359660903dd2d0b49d72519e9fcc5a3ab046f111d5f03327925d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c56ab2553f046cb26fd828984e6ce0ebffc4269533aa96d00fd70bb86fb4fce7900286500a83b4bba367a8a2477aaabcb4c5f8371353b826cb95d35b7ea7bdc8"} 14:28:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:28:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:28:28 INFO - Contents: 14:28:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/382fe90e4ba1e8f8d143cd2e60c270eef4a1c84ec4b86d35f8032f7f919b3fcf3d67ccd8be7f5fbbe44b6c1ac646f9ea5a00b7976c8f04f3dc8c47375c27d103", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8015ec6c572de8ff89d86e642d3d71b9543233007d49e09faea965992a9e1a7c07601b9992359660903dd2d0b49d72519e9fcc5a3ab046f111d5f03327925d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c56ab2553f046cb26fd828984e6ce0ebffc4269533aa96d00fd70bb86fb4fce7900286500a83b4bba367a8a2477aaabcb4c5f8371353b826cb95d35b7ea7bdc8"} 14:28:28 INFO - Running post-run listener: copy_logs_to_upload_dir 14:28:28 INFO - Copying logs to upload dir... 14:28:28 INFO - mkdir: /builds/slave/test/build/upload/logs 14:28:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.353984 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-05 14:28:28.834132) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 14:28:28.837795) ========= 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=33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500 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/382fe90e4ba1e8f8d143cd2e60c270eef4a1c84ec4b86d35f8032f7f919b3fcf3d67ccd8be7f5fbbe44b6c1ac646f9ea5a00b7976c8f04f3dc8c47375c27d103", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8015ec6c572de8ff89d86e642d3d71b9543233007d49e09faea965992a9e1a7c07601b9992359660903dd2d0b49d72519e9fcc5a3ab046f111d5f03327925d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c56ab2553f046cb26fd828984e6ce0ebffc4269533aa96d00fd70bb86fb4fce7900286500a83b4bba367a8a2477aaabcb4c5f8371353b826cb95d35b7ea7bdc8"} build_url:https://queue.taskcluster.net/v1/task/UPB2nhzWQh2Az4g88PyzGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011133 build_url: 'https://queue.taskcluster.net/v1/task/UPB2nhzWQh2Az4g88PyzGw/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/382fe90e4ba1e8f8d143cd2e60c270eef4a1c84ec4b86d35f8032f7f919b3fcf3d67ccd8be7f5fbbe44b6c1ac646f9ea5a00b7976c8f04f3dc8c47375c27d103", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8015ec6c572de8ff89d86e642d3d71b9543233007d49e09faea965992a9e1a7c07601b9992359660903dd2d0b49d72519e9fcc5a3ab046f111d5f03327925d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c56ab2553f046cb26fd828984e6ce0ebffc4269533aa96d00fd70bb86fb4fce7900286500a83b4bba367a8a2477aaabcb4c5f8371353b826cb95d35b7ea7bdc8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 14:28:28.868990) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:28:28.869574) ========= 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=33d5923976266a1c518c4bf7000001ab-1467752839.486958-1346561500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:28:28.954480) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 14:28:28.955349) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 14:28:28.956077) ========= ========= Total master_lag: 0.18 =========