builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1467423900.51 results: success (0) buildid: 20160701182722 builduid: 3e59f01fdcd34c91b203e3bc051de09d revision: 49a1d28776b4a2867bb8818dfab61c352cc02f49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 18:45:00.514046) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 18:45:00.514649) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 18:45:00.514967) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 18:45:00.530130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 18:45:00.530411) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 18:45:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-07-01 18:45:01 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133105 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 18:45:00.680269) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 18:45:00.680820) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015197 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 18:45:00.749240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 18:45:00.749580) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 49a1d28776b4a2867bb8818dfab61c352cc02f49 --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 49a1d28776b4a2867bb8818dfab61c352cc02f49 --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=e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 18:45:01,794 truncating revision to first 12 chars 2016-07-01 18:45:01,794 Setting DEBUG logging. 2016-07-01 18:45:01,794 attempt 1/10 2016-07-01 18:45:01,794 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/49a1d28776b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 18:45:02,270 unpacking tar archive at: fx-team-49a1d28776b4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.902803 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 18:45:01.668600) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 18:45:01.668906) ========= script_repo_revision: 49a1d28776b4a2867bb8818dfab61c352cc02f49 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 18:45:01.669313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 18:45:01.669600) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 18:45:01.680595) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-01 18:45:01.680877) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:45:02 INFO - MultiFileLogger online at 20160701 18:45:02 in /builds/slave/test 18:45:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:45:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:45:02 INFO - {'append_to_log': False, 18:45:02 INFO - 'base_work_dir': '/builds/slave/test', 18:45:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:45:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:45:02 INFO - 'branch': 'Fx-Team-Non-PGO', 18:45:02 INFO - 'buildbot_json_path': 'buildprops.json', 18:45:02 INFO - 'config_files': ('talos/linux_config.py',), 18:45:02 INFO - 'default_actions': ('clobber', 18:45:02 INFO - 'read-buildbot-config', 18:45:02 INFO - 'download-and-extract', 18:45:02 INFO - 'populate-webroot', 18:45:02 INFO - 'create-virtualenv', 18:45:02 INFO - 'install', 18:45:02 INFO - 'run-tests'), 18:45:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:45:02 INFO - 'download_minidump_stackwalk': True, 18:45:02 INFO - 'download_symbols': 'ondemand', 18:45:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:45:02 INFO - 'tooltool.py': '/tools/tooltool.py', 18:45:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:45:02 INFO - '/tools/misc-python/virtualenv.py')}, 18:45:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:45:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:45:02 INFO - 'installer_path': 'installer.exe', 18:45:02 INFO - 'log_level': 'info', 18:45:02 INFO - 'log_name': 'talos', 18:45:02 INFO - 'log_to_console': True, 18:45:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:45:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:45:02 INFO - 'opt_config_files': (), 18:45:02 INFO - 'pip_index': False, 18:45:02 INFO - 'sps_profile': False, 18:45:02 INFO - 'sps_profile_interval': 0, 18:45:02 INFO - 'suite': 'dromaeojs', 18:45:02 INFO - 'system_bits': '32', 18:45:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:45:02 INFO - 'title': 'talos-linux64-ix-006', 18:45:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:45:02 INFO - 'use_talos_json': True, 18:45:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:45:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:45:02 INFO - 'work_dir': 'build'} 18:45:02 INFO - ##### 18:45:02 INFO - ##### Running clobber step. 18:45:02 INFO - ##### 18:45:02 INFO - Running pre-action listener: _resource_record_pre_action 18:45:02 INFO - Running main action method: clobber 18:45:02 INFO - rmtree: /builds/slave/test/build 18:45:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:45:03 INFO - Running post-action listener: _resource_record_post_action 18:45:03 INFO - ##### 18:45:03 INFO - ##### Finished clobber step (success) 18:45:03 INFO - ##### 18:45:03 INFO - ##### 18:45:03 INFO - ##### Running read-buildbot-config step. 18:45:03 INFO - ##### 18:45:03 INFO - Running pre-action listener: _resource_record_pre_action 18:45:03 INFO - Running main action method: read_buildbot_config 18:45:03 INFO - Using buildbot properties: 18:45:03 INFO - { 18:45:03 INFO - "project": "", 18:45:03 INFO - "product": "firefox", 18:45:03 INFO - "script_repo_revision": "production", 18:45:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:45:03 INFO - "repository": "", 18:45:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:45:03 INFO - "buildid": "20160701182722", 18:45:03 INFO - "pgo_build": "False", 18:45:03 INFO - "basedir": "/builds/slave/test", 18:45:03 INFO - "buildnumber": 1925, 18:45:03 INFO - "slavename": "talos-linux64-ix-006", 18:45:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:45:03 INFO - "platform": "ubuntu64_hw", 18:45:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:45:03 INFO - "branch": "fx-team", 18:45:03 INFO - "repo_path": "integration/fx-team", 18:45:03 INFO - "revision": "49a1d28776b4a2867bb8818dfab61c352cc02f49", 18:45:03 INFO - "stage_platform": "linux64", 18:45:03 INFO - "builduid": "3e59f01fdcd34c91b203e3bc051de09d", 18:45:03 INFO - "slavebuilddir": "test" 18:45:03 INFO - } 18:45:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:45:03 INFO - Running post-action listener: _resource_record_post_action 18:45:03 INFO - ##### 18:45:03 INFO - ##### Finished read-buildbot-config step (success) 18:45:03 INFO - ##### 18:45:03 INFO - ##### 18:45:03 INFO - ##### Running download-and-extract step. 18:45:03 INFO - ##### 18:45:03 INFO - Running pre-action listener: _resource_record_pre_action 18:45:03 INFO - Running main action method: download_and_extract 18:45:03 INFO - mkdir: /builds/slave/test/build/tests 18:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:03 INFO - https://queue.taskcluster.net/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:45:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:45:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:45:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/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 18:45:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/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 18:45:05 INFO - Downloaded 1361 bytes. 18:45:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:45:05 INFO - Using the following test package requirements: 18:45:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:45:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:45:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:45:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:05 INFO - u'jsshell-linux-x86_64.zip'], 18:45:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:45:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:45:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:45:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:45:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:45:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:45:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:05 INFO - https://queue.taskcluster.net/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:45:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:45:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:45:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/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 18:45:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/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 18:45:07 INFO - Downloaded 22704628 bytes. 18:45:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:45:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:45:08 INFO - Return code: 0 18:45:08 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 18:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:08 INFO - https://queue.taskcluster.net/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:45:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:45:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:45:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/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 18:45:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/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 18:45:09 INFO - Downloaded 22704628 bytes. 18:45:09 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'] 18:45:09 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 18:45:11 INFO - Return code: 0 18:45:11 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')]} 18:45:11 INFO - https://queue.taskcluster.net/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:45:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:45:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:45:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/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 18:45:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/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 18:45:13 INFO - Downloaded 14405242 bytes. 18:45:13 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'] 18:45:13 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 18:45:13 INFO - Return code: 0 18:45:13 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')]} 18:45:13 INFO - https://queue.taskcluster.net/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:45:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:45:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:45:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/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 18:45:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/endIu6WcR62CmpkOv9XWNw/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 18:45:15 INFO - Downloaded 56462589 bytes. 18:45:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:45:15 INFO - mkdir: /builds/slave/test/properties 18:45:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:45:15 INFO - Writing to file /builds/slave/test/properties/build_url 18:45:15 INFO - Contents: 18:45:15 INFO - build_url:https://queue.taskcluster.net/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:45:16 INFO - Running post-action listener: _resource_record_post_action 18:45:16 INFO - Running post-action listener: set_extra_try_arguments 18:45:16 INFO - ##### 18:45:16 INFO - ##### Finished download-and-extract step (success) 18:45:16 INFO - ##### 18:45:16 INFO - ##### 18:45:16 INFO - ##### Running populate-webroot step. 18:45:16 INFO - ##### 18:45:16 INFO - Running pre-action listener: _resource_record_pre_action 18:45:16 INFO - Running main action method: populate_webroot 18:45:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:45:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:45:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:45:16 INFO - '--tppagecycles', 18:45:16 INFO - '7'], 18:45:16 INFO - 'tests': ['tsvgm']}}, 18:45:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:45:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:45:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:45:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:45:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:45:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:45:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:16 INFO - 'talos_options': ['--disable-e10s'], 18:45:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:45:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:45:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:16 INFO - 'talos_options': ['--disable-e10s'], 18:45:16 INFO - 'tests': ['damp', 'tps']}, 18:45:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:16 INFO - 'tests': ['damp', 'tps']}, 18:45:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:45:16 INFO - 'tests': ['dromaeo_dom']}, 18:45:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:45:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:45:16 INFO - 'tests': ['basic_compositor_video']}, 18:45:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:45:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:45:16 INFO - 'tests': ['a11yr', 18:45:16 INFO - 'ts_paint', 18:45:16 INFO - 'tpaint', 18:45:16 INFO - 'sessionrestore', 18:45:16 INFO - 'sessionrestore_no_auto_restore', 18:45:16 INFO - 'tabpaint']}, 18:45:16 INFO - 'other-e10s': {'tests': ['a11yr', 18:45:16 INFO - 'ts_paint', 18:45:16 INFO - 'tpaint', 18:45:16 INFO - 'sessionrestore', 18:45:16 INFO - 'sessionrestore_no_auto_restore', 18:45:16 INFO - 'tabpaint']}, 18:45:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:45:16 INFO - 'ts_paint', 18:45:16 INFO - 'tpaint', 18:45:16 INFO - 'sessionrestore', 18:45:16 INFO - 'sessionrestore_no_auto_restore', 18:45:16 INFO - 'tabpaint']}, 18:45:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:45:16 INFO - 'ts_paint', 18:45:16 INFO - 'tpaint', 18:45:16 INFO - 'sessionrestore', 18:45:16 INFO - 'sessionrestore_no_auto_restore', 18:45:16 INFO - 'tabpaint']}, 18:45:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:45:16 INFO - 'tests': ['a11yr', 18:45:16 INFO - 'ts_paint', 18:45:16 INFO - 'tpaint', 18:45:16 INFO - 'sessionrestore', 18:45:16 INFO - 'sessionrestore_no_auto_restore', 18:45:16 INFO - 'tabpaint']}, 18:45:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:45:16 INFO - 'tests': ['a11yr', 18:45:16 INFO - 'ts_paint', 18:45:16 INFO - 'tpaint', 18:45:16 INFO - 'sessionrestore', 18:45:16 INFO - 'sessionrestore_no_auto_restore', 18:45:16 INFO - 'tabpaint']}, 18:45:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:45:16 INFO - 'tests': ['tsvgx', 18:45:16 INFO - 'tsvgr_opacity', 18:45:16 INFO - 'tart', 18:45:16 INFO - 'tscrollx', 18:45:16 INFO - 'cart']}, 18:45:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:45:16 INFO - 'tsvgr_opacity', 18:45:16 INFO - 'tart', 18:45:16 INFO - 'tscrollx', 18:45:16 INFO - 'cart']}, 18:45:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:16 INFO - 'talos_options': ['--disable-e10s'], 18:45:16 INFO - 'tests': ['tp5o']}, 18:45:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:16 INFO - 'tests': ['tp5o']}, 18:45:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:16 INFO - 'talos_options': ['--disable-e10s', 18:45:16 INFO - '--xperf_path', 18:45:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:45:16 INFO - 'tests': ['tp5n']}, 18:45:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:16 INFO - 'talos_options': ['--xperf_path', 18:45:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:45:16 INFO - 'tests': ['tp5n']}}, 18:45:16 INFO - 'talos.zip': {'path': '', 18:45:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:45:16 INFO - Running post-action listener: _resource_record_post_action 18:45:16 INFO - ##### 18:45:16 INFO - ##### Finished populate-webroot step (success) 18:45:16 INFO - ##### 18:45:16 INFO - ##### 18:45:16 INFO - ##### Running create-virtualenv step. 18:45:16 INFO - ##### 18:45:16 INFO - Running pre-action listener: _resource_record_pre_action 18:45:16 INFO - Running main action method: create_virtualenv 18:45:16 INFO - Creating virtualenv /builds/slave/test/build/venv 18:45:16 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 18:45:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:45:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:45:16 INFO - Using real prefix '/usr' 18:45:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:45:16 INFO - Installing distribute.............................................................................................................................................................................................done. 18:45:18 INFO - Installing pip.................done. 18:45:18 INFO - Return code: 0 18:45:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:45:18 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')]} 18:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:18 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')]} 18:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:18 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 0x10a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13603b0>, '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 0x13612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', '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 18:45:18 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 18:45:18 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 18:45:18 INFO - Using env: {'DISPLAY': ':0', 18:45:18 INFO - 'HOME': '/home/cltbld', 18:45:18 INFO - 'LANG': 'en_US.UTF-8', 18:45:18 INFO - 'LANGUAGE': 'en_US:en', 18:45:18 INFO - 'LOGNAME': 'cltbld', 18:45:18 INFO - 'MAIL': '/var/mail/cltbld', 18:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:18 INFO - 'MOZ_NO_REMOTE': '1', 18:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:18 INFO - 'NO_EM_RESTART': '1', 18:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:18 INFO - 'PWD': '/builds/slave/test', 18:45:18 INFO - 'SHELL': '/bin/bash', 18:45:18 INFO - 'SHLVL': '1', 18:45:18 INFO - 'TERM': 'linux', 18:45:18 INFO - 'TMOUT': '86400', 18:45:18 INFO - 'USER': 'cltbld', 18:45:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', 18:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:18 INFO - '_': '/tools/buildbot/bin/python'} 18:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:19 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 18:45:19 INFO - Cleaning up... 18:45:19 INFO - Return code: 0 18:45:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13603b0>, '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 0x13612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', '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 18:45:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:45:19 INFO - Using env: {'DISPLAY': ':0', 18:45:19 INFO - 'HOME': '/home/cltbld', 18:45:19 INFO - 'LANG': 'en_US.UTF-8', 18:45:19 INFO - 'LANGUAGE': 'en_US:en', 18:45:19 INFO - 'LOGNAME': 'cltbld', 18:45:19 INFO - 'MAIL': '/var/mail/cltbld', 18:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:19 INFO - 'MOZ_NO_REMOTE': '1', 18:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:19 INFO - 'NO_EM_RESTART': '1', 18:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:19 INFO - 'PWD': '/builds/slave/test', 18:45:19 INFO - 'SHELL': '/bin/bash', 18:45:19 INFO - 'SHLVL': '1', 18:45:19 INFO - 'TERM': 'linux', 18:45:19 INFO - 'TMOUT': '86400', 18:45:19 INFO - 'USER': 'cltbld', 18:45:19 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', 18:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:19 INFO - '_': '/tools/buildbot/bin/python'} 18:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:19 INFO - Downloading/unpacking psutil>=3.1.1 18:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:45:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:45:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:45:21 INFO - Installing collected packages: psutil 18:45:21 INFO - Running setup.py install for psutil 18:45:21 INFO - building 'psutil._psutil_linux' extension 18:45:21 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 18:45:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:45:21 INFO - building 'psutil._psutil_posix' extension 18:45:21 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 18:45:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:45:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:45:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:45:21 INFO - Successfully installed psutil 18:45:21 INFO - Cleaning up... 18:45:21 INFO - Return code: 0 18:45:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13603b0>, '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 0x13612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', '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 18:45:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:45:21 INFO - Using env: {'DISPLAY': ':0', 18:45:21 INFO - 'HOME': '/home/cltbld', 18:45:21 INFO - 'LANG': 'en_US.UTF-8', 18:45:21 INFO - 'LANGUAGE': 'en_US:en', 18:45:21 INFO - 'LOGNAME': 'cltbld', 18:45:21 INFO - 'MAIL': '/var/mail/cltbld', 18:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:21 INFO - 'MOZ_NO_REMOTE': '1', 18:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:21 INFO - 'NO_EM_RESTART': '1', 18:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:21 INFO - 'PWD': '/builds/slave/test', 18:45:21 INFO - 'SHELL': '/bin/bash', 18:45:21 INFO - 'SHLVL': '1', 18:45:21 INFO - 'TERM': 'linux', 18:45:21 INFO - 'TMOUT': '86400', 18:45:21 INFO - 'USER': 'cltbld', 18:45:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', 18:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:21 INFO - '_': '/tools/buildbot/bin/python'} 18:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:45:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:45:24 INFO - Installing collected packages: mozsystemmonitor 18:45:24 INFO - Running setup.py install for mozsystemmonitor 18:45:24 INFO - Successfully installed mozsystemmonitor 18:45:24 INFO - Cleaning up... 18:45:24 INFO - Return code: 0 18:45:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:45:24 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')]} 18:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:24 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')]} 18:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:24 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 0x10a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13603b0>, '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 0x13612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', '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 18:45:24 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 18:45:24 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 18:45:24 INFO - Using env: {'DISPLAY': ':0', 18:45:24 INFO - 'HOME': '/home/cltbld', 18:45:24 INFO - 'LANG': 'en_US.UTF-8', 18:45:24 INFO - 'LANGUAGE': 'en_US:en', 18:45:24 INFO - 'LOGNAME': 'cltbld', 18:45:24 INFO - 'MAIL': '/var/mail/cltbld', 18:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:24 INFO - 'MOZ_NO_REMOTE': '1', 18:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:24 INFO - 'NO_EM_RESTART': '1', 18:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:24 INFO - 'PWD': '/builds/slave/test', 18:45:24 INFO - 'SHELL': '/bin/bash', 18:45:24 INFO - 'SHLVL': '1', 18:45:24 INFO - 'TERM': 'linux', 18:45:24 INFO - 'TMOUT': '86400', 18:45:24 INFO - 'USER': 'cltbld', 18:45:24 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', 18:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:24 INFO - '_': '/tools/buildbot/bin/python'} 18:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:24 INFO - Downloading/unpacking jsonschema==2.5.1 18:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:45:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:26 INFO - Downloading functools32-3.2.3-2.tar.gz 18:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:45:26 INFO - warning: no files found matching '*.txt' 18:45:26 INFO - no previously-included directories found matching 'build' 18:45:26 INFO - no previously-included directories found matching 'dist' 18:45:26 INFO - no previously-included directories found matching '.git*' 18:45:26 INFO - Installing collected packages: jsonschema, functools32 18:45:26 INFO - Running setup.py install for functools32 18:45:26 INFO - warning: no files found matching '*.txt' 18:45:26 INFO - no previously-included directories found matching 'build' 18:45:26 INFO - no previously-included directories found matching 'dist' 18:45:26 INFO - no previously-included directories found matching '.git*' 18:45:26 INFO - Successfully installed jsonschema functools32 18:45:26 INFO - Cleaning up... 18:45:26 INFO - Return code: 0 18:45:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:45: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')]} 18:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45: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')]} 18:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13603b0>, '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 0x13612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', '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 18:45:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:45:26 INFO - Using env: {'DISPLAY': ':0', 18:45:26 INFO - 'HOME': '/home/cltbld', 18:45:26 INFO - 'LANG': 'en_US.UTF-8', 18:45:26 INFO - 'LANGUAGE': 'en_US:en', 18:45:26 INFO - 'LOGNAME': 'cltbld', 18:45:26 INFO - 'MAIL': '/var/mail/cltbld', 18:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:26 INFO - 'MOZ_NO_REMOTE': '1', 18:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:26 INFO - 'NO_EM_RESTART': '1', 18:45:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:26 INFO - 'PWD': '/builds/slave/test', 18:45:26 INFO - 'SHELL': '/bin/bash', 18:45:26 INFO - 'SHLVL': '1', 18:45:26 INFO - 'TERM': 'linux', 18:45:26 INFO - 'TMOUT': '86400', 18:45:26 INFO - 'USER': 'cltbld', 18:45:26 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', 18:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:26 INFO - '_': '/tools/buildbot/bin/python'} 18:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:26 INFO - Downloading/unpacking blobuploader==1.2.4 18:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:28 INFO - Downloading blobuploader-1.2.4.tar.gz 18:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:45:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:45:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:45:29 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 18:45:29 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 18:45:29 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 18:45:29 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 18:45:29 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 18:45:29 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 18:45:29 INFO - Downloading docopt-0.6.1.tar.gz 18:45:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:45:29 INFO - Installing collected packages: blobuploader, requests, docopt 18:45:29 INFO - Running setup.py install for blobuploader 18:45:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:45:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:45:29 INFO - Running setup.py install for requests 18:45:30 INFO - Running setup.py install for docopt 18:45:30 INFO - Successfully installed blobuploader requests docopt 18:45:30 INFO - Cleaning up... 18:45:30 INFO - Return code: 0 18:45:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45: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')]} 18:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45: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')]} 18:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:30 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 0x10a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13603b0>, '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 0x13612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', '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 18:45:30 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 18:45:30 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 18:45:30 INFO - Using env: {'DISPLAY': ':0', 18:45:30 INFO - 'HOME': '/home/cltbld', 18:45:30 INFO - 'LANG': 'en_US.UTF-8', 18:45:30 INFO - 'LANGUAGE': 'en_US:en', 18:45:30 INFO - 'LOGNAME': 'cltbld', 18:45:30 INFO - 'MAIL': '/var/mail/cltbld', 18:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:30 INFO - 'MOZ_NO_REMOTE': '1', 18:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:30 INFO - 'NO_EM_RESTART': '1', 18:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:30 INFO - 'PWD': '/builds/slave/test', 18:45:30 INFO - 'SHELL': '/bin/bash', 18:45:30 INFO - 'SHLVL': '1', 18:45:30 INFO - 'TERM': 'linux', 18:45:30 INFO - 'TMOUT': '86400', 18:45:30 INFO - 'USER': 'cltbld', 18:45:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', 18:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:30 INFO - '_': '/tools/buildbot/bin/python'} 18:45:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:45:30 INFO - Running setup.py (path:/tmp/pip-4MtI3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:45:30 INFO - Running setup.py (path:/tmp/pip-MZPGu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:45:30 INFO - Running setup.py (path:/tmp/pip-RwYTha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:45:30 INFO - Running setup.py (path:/tmp/pip-u3fSsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:45:30 INFO - Running setup.py (path:/tmp/pip-wQKjLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:45:30 INFO - Running setup.py (path:/tmp/pip-9eylq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:45:30 INFO - Running setup.py (path:/tmp/pip-tn1tNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:45:30 INFO - Running setup.py (path:/tmp/pip-DYHx_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:45:30 INFO - Running setup.py (path:/tmp/pip-aGqrIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:45:31 INFO - Running setup.py (path:/tmp/pip-E23iOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:45:31 INFO - Running setup.py (path:/tmp/pip-mIGNod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:45:31 INFO - Running setup.py (path:/tmp/pip-caX7V9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:45:31 INFO - Running setup.py (path:/tmp/pip-HHT0q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:45:31 INFO - Running setup.py (path:/tmp/pip-pVYWT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:31 INFO - Running setup.py (path:/tmp/pip-QiPP27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:45:31 INFO - Running setup.py (path:/tmp/pip-d672of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:45:31 INFO - Running setup.py (path:/tmp/pip-sXxMLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:45:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:45:31 INFO - Running setup.py install for manifestparser 18:45:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:45:31 INFO - Running setup.py install for mozcrash 18:45:31 INFO - Running setup.py install for mozdebug 18:45:31 INFO - Running setup.py install for mozdevice 18:45:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:45:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:45:32 INFO - Running setup.py install for mozfile 18:45:32 INFO - Running setup.py install for mozhttpd 18:45:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:45:32 INFO - Running setup.py install for mozinfo 18:45:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:45:32 INFO - Running setup.py install for mozInstall 18:45:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:45:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:45:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:45:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:45:32 INFO - Running setup.py install for mozleak 18:45:32 INFO - Running setup.py install for mozlog 18:45:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:45:32 INFO - Running setup.py install for moznetwork 18:45:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:45:32 INFO - Running setup.py install for mozprocess 18:45:32 INFO - Running setup.py install for mozprofile 18:45:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:45:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:45:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:45:33 INFO - Running setup.py install for mozrunner 18:45:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:45:33 INFO - Running setup.py install for mozscreenshot 18:45:33 INFO - Running setup.py install for moztest 18:45:33 INFO - Running setup.py install for mozversion 18:45:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:45:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:45:33 INFO - Cleaning up... 18:45:33 INFO - Return code: 0 18:45:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13603b0>, '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 0x13612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', '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 18:45:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:45:33 INFO - Using env: {'DISPLAY': ':0', 18:45:33 INFO - 'HOME': '/home/cltbld', 18:45:33 INFO - 'LANG': 'en_US.UTF-8', 18:45:33 INFO - 'LANGUAGE': 'en_US:en', 18:45:33 INFO - 'LOGNAME': 'cltbld', 18:45:33 INFO - 'MAIL': '/var/mail/cltbld', 18:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:33 INFO - 'MOZ_NO_REMOTE': '1', 18:45:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:33 INFO - 'NO_EM_RESTART': '1', 18:45:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:33 INFO - 'PWD': '/builds/slave/test', 18:45:33 INFO - 'SHELL': '/bin/bash', 18:45:33 INFO - 'SHLVL': '1', 18:45:33 INFO - 'TERM': 'linux', 18:45:33 INFO - 'TMOUT': '86400', 18:45:33 INFO - 'USER': 'cltbld', 18:45:33 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', 18:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:33 INFO - '_': '/tools/buildbot/bin/python'} 18:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:45:33 INFO - Running setup.py (path:/tmp/pip-9rvXXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:45:33 INFO - Running setup.py (path:/tmp/pip-o2YmSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:45:33 INFO - Running setup.py (path:/tmp/pip-RGunNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:45:33 INFO - Running setup.py (path:/tmp/pip-zx0eIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:45:33 INFO - Running setup.py (path:/tmp/pip-Ozd0mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:45:34 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)) 18:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:45:34 INFO - Running setup.py (path:/tmp/pip-NV56Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:45:34 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)) 18:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:45:34 INFO - Running setup.py (path:/tmp/pip-Nk9Bv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:45:34 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)) 18:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:45:34 INFO - Running setup.py (path:/tmp/pip-XyO5J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:45:34 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)) 18:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:45:34 INFO - Running setup.py (path:/tmp/pip-IQy0gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:45:34 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)) 18:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:45:34 INFO - Running setup.py (path:/tmp/pip-dkEWvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:45:34 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)) 18:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:45:34 INFO - Running setup.py (path:/tmp/pip-ypqvzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:45:34 INFO - Running setup.py (path:/tmp/pip-hqTf1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:45:34 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)) 18:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:45:34 INFO - Running setup.py (path:/tmp/pip-0X6Mc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:45:34 INFO - Running setup.py (path:/tmp/pip-FZaaO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:45:34 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)) 18:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:34 INFO - Running setup.py (path:/tmp/pip-nZ92mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:45:34 INFO - Running setup.py (path:/tmp/pip-uOj5YM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:45:34 INFO - Running setup.py (path:/tmp/pip-9P2hjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:45:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:36 INFO - Downloading blessings-1.6.tar.gz 18:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:45:36 INFO - Installing collected packages: blessings 18:45:36 INFO - Running setup.py install for blessings 18:45:37 INFO - Successfully installed blessings 18:45:37 INFO - Cleaning up... 18:45:37 INFO - Return code: 0 18:45:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:45:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:45:37 INFO - Reading from file tmpfile_stdout 18:45:37 INFO - Current package versions: 18:45:37 INFO - argparse == 1.2.1 18:45:37 INFO - blessings == 1.6 18:45:37 INFO - blobuploader == 1.2.4 18:45:37 INFO - docopt == 0.6.1 18:45:37 INFO - functools32 == 3.2.3-2 18:45:37 INFO - jsonschema == 2.5.1 18:45:37 INFO - manifestparser == 1.1 18:45:37 INFO - mozInstall == 1.12 18:45:37 INFO - mozcrash == 0.17 18:45:37 INFO - mozdebug == 0.1 18:45:37 INFO - mozdevice == 0.48 18:45:37 INFO - mozfile == 1.2 18:45:37 INFO - mozhttpd == 0.7 18:45:37 INFO - mozinfo == 0.9 18:45:37 INFO - mozleak == 0.1 18:45:37 INFO - mozlog == 3.2 18:45:37 INFO - moznetwork == 0.27 18:45:37 INFO - mozprocess == 0.22 18:45:37 INFO - mozprofile == 0.28 18:45:37 INFO - mozrunner == 6.11 18:45:37 INFO - mozscreenshot == 0.1 18:45:37 INFO - mozsystemmonitor == 0.3 18:45:37 INFO - moztest == 0.7 18:45:37 INFO - mozversion == 1.4 18:45:37 INFO - psutil == 3.1.1 18:45:37 INFO - requests == 1.2.3 18:45:37 INFO - wsgiref == 0.1.2 18:45:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:37 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 0x10a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13603b0>, '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 0x13612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', '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 18:45:37 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 18:45:37 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 18:45:37 INFO - Using env: {'DISPLAY': ':0', 18:45:37 INFO - 'HOME': '/home/cltbld', 18:45:37 INFO - 'LANG': 'en_US.UTF-8', 18:45:37 INFO - 'LANGUAGE': 'en_US:en', 18:45:37 INFO - 'LOGNAME': 'cltbld', 18:45:37 INFO - 'MAIL': '/var/mail/cltbld', 18:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:37 INFO - 'MOZ_NO_REMOTE': '1', 18:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:37 INFO - 'NO_EM_RESTART': '1', 18:45:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:37 INFO - 'PWD': '/builds/slave/test', 18:45:37 INFO - 'SHELL': '/bin/bash', 18:45:37 INFO - 'SHLVL': '1', 18:45:37 INFO - 'TERM': 'linux', 18:45:37 INFO - 'TMOUT': '86400', 18:45:37 INFO - 'USER': 'cltbld', 18:45:37 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', 18:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:37 INFO - '_': '/tools/buildbot/bin/python'} 18:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:45:37 INFO - Cleaning up... 18:45:37 INFO - Return code: 0 18:45:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13603b0>, '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 0x13612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', '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 18:45:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:45:37 INFO - Using env: {'DISPLAY': ':0', 18:45:37 INFO - 'HOME': '/home/cltbld', 18:45:37 INFO - 'LANG': 'en_US.UTF-8', 18:45:37 INFO - 'LANGUAGE': 'en_US:en', 18:45:37 INFO - 'LOGNAME': 'cltbld', 18:45:37 INFO - 'MAIL': '/var/mail/cltbld', 18:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:37 INFO - 'MOZ_NO_REMOTE': '1', 18:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:37 INFO - 'NO_EM_RESTART': '1', 18:45:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:37 INFO - 'PWD': '/builds/slave/test', 18:45:37 INFO - 'SHELL': '/bin/bash', 18:45:37 INFO - 'SHLVL': '1', 18:45:37 INFO - 'TERM': 'linux', 18:45:37 INFO - 'TMOUT': '86400', 18:45:37 INFO - 'USER': 'cltbld', 18:45:37 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', 18:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:37 INFO - '_': '/tools/buildbot/bin/python'} 18:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:45:37 INFO - Cleaning up... 18:45:37 INFO - Return code: 0 18:45:37 INFO - Running post-action listener: _resource_record_post_action 18:45:37 INFO - Running post-action listener: _start_resource_monitoring 18:45:37 INFO - Starting resource monitoring. 18:45:37 INFO - ##### 18:45:37 INFO - ##### Finished create-virtualenv step (success) 18:45:37 INFO - ##### 18:45:37 INFO - ##### 18:45:37 INFO - ##### Running install step. 18:45:37 INFO - ##### 18:45:37 INFO - Running pre-action listener: _resource_record_pre_action 18:45:37 INFO - Running main action method: install 18:45:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:45:37 INFO - Reading from file tmpfile_stdout 18:45:37 INFO - Detecting whether we're running mozinstall >=1.0... 18:45:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:45:38 INFO - Reading from file tmpfile_stdout 18:45:38 INFO - Output received: 18:45:38 INFO - Usage: mozinstall [options] installer 18:45:38 INFO - Options: 18:45:38 INFO - -h, --help show this help message and exit 18:45:38 INFO - -d DEST, --destination=DEST 18:45:38 INFO - Directory to install application into. [default: 18:45:38 INFO - "/builds/slave/test"] 18:45:38 INFO - --app=APP Application being installed. [default: firefox] 18:45:38 INFO - mkdir: /builds/slave/test/build/application 18:45:38 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'] 18:45:38 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 18:45:54 INFO - Reading from file tmpfile_stdout 18:45:54 INFO - Output received: 18:45:54 INFO - /builds/slave/test/build/application/firefox/firefox 18:45:54 INFO - Running post-action listener: _resource_record_post_action 18:45:54 INFO - ##### 18:45:54 INFO - ##### Finished install step (success) 18:45:54 INFO - ##### 18:45:54 INFO - ##### 18:45:54 INFO - ##### Running run-tests step. 18:45:54 INFO - ##### 18:45:54 INFO - Running pre-action listener: _resource_record_pre_action 18:45:54 INFO - Running main action method: run_tests 18:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:45:54 INFO - Python 2.7.3 18:45:54 INFO - Return code: 0 18:45:54 INFO - grabbing minidump binary from tooltool 18:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13603b0>, '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 0x13612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:45:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:45:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:45:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:45:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:45:54 INFO - Return code: 0 18:45:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:45:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:45:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:45:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:45:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 18:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 18:45:54 INFO - Using env: {'DISPLAY': ':0', 18:45:54 INFO - 'HOME': '/home/cltbld', 18:45:54 INFO - 'LANG': 'en_US.UTF-8', 18:45:54 INFO - 'LANGUAGE': 'en_US:en', 18:45:54 INFO - 'LOGNAME': 'cltbld', 18:45:54 INFO - 'MAIL': '/var/mail/cltbld', 18:45:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:45:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:54 INFO - 'MOZ_NO_REMOTE': '1', 18:45:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:54 INFO - 'NO_EM_RESTART': '1', 18:45:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:54 INFO - 'PWD': '/builds/slave/test', 18:45:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:45:54 INFO - 'SHELL': '/bin/bash', 18:45:54 INFO - 'SHLVL': '1', 18:45:54 INFO - 'TERM': 'linux', 18:45:54 INFO - 'TMOUT': '86400', 18:45:54 INFO - 'USER': 'cltbld', 18:45:54 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818', 18:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:54 INFO - '_': '/tools/buildbot/bin/python'} 18:45:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 18:45:54 INFO - mozversion application_buildid: 20160701182722 18:45:54 INFO - mozversion application_changeset: 49a1d28776b4a2867bb8818dfab61c352cc02f49 18:45:54 INFO - mozversion application_display_name: Nightly 18:45:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:45:54 INFO - mozversion application_name: Firefox 18:45:54 INFO - mozversion application_remotingname: firefox 18:45:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:45:54 INFO - mozversion application_vendor: Mozilla 18:45:54 INFO - mozversion application_version: 50.0a1 18:45:54 INFO - mozversion platform_buildid: 20160701182722 18:45:54 INFO - mozversion platform_changeset: 49a1d28776b4a2867bb8818dfab61c352cc02f49 18:45:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:45:54 INFO - mozversion platform_version: 50.0a1 18:45:54 INFO - using testdate: 1467423954 18:45:54 INFO - actual date: 1467423954 18:45:54 INFO - starting webserver on 'localhost:51964' 18:45:54 INFO - SUITE-START | Running 2 tests 18:45:54 INFO - TEST-START | dromaeo_css 18:45:54 INFO - operating with platform_type : linux_ 18:45:54 INFO - Initialising browser for dromaeo_css test... 18:45:54 INFO - TEST-INFO | started process 27350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAT48q6/profile http://localhost:51964/getInfo.html) 18:45:58 INFO - PROCESS | 27350 | __metrics Screen width/height:1600/1200 18:45:58 INFO - PROCESS | 27350 | colorDepth:24 18:45:58 INFO - PROCESS | 27350 | Browser inner width/height: 1024/697 18:45:58 INFO - PROCESS | 27350 | __metrics 18:45:59 INFO - PROCESS | 27350 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:46:00 INFO - TEST-INFO | 27350: exit 0 18:46:00 INFO - Browser initialized. 18:46:00 INFO - Running cycle 1/1 for dromaeo_css test... 18:46:00 INFO - TEST-INFO | started process 27433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAT48q6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:46:12 INFO - PROCESS | 27433 | RSS: Main: 158941184 18:46:12 INFO - PROCESS | 27433 | 18:47:03 INFO - PROCESS | 27433 | 1467424023255 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] 18:49:16 INFO - PROCESS | 27433 | Cycle 1(1): loaded http://localhost:51964/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51964/tests/dromaeo/cssquery-ext.html) 18:49:17 INFO - PROCESS | 27433 | RSS: Main: 252801024 18:49:17 INFO - PROCESS | 27433 | 18:52:20 INFO - PROCESS | 27433 | Cycle 1(1): loaded http://localhost:51964/tests/dromaeo/cssquery-ext.html (next: http://localhost:51964/tests/dromaeo/cssquery-jquery.html) 18:52:20 INFO - PROCESS | 27433 | RSS: Main: 244482048 18:52:20 INFO - PROCESS | 27433 | 18:55:23 INFO - PROCESS | 27433 | Cycle 1(1): loaded http://localhost:51964/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51964/tests/dromaeo/cssquery-mootools.html) 18:55:23 INFO - PROCESS | 27433 | RSS: Main: 245350400 18:55:23 INFO - PROCESS | 27433 | 18:58:26 INFO - PROCESS | 27433 | Cycle 1(1): loaded http://localhost:51964/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51964/tests/dromaeo/cssquery-prototype.html) 18:58:26 INFO - PROCESS | 27433 | RSS: Main: 233762816 18:58:26 INFO - PROCESS | 27433 | 19:01:29 INFO - PROCESS | 27433 | Cycle 1(1): loaded http://localhost:51964/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51964/tests/dromaeo/cssquery-yui.html) 19:01:30 INFO - PROCESS | 27433 | RSS: Main: 217452544 19:01:30 INFO - PROCESS | 27433 | 19:04:33 INFO - PROCESS | 27433 | Cycle 1(1): loaded http://localhost:51964/tests/dromaeo/cssquery-yui.html (next: http://localhost:51964/tests/dromaeo/cssquery-dojo.html) 19:04:33 INFO - PROCESS | 27433 | RSS: Main: 273989632 19:04:33 INFO - PROCESS | 27433 | 19:04:33 INFO - PROCESS | 27433 | __start_tp_report 19:04:33 INFO - PROCESS | 27433 | _x_x_mozilla_page_load 19:04:33 INFO - PROCESS | 27433 | _x_x_mozilla_page_load_details 19:04:33 INFO - PROCESS | 27433 | |i|pagename|runs| 19:04:33 INFO - PROCESS | 27433 | |0;dojo.html;2637.393399518111;2657.0833062593424;2672.4387878545504;2695.9460810783785;2699.041840146747;4746.501617330174;4807.903841923164;4842.322074909515;4884.316195732596;4930.186519224329;4785.258284965836;4798.688085274454;4813.56677898989;4881.072596206718;4887.1447496688115;4372.060007098466;4465.933011004838;4469.329600559926;4526.207913615121;4647.674662773607;4543.159515489629;4567.680262381635;4583.129205450954;4599.563041511051;4619.538046195387;4409.492908315537;4432.401625780511;4460.018795864937;4460.353248778909;4511.661625378109;4470.396496472967;4474.351219073249;4477.686561940665;4483.506814250462;4531.410916580857;4498.8425405110665;4506.639468842517;4519.548045195487;4536.455625324982;4581.885452863672;4740.620750339965;4842.709437433765;4894.853154405374;4962.206047032493;4978.178600530908;5315.149576067849;5317.627766056377;5325.760340784635;5329.120695085307;5343;5311.548518375943;5311.601629877736;5317.867053323659;5340.652857564246;5352.4915133062295;4785.019071090418;4875.780589873393;4890.193118135503;4924.901501969941;4925.088858561106;5420.756065977041;5430.67415955044;5433.049216387117;5434.945650543523;5494.5054945055135;5233.502817232356;5264.15773476242;5271.762770675329;5277.076511610453;5282.128448805981;5019.573336266459;5175.45657705943;5196.558292545101;5219.686818790885;5238.528532432099;5159.122949098587;5163.690178589297;5181.766820493087;5188.507091826271;5223.503767142115;4986.875328116754;5140.126178549655;5148.613853960968;5149;5156.020356132323;4378.387025816324;4420.115976804652;4435.889102772392;4437.622802061861;4441.20058389493;3860.575336712959;3878.5733569307354;3891.2606604745006;3892.1048158923604;3924.293627147084;4483.461984561874;4483.955160448354;4523.072770082125;4531.18438681034;4537.863864084083;5179.067767801832;5211.42674305826;5217.713025783618;5225.764840582183;5275.20871869215;4351.477822661238;4455.242608756519;4483.30508771141;4483.955160448419;4490.842820501332;4779.522047795263;4779.689320194177;4782.713037217778;4793.736344501016;4826.444958829779;4889.804407823718;4893.412790465167;4899.020195960893;4900.656954013256;4960.801567937314;5099.26060721186;5202.921956170585;5247.055530004636;5284.180951952453;5339.359276886798;4938.703677779345;4945.406551213878;4983.950160498349;4989.852333963281;4992.425871024733;5186.2479940409185;5189.922151167811;5191.740412979411;5194.961007798531;5245.632805703564;5125.103106956193;5225.477452254896;5233.476652334736;5241.764120614505;5243.030039442715;5101.69389836611;5145.588352931832;5149.382074150976;5151.2788209649925;5202.063628546898;5131.4868513148385;5160.690358578498;5161.690298582097;5163.6127290454115;5211.687298762086;4843;4971.875703107451;5002.299678045149;5080.364954380702;5085.338905942352;5093.719845408538;5112.079825631422;5114.667546609458;5129.2306154075695;5160;5047.041062198171;5050.646454748133;5051.6716413433005;5056.191009438472;5101.107306221471 19:04:33 INFO - PROCESS | 27433 | |1;ext.html;548.0112569486623;578.2569398323153;582.382674365173;593.7120496559168;605.2434456928839;27623.30941726458;30381.696183038162;30403.087907362788;30417.54373684391;30509;30021;30780.53829192564;40938;42169.156616867724;42324.57675423245;7690.115636701767;7817.6091195440285;7818.530888146701;7823.569703666296;7828.765137045869;7916.920830791676;8002.119766825645;8009.759707208793;8010.359171266314;8012;7695.461317707763;7975.641096150658;7975.7607271781935;8219.13699061596;10090.445025523593;10048.497575121215;10415.895841041569;10425.530851111718;10429.374237545695;10431.999999999962;10120.645777397756;10196.74508137295;10200.846987295197;10202.897971020344;10203.693889183336;30641.233969150726;31315.686843131505;31343.84328078368;39188.412173817414;39453.60546394557;3092.6443459002053;3160.478521044025;3177.413018940178;3258.6904244096772;3643.453481977698;30107.601458465477;30294.54558181629;30533.847330763427;30561.69438305633;30605.69394306073;3594.8741794037346;3615.8553657853654;3686.3548878946076;3704.722145839046;3805.276997370491;276595;276699;276740;276927;277446;47812.760936195096;49524.25713614299;49624.751876240385;55500.72249638726;55544.44455555393;46610;56470.435295646515;58670.70664646735;58739;63608.363916361166;13771.380287887068;13934.37295321713;13995.580132596038;14005.859941400455;14013.159210447202;10859.78280434387;10937.398443085547;10957.06864916475;10957.561697532168;10965.177611679155;16298.185090745415;16523.917380413022;16533.58666033335;16571.171441428123;16596;4783.521647835259;5249;5975.492083172979;6030.33666296707;6034.879302413927;809.2554849538438;920.6271460058687;970.2819913264134;1007.2143727892255;1041;24659.260222193363;24993.75006249914;25064.87467562687;25129.62305565418;25132.623010654854;947.966821161256;1003.1272792670278;1017.8931212222758;1082.5615625671458;1084.3331351219101;14497;14617.78073328901;14959.700805983819;15149.394024239127;15203.315850786741;397666;398233;398854;399300;401720;43076.78461607735;48273.27590086152;50153;50313.24530132051;50494.49505504898;1204.8253003314471;1224.2899118511064;1231.132051903406;1237.5520640850227;1244.1291096232853;28840.423191536473;29480.262993425335;29729.554056689598;30200.84899575488;30279;44579;45031.54968450405;45045.774771125936;45064.324035140155;45080.77459612681;350272;394883;403888;404432;571157.0095046819;25304.240872773848;25306.367340816625;25319.493610128062;25353.619695704212;25629;42268.577314226466;42373;43102.35346469868;43326.350104749086;43771.781141095365;37138.44292335563;37164.81417593003;37552;37581.81209093937;38147;37331.81334093312;37441;37493.250134996604;37538.2492350146;37959.81020094882;36108;36641.63358366489;36796.080097997765;37054.8147259262;37085;32640.183995400304;33178.33643327168;33303.83348083244;33403;33404.832975834965;24864.25407237786;25374.238772836845;25598.360040999123;25717.35706607275;25775.613365799152 19:04:33 INFO - PROCESS | 27433 | |2;jquery.html;342.8469213340221;364.46241793354795;366.58026559589257;373.667435981976;385.19302062179725;13315.933420332896;16385.50843474696;16946.74579881301;18011;18963.241470341203;17032.574185645364;17108.657826843486;17143.31426742932;17472.563185920357;17502.474925752216;5090.490950904898;5091.236314552819;5263.078961181797;5270.4729527047375;5270.868228294285;3802.524684414448;5165.328507294046;5179.404368497633;5808.535317174616;6074.149619053314;6142.84642883927;6150.784722534712;6152.077188421727;6162.722677479502;6171.382861713838;6002.819915402523;6114.8777024459705;6163.9383606164265;6179.042248451452;6191.226096737908;3403.7447191460737;5027.4469808321055;5360.705161216131;5430.945690543123;5455.208994695787;21424.78575214259;21507.46231344213;21574.352769416942;21833.235836745636;22067.33797986063;2013.2148462099792;2033.1359172351692;2088.812006919369;2299.563083014222;2435.0138194031447;13756.46609721824;13867.930660346734;13887.861121388758;14114.576562703136;14466.276686165755;1726.1369315342329;1772.4062439082923;1800.8919464832152;1805.8555315574854;1811.610503741702;61965.38034619641;66091;66504.3349566503;77210.61394692991;77500;8966.103389661112;9507.477088760184;10008.09927106564;10176.847347289797;10356.689299321033;12647.747045059232;13637.249951252577;13639;14000.649983750283;14081.929590351983;7047;7191.568505889663;7208.963955180296;7220.241874603196;7283.4537409694485;6657.733690652417;6868.9313106869295;6888.276730943179;7007.789766307019;7021.1574611047;4458.910821783611;4479.260921947907;4485.147821913826;4497.280435130363;4547.840825571089;1824.9817501824812;1857.4799056264267;1862.9441116766247;1869.1121717184228;1874.100431792747;816.5386556595505;867.5835598912557;916.1479823763964;980.2452111873818;987.4618333008527;17025.829741702673;17752.822471775376;17833.375831845824;17917.910410448127;18305.63388732218;848.6817443458702;883.0330787787362;893.1693525021662;913.9680111196076;934.2852717670987;9471.905280947103;9927;9974.351667141613;10045.095941365313;10064.647737329158;301215;308279;308820;375027;408149;86057.5697121523;91189.54405228065;92879.53560232156;94309;94475.52762236282;878.0166213840668;892.2193081054078;898.2634239923331;917.3945196170496;922.423485321674;16450;16497.83502165011;16741.83258167403;16981.150942453074;17156.914215428842;28040;28729.56905646375;38033;40606.79696601498;41559;56784.43215567957;58976.70511647414;59200.407995919486;59692.70153649204;60420;7722.806929826575;7997.160298168841;8038.87941680887;8080.959595201986;8097.878531822145;11962.46168922418;12387;12390.3185324808;12392.56626018085;12457.688557786129;10348.430836303774;10389.168866490512;10633.20250981195;10760.3543787373;11084.667459976214;10681.786364272515;10753.946230268799;10754.677359679223;10975.121990240921;11143.94428027887;10835.187360947803;10961.725956851142;10997.175211859303;11012.449377531251;11069;7965.601719913865;7972.760817175494;7979.162187970412;7989.960050199712;8117.147699491468;10222.48887555634;10502.107320877505;10690.465476726287;10991.835122473009;11077.16921230927 19:04:33 INFO - PROCESS | 27433 | |3;mootools.html;1207.643745095197;1287.073307218802;1372.7529044771943;1375.1542801177277;1684.7641330213771;6850.7602233921825;7580.734674286401;7844.882326765103;7851.528908265508;8052.879206811903;7770.33952114071;7845.80385490363;7858.253465920729;7885.960570197141;7894.5657988810735;1890.1210936914333;2139.058814121789;2182.847200695952;2199.83501237407;2219.1789038055863;2233.932982010542;2257.052038143975;2259.1302348595746;2259.9435014124615;2260.7513173550897;2189.9233526826565;2195.835312351572;2231;2232.944176395595;2235.731712194539;1848.6949653307256;2093.194120263694;2161.945951351229;2162.718846549946;2166.8049875511124;2181.3783071824614;2193.385851961453;2198.582269368831;2198.86806791593;2201.361605134509;7946.404019698546;7979.241972012649;7984.441089123764;8002.319802816767;8005.399595030396;4516.18708632446;4624.121416930772;4644.744539050384;4652.55800698933;4653.88365290867;2941;2971.257185703574;3077.492213784723;3094.984525077383;3104.0222329966214;1009.7526106104051;1020.454057079459;1021.7701017271129;1031.0205304960243;1031.3914790273775;10887.455627218687;10926.726831829188;10949.178811589163;10958.780824383548;10979.780404391948;4214.4099826024385;4246.745195288231;4417.867463976086;4426.203283408953;4492.05666809967;8548.358873084544;8584.141585841491;8643.481391116553;8648.1784230498;8650.740477785677;4586.8165273388695;4588.609968152745;4591.173588754056;4593.47175074864;4604.470485894165;3719.9442008369897;4096.221717873654;4220.388043733641;4233.894152646147;4310.396544483775;3421.863125475003;3486.2504561519395;3557.626449222846;3607.1342877709685;3680.5583330000572;967.9177269932135;1021.1575450253571;1023.948802559869;1030.907218350352;1077.095239998405;780.8165081205912;831.0526000359595;849.2611428057629;858.9785255368665;866.5017614871348;5090.211017292326;5120.897582048338;5220.817271395483;5249.291345668362;5396.1366181410785;416.3795944043414;438.1456160487063;439.5077513185253;449.9437570303712;606.9939300607026;3502.0894567412656;3540.398132317512;3607.603163651996;3720.2373513429684;3721.4975978243133;9524.428534287965;9814.3620664658;9842.163416109568;9847.901520984842;9863.309568330147;9132.452052876848;9570.521473926276;9811.803763924681;9812.362196457207;9819.558119884623;7028.05121308627;7151.821204469826;7167.605781682058;7193.424526037905;7208;4873.390826146731;4959.553640172402;4962.33008543842;5362.9463705364005;5607.383187849415;9147.405418647766;9211.124943130391;9216.861747073664;9233.353665243369;9344.626214951326;8818.426802257833;9429.15137637616;9434.24526037929;9459.858102128335;9469.289803264921;6218.875622487615;6750.831229219112;6934.549254298455;7006.159260888726;7056.259092795182;7754.6898124074405;7759.689612415666;7815.218478152139;7819.648115834915;7838.059432868093;6901.447884169154;7076.610786406797;7088.751893683902;7152.356287934111;7204.891926621;6955.026296318621;7012.123484564429;7013.368796808311;7106.538075025107;7127.322904324081;6114.6942652868065;6525.1517302750335;6525.738970441319;6531.673416329069;6654.234763002317;4604.355390245301;4650.209464390994;4685.8594242172785;4691.390119284471;4699.224627936489;4574.88562785933;4686.133065382779;4690.437147542317;4703.247480403119;4704.858854234379 19:04:33 INFO - PROCESS | 27433 | |4;prototype.html;294.37445428464514;299.57460406223163;301.44684503935275;302.1494493002197;305.11212371997493;4830.782614782334;4869.4887036861155;4875.12427620042;4888.951110488899;4909.631777616684;4810.39870016248;4812.326274321589;4814.638902082349;4824.565789078983;4865.467377775998;3666.4866918631346;3734.8506059757715;3789.5452545694557;3844.6732027777534;3852.0739630184908;3811;3819.694424446038;3829.8659546915724;3839.7504162229366;3844.9426407737815;3600.8199590020527;3806.3338915689783;3809.257194847006;3817.3892177251646;3823.1971286029966;3673.7244706646975;3805.543334799842;3805.8667946621736;3808.2002779416357;3828.7894165820867;3369.4777309517062;3377.696007359325;3383.1372999885116;3383.847726852273;3395.2360718838313;4753.239481682914;4771.850578618096;4782.067496838118;4798.5201479852085;4808.831690890837;4250.3199488081755;4305.729809706144;4329.588689074533;4375.584319489643;4395.736255824629;5062.873593090911;5065.366009674948;5105.9489405106215;5132.1275383184575;5146.228065790124;3648.72634552407;3669.43123815809;3673;3679.7792132472136;3684.207895302523;5172.405173405032;5296.999999999962;5379.789547351854;5388.413561490467;5396.406395296514;3780.584135745066;3799.601041890617;3808.809559522013;3810.2950954073585;3812.5424949006297;3856.8236687809926;3860.6911447084726;3864.5555761087835;3877.3990031545154;3880.3791393377487;4336.631386332134;4344.869653910388;4378.124375124988;4380.496242932104;4389.385486031958;4879.829205977774;5099.3370861787735;5102.367242482444;5113.437521872591;5163.96023570695;1285.8778416050648;1303.5205042276893;1306.4643496166525;1307.1111644082116;1315.302889468583;820.2945466898462;823.4565186976566;857.4726543175902;886.4415418286438;888.6889588644052;4521.321801729767;4527.615152712056;4528.977355113203;4529.463500439764;4537.500874903758;5229.346331708536;5239.659422137549;5250.553702935217;5265.447128051576;5280.735963201824;4370.541093185233;4488.596026357578;4498.5501449854755;4504.594586487232;4624.427694583857;2804.9201057592973;2808.382155925693;2808.4102338508733;2822.520171570838;2836.007397410931;4985.875353116201;4991.850244492671;5005.174146265898;5010.3737032870895;5011.373578302712;5112.667676601009;5405.324334458192;5424.321959755031;5458.918116228259;5471.644343117685;4901.240307752304;4966.776495057731;4970.850874473772;4976.800927962841;4988;5314.548263397654;5315.681059136464;5323.866903327448;5343.62594618373;5368.651037682695;4968.22992436173;5202.5952992691;5214.087534681492;5221.582273418194;5268.710220937732;4976.328195693535;4993.8014876430125;5003.824866129668;5006.799728010838;5015.17249653803;3727.1241258304817;3737.3833317503395;3760.9059773505883;3769.5288088988877;3772.1512659651357;5153.819616313411;5293.497117773805;5309.415964244007;5315.006872422841;5346.732663366894;5120;5137.152369859081;5153.948460515347;5155.561777248826;5160.225966105114;5109.310243117132;5123.948760512347;5128.79484820603;5152.922706159486;5154.252633368215;4827.662063655511;4915.827946021872;5068.493150684902;5074.847754567369;5082.738181509193;4987.526185012418;5191.974040129926;5212.211466865209;5245.64943757373;5247.166530073718;5127.41034781005;5137.17805151174;5137.279011531029;5141.203113517411;5154.355705536808 19:04:33 INFO - PROCESS | 27433 | |5;yui.html;655.9442447391972;702.5012241308671;747.8504299140174;750.2422553221245;771.0862627786074;13126.278054706987;13259;13639;13651.863481365184;13711.451541938322;13222.735545289113;13280.269585172811;13406.396712147953;13415.932920335408;13439;556.6576555418409;751.8270797716501;782.6556315221313;787.1773996173997;808.1030056637128;811.6185392865344;812.2202685421972;813.4590497319275;817.6443247187492;819.086718309087;845.3786466946789;846.289117141601;847.9788005299855;849.2611428057568;851.2168804699692;672.7678950761979;691.4468425259822;693.0816667915033;695.9373656370951;848.6138806842872;594.5808205215313;610.1214251477858;610.349977274206;613.9969300153471;615.4799194680488;13448.932755336258;13460.596182114552;13483.595492135251;13486.258255795927;13528.797068043987;12736.235825850386;13143.34283285832;13288.402021909038;13364.198148111047;13589.864101359057;11717.53129874804;11743.236689615147;11750.031183734563;11838.46726897283;11929;4052.1693052924375;4113.773742444165;4114.753114813091;4124.13393187431;4201.6008479194425;53738.31308434602;55679;55822.720886395306;62231.6888415555;62449.37550624526;10490.877714491015;10798.730031749112;10896.18278629106;10908.290961087503;10975.451227438596;19122.04389780533;19169.52076198106;19195.61608767845;19205.61588768217;19245.518862028563;7265.927340726631;7358.080239970004;7410.296021877913;7530.246975302426;7665.61671916402;3667.8349474273723;3891.8832435026993;3902.1415288636454;3954.5452272988973;4013.5585085640555;2930.033089080598;3035.317053662908;3047.268655522703;3053.1603808952714;3057.1592811976884;504.7400588696824;522.3861962194483;522.9790808367623;523.7538356972293;525.6005435868767;500.059530896533;521.392577647037;527.2065541360229;530.9575233981273;533.8558589180899;6880.58716477013;7418.554886706707;7477.176931221103;7661.578613176217;7853.685852565834;514.1773162939342;524.5960610330025;534.1533669134387;540.3111033432326;543.2557396367002;3460.584729832386;3476.652334766554;3533.2756784859043;3632.654897784706;3647.890563283053;54893;59147.70426147928;90957;94670;94673;81897;83611.5819420899;83681.16318836855;83958;85228;71705.6414717923;71904.28095718975;73707;74671;74947.62526187334;6784.3894049535775;6920.8961865573065;7079.398251148504;7162.677679504331;7183.066201393785;44442.55557444384;45563.316550252435;46116.53883461257;46131.76934115308;46496.7675161622;64941.72703955339;67201.32798671951;67272.66363668151;67697.66151169213;67737;9094.772630684021;9356.438613682929;9450.574724137292;9475;9661.9033809661;10598.152147828001;10661;10821.621243256448;10967.232293739362;11002.064824490008;9776.315657903879;9881.703548893545;10045.648402305884;10052.899471005196;10163.339382940085;9080.636774528944;9157.221636161;9185.265178785547;9289.4890781005;9294.814103718023;10046.799064018825;10293.639722609672;10306.381617102998;10391.168706503311;10519.737006574896;7677.961610191914;7701.4608977371045;7774.883376749466;7900.051993760785;8153.918460815553;8276.28781806527;8314.6674133034;8502.74491765248;8526.957365213382;8585.313174946114 19:04:33 INFO - PROCESS | 27433 | __end_tp_report 19:04:33 INFO - PROCESS | 27433 | __start_cc_report 19:04:33 INFO - PROCESS | 27433 | _x_x_mozilla_cycle_collect,945 19:04:33 INFO - PROCESS | 27433 | __end_cc_report 19:04:33 INFO - PROCESS | 27433 | __startTimestamp1467425073292__endTimestamp 19:04:33 INFO - PROCESS | 27433 | 19:04:33 INFO - PROCESS | 27433 | ------- Summary: start ------- 19:04:33 INFO - PROCESS | 27433 | Number of tests: 6 19:04:33 INFO - PROCESS | 27433 | 19:04:33 INFO - PROCESS | 27433 | [#0] dojo.html Cycles:165 Average:4842.67 Median:4971.88 stddev:521.77 (10.5%) stddev-sans-first:493.86 19:04:33 INFO - PROCESS | 27433 | Values: 2637.4 2657.1 2672.4 2695.9 2699.0 4746.5 4807.9 4842.3 4884.3 4930.2 4785.3 4798.7 4813.6 4881.1 4887.1 4372.1 4465.9 4469.3 4526.2 4647.7 4543.2 4567.7 4583.1 4599.6 4619.5 4409.5 4432.4 4460.0 4460.4 4511.7 4470.4 4474.4 4477.7 4483.5 4531.4 4498.8 4506.6 4519.5 4536.5 4581.9 4740.6 4842.7 4894.9 4962.2 4978.2 5315.1 5317.6 5325.8 5329.1 5343.0 5311.5 5311.6 5317.9 5340.7 5352.5 4785.0 4875.8 4890.2 4924.9 4925.1 5420.8 5430.7 5433.0 5434.9 5494.5 5233.5 5264.2 5271.8 5277.1 5282.1 5019.6 5175.5 5196.6 5219.7 5238.5 5159.1 5163.7 5181.8 5188.5 5223.5 4986.9 5140.1 5148.6 5149.0 5156.0 4378.4 4420.1 4435.9 4437.6 4441.2 3860.6 3878.6 3891.3 3892.1 3924.3 4483.5 4484.0 4523.1 4531.2 4537.9 5179.1 5211.4 5217.7 5225.8 5275.2 4351.5 4455.2 4483.3 4484.0 4490.8 4779.5 4779.7 4782.7 4793.7 4826.4 4889.8 4893.4 4899.0 4900.7 4960.8 5099.3 5202.9 5247.1 5284.2 5339.4 4938.7 4945.4 4984.0 4989.9 4992.4 5186.2 5189.9 5191.7 5195.0 5245.6 5125.1 5225.5 5233.5 5241.8 5243.0 5101.7 5145.6 5149.4 5151.3 5202.1 5131.5 5160.7 5161.7 5163.6 5211.7 4843.0 4971.9 5002.3 5080.4 5085.3 5093.7 5112.1 5114.7 5129.2 5160.0 5047.0 5050.6 5051.7 5056.2 5101.1 19:04:33 INFO - PROCESS | 27433 | 19:04:33 INFO - PROCESS | 27433 | [#1] ext.html Cycles:180 Average:51265.88 Median:191838.42 stddev:99386.42 (51.8%) stddev-sans-first:99592.27 19:04:33 INFO - PROCESS | 27433 | Values: 548.0 578.3 582.4 593.7 605.2 27623.3 30381.7 30403.1 30417.5 30509.0 30021.0 30780.5 40938.0 42169.2 42324.6 7690.1 7817.6 7818.5 7823.6 7828.8 7916.9 8002.1 8009.8 8010.4 8012.0 7695.5 7975.6 7975.8 8219.1 10090.4 10048.5 10415.9 10425.5 10429.4 10432.0 10120.6 10196.7 10200.8 10202.9 10203.7 30641.2 31315.7 31343.8 39188.4 39453.6 3092.6 3160.5 3177.4 3258.7 3643.5 30107.6 30294.5 30533.8 30561.7 30605.7 3594.9 3615.9 3686.4 3704.7 3805.3 276595.0 276699.0 276740.0 276927.0 277446.0 47812.8 49524.3 49624.8 55500.7 55544.4 46610.0 56470.4 58670.7 58739.0 63608.4 13771.4 13934.4 13995.6 14005.9 14013.2 10859.8 10937.4 10957.1 10957.6 10965.2 16298.2 16523.9 16533.6 16571.2 16596.0 4783.5 5249.0 5975.5 6030.3 6034.9 809.3 920.6 970.3 1007.2 1041.0 24659.3 24993.8 25064.9 25129.6 25132.6 948.0 1003.1 1017.9 1082.6 1084.3 14497.0 14617.8 14959.7 15149.4 15203.3 397666.0 398233.0 398854.0 399300.0 401720.0 43076.8 48273.3 50153.0 50313.2 50494.5 1204.8 1224.3 1231.1 1237.6 1244.1 28840.4 29480.3 29729.6 30200.8 30279.0 44579.0 45031.5 45045.8 45064.3 45080.8 350272.0 394883.0 403888.0 404432.0 571157.0 25304.2 25306.4 25319.5 25353.6 25629.0 42268.6 42373.0 43102.4 43326.4 43771.8 37138.4 37164.8 37552.0 37581.8 38147.0 37331.8 37441.0 37493.3 37538.2 37959.8 36108.0 36641.6 36796.1 37054.8 37085.0 32640.2 33178.3 33303.8 33403.0 33404.8 24864.3 25374.2 25598.4 25717.4 25775.6 19:04:33 INFO - PROCESS | 27433 | 19:04:33 INFO - PROCESS | 27433 | [#2] jquery.html Cycles:180 Average:23900.83 Median:189414.76 stddev:57531.06 (30.4%) stddev-sans-first:57665.26 19:04:33 INFO - PROCESS | 27433 | Values: 342.8 364.5 366.6 373.7 385.2 13315.9 16385.5 16946.7 18011.0 18963.2 17032.6 17108.7 17143.3 17472.6 17502.5 5090.5 5091.2 5263.1 5270.5 5270.9 3802.5 5165.3 5179.4 5808.5 6074.1 6142.8 6150.8 6152.1 6162.7 6171.4 6002.8 6114.9 6163.9 6179.0 6191.2 3403.7 5027.4 5360.7 5430.9 5455.2 21424.8 21507.5 21574.4 21833.2 22067.3 2013.2 2033.1 2088.8 2299.6 2435.0 13756.5 13867.9 13887.9 14114.6 14466.3 1726.1 1772.4 1800.9 1805.9 1811.6 61965.4 66091.0 66504.3 77210.6 77500.0 8966.1 9507.5 10008.1 10176.8 10356.7 12647.7 13637.2 13639.0 14000.6 14081.9 7047.0 7191.6 7209.0 7220.2 7283.5 6657.7 6868.9 6888.3 7007.8 7021.2 4458.9 4479.3 4485.1 4497.3 4547.8 1825.0 1857.5 1862.9 1869.1 1874.1 816.5 867.6 916.1 980.2 987.5 17025.8 17752.8 17833.4 17917.9 18305.6 848.7 883.0 893.2 914.0 934.3 9471.9 9927.0 9974.4 10045.1 10064.6 301215.0 308279.0 308820.0 375027.0 408149.0 86057.6 91189.5 92879.5 94309.0 94475.5 878.0 892.2 898.3 917.4 922.4 16450.0 16497.8 16741.8 16981.2 17156.9 28040.0 28729.6 38033.0 40606.8 41559.0 56784.4 58976.7 59200.4 59692.7 60420.0 7722.8 7997.2 8038.9 8081.0 8097.9 11962.5 12387.0 12390.3 12392.6 12457.7 10348.4 10389.2 10633.2 10760.4 11084.7 10681.8 10753.9 10754.7 10975.1 11143.9 10835.2 10961.7 10997.2 11012.4 11069.0 7965.6 7972.8 7979.2 7990.0 8117.1 10222.5 10502.1 10690.5 10991.8 11077.2 19:04:33 INFO - PROCESS | 27433 | 19:04:33 INFO - PROCESS | 27433 | [#3] mootools.html Cycles:180 Average:5181.79 Median:4701.24 stddev:2948.08 (62.7%) stddev-sans-first:2941.22 19:04:33 INFO - PROCESS | 27433 | Values: 1207.6 1287.1 1372.8 1375.2 1684.8 6850.8 7580.7 7844.9 7851.5 8052.9 7770.3 7845.8 7858.3 7886.0 7894.6 1890.1 2139.1 2182.8 2199.8 2219.2 2233.9 2257.1 2259.1 2259.9 2260.8 2189.9 2195.8 2231.0 2232.9 2235.7 1848.7 2093.2 2161.9 2162.7 2166.8 2181.4 2193.4 2198.6 2198.9 2201.4 7946.4 7979.2 7984.4 8002.3 8005.4 4516.2 4624.1 4644.7 4652.6 4653.9 2941.0 2971.3 3077.5 3095.0 3104.0 1009.8 1020.5 1021.8 1031.0 1031.4 10887.5 10926.7 10949.2 10958.8 10979.8 4214.4 4246.7 4417.9 4426.2 4492.1 8548.4 8584.1 8643.5 8648.2 8650.7 4586.8 4588.6 4591.2 4593.5 4604.5 3719.9 4096.2 4220.4 4233.9 4310.4 3421.9 3486.3 3557.6 3607.1 3680.6 967.9 1021.2 1023.9 1030.9 1077.1 780.8 831.1 849.3 859.0 866.5 5090.2 5120.9 5220.8 5249.3 5396.1 416.4 438.1 439.5 449.9 607.0 3502.1 3540.4 3607.6 3720.2 3721.5 9524.4 9814.4 9842.2 9847.9 9863.3 9132.5 9570.5 9811.8 9812.4 9819.6 7028.1 7151.8 7167.6 7193.4 7208.0 4873.4 4959.6 4962.3 5362.9 5607.4 9147.4 9211.1 9216.9 9233.4 9344.6 8818.4 9429.2 9434.2 9459.9 9469.3 6218.9 6750.8 6934.5 7006.2 7056.3 7754.7 7759.7 7815.2 7819.6 7838.1 6901.4 7076.6 7088.8 7152.4 7204.9 6955.0 7012.1 7013.4 7106.5 7127.3 6114.7 6525.2 6525.7 6531.7 6654.2 4604.4 4650.2 4685.9 4691.4 4699.2 4574.9 4686.1 4690.4 4703.2 4704.9 19:04:33 INFO - PROCESS | 27433 | 19:04:33 INFO - PROCESS | 27433 | [#4] prototype.html Cycles:180 Average:4266.46 Median:4848.12 stddev:1239.40 (25.6%) stddev-sans-first:1206.48 19:04:33 INFO - PROCESS | 27433 | Values: 294.4 299.6 301.4 302.1 305.1 4830.8 4869.5 4875.1 4889.0 4909.6 4810.4 4812.3 4814.6 4824.6 4865.5 3666.5 3734.9 3789.5 3844.7 3852.1 3811.0 3819.7 3829.9 3839.8 3844.9 3600.8 3806.3 3809.3 3817.4 3823.2 3673.7 3805.5 3805.9 3808.2 3828.8 3369.5 3377.7 3383.1 3383.8 3395.2 4753.2 4771.9 4782.1 4798.5 4808.8 4250.3 4305.7 4329.6 4375.6 4395.7 5062.9 5065.4 5105.9 5132.1 5146.2 3648.7 3669.4 3673.0 3679.8 3684.2 5172.4 5297.0 5379.8 5388.4 5396.4 3780.6 3799.6 3808.8 3810.3 3812.5 3856.8 3860.7 3864.6 3877.4 3880.4 4336.6 4344.9 4378.1 4380.5 4389.4 4879.8 5099.3 5102.4 5113.4 5164.0 1285.9 1303.5 1306.5 1307.1 1315.3 820.3 823.5 857.5 886.4 888.7 4521.3 4527.6 4529.0 4529.5 4537.5 5229.3 5239.7 5250.6 5265.4 5280.7 4370.5 4488.6 4498.6 4504.6 4624.4 2804.9 2808.4 2808.4 2822.5 2836.0 4985.9 4991.9 5005.2 5010.4 5011.4 5112.7 5405.3 5424.3 5458.9 5471.6 4901.2 4966.8 4970.9 4976.8 4988.0 5314.5 5315.7 5323.9 5343.6 5368.7 4968.2 5202.6 5214.1 5221.6 5268.7 4976.3 4993.8 5003.8 5006.8 5015.2 3727.1 3737.4 3760.9 3769.5 3772.2 5153.8 5293.5 5309.4 5315.0 5346.7 5120.0 5137.2 5153.9 5155.6 5160.2 5109.3 5123.9 5128.8 5152.9 5154.3 4827.7 4915.8 5068.5 5074.8 5082.7 4987.5 5192.0 5212.2 5245.6 5247.2 5127.4 5137.2 5137.3 5141.2 5154.4 19:04:33 INFO - PROCESS | 27433 | 19:04:33 INFO - PROCESS | 27433 | [#5] yui.html Cycles:180 Average:16958.54 Median:28117.83 stddev:24059.12 (85.6%) stddev-sans-first:24095.47 19:04:33 INFO - PROCESS | 27433 | Values: 655.9 702.5 747.9 750.2 771.1 13126.3 13259.0 13639.0 13651.9 13711.5 13222.7 13280.3 13406.4 13415.9 13439.0 556.7 751.8 782.7 787.2 808.1 811.6 812.2 813.5 817.6 819.1 845.4 846.3 848.0 849.3 851.2 672.8 691.4 693.1 695.9 848.6 594.6 610.1 610.3 614.0 615.5 13448.9 13460.6 13483.6 13486.3 13528.8 12736.2 13143.3 13288.4 13364.2 13589.9 11717.5 11743.2 11750.0 11838.5 11929.0 4052.2 4113.8 4114.8 4124.1 4201.6 53738.3 55679.0 55822.7 62231.7 62449.4 10490.9 10798.7 10896.2 10908.3 10975.5 19122.0 19169.5 19195.6 19205.6 19245.5 7265.9 7358.1 7410.3 7530.2 7665.6 3667.8 3891.9 3902.1 3954.5 4013.6 2930.0 3035.3 3047.3 3053.2 3057.2 504.7 522.4 523.0 523.8 525.6 500.1 521.4 527.2 531.0 533.9 6880.6 7418.6 7477.2 7661.6 7853.7 514.2 524.6 534.2 540.3 543.3 3460.6 3476.7 3533.3 3632.7 3647.9 54893.0 59147.7 90957.0 94670.0 94673.0 81897.0 83611.6 83681.2 83958.0 85228.0 71705.6 71904.3 73707.0 74671.0 74947.6 6784.4 6920.9 7079.4 7162.7 7183.1 44442.6 45563.3 46116.5 46131.8 46496.8 64941.7 67201.3 67272.7 67697.7 67737.0 9094.8 9356.4 9450.6 9475.0 9661.9 10598.2 10661.0 10821.6 10967.2 11002.1 9776.3 9881.7 10045.6 10052.9 10163.3 9080.6 9157.2 9185.3 9289.5 9294.8 10046.8 10293.6 10306.4 10391.2 10519.7 7678.0 7701.5 7774.9 7900.1 8153.9 8276.3 8314.7 8502.7 8527.0 8585.3 19:04:33 INFO - PROCESS | 27433 | -------- Summary: end -------- 19:04:33 INFO - PROCESS | 27433 | 19:04:33 INFO - TEST-INFO | 27433: exit 0 19:04:34 INFO - TEST-OK | dromaeo_css | took 1119399ms 19:04:34 INFO - TEST-START | kraken 19:04:34 INFO - operating with platform_type : linux_ 19:04:34 INFO - Initialising browser for kraken test... 19:04:34 INFO - TEST-INFO | started process 27623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC3DibF/profile http://localhost:51964/getInfo.html) 19:04:38 INFO - PROCESS | 27623 | __metrics Screen width/height:1600/1200 19:04:38 INFO - PROCESS | 27623 | colorDepth:24 19:04:38 INFO - PROCESS | 27623 | Browser inner width/height: 1024/697 19:04:38 INFO - PROCESS | 27623 | __metrics 19:04:39 INFO - PROCESS | 27623 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:04:40 INFO - TEST-INFO | 27623: exit 0 19:04:40 INFO - Browser initialized. 19:04:40 INFO - Running cycle 1/1 for kraken test... 19:04:40 INFO - TEST-INFO | started process 27704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC3DibF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:52 INFO - PROCESS | 27704 | RSS: Main: 159268864 19:04:52 INFO - PROCESS | 27704 | 19:04:54 INFO - PROCESS | 27704 | Cycle 1(1): loaded http://localhost:51964/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51964/tests/kraken/driver.html?testName=audio-beat-detection) 19:04:55 INFO - PROCESS | 27704 | RSS: Main: 217120768 19:04:55 INFO - PROCESS | 27704 | 19:04:58 INFO - PROCESS | 27704 | Cycle 1(1): loaded http://localhost:51964/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51964/tests/kraken/driver.html?testName=audio-dft) 19:04:59 INFO - PROCESS | 27704 | RSS: Main: 204062720 19:04:59 INFO - PROCESS | 27704 | 19:05:02 INFO - PROCESS | 27704 | Cycle 1(1): loaded http://localhost:51964/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51964/tests/kraken/driver.html?testName=audio-fft) 19:05:02 INFO - PROCESS | 27704 | RSS: Main: 271540224 19:05:02 INFO - PROCESS | 27704 | 19:05:05 INFO - PROCESS | 27704 | Cycle 1(1): loaded http://localhost:51964/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51964/tests/kraken/driver.html?testName=audio-oscillator) 19:05:05 INFO - PROCESS | 27704 | RSS: Main: 182095872 19:05:05 INFO - PROCESS | 27704 | 19:05:08 INFO - PROCESS | 27704 | Cycle 1(1): loaded http://localhost:51964/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51964/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:05:08 INFO - PROCESS | 27704 | RSS: Main: 186011648 19:05:08 INFO - PROCESS | 27704 | 19:05:11 INFO - PROCESS | 27704 | Cycle 1(1): loaded http://localhost:51964/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51964/tests/kraken/driver.html?testName=imaging-darkroom) 19:05:12 INFO - PROCESS | 27704 | RSS: Main: 222556160 19:05:12 INFO - PROCESS | 27704 | 19:05:15 INFO - PROCESS | 27704 | Cycle 1(1): loaded http://localhost:51964/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51964/tests/kraken/driver.html?testName=imaging-desaturate) 19:05:16 INFO - PROCESS | 27704 | RSS: Main: 217591808 19:05:16 INFO - PROCESS | 27704 | 19:05:19 INFO - PROCESS | 27704 | Cycle 1(1): loaded http://localhost:51964/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51964/tests/kraken/driver.html?testName=json-parse-financial) 19:05:20 INFO - PROCESS | 27704 | RSS: Main: 220704768 19:05:20 INFO - PROCESS | 27704 | 19:05:21 INFO - PROCESS | 27704 | Cycle 1(1): loaded http://localhost:51964/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51964/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:05:22 INFO - PROCESS | 27704 | RSS: Main: 206979072 19:05:22 INFO - PROCESS | 27704 | 19:05:24 INFO - PROCESS | 27704 | Cycle 1(1): loaded http://localhost:51964/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51964/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:05:24 INFO - PROCESS | 27704 | RSS: Main: 212529152 19:05:24 INFO - PROCESS | 27704 | 19:05:26 INFO - PROCESS | 27704 | Cycle 1(1): loaded http://localhost:51964/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51964/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:05:27 INFO - PROCESS | 27704 | RSS: Main: 210870272 19:05:27 INFO - PROCESS | 27704 | 19:05:30 INFO - PROCESS | 27704 | Cycle 1(1): loaded http://localhost:51964/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:05:31 INFO - PROCESS | 27704 | RSS: Main: 226009088 19:05:31 INFO - PROCESS | 27704 | 19:05:33 INFO - PROCESS | 27704 | Cycle 1(1): loaded http://localhost:51964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:05:34 INFO - PROCESS | 27704 | RSS: Main: 225357824 19:05:34 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | Cycle 1(1): loaded http://localhost:51964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51964/tests/kraken/driver.html?testName=ai-astar) 19:05:36 INFO - PROCESS | 27704 | RSS: Main: 267698176 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | __start_tp_report 19:05:36 INFO - PROCESS | 27704 | _x_x_mozilla_page_load 19:05:36 INFO - PROCESS | 27704 | _x_x_mozilla_page_load_details 19:05:36 INFO - PROCESS | 27704 | |i|pagename|runs| 19:05:36 INFO - PROCESS | 27704 | |0;ai-astar;105;114;114;116;114;113;113;113;114;113 19:05:36 INFO - PROCESS | 27704 | |1;audio-beat-detection;145;121;124;183;123;123;151;124;183;128 19:05:36 INFO - PROCESS | 27704 | |2;audio-dft;163;162;161;163;164;161;164;160;160;162 19:05:36 INFO - PROCESS | 27704 | |3;audio-fft;76;77;76;123;76;77;75;76;113;76 19:05:36 INFO - PROCESS | 27704 | |4;audio-oscillator;85;86;110;85;85;85;118;84;86;129 19:05:36 INFO - PROCESS | 27704 | |5;imaging-gaussian-blur;118;117;116;116;116;117;118;118;118;117 19:05:36 INFO - PROCESS | 27704 | |6;imaging-darkroom;146;148;147;146;146;146;146;146;146;146 19:05:36 INFO - PROCESS | 27704 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 19:05:36 INFO - PROCESS | 27704 | |8;json-parse-financial;64;63;64;64;64;63;66;63;63;64 19:05:36 INFO - PROCESS | 27704 | |9;json-stringify-tinderbox;64;64;64;63;65;64;66;65;64;64 19:05:36 INFO - PROCESS | 27704 | |10;stanford-crypto-aes;79;78;79;78;79;84;81;79;79;78 19:05:36 INFO - PROCESS | 27704 | |11;stanford-crypto-ccm;130;130;126;128;132;129;145;127;166;130 19:05:36 INFO - PROCESS | 27704 | |12;stanford-crypto-pbkdf2;173;164;165;163;166;165;165;169;167;169 19:05:36 INFO - PROCESS | 27704 | |13;stanford-crypto-sha256-iterative;68;69;67;67;65;66;67;66;65;66 19:05:36 INFO - PROCESS | 27704 | __end_tp_report 19:05:36 INFO - PROCESS | 27704 | __start_cc_report 19:05:36 INFO - PROCESS | 27704 | _x_x_mozilla_cycle_collect,1867 19:05:36 INFO - PROCESS | 27704 | __end_cc_report 19:05:36 INFO - PROCESS | 27704 | __startTimestamp1467425136488__endTimestamp 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | ------- Summary: start ------- 19:05:36 INFO - PROCESS | 27704 | Number of tests: 14 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:2.92 (2.6%) stddev-sans-first:0.97 19:05:36 INFO - PROCESS | 27704 | Values: 105.0 114.0 114.0 116.0 114.0 113.0 113.0 113.0 114.0 113.0 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:136.50 stddev:24.58 (18.0%) stddev-sans-first:26.01 19:05:36 INFO - PROCESS | 27704 | Values: 145.0 121.0 124.0 183.0 123.0 123.0 151.0 124.0 183.0 128.0 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.49 (0.9%) stddev-sans-first:1.54 19:05:36 INFO - PROCESS | 27704 | Values: 163.0 162.0 161.0 163.0 164.0 161.0 164.0 160.0 160.0 162.0 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | [#3] audio-fft Cycles:10 Average:84.50 Median:76.00 stddev:17.82 (23.4%) stddev-sans-first:18.64 19:05:36 INFO - PROCESS | 27704 | Values: 76.0 77.0 76.0 123.0 76.0 77.0 75.0 76.0 113.0 76.0 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:85.00 stddev:16.97 (20.0%) stddev-sans-first:17.59 19:05:36 INFO - PROCESS | 27704 | Values: 85.0 86.0 110.0 85.0 85.0 85.0 118.0 84.0 86.0 129.0 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.50 stddev:0.88 (0.7%) stddev-sans-first:0.87 19:05:36 INFO - PROCESS | 27704 | Values: 118.0 117.0 116.0 116.0 116.0 117.0 118.0 118.0 118.0 117.0 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 19:05:36 INFO - PROCESS | 27704 | Values: 146.0 148.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:05:36 INFO - PROCESS | 27704 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 19:05:36 INFO - PROCESS | 27704 | Values: 64.0 63.0 64.0 64.0 64.0 63.0 66.0 63.0 63.0 64.0 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 19:05:36 INFO - PROCESS | 27704 | Values: 64.0 64.0 64.0 63.0 65.0 64.0 66.0 65.0 64.0 64.0 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:1.84 (2.3%) stddev-sans-first:1.94 19:05:36 INFO - PROCESS | 27704 | Values: 79.0 78.0 79.0 78.0 79.0 84.0 81.0 79.0 79.0 78.0 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:130.00 stddev:12.34 (9.5%) stddev-sans-first:12.99 19:05:36 INFO - PROCESS | 27704 | Values: 130.0 130.0 126.0 128.0 132.0 129.0 145.0 127.0 166.0 130.0 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:166.50 stddev:2.99 (1.8%) stddev-sans-first:2.09 19:05:36 INFO - PROCESS | 27704 | Values: 173.0 164.0 165.0 163.0 166.0 165.0 165.0 169.0 167.0 169.0 19:05:36 INFO - PROCESS | 27704 | 19:05:36 INFO - PROCESS | 27704 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.26 (1.9%) stddev-sans-first:1.24 19:05:36 INFO - PROCESS | 27704 | Values: 68.0 69.0 67.0 67.0 65.0 66.0 67.0 66.0 65.0 66.0 19:05:36 INFO - PROCESS | 27704 | -------- Summary: end -------- 19:05:36 INFO - PROCESS | 27704 | 19:05:37 INFO - TEST-INFO | 27704: exit 0 19:05:37 INFO - TEST-OK | kraken | took 63469ms 19:05:37 INFO - SUITE-END | took 1182s 19:05:37 INFO - Completed test suite (00:19:43) 19:05:37 INFO - javascript benchmark 19:05:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2637.393399518111, 2657.0833062593424, 2672.4387878545504, 2695.9460810783785, 2699.041840146747, 4746.501617330174, 4807.903841923164, 4842.322074909515, 4884.316195732596, 4930.186519224329, 4785.258284965836, 4798.688085274454, 4813.56677898989, 4881.072596206718, 4887.1447496688115, 4372.060007098466, 4465.933011004838, 4469.329600559926, 4526.207913615121, 4647.674662773607, 4543.159515489629, 4567.680262381635, 4583.129205450954, 4599.563041511051, 4619.538046195387, 4409.492908315537, 4432.401625780511, 4460.018795864937, 4460.353248778909, 4511.661625378109, 4470.396496472967, 4474.351219073249, 4477.686561940665, 4483.506814250462, 4531.410916580857, 4498.8425405110665, 4506.639468842517, 4519.548045195487, 4536.455625324982, 4581.885452863672, 4740.620750339965, 4842.709437433765, 4894.853154405374, 4962.206047032493, 4978.178600530908, 5315.149576067849, 5317.627766056377, 5325.760340784635, 5329.120695085307, 5343.0, 5311.548518375943, 5311.601629877736, 5317.867053323659, 5340.652857564246, 5352.4915133062295, 4785.019071090418, 4875.780589873393, 4890.193118135503, 4924.901501969941, 4925.088858561106, 5420.756065977041, 5430.67415955044, 5433.049216387117, 5434.945650543523, 5494.5054945055135, 5233.502817232356, 5264.15773476242, 5271.762770675329, 5277.076511610453, 5282.128448805981, 5019.573336266459, 5175.45657705943, 5196.558292545101, 5219.686818790885, 5238.528532432099, 5159.122949098587, 5163.690178589297, 5181.766820493087, 5188.507091826271, 5223.503767142115, 4986.875328116754, 5140.126178549655, 5148.613853960968, 5149.0, 5156.020356132323, 4378.387025816324, 4420.115976804652, 4435.889102772392, 4437.622802061861, 4441.20058389493, 3860.575336712959, 3878.5733569307354, 3891.2606604745006, 3892.1048158923604, 3924.293627147084, 4483.461984561874, 4483.955160448354, 4523.072770082125, 4531.18438681034, 4537.863864084083, 5179.067767801832, 5211.42674305826, 5217.713025783618, 5225.764840582183, 5275.20871869215, 4351.477822661238, 4455.242608756519, 4483.30508771141, 4483.955160448419, 4490.842820501332, 4779.522047795263, 4779.689320194177, 4782.713037217778, 4793.736344501016, 4826.444958829779, 4889.804407823718, 4893.412790465167, 4899.020195960893, 4900.656954013256, 4960.801567937314, 5099.26060721186, 5202.921956170585, 5247.055530004636, 5284.180951952453, 5339.359276886798, 4938.703677779345, 4945.406551213878, 4983.950160498349, 4989.852333963281, 4992.425871024733, 5186.2479940409185, 5189.922151167811, 5191.740412979411, 5194.961007798531, 5245.632805703564, 5125.103106956193, 5225.477452254896, 5233.476652334736, 5241.764120614505, 5243.030039442715, 5101.69389836611, 5145.588352931832, 5149.382074150976, 5151.2788209649925, 5202.063628546898, 5131.4868513148385, 5160.690358578498, 5161.690298582097, 5163.6127290454115, 5211.687298762086, 4843.0, 4971.875703107451, 5002.299678045149, 5080.364954380702, 5085.338905942352, 5093.719845408538, 5112.079825631422, 5114.667546609458, 5129.2306154075695, 5160.0, 5047.041062198171, 5050.646454748133, 5051.6716413433005, 5056.191009438472, 5101.107306221471], "value": 4808.100343672279, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.0112569486623, 578.2569398323153, 582.382674365173, 593.7120496559168, 605.2434456928839, 27623.30941726458, 30381.696183038162, 30403.087907362788, 30417.54373684391, 30509.0, 30021.0, 30780.53829192564, 40938.0, 42169.156616867724, 42324.57675423245, 7690.115636701767, 7817.6091195440285, 7818.530888146701, 7823.569703666296, 7828.765137045869, 7916.920830791676, 8002.119766825645, 8009.759707208793, 8010.359171266314, 8012.0, 7695.461317707763, 7975.641096150658, 7975.7607271781935, 8219.13699061596, 10090.445025523593, 10048.497575121215, 10415.895841041569, 10425.530851111718, 10429.374237545695, 10431.999999999962, 10120.645777397756, 10196.74508137295, 10200.846987295197, 10202.897971020344, 10203.693889183336, 30641.233969150726, 31315.686843131505, 31343.84328078368, 39188.412173817414, 39453.60546394557, 3092.6443459002053, 3160.478521044025, 3177.413018940178, 3258.6904244096772, 3643.453481977698, 30107.601458465477, 30294.54558181629, 30533.847330763427, 30561.69438305633, 30605.69394306073, 3594.8741794037346, 3615.8553657853654, 3686.3548878946076, 3704.722145839046, 3805.276997370491, 276595.0, 276699.0, 276740.0, 276927.0, 277446.0, 47812.760936195096, 49524.25713614299, 49624.751876240385, 55500.72249638726, 55544.44455555393, 46610.0, 56470.435295646515, 58670.70664646735, 58739.0, 63608.363916361166, 13771.380287887068, 13934.37295321713, 13995.580132596038, 14005.859941400455, 14013.159210447202, 10859.78280434387, 10937.398443085547, 10957.06864916475, 10957.561697532168, 10965.177611679155, 16298.185090745415, 16523.917380413022, 16533.58666033335, 16571.171441428123, 16596.0, 4783.521647835259, 5249.0, 5975.492083172979, 6030.33666296707, 6034.879302413927, 809.2554849538438, 920.6271460058687, 970.2819913264134, 1007.2143727892255, 1041.0, 24659.260222193363, 24993.75006249914, 25064.87467562687, 25129.62305565418, 25132.623010654854, 947.966821161256, 1003.1272792670278, 1017.8931212222758, 1082.5615625671458, 1084.3331351219101, 14497.0, 14617.78073328901, 14959.700805983819, 15149.394024239127, 15203.315850786741, 397666.0, 398233.0, 398854.0, 399300.0, 401720.0, 43076.78461607735, 48273.27590086152, 50153.0, 50313.24530132051, 50494.49505504898, 1204.8253003314471, 1224.2899118511064, 1231.132051903406, 1237.5520640850227, 1244.1291096232853, 28840.423191536473, 29480.262993425335, 29729.554056689598, 30200.84899575488, 30279.0, 44579.0, 45031.54968450405, 45045.774771125936, 45064.324035140155, 45080.77459612681, 350272.0, 394883.0, 403888.0, 404432.0, 571157.0095046819, 25304.240872773848, 25306.367340816625, 25319.493610128062, 25353.619695704212, 25629.0, 42268.577314226466, 42373.0, 43102.35346469868, 43326.350104749086, 43771.781141095365, 37138.44292335563, 37164.81417593003, 37552.0, 37581.81209093937, 38147.0, 37331.81334093312, 37441.0, 37493.250134996604, 37538.2492350146, 37959.81020094882, 36108.0, 36641.63358366489, 36796.080097997765, 37054.8147259262, 37085.0, 32640.183995400304, 33178.33643327168, 33303.83348083244, 33403.0, 33404.832975834965, 24864.25407237786, 25374.238772836845, 25598.360040999123, 25717.35706607275, 25775.613365799152], "value": 17875.85122802229, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.8469213340221, 364.46241793354795, 366.58026559589257, 373.667435981976, 385.19302062179725, 13315.933420332896, 16385.50843474696, 16946.74579881301, 18011.0, 18963.241470341203, 17032.574185645364, 17108.657826843486, 17143.31426742932, 17472.563185920357, 17502.474925752216, 5090.490950904898, 5091.236314552819, 5263.078961181797, 5270.4729527047375, 5270.868228294285, 3802.524684414448, 5165.328507294046, 5179.404368497633, 5808.535317174616, 6074.149619053314, 6142.84642883927, 6150.784722534712, 6152.077188421727, 6162.722677479502, 6171.382861713838, 6002.819915402523, 6114.8777024459705, 6163.9383606164265, 6179.042248451452, 6191.226096737908, 3403.7447191460737, 5027.4469808321055, 5360.705161216131, 5430.945690543123, 5455.208994695787, 21424.78575214259, 21507.46231344213, 21574.352769416942, 21833.235836745636, 22067.33797986063, 2013.2148462099792, 2033.1359172351692, 2088.812006919369, 2299.563083014222, 2435.0138194031447, 13756.46609721824, 13867.930660346734, 13887.861121388758, 14114.576562703136, 14466.276686165755, 1726.1369315342329, 1772.4062439082923, 1800.8919464832152, 1805.8555315574854, 1811.610503741702, 61965.38034619641, 66091.0, 66504.3349566503, 77210.61394692991, 77500.0, 8966.103389661112, 9507.477088760184, 10008.09927106564, 10176.847347289797, 10356.689299321033, 12647.747045059232, 13637.249951252577, 13639.0, 14000.649983750283, 14081.929590351983, 7047.0, 7191.568505889663, 7208.963955180296, 7220.241874603196, 7283.4537409694485, 6657.733690652417, 6868.9313106869295, 6888.276730943179, 7007.789766307019, 7021.1574611047, 4458.910821783611, 4479.260921947907, 4485.147821913826, 4497.280435130363, 4547.840825571089, 1824.9817501824812, 1857.4799056264267, 1862.9441116766247, 1869.1121717184228, 1874.100431792747, 816.5386556595505, 867.5835598912557, 916.1479823763964, 980.2452111873818, 987.4618333008527, 17025.829741702673, 17752.822471775376, 17833.375831845824, 17917.910410448127, 18305.63388732218, 848.6817443458702, 883.0330787787362, 893.1693525021662, 913.9680111196076, 934.2852717670987, 9471.905280947103, 9927.0, 9974.351667141613, 10045.095941365313, 10064.647737329158, 301215.0, 308279.0, 308820.0, 375027.0, 408149.0, 86057.5697121523, 91189.54405228065, 92879.53560232156, 94309.0, 94475.52762236282, 878.0166213840668, 892.2193081054078, 898.2634239923331, 917.3945196170496, 922.423485321674, 16450.0, 16497.83502165011, 16741.83258167403, 16981.150942453074, 17156.914215428842, 28040.0, 28729.56905646375, 38033.0, 40606.79696601498, 41559.0, 56784.43215567957, 58976.70511647414, 59200.407995919486, 59692.70153649204, 60420.0, 7722.806929826575, 7997.160298168841, 8038.87941680887, 8080.959595201986, 8097.878531822145, 11962.46168922418, 12387.0, 12390.3185324808, 12392.56626018085, 12457.688557786129, 10348.430836303774, 10389.168866490512, 10633.20250981195, 10760.3543787373, 11084.667459976214, 10681.786364272515, 10753.946230268799, 10754.677359679223, 10975.121990240921, 11143.94428027887, 10835.187360947803, 10961.725956851142, 10997.175211859303, 11012.449377531251, 11069.0, 7965.601719913865, 7972.760817175494, 7979.162187970412, 7989.960050199712, 8117.147699491468, 10222.48887555634, 10502.107320877505, 10690.465476726287, 10991.835122473009, 11077.16921230927], "value": 8558.727555186499, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1207.643745095197, 1287.073307218802, 1372.7529044771943, 1375.1542801177277, 1684.7641330213771, 6850.7602233921825, 7580.734674286401, 7844.882326765103, 7851.528908265508, 8052.879206811903, 7770.33952114071, 7845.80385490363, 7858.253465920729, 7885.960570197141, 7894.5657988810735, 1890.1210936914333, 2139.058814121789, 2182.847200695952, 2199.83501237407, 2219.1789038055863, 2233.932982010542, 2257.052038143975, 2259.1302348595746, 2259.9435014124615, 2260.7513173550897, 2189.9233526826565, 2195.835312351572, 2231.0, 2232.944176395595, 2235.731712194539, 1848.6949653307256, 2093.194120263694, 2161.945951351229, 2162.718846549946, 2166.8049875511124, 2181.3783071824614, 2193.385851961453, 2198.582269368831, 2198.86806791593, 2201.361605134509, 7946.404019698546, 7979.241972012649, 7984.441089123764, 8002.319802816767, 8005.399595030396, 4516.18708632446, 4624.121416930772, 4644.744539050384, 4652.55800698933, 4653.88365290867, 2941.0, 2971.257185703574, 3077.492213784723, 3094.984525077383, 3104.0222329966214, 1009.7526106104051, 1020.454057079459, 1021.7701017271129, 1031.0205304960243, 1031.3914790273775, 10887.455627218687, 10926.726831829188, 10949.178811589163, 10958.780824383548, 10979.780404391948, 4214.4099826024385, 4246.745195288231, 4417.867463976086, 4426.203283408953, 4492.05666809967, 8548.358873084544, 8584.141585841491, 8643.481391116553, 8648.1784230498, 8650.740477785677, 4586.8165273388695, 4588.609968152745, 4591.173588754056, 4593.47175074864, 4604.470485894165, 3719.9442008369897, 4096.221717873654, 4220.388043733641, 4233.894152646147, 4310.396544483775, 3421.863125475003, 3486.2504561519395, 3557.626449222846, 3607.1342877709685, 3680.5583330000572, 967.9177269932135, 1021.1575450253571, 1023.948802559869, 1030.907218350352, 1077.095239998405, 780.8165081205912, 831.0526000359595, 849.2611428057629, 858.9785255368665, 866.5017614871348, 5090.211017292326, 5120.897582048338, 5220.817271395483, 5249.291345668362, 5396.1366181410785, 416.3795944043414, 438.1456160487063, 439.5077513185253, 449.9437570303712, 606.9939300607026, 3502.0894567412656, 3540.398132317512, 3607.603163651996, 3720.2373513429684, 3721.4975978243133, 9524.428534287965, 9814.3620664658, 9842.163416109568, 9847.901520984842, 9863.309568330147, 9132.452052876848, 9570.521473926276, 9811.803763924681, 9812.362196457207, 9819.558119884623, 7028.05121308627, 7151.821204469826, 7167.605781682058, 7193.424526037905, 7208.0, 4873.390826146731, 4959.553640172402, 4962.33008543842, 5362.9463705364005, 5607.383187849415, 9147.405418647766, 9211.124943130391, 9216.861747073664, 9233.353665243369, 9344.626214951326, 8818.426802257833, 9429.15137637616, 9434.24526037929, 9459.858102128335, 9469.289803264921, 6218.875622487615, 6750.831229219112, 6934.549254298455, 7006.159260888726, 7056.259092795182, 7754.6898124074405, 7759.689612415666, 7815.218478152139, 7819.648115834915, 7838.059432868093, 6901.447884169154, 7076.610786406797, 7088.751893683902, 7152.356287934111, 7204.891926621, 6955.026296318621, 7012.123484564429, 7013.368796808311, 7106.538075025107, 7127.322904324081, 6114.6942652868065, 6525.1517302750335, 6525.738970441319, 6531.673416329069, 6654.234763002317, 4604.355390245301, 4650.209464390994, 4685.8594242172785, 4691.390119284471, 4699.224627936489, 4574.88562785933, 4686.133065382779, 4690.437147542317, 4703.247480403119, 4704.858854234379], "value": 4093.611242523956, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.37445428464514, 299.57460406223163, 301.44684503935275, 302.1494493002197, 305.11212371997493, 4830.782614782334, 4869.4887036861155, 4875.12427620042, 4888.951110488899, 4909.631777616684, 4810.39870016248, 4812.326274321589, 4814.638902082349, 4824.565789078983, 4865.467377775998, 3666.4866918631346, 3734.8506059757715, 3789.5452545694557, 3844.6732027777534, 3852.0739630184908, 3811.0, 3819.694424446038, 3829.8659546915724, 3839.7504162229366, 3844.9426407737815, 3600.8199590020527, 3806.3338915689783, 3809.257194847006, 3817.3892177251646, 3823.1971286029966, 3673.7244706646975, 3805.543334799842, 3805.8667946621736, 3808.2002779416357, 3828.7894165820867, 3369.4777309517062, 3377.696007359325, 3383.1372999885116, 3383.847726852273, 3395.2360718838313, 4753.239481682914, 4771.850578618096, 4782.067496838118, 4798.5201479852085, 4808.831690890837, 4250.3199488081755, 4305.729809706144, 4329.588689074533, 4375.584319489643, 4395.736255824629, 5062.873593090911, 5065.366009674948, 5105.9489405106215, 5132.1275383184575, 5146.228065790124, 3648.72634552407, 3669.43123815809, 3673.0, 3679.7792132472136, 3684.207895302523, 5172.405173405032, 5296.999999999962, 5379.789547351854, 5388.413561490467, 5396.406395296514, 3780.584135745066, 3799.601041890617, 3808.809559522013, 3810.2950954073585, 3812.5424949006297, 3856.8236687809926, 3860.6911447084726, 3864.5555761087835, 3877.3990031545154, 3880.3791393377487, 4336.631386332134, 4344.869653910388, 4378.124375124988, 4380.496242932104, 4389.385486031958, 4879.829205977774, 5099.3370861787735, 5102.367242482444, 5113.437521872591, 5163.96023570695, 1285.8778416050648, 1303.5205042276893, 1306.4643496166525, 1307.1111644082116, 1315.302889468583, 820.2945466898462, 823.4565186976566, 857.4726543175902, 886.4415418286438, 888.6889588644052, 4521.321801729767, 4527.615152712056, 4528.977355113203, 4529.463500439764, 4537.500874903758, 5229.346331708536, 5239.659422137549, 5250.553702935217, 5265.447128051576, 5280.735963201824, 4370.541093185233, 4488.596026357578, 4498.5501449854755, 4504.594586487232, 4624.427694583857, 2804.9201057592973, 2808.382155925693, 2808.4102338508733, 2822.520171570838, 2836.007397410931, 4985.875353116201, 4991.850244492671, 5005.174146265898, 5010.3737032870895, 5011.373578302712, 5112.667676601009, 5405.324334458192, 5424.321959755031, 5458.918116228259, 5471.644343117685, 4901.240307752304, 4966.776495057731, 4970.850874473772, 4976.800927962841, 4988.0, 5314.548263397654, 5315.681059136464, 5323.866903327448, 5343.62594618373, 5368.651037682695, 4968.22992436173, 5202.5952992691, 5214.087534681492, 5221.582273418194, 5268.710220937732, 4976.328195693535, 4993.8014876430125, 5003.824866129668, 5006.799728010838, 5015.17249653803, 3727.1241258304817, 3737.3833317503395, 3760.9059773505883, 3769.5288088988877, 3772.1512659651357, 5153.819616313411, 5293.497117773805, 5309.415964244007, 5315.006872422841, 5346.732663366894, 5120.0, 5137.152369859081, 5153.948460515347, 5155.561777248826, 5160.225966105114, 5109.310243117132, 5123.948760512347, 5128.79484820603, 5152.922706159486, 5154.252633368215, 4827.662063655511, 4915.827946021872, 5068.493150684902, 5074.847754567369, 5082.738181509193, 4987.526185012418, 5191.974040129926, 5212.211466865209, 5245.64943757373, 5247.166530073718, 5127.41034781005, 5137.17805151174, 5137.279011531029, 5141.203113517411, 5154.355705536808], "value": 3869.757777990351, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.9442447391972, 702.5012241308671, 747.8504299140174, 750.2422553221245, 771.0862627786074, 13126.278054706987, 13259.0, 13639.0, 13651.863481365184, 13711.451541938322, 13222.735545289113, 13280.269585172811, 13406.396712147953, 13415.932920335408, 13439.0, 556.6576555418409, 751.8270797716501, 782.6556315221313, 787.1773996173997, 808.1030056637128, 811.6185392865344, 812.2202685421972, 813.4590497319275, 817.6443247187492, 819.086718309087, 845.3786466946789, 846.289117141601, 847.9788005299855, 849.2611428057568, 851.2168804699692, 672.7678950761979, 691.4468425259822, 693.0816667915033, 695.9373656370951, 848.6138806842872, 594.5808205215313, 610.1214251477858, 610.349977274206, 613.9969300153471, 615.4799194680488, 13448.932755336258, 13460.596182114552, 13483.595492135251, 13486.258255795927, 13528.797068043987, 12736.235825850386, 13143.34283285832, 13288.402021909038, 13364.198148111047, 13589.864101359057, 11717.53129874804, 11743.236689615147, 11750.031183734563, 11838.46726897283, 11929.0, 4052.1693052924375, 4113.773742444165, 4114.753114813091, 4124.13393187431, 4201.6008479194425, 53738.31308434602, 55679.0, 55822.720886395306, 62231.6888415555, 62449.37550624526, 10490.877714491015, 10798.730031749112, 10896.18278629106, 10908.290961087503, 10975.451227438596, 19122.04389780533, 19169.52076198106, 19195.61608767845, 19205.61588768217, 19245.518862028563, 7265.927340726631, 7358.080239970004, 7410.296021877913, 7530.246975302426, 7665.61671916402, 3667.8349474273723, 3891.8832435026993, 3902.1415288636454, 3954.5452272988973, 4013.5585085640555, 2930.033089080598, 3035.317053662908, 3047.268655522703, 3053.1603808952714, 3057.1592811976884, 504.7400588696824, 522.3861962194483, 522.9790808367623, 523.7538356972293, 525.6005435868767, 500.059530896533, 521.392577647037, 527.2065541360229, 530.9575233981273, 533.8558589180899, 6880.58716477013, 7418.554886706707, 7477.176931221103, 7661.578613176217, 7853.685852565834, 514.1773162939342, 524.5960610330025, 534.1533669134387, 540.3111033432326, 543.2557396367002, 3460.584729832386, 3476.652334766554, 3533.2756784859043, 3632.654897784706, 3647.890563283053, 54893.0, 59147.70426147928, 90957.0, 94670.0, 94673.0, 81897.0, 83611.5819420899, 83681.16318836855, 83958.0, 85228.0, 71705.6414717923, 71904.28095718975, 73707.0, 74671.0, 74947.62526187334, 6784.3894049535775, 6920.8961865573065, 7079.398251148504, 7162.677679504331, 7183.066201393785, 44442.55557444384, 45563.316550252435, 46116.53883461257, 46131.76934115308, 46496.7675161622, 64941.72703955339, 67201.32798671951, 67272.66363668151, 67697.66151169213, 67737.0, 9094.772630684021, 9356.438613682929, 9450.574724137292, 9475.0, 9661.9033809661, 10598.152147828001, 10661.0, 10821.621243256448, 10967.232293739362, 11002.064824490008, 9776.315657903879, 9881.703548893545, 10045.648402305884, 10052.899471005196, 10163.339382940085, 9080.636774528944, 9157.221636161, 9185.265178785547, 9289.4890781005, 9294.814103718023, 10046.799064018825, 10293.639722609672, 10306.381617102998, 10391.168706503311, 10519.737006574896, 7677.961610191914, 7701.4608977371045, 7774.883376749466, 7900.051993760785, 8153.918460815553, 8276.28781806527, 8314.6674133034, 8502.74491765248, 8526.957365213382, 8585.313174946114], "value": 6323.8118492521535, "unit": "score"}], "name": "dromaeo_css", "value": 6475.07467376466, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 116.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 121.0, 124.0, 183.0, 123.0, 123.0, 151.0, 124.0, 183.0, 128.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 163.0, 164.0, 161.0, 164.0, 160.0, 160.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 123.0, 76.0, 77.0, 75.0, 76.0, 113.0, 76.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 110.0, 85.0, 85.0, 85.0, 118.0, 84.0, 86.0, 129.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 116.0, 116.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 66.0, 63.0, 63.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 65.0, 64.0, 66.0, 65.0, 64.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 78.0, 79.0, 84.0, 81.0, 79.0, 79.0, 78.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 130.0, 126.0, 128.0, 132.0, 129.0, 145.0, 127.0, 166.0, 130.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 164.0, 165.0, 163.0, 166.0, 165.0, 165.0, 169.0, 167.0, 169.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 67.0, 65.0, 66.0, 67.0, 66.0, 65.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1528.4999999999998, "alertThreshold": 2.0}]} 19:05:37 INFO - Return code: 0 19:05:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:05:37 INFO - # TBPL SUCCESS # 19:05:37 INFO - Running post-action listener: _resource_record_post_action 19:05:37 INFO - ##### 19:05:37 INFO - ##### Finished run-tests step (success) 19:05:37 INFO - ##### 19:05:37 INFO - Running post-run listener: _resource_record_post_run 19:05:37 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543322112; Read time: 12; Write time: 479996 19:05:37 INFO - TinderboxPrint: CPU usage
13.0% 19:05:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:05:37 INFO - TinderboxPrint: I/O write bytes / time
543,322,112 / 479,996 19:05:37 INFO - TinderboxPrint: CPU idle
8,329.3 (87.0%) 19:05:37 INFO - TinderboxPrint: CPU user
1,200.4 (12.5%) 19:05:37 INFO - TinderboxPrint: Swap in / out
0 / 0 19:05:37 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255819776; Read time: 0; Write time: 230808 19:05:37 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 287502336; Read time: 0; Write time: 249188 19:05:38 INFO - Running post-run listener: _upload_blobber_files 19:05:38 INFO - Blob upload gear active. 19:05:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:05:38 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 19:05:38 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:05:38 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:05:38 INFO - (blobuploader) - INFO - Open directory for files ... 19:05:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:05:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:05:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:42 INFO - (blobuploader) - INFO - Done attempting. 19:05:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:05:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:05:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:42 INFO - (blobuploader) - INFO - Done attempting. 19:05:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:05:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:05:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:43 INFO - (blobuploader) - INFO - Done attempting. 19:05:43 INFO - (blobuploader) - INFO - Iteration through files over. 19:05:43 INFO - Return code: 0 19:05:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:05:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:05:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0f624be17db364b8cdef20c1c3e7db64da6b15a3a118f0ef7ff9a99d7a273578ed60a1c607b46d52d667a0948f6a19d77344e8fbcdc8ffd8b31fa489a04a532", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/710e860f303b25806b34a3a2ec37d075f47eb15f1d1a40f38246940a68bc5e92dce0983e3e2d8b08f174791a80582aa9f3c84071c1391384c86c2168cce1b4a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c5aaaef66423f0ba0858805178c00a316b387732fc4fd4e142a2253cb2f0d146601e9fe7dbf69411d91c7c558f650e61b954b11171dcc28c123976a83eea91a4"} 19:05:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:05:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:05:43 INFO - Contents: 19:05:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0f624be17db364b8cdef20c1c3e7db64da6b15a3a118f0ef7ff9a99d7a273578ed60a1c607b46d52d667a0948f6a19d77344e8fbcdc8ffd8b31fa489a04a532", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/710e860f303b25806b34a3a2ec37d075f47eb15f1d1a40f38246940a68bc5e92dce0983e3e2d8b08f174791a80582aa9f3c84071c1391384c86c2168cce1b4a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c5aaaef66423f0ba0858805178c00a316b387732fc4fd4e142a2253cb2f0d146601e9fe7dbf69411d91c7c558f650e61b954b11171dcc28c123976a83eea91a4"} 19:05:43 INFO - Running post-run listener: copy_logs_to_upload_dir 19:05:43 INFO - Copying logs to upload dir... 19:05:43 INFO - mkdir: /builds/slave/test/build/upload/logs 19:05:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.084195 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-01 19:05:42.777021) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 19:05:42.780927) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818 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-Non-PGO/sha512/a0f624be17db364b8cdef20c1c3e7db64da6b15a3a118f0ef7ff9a99d7a273578ed60a1c607b46d52d667a0948f6a19d77344e8fbcdc8ffd8b31fa489a04a532", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/710e860f303b25806b34a3a2ec37d075f47eb15f1d1a40f38246940a68bc5e92dce0983e3e2d8b08f174791a80582aa9f3c84071c1391384c86c2168cce1b4a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c5aaaef66423f0ba0858805178c00a316b387732fc4fd4e142a2253cb2f0d146601e9fe7dbf69411d91c7c558f650e61b954b11171dcc28c123976a83eea91a4"} build_url:https://queue.taskcluster.net/v1/task/endIu6WcR62CmpkOv9XWNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/endIu6WcR62CmpkOv9XWNw/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-Non-PGO/sha512/a0f624be17db364b8cdef20c1c3e7db64da6b15a3a118f0ef7ff9a99d7a273578ed60a1c607b46d52d667a0948f6a19d77344e8fbcdc8ffd8b31fa489a04a532", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/710e860f303b25806b34a3a2ec37d075f47eb15f1d1a40f38246940a68bc5e92dce0983e3e2d8b08f174791a80582aa9f3c84071c1391384c86c2168cce1b4a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c5aaaef66423f0ba0858805178c00a316b387732fc4fd4e142a2253cb2f0d146601e9fe7dbf69411d91c7c558f650e61b954b11171dcc28c123976a83eea91a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 19:05:42.805932) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 19:05:42.806245) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467423614.768334-100140818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 19:05:42.891436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 19:05:42.891755) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 19:05:42.892037) ========= ========= Total master_lag: 0.19 =========