builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-062 starttime: 1467771863.01 results: success (0) buildid: 20160705180326 builduid: 729517e39bbb423da53326447d6d5020 revision: 78d2fb74e22f7d4858c88173071a5b6988c07389 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 19:24:23.010395) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 19:24:23.010805) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 19:24:23.011088) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 19:24:23.041760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:24:23.042026) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 19:24:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-07-05 19:24:23 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:24:23.188976) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:24:23.189262) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016399 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:24:23.241966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:24:23.242440) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 78d2fb74e22f7d4858c88173071a5b6988c07389 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 78d2fb74e22f7d4858c88173071a5b6988c07389 --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=a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 19:24:23,351 truncating revision to first 12 chars 2016-07-05 19:24:23,351 Setting DEBUG logging. 2016-07-05 19:24:23,351 attempt 1/10 2016-07-05 19:24:23,351 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/78d2fb74e22f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 19:24:23,645 unpacking tar archive at: autoland-78d2fb74e22f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673415 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:24:23.931254) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 19:24:23.931612) ========= script_repo_revision: 78d2fb74e22f7d4858c88173071a5b6988c07389 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 19:24:23.931985) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 19:24:23.932265) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 19:24:23.948343) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-05 19:24:23.948621) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:24:24 INFO - MultiFileLogger online at 20160705 19:24:24 in /builds/slave/test 19:24:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 19:24:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:24:24 INFO - {'append_to_log': False, 19:24:24 INFO - 'base_work_dir': '/builds/slave/test', 19:24:24 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 19:24:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:24:24 INFO - 'branch': 'Autoland-Non-PGO', 19:24:24 INFO - 'buildbot_json_path': 'buildprops.json', 19:24:24 INFO - 'config_files': ('talos/linux_config.py',), 19:24:24 INFO - 'default_actions': ('clobber', 19:24:24 INFO - 'read-buildbot-config', 19:24:24 INFO - 'download-and-extract', 19:24:24 INFO - 'populate-webroot', 19:24:24 INFO - 'create-virtualenv', 19:24:24 INFO - 'install', 19:24:24 INFO - 'run-tests'), 19:24:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:24:24 INFO - 'download_minidump_stackwalk': True, 19:24:24 INFO - 'download_symbols': 'ondemand', 19:24:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:24:24 INFO - 'tooltool.py': '/tools/tooltool.py', 19:24:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:24:24 INFO - '/tools/misc-python/virtualenv.py')}, 19:24:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:24:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:24:24 INFO - 'installer_path': 'installer.exe', 19:24:24 INFO - 'log_level': 'info', 19:24:24 INFO - 'log_name': 'talos', 19:24:24 INFO - 'log_to_console': True, 19:24:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:24:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:24:24 INFO - 'opt_config_files': (), 19:24:24 INFO - 'pip_index': False, 19:24:24 INFO - 'sps_profile': False, 19:24:24 INFO - 'sps_profile_interval': 0, 19:24:24 INFO - 'suite': 'dromaeojs', 19:24:24 INFO - 'system_bits': '32', 19:24:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:24:24 INFO - 'title': 'talos-linux64-ix-062', 19:24:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:24:24 INFO - 'use_talos_json': True, 19:24:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:24:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:24:24 INFO - 'work_dir': 'build'} 19:24:24 INFO - ##### 19:24:24 INFO - ##### Running clobber step. 19:24:24 INFO - ##### 19:24:24 INFO - Running pre-action listener: _resource_record_pre_action 19:24:24 INFO - Running main action method: clobber 19:24:24 INFO - rmtree: /builds/slave/test/build 19:24:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:24:25 INFO - Running post-action listener: _resource_record_post_action 19:24:25 INFO - ##### 19:24:25 INFO - ##### Finished clobber step (success) 19:24:25 INFO - ##### 19:24:25 INFO - ##### 19:24:25 INFO - ##### Running read-buildbot-config step. 19:24:25 INFO - ##### 19:24:25 INFO - Running pre-action listener: _resource_record_pre_action 19:24:25 INFO - Running main action method: read_buildbot_config 19:24:25 INFO - Using buildbot properties: 19:24:25 INFO - { 19:24:25 INFO - "project": "", 19:24:25 INFO - "product": "firefox", 19:24:25 INFO - "script_repo_revision": "production", 19:24:25 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 19:24:25 INFO - "repository": "", 19:24:25 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 19:24:25 INFO - "buildid": "20160705180326", 19:24:25 INFO - "pgo_build": "False", 19:24:25 INFO - "basedir": "/builds/slave/test", 19:24:25 INFO - "buildnumber": 36, 19:24:25 INFO - "slavename": "talos-linux64-ix-062", 19:24:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:24:25 INFO - "platform": "ubuntu64_hw", 19:24:25 INFO - "scheduler": "tests-autoland-linux64-talos", 19:24:25 INFO - "branch": "autoland", 19:24:25 INFO - "repo_path": "integration/autoland", 19:24:25 INFO - "revision": "78d2fb74e22f7d4858c88173071a5b6988c07389", 19:24:25 INFO - "stage_platform": "linux64", 19:24:25 INFO - "builduid": "729517e39bbb423da53326447d6d5020", 19:24:25 INFO - "slavebuilddir": "test" 19:24:25 INFO - } 19:24:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:24:25 INFO - Running post-action listener: _resource_record_post_action 19:24:25 INFO - ##### 19:24:25 INFO - ##### Finished read-buildbot-config step (success) 19:24:25 INFO - ##### 19:24:25 INFO - ##### 19:24:25 INFO - ##### Running download-and-extract step. 19:24:25 INFO - ##### 19:24:25 INFO - Running pre-action listener: _resource_record_pre_action 19:24:25 INFO - Running main action method: download_and_extract 19:24:25 INFO - mkdir: /builds/slave/test/build/tests 19:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:24:25 INFO - https://queue.taskcluster.net/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:24:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:24:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:24:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/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 19:24:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/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 19:24:27 INFO - Downloaded 1361 bytes. 19:24:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:24:27 INFO - Using the following test package requirements: 19:24:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:24:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:24:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:24:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:27 INFO - u'jsshell-linux-x86_64.zip'], 19:24:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:24:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:24:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:24:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:24:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:24:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:24:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:24:27 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')]} 19:24:27 INFO - https://queue.taskcluster.net/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:24:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:24:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:24:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/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 19:24:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/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 19:24:31 INFO - Downloaded 22732508 bytes. 19:24:31 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'] 19:24:31 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 19:24:32 INFO - Return code: 0 19:24:32 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 19:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:24:32 INFO - https://queue.taskcluster.net/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:24:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:24:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:24:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/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 19:24:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/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 19:24:34 INFO - Downloaded 22732508 bytes. 19:24:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:24:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:24:35 INFO - Return code: 0 19:24:35 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')]} 19:24:35 INFO - https://queue.taskcluster.net/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/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 19:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/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 19:24:36 INFO - Downloaded 14403333 bytes. 19:24:36 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'] 19:24:36 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 19:24:36 INFO - Return code: 0 19:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:24:36 INFO - https://queue.taskcluster.net/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:24:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:24:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:24:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/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 19:24:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COSorXfrTdOOu5VTzZeONA/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 19:24:38 INFO - Downloaded 56504419 bytes. 19:24:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:24:38 INFO - mkdir: /builds/slave/test/properties 19:24:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:24:38 INFO - Writing to file /builds/slave/test/properties/build_url 19:24:38 INFO - Contents: 19:24:38 INFO - build_url:https://queue.taskcluster.net/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:24:38 INFO - Running post-action listener: _resource_record_post_action 19:24:38 INFO - Running post-action listener: set_extra_try_arguments 19:24:38 INFO - ##### 19:24:38 INFO - ##### Finished download-and-extract step (success) 19:24:38 INFO - ##### 19:24:38 INFO - ##### 19:24:38 INFO - ##### Running populate-webroot step. 19:24:38 INFO - ##### 19:24:38 INFO - Running pre-action listener: _resource_record_pre_action 19:24:38 INFO - Running main action method: populate_webroot 19:24:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:24:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:24:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:24:38 INFO - '--tppagecycles', 19:24:38 INFO - '7'], 19:24:38 INFO - 'tests': ['tsvgm']}}, 19:24:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:24:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:24:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:24:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:24:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:24:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:24:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:38 INFO - 'talos_options': ['--disable-e10s'], 19:24:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:24:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:24:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:38 INFO - 'talos_options': ['--disable-e10s'], 19:24:38 INFO - 'tests': ['damp', 'tps']}, 19:24:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:38 INFO - 'tests': ['damp', 'tps']}, 19:24:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:24:38 INFO - 'tests': ['dromaeo_dom']}, 19:24:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:24:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:24:38 INFO - 'tests': ['basic_compositor_video']}, 19:24:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:24:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:24:38 INFO - 'tests': ['a11yr', 19:24:38 INFO - 'ts_paint', 19:24:38 INFO - 'tpaint', 19:24:38 INFO - 'sessionrestore', 19:24:38 INFO - 'sessionrestore_no_auto_restore', 19:24:38 INFO - 'tabpaint']}, 19:24:38 INFO - 'other-e10s': {'tests': ['a11yr', 19:24:38 INFO - 'ts_paint', 19:24:38 INFO - 'tpaint', 19:24:38 INFO - 'sessionrestore', 19:24:38 INFO - 'sessionrestore_no_auto_restore', 19:24:38 INFO - 'tabpaint']}, 19:24:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:24:38 INFO - 'ts_paint', 19:24:38 INFO - 'tpaint', 19:24:38 INFO - 'sessionrestore', 19:24:38 INFO - 'sessionrestore_no_auto_restore', 19:24:38 INFO - 'tabpaint']}, 19:24:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:24:38 INFO - 'ts_paint', 19:24:38 INFO - 'tpaint', 19:24:38 INFO - 'sessionrestore', 19:24:38 INFO - 'sessionrestore_no_auto_restore', 19:24:38 INFO - 'tabpaint']}, 19:24:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:24:38 INFO - 'tests': ['a11yr', 19:24:38 INFO - 'ts_paint', 19:24:38 INFO - 'tpaint', 19:24:38 INFO - 'sessionrestore', 19:24:38 INFO - 'sessionrestore_no_auto_restore', 19:24:38 INFO - 'tabpaint']}, 19:24:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:24:38 INFO - 'tests': ['a11yr', 19:24:38 INFO - 'ts_paint', 19:24:38 INFO - 'tpaint', 19:24:38 INFO - 'sessionrestore', 19:24:38 INFO - 'sessionrestore_no_auto_restore', 19:24:38 INFO - 'tabpaint']}, 19:24:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:24:38 INFO - 'tests': ['tsvgx', 19:24:38 INFO - 'tsvgr_opacity', 19:24:38 INFO - 'tart', 19:24:38 INFO - 'tscrollx', 19:24:38 INFO - 'cart']}, 19:24:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:24:38 INFO - 'tsvgr_opacity', 19:24:38 INFO - 'tart', 19:24:38 INFO - 'tscrollx', 19:24:38 INFO - 'cart']}, 19:24:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:38 INFO - 'talos_options': ['--disable-e10s'], 19:24:38 INFO - 'tests': ['tp5o']}, 19:24:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:38 INFO - 'tests': ['tp5o']}, 19:24:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:38 INFO - 'talos_options': ['--disable-e10s', 19:24:38 INFO - '--xperf_path', 19:24:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:24:38 INFO - 'tests': ['tp5n']}, 19:24:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:24:38 INFO - 'talos_options': ['--xperf_path', 19:24:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:24:38 INFO - 'tests': ['tp5n']}}, 19:24:38 INFO - 'talos.zip': {'path': '', 19:24:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:24:38 INFO - Running post-action listener: _resource_record_post_action 19:24:38 INFO - ##### 19:24:38 INFO - ##### Finished populate-webroot step (success) 19:24:38 INFO - ##### 19:24:38 INFO - ##### 19:24:38 INFO - ##### Running create-virtualenv step. 19:24:38 INFO - ##### 19:24:38 INFO - Running pre-action listener: _resource_record_pre_action 19:24:38 INFO - Running main action method: create_virtualenv 19:24:38 INFO - Creating virtualenv /builds/slave/test/build/venv 19:24:38 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 19:24:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:24:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:24:38 INFO - Using real prefix '/usr' 19:24:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:24:39 INFO - Installing distribute.............................................................................................................................................................................................done. 19:24:41 INFO - Installing pip.................done. 19:24:41 INFO - Return code: 0 19:24:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:24:41 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')]} 19:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:41 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')]} 19:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:41 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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', '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 19:24:41 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 19:24:41 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 19:24:41 INFO - Using env: {'DISPLAY': ':0', 19:24:41 INFO - 'HOME': '/home/cltbld', 19:24:41 INFO - 'LANG': 'en_US.UTF-8', 19:24:41 INFO - 'LANGUAGE': 'en_US:en', 19:24:41 INFO - 'LOGNAME': 'cltbld', 19:24:41 INFO - 'MAIL': '/var/mail/cltbld', 19:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:41 INFO - 'MOZ_NO_REMOTE': '1', 19:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:41 INFO - 'NO_EM_RESTART': '1', 19:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:41 INFO - 'PWD': '/builds/slave/test', 19:24:41 INFO - 'SHELL': '/bin/bash', 19:24:41 INFO - 'SHLVL': '1', 19:24:41 INFO - 'TERM': 'linux', 19:24:41 INFO - 'TMOUT': '86400', 19:24:41 INFO - 'USER': 'cltbld', 19:24:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', 19:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:41 INFO - '_': '/tools/buildbot/bin/python'} 19:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:41 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 19:24:41 INFO - Cleaning up... 19:24:41 INFO - Return code: 0 19:24:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:24:41 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')]} 19:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:41 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')]} 19:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:41 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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', '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 19:24:41 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 19:24:41 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 19:24:41 INFO - Using env: {'DISPLAY': ':0', 19:24:41 INFO - 'HOME': '/home/cltbld', 19:24:41 INFO - 'LANG': 'en_US.UTF-8', 19:24:41 INFO - 'LANGUAGE': 'en_US:en', 19:24:41 INFO - 'LOGNAME': 'cltbld', 19:24:41 INFO - 'MAIL': '/var/mail/cltbld', 19:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:41 INFO - 'MOZ_NO_REMOTE': '1', 19:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:41 INFO - 'NO_EM_RESTART': '1', 19:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:41 INFO - 'PWD': '/builds/slave/test', 19:24:41 INFO - 'SHELL': '/bin/bash', 19:24:41 INFO - 'SHLVL': '1', 19:24:41 INFO - 'TERM': 'linux', 19:24:41 INFO - 'TMOUT': '86400', 19:24:41 INFO - 'USER': 'cltbld', 19:24:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', 19:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:41 INFO - '_': '/tools/buildbot/bin/python'} 19:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:41 INFO - Downloading/unpacking psutil>=3.1.1 19:24:41 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 19:24:41 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 19:24:41 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 19:24:41 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 19:24:41 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 19:24:41 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 19:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:24:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:24:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:24:43 INFO - Installing collected packages: psutil 19:24:43 INFO - Running setup.py install for psutil 19:24:43 INFO - building 'psutil._psutil_linux' extension 19:24:43 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 19:24:44 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 19:24:44 INFO - building 'psutil._psutil_posix' extension 19:24:44 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 19:24:44 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 19:24:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:24:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:24:44 INFO - Successfully installed psutil 19:24:44 INFO - Cleaning up... 19:24:44 INFO - Return code: 0 19:24:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:24:44 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')]} 19:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:44 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')]} 19:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:44 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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', '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 19:24:44 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 19:24:44 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 19:24:44 INFO - Using env: {'DISPLAY': ':0', 19:24:44 INFO - 'HOME': '/home/cltbld', 19:24:44 INFO - 'LANG': 'en_US.UTF-8', 19:24:44 INFO - 'LANGUAGE': 'en_US:en', 19:24:44 INFO - 'LOGNAME': 'cltbld', 19:24:44 INFO - 'MAIL': '/var/mail/cltbld', 19:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:44 INFO - 'MOZ_NO_REMOTE': '1', 19:24:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:44 INFO - 'NO_EM_RESTART': '1', 19:24:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:44 INFO - 'PWD': '/builds/slave/test', 19:24:44 INFO - 'SHELL': '/bin/bash', 19:24:44 INFO - 'SHLVL': '1', 19:24:44 INFO - 'TERM': 'linux', 19:24:44 INFO - 'TMOUT': '86400', 19:24:44 INFO - 'USER': 'cltbld', 19:24:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', 19:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:44 INFO - '_': '/tools/buildbot/bin/python'} 19:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:24:44 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 19:24:44 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 19:24:44 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 19:24:44 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 19:24:44 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 19:24:44 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 19:24:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:24:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:24:46 INFO - Installing collected packages: mozsystemmonitor 19:24:46 INFO - Running setup.py install for mozsystemmonitor 19:24:46 INFO - Successfully installed mozsystemmonitor 19:24:46 INFO - Cleaning up... 19:24:46 INFO - Return code: 0 19:24:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:24:46 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')]} 19:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:46 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')]} 19:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:46 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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', '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 19:24:46 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 19:24:46 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 19:24:46 INFO - Using env: {'DISPLAY': ':0', 19:24:46 INFO - 'HOME': '/home/cltbld', 19:24:46 INFO - 'LANG': 'en_US.UTF-8', 19:24:46 INFO - 'LANGUAGE': 'en_US:en', 19:24:46 INFO - 'LOGNAME': 'cltbld', 19:24:46 INFO - 'MAIL': '/var/mail/cltbld', 19:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:46 INFO - 'MOZ_NO_REMOTE': '1', 19:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:46 INFO - 'NO_EM_RESTART': '1', 19:24:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:46 INFO - 'PWD': '/builds/slave/test', 19:24:46 INFO - 'SHELL': '/bin/bash', 19:24:46 INFO - 'SHLVL': '1', 19:24:46 INFO - 'TERM': 'linux', 19:24:46 INFO - 'TMOUT': '86400', 19:24:46 INFO - 'USER': 'cltbld', 19:24:46 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', 19:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:46 INFO - '_': '/tools/buildbot/bin/python'} 19:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:46 INFO - Downloading/unpacking jsonschema==2.5.1 19:24:46 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 19:24:46 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 19:24:46 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 19:24:46 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 19:24:46 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 19:24:46 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 19:24:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:24:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:49 INFO - Downloading functools32-3.2.3-2.tar.gz 19:24:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:24:49 INFO - warning: no files found matching '*.txt' 19:24:49 INFO - no previously-included directories found matching 'build' 19:24:49 INFO - no previously-included directories found matching 'dist' 19:24:49 INFO - no previously-included directories found matching '.git*' 19:24:49 INFO - Installing collected packages: jsonschema, functools32 19:24:49 INFO - Running setup.py install for functools32 19:24:49 INFO - warning: no files found matching '*.txt' 19:24:49 INFO - no previously-included directories found matching 'build' 19:24:49 INFO - no previously-included directories found matching 'dist' 19:24:49 INFO - no previously-included directories found matching '.git*' 19:24:49 INFO - Successfully installed jsonschema functools32 19:24:49 INFO - Cleaning up... 19:24:49 INFO - Return code: 0 19:24:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:24:49 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')]} 19:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:49 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')]} 19:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:49 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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', '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 19:24:49 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 19:24:49 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 19:24:49 INFO - Using env: {'DISPLAY': ':0', 19:24:49 INFO - 'HOME': '/home/cltbld', 19:24:49 INFO - 'LANG': 'en_US.UTF-8', 19:24:49 INFO - 'LANGUAGE': 'en_US:en', 19:24:49 INFO - 'LOGNAME': 'cltbld', 19:24:49 INFO - 'MAIL': '/var/mail/cltbld', 19:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:49 INFO - 'MOZ_NO_REMOTE': '1', 19:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:49 INFO - 'NO_EM_RESTART': '1', 19:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:49 INFO - 'PWD': '/builds/slave/test', 19:24:49 INFO - 'SHELL': '/bin/bash', 19:24:49 INFO - 'SHLVL': '1', 19:24:49 INFO - 'TERM': 'linux', 19:24:49 INFO - 'TMOUT': '86400', 19:24:49 INFO - 'USER': 'cltbld', 19:24:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', 19:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:49 INFO - '_': '/tools/buildbot/bin/python'} 19:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:49 INFO - Downloading/unpacking blobuploader==1.2.4 19:24:49 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 19:24:49 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 19:24:49 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 19:24:49 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 19:24:49 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 19:24:49 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 19:24:51 INFO - Downloading blobuploader-1.2.4.tar.gz 19:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:24:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:24:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:52 INFO - Downloading docopt-0.6.1.tar.gz 19:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:24:52 INFO - Installing collected packages: blobuploader, requests, docopt 19:24:52 INFO - Running setup.py install for blobuploader 19:24:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:24:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:24:52 INFO - Running setup.py install for requests 19:24:52 INFO - Running setup.py install for docopt 19:24:52 INFO - Successfully installed blobuploader requests docopt 19:24:52 INFO - Cleaning up... 19:24:52 INFO - Return code: 0 19:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24:52 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')]} 19:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:52 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')]} 19:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:52 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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', '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 19:24:52 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 19:24:52 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 19:24:52 INFO - Using env: {'DISPLAY': ':0', 19:24:52 INFO - 'HOME': '/home/cltbld', 19:24:52 INFO - 'LANG': 'en_US.UTF-8', 19:24:52 INFO - 'LANGUAGE': 'en_US:en', 19:24:52 INFO - 'LOGNAME': 'cltbld', 19:24:52 INFO - 'MAIL': '/var/mail/cltbld', 19:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:52 INFO - 'MOZ_NO_REMOTE': '1', 19:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:52 INFO - 'NO_EM_RESTART': '1', 19:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:52 INFO - 'PWD': '/builds/slave/test', 19:24:52 INFO - 'SHELL': '/bin/bash', 19:24:52 INFO - 'SHLVL': '1', 19:24:52 INFO - 'TERM': 'linux', 19:24:52 INFO - 'TMOUT': '86400', 19:24:52 INFO - 'USER': 'cltbld', 19:24:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', 19:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:52 INFO - '_': '/tools/buildbot/bin/python'} 19:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:24:52 INFO - Running setup.py (path:/tmp/pip-tF8iGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:24:53 INFO - Running setup.py (path:/tmp/pip-umrLr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:24:53 INFO - Running setup.py (path:/tmp/pip-IIHCFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:24:53 INFO - Running setup.py (path:/tmp/pip-o_9GHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:24:53 INFO - Running setup.py (path:/tmp/pip-ds_BWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:24:53 INFO - Running setup.py (path:/tmp/pip-UVNfa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:24:53 INFO - Running setup.py (path:/tmp/pip-x5a2Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:24:53 INFO - Running setup.py (path:/tmp/pip-QUcJtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:24:53 INFO - Running setup.py (path:/tmp/pip-1LCLZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:24:53 INFO - Running setup.py (path:/tmp/pip-PcbaCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:24:53 INFO - Running setup.py (path:/tmp/pip-4AS7Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:24:53 INFO - Running setup.py (path:/tmp/pip-El5lpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:24:53 INFO - Running setup.py (path:/tmp/pip-5eLOJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:24:53 INFO - Running setup.py (path:/tmp/pip-a4Lmc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:53 INFO - Running setup.py (path:/tmp/pip-9CGPzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:24:54 INFO - Running setup.py (path:/tmp/pip-cHNzlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:24:54 INFO - Running setup.py (path:/tmp/pip-bBmkWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:24:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:24:54 INFO - Running setup.py install for manifestparser 19:24:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:24:54 INFO - Running setup.py install for mozcrash 19:24:54 INFO - Running setup.py install for mozdebug 19:24:54 INFO - Running setup.py install for mozdevice 19:24:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:24:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:24:54 INFO - Running setup.py install for mozfile 19:24:54 INFO - Running setup.py install for mozhttpd 19:24:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:24:54 INFO - Running setup.py install for mozinfo 19:24:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:24:54 INFO - Running setup.py install for mozInstall 19:24:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:24:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:24:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:24:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:24:55 INFO - Running setup.py install for mozleak 19:24:55 INFO - Running setup.py install for mozlog 19:24:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:24:55 INFO - Running setup.py install for moznetwork 19:24:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:24:55 INFO - Running setup.py install for mozprocess 19:24:55 INFO - Running setup.py install for mozprofile 19:24:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:24:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:24:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:24:55 INFO - Running setup.py install for mozrunner 19:24:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:24:55 INFO - Running setup.py install for mozscreenshot 19:24:55 INFO - Running setup.py install for moztest 19:24:55 INFO - Running setup.py install for mozversion 19:24:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:24:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:24:55 INFO - Cleaning up... 19:24:56 INFO - Return code: 0 19:24:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:56 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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', '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 19:24:56 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 19:24:56 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 19:24:56 INFO - Using env: {'DISPLAY': ':0', 19:24:56 INFO - 'HOME': '/home/cltbld', 19:24:56 INFO - 'LANG': 'en_US.UTF-8', 19:24:56 INFO - 'LANGUAGE': 'en_US:en', 19:24:56 INFO - 'LOGNAME': 'cltbld', 19:24:56 INFO - 'MAIL': '/var/mail/cltbld', 19:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:56 INFO - 'MOZ_NO_REMOTE': '1', 19:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:56 INFO - 'NO_EM_RESTART': '1', 19:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:56 INFO - 'PWD': '/builds/slave/test', 19:24:56 INFO - 'SHELL': '/bin/bash', 19:24:56 INFO - 'SHLVL': '1', 19:24:56 INFO - 'TERM': 'linux', 19:24:56 INFO - 'TMOUT': '86400', 19:24:56 INFO - 'USER': 'cltbld', 19:24:56 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', 19:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:56 INFO - '_': '/tools/buildbot/bin/python'} 19:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:24:56 INFO - Running setup.py (path:/tmp/pip-JiYX6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:24:56 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)) 19:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:24:56 INFO - Running setup.py (path:/tmp/pip-HBclFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:24:56 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)) 19:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:24:56 INFO - Running setup.py (path:/tmp/pip-mw11yX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:24:56 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)) 19:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:24:56 INFO - Running setup.py (path:/tmp/pip-5_wRUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:24:56 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)) 19:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:24:56 INFO - Running setup.py (path:/tmp/pip-bR6dWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:24:56 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)) 19:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:24:56 INFO - Running setup.py (path:/tmp/pip-wOWjr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:24:56 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)) 19:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:24:56 INFO - Running setup.py (path:/tmp/pip-qCOKQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:24:56 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)) 19:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:24:56 INFO - Running setup.py (path:/tmp/pip-suY3ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:24:56 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)) 19:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:24:56 INFO - Running setup.py (path:/tmp/pip-HrJ5Qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:24:56 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)) 19:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:24:56 INFO - Running setup.py (path:/tmp/pip-ZYACMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:24:56 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)) 19:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:24:56 INFO - Running setup.py (path:/tmp/pip-1vaF3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:24:57 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)) 19:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:24:57 INFO - Running setup.py (path:/tmp/pip-ZDyA0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:24:57 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)) 19:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:24:57 INFO - Running setup.py (path:/tmp/pip-2FbD7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:24:57 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)) 19:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:24:57 INFO - Running setup.py (path:/tmp/pip-Var6qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:24:57 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)) 19:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:57 INFO - Running setup.py (path:/tmp/pip-2cPSIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:57 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)) 19:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:24:57 INFO - Running setup.py (path:/tmp/pip-sKlEOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:24:57 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)) 19:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:24:57 INFO - Running setup.py (path:/tmp/pip-1o6Sek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:24:57 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)) 19:24:57 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)) 19:24:57 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)) 19:24:57 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)) 19:24:57 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)) 19:24:57 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)) 19:24:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:24:57 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 19:24:57 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 19:24:57 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 19:24:57 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 19:24:57 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 19:24:57 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 19:24:59 INFO - Downloading blessings-1.6.tar.gz 19:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:24:59 INFO - Installing collected packages: blessings 19:24:59 INFO - Running setup.py install for blessings 19:24:59 INFO - Successfully installed blessings 19:24:59 INFO - Cleaning up... 19:24:59 INFO - Return code: 0 19:24:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:24:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:24:59 INFO - Reading from file tmpfile_stdout 19:24:59 INFO - Current package versions: 19:24:59 INFO - argparse == 1.2.1 19:24:59 INFO - blessings == 1.6 19:24:59 INFO - blobuploader == 1.2.4 19:24:59 INFO - docopt == 0.6.1 19:24:59 INFO - functools32 == 3.2.3-2 19:24:59 INFO - jsonschema == 2.5.1 19:24:59 INFO - manifestparser == 1.1 19:24:59 INFO - mozInstall == 1.12 19:24:59 INFO - mozcrash == 0.17 19:24:59 INFO - mozdebug == 0.1 19:24:59 INFO - mozdevice == 0.48 19:24:59 INFO - mozfile == 1.2 19:24:59 INFO - mozhttpd == 0.7 19:24:59 INFO - mozinfo == 0.9 19:24:59 INFO - mozleak == 0.1 19:24:59 INFO - mozlog == 3.2 19:24:59 INFO - moznetwork == 0.27 19:24:59 INFO - mozprocess == 0.22 19:24:59 INFO - mozprofile == 0.28 19:24:59 INFO - mozrunner == 6.11 19:24:59 INFO - mozscreenshot == 0.1 19:24:59 INFO - mozsystemmonitor == 0.3 19:24:59 INFO - moztest == 0.7 19:24:59 INFO - mozversion == 1.4 19:24:59 INFO - psutil == 3.1.1 19:24:59 INFO - requests == 1.2.3 19:24:59 INFO - wsgiref == 0.1.2 19:24:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:59 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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', '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 19:24:59 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 19:24:59 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 19:24:59 INFO - Using env: {'DISPLAY': ':0', 19:24:59 INFO - 'HOME': '/home/cltbld', 19:24:59 INFO - 'LANG': 'en_US.UTF-8', 19:24:59 INFO - 'LANGUAGE': 'en_US:en', 19:24:59 INFO - 'LOGNAME': 'cltbld', 19:24:59 INFO - 'MAIL': '/var/mail/cltbld', 19:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:59 INFO - 'MOZ_NO_REMOTE': '1', 19:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:59 INFO - 'NO_EM_RESTART': '1', 19:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:59 INFO - 'PWD': '/builds/slave/test', 19:24:59 INFO - 'SHELL': '/bin/bash', 19:24:59 INFO - 'SHLVL': '1', 19:24:59 INFO - 'TERM': 'linux', 19:24:59 INFO - 'TMOUT': '86400', 19:24:59 INFO - 'USER': 'cltbld', 19:24:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', 19:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:59 INFO - '_': '/tools/buildbot/bin/python'} 19:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 INFO - Cleaning up... 19:25:00 INFO - Return code: 0 19:25:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:25:00 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')]} 19:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:00 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')]} 19:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:00 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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', '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 19:25:00 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 19:25:00 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 19:25:00 INFO - Using env: {'DISPLAY': ':0', 19:25:00 INFO - 'HOME': '/home/cltbld', 19:25:00 INFO - 'LANG': 'en_US.UTF-8', 19:25:00 INFO - 'LANGUAGE': 'en_US:en', 19:25:00 INFO - 'LOGNAME': 'cltbld', 19:25:00 INFO - 'MAIL': '/var/mail/cltbld', 19:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:00 INFO - 'MOZ_NO_REMOTE': '1', 19:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:00 INFO - 'NO_EM_RESTART': '1', 19:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:00 INFO - 'PWD': '/builds/slave/test', 19:25:00 INFO - 'SHELL': '/bin/bash', 19:25:00 INFO - 'SHLVL': '1', 19:25:00 INFO - 'TERM': 'linux', 19:25:00 INFO - 'TMOUT': '86400', 19:25:00 INFO - 'USER': 'cltbld', 19:25:00 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', 19:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:00 INFO - '_': '/tools/buildbot/bin/python'} 19:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:25:00 INFO - Cleaning up... 19:25:00 INFO - Return code: 0 19:25:00 INFO - Running post-action listener: _resource_record_post_action 19:25:00 INFO - Running post-action listener: _start_resource_monitoring 19:25:00 INFO - Starting resource monitoring. 19:25:00 INFO - ##### 19:25:00 INFO - ##### Finished create-virtualenv step (success) 19:25:00 INFO - ##### 19:25:00 INFO - ##### 19:25:00 INFO - ##### Running install step. 19:25:00 INFO - ##### 19:25:00 INFO - Running pre-action listener: _resource_record_pre_action 19:25:00 INFO - Running main action method: install 19:25:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:25:00 INFO - Reading from file tmpfile_stdout 19:25:00 INFO - Detecting whether we're running mozinstall >=1.0... 19:25:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:25:00 INFO - Reading from file tmpfile_stdout 19:25:00 INFO - Output received: 19:25:00 INFO - Usage: mozinstall [options] installer 19:25:00 INFO - Options: 19:25:00 INFO - -h, --help show this help message and exit 19:25:00 INFO - -d DEST, --destination=DEST 19:25:00 INFO - Directory to install application into. [default: 19:25:00 INFO - "/builds/slave/test"] 19:25:00 INFO - --app=APP Application being installed. [default: firefox] 19:25:00 INFO - mkdir: /builds/slave/test/build/application 19:25:00 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'] 19:25:00 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 19:25:17 INFO - Reading from file tmpfile_stdout 19:25:17 INFO - Output received: 19:25:17 INFO - /builds/slave/test/build/application/firefox/firefox 19:25:17 INFO - Running post-action listener: _resource_record_post_action 19:25:17 INFO - ##### 19:25:17 INFO - ##### Finished install step (success) 19:25:17 INFO - ##### 19:25:17 INFO - ##### 19:25:17 INFO - ##### Running run-tests step. 19:25:17 INFO - ##### 19:25:17 INFO - Running pre-action listener: _resource_record_pre_action 19:25:17 INFO - Running main action method: run_tests 19:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:25:17 INFO - Python 2.7.3 19:25:17 INFO - Return code: 0 19:25:17 INFO - grabbing minidump binary from tooltool 19:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:25:17 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 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:25:17 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 19:25:17 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 19:25:17 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 19:25:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:25:17 INFO - Return code: 0 19:25:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:25:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:25:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:25:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:25:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 19:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 19:25:17 INFO - Using env: {'DISPLAY': ':0', 19:25:17 INFO - 'HOME': '/home/cltbld', 19:25:17 INFO - 'LANG': 'en_US.UTF-8', 19:25:17 INFO - 'LANGUAGE': 'en_US:en', 19:25:17 INFO - 'LOGNAME': 'cltbld', 19:25:17 INFO - 'MAIL': '/var/mail/cltbld', 19:25:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:25:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:17 INFO - 'MOZ_NO_REMOTE': '1', 19:25:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:17 INFO - 'NO_EM_RESTART': '1', 19:25:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:17 INFO - 'PWD': '/builds/slave/test', 19:25:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:25:17 INFO - 'SHELL': '/bin/bash', 19:25:17 INFO - 'SHLVL': '1', 19:25:17 INFO - 'TERM': 'linux', 19:25:17 INFO - 'TMOUT': '86400', 19:25:17 INFO - 'USER': 'cltbld', 19:25:17 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122', 19:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:17 INFO - '_': '/tools/buildbot/bin/python'} 19:25:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 19:25:17 INFO - mozversion application_buildid: 20160705180326 19:25:17 INFO - mozversion application_changeset: 78d2fb74e22f7d4858c88173071a5b6988c07389 19:25:17 INFO - mozversion application_display_name: Nightly 19:25:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:25:17 INFO - mozversion application_name: Firefox 19:25:17 INFO - mozversion application_remotingname: firefox 19:25:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:25:17 INFO - mozversion application_vendor: Mozilla 19:25:17 INFO - mozversion application_version: 50.0a1 19:25:17 INFO - mozversion platform_buildid: 20160705180326 19:25:17 INFO - mozversion platform_changeset: 78d2fb74e22f7d4858c88173071a5b6988c07389 19:25:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:25:17 INFO - mozversion platform_version: 50.0a1 19:25:17 INFO - using testdate: 1467771917 19:25:17 INFO - actual date: 1467771917 19:25:17 INFO - starting webserver on 'localhost:41850' 19:25:17 INFO - SUITE-START | Running 2 tests 19:25:17 INFO - TEST-START | dromaeo_css 19:25:17 INFO - operating with platform_type : linux_ 19:25:17 INFO - Initialising browser for dromaeo_css test... 19:25:17 INFO - TEST-INFO | started process 16746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvuapb3/profile http://localhost:41850/getInfo.html) 19:25:21 INFO - PROCESS | 16746 | __metrics Screen width/height:1600/1200 19:25:21 INFO - PROCESS | 16746 | colorDepth:24 19:25:21 INFO - PROCESS | 16746 | Browser inner width/height: 1024/697 19:25:21 INFO - PROCESS | 16746 | __metrics 19:25:22 INFO - PROCESS | 16746 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:25:23 INFO - TEST-INFO | 16746: exit 0 19:25:23 INFO - Browser initialized. 19:25:23 INFO - Running cycle 1/1 for dromaeo_css test... 19:25:23 INFO - TEST-INFO | started process 16828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvuapb3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:34 INFO - PROCESS | 16828 | RSS: Main: 159420416 19:25:34 INFO - PROCESS | 16828 | 19:26:25 INFO - PROCESS | 16828 | 1467771985926 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] 19:28:38 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:41850/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41850/tests/dromaeo/cssquery-ext.html) 19:28:39 INFO - PROCESS | 16828 | RSS: Main: 272936960 19:28:39 INFO - PROCESS | 16828 | 19:31:42 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:41850/tests/dromaeo/cssquery-ext.html (next: http://localhost:41850/tests/dromaeo/cssquery-jquery.html) 19:31:42 INFO - PROCESS | 16828 | RSS: Main: 248610816 19:31:42 INFO - PROCESS | 16828 | 19:34:45 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:41850/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41850/tests/dromaeo/cssquery-mootools.html) 19:34:45 INFO - PROCESS | 16828 | RSS: Main: 248004608 19:34:45 INFO - PROCESS | 16828 | 19:37:48 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:41850/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41850/tests/dromaeo/cssquery-prototype.html) 19:37:48 INFO - PROCESS | 16828 | RSS: Main: 239144960 19:37:48 INFO - PROCESS | 16828 | 19:40:51 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:41850/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41850/tests/dromaeo/cssquery-yui.html) 19:40:52 INFO - PROCESS | 16828 | RSS: Main: 215965696 19:40:52 INFO - PROCESS | 16828 | 19:43:54 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:41850/tests/dromaeo/cssquery-yui.html (next: http://localhost:41850/tests/dromaeo/cssquery-dojo.html) 19:43:55 INFO - PROCESS | 16828 | RSS: Main: 313794560 19:43:55 INFO - PROCESS | 16828 | 19:43:55 INFO - PROCESS | 16828 | __start_tp_report 19:43:55 INFO - PROCESS | 16828 | _x_x_mozilla_page_load 19:43:55 INFO - PROCESS | 16828 | _x_x_mozilla_page_load_details 19:43:55 INFO - PROCESS | 16828 | |i|pagename|runs| 19:43:55 INFO - PROCESS | 16828 | |0;dojo.html;2617.1232637066582;2627.842329460232;2664.200739778067;2664.933376665583;2673.8395696258212;4635.258358662614;4705.60002399796;4712.575868171873;4752.762361881905;4784.61723062155;4696.553827386393;4738.076075165344;4768.880777980552;4772.80908763649;4784.043191361724;4281.72168809028;4320.783960801963;4361.062371590107;4405.581469760367;4453.242948698713;75.97793237964017;4371.606555410012;4406.449193850769;4461.219286624844;4465.933011004838;4283.186194623043;4312.072904325585;4313.266744653416;4378.5183629800695;4398.054418300081;4327.8485253016;4363.865394997292;4364.214441400547;4369.060651959844;4425.712328698624;4330.350447432878;4344.826206951718;4355.542668019875;4373.169097871394;4391.231534481453;4617.561331673485;4640.559146881041;4706.905861882778;4826.22780355145;4854.7572621369145;5045.772940217699;5061.089003979282;5118.129917913963;5142.51146141116;5168.793248270064;5208.218767184915;5210.478952104797;5214.243934629458;5215.687058776485;5218.165093585008;4653.488116307203;4700.623950083985;4823.27650852375;4851.369321988154;4855.708657480563;5130.743462826844;5233.869153271199;5235.816746413857;5236.6857988520815;5292;5006.3491746073505;5032.295478632995;5069.721165335942;5071.163258062452;5074.517920797518;4924.778384972685;4930.6795058321095;5137.845864624067;5138.871528211825;5142.254373115952;4952.108620448354;4957.082939656175;4959.876003099951;4980.950190498049;4994.775235114428;4892.8532144035735;4926.088673595396;4934.703917764946;4942.233953737176;4983.6013118950395;4208.600182982612;4240.787960601958;4255.297875850512;4265.616094551505;4295.8496452624;3763.8118094095184;3765.9246815064093;3788.981055094762;3817.9618203818163;3838.1939792643857;4245.57544245573;4251.4685664291965;4254.149170165979;4281.507626622916;4302.118065796504;4899.510048995072;5044.571211447068;5085.0338435697095;5091.465396133427;5100.2349647553165;4262.168877069003;4276.8289268429535;4298.46269216348;4300.354946757949;4315.3095504719095;4586.128635559233;4597.402337696145;4597.42532183477;4605.171069207575;4643.210654188796;4679.040796636681;4702.106599746037;4759.262314341283;4769.952300476951;4776.355192049029;5083.059633967728;5102.209157580581;5110.080185566485;5114.1305977984575;5124.666896651705;4703.082898834695;4727.4799772025735;4739.123262196505;4753.667243292936;4757.072370887782;4878.487758785276;4883.462819089827;4909.459959404534;4942.28336891156;4991.775370108281;5051.797928082836;5057.974710126426;5065.113605119016;5069.569086627678;5117.1045067113855;4792.568668819823;4924.556789888928;4933.383327084114;4935.062338155739;4988.850334489971;4834;4844.321794948781;4849.369581954324;4872.537108974641;4893.21708526634;4797.784099715591;4806.591439727662;4817.759112044314;4848.539388758062;4863.416390033219;4782.95217047839;4879.682820616648;4906.313116163811;4908.410990681141;4949.28235405857;4707.223308154254;4728.0543891221205;4761.1429942609275;4761.976190119027;4801.423829140525 19:43:55 INFO - PROCESS | 16828 | |1;ext.html;570.5948776368778;584.6784268652242;587.2483221476512;589.6609449566498;593.1132956230437;27723;40355.192896142056;41369.58630413695;41458.37812432816;44960;42063.789681051625;42334.576654233446;42520.57479425205;42544;42570.36144457835;7440.441966852481;7805.882911756314;7960.960195199045;7963;7974.7208847690345;7447.925520744778;7721.613919304041;7752.147263800977;9931.553080111376;10212.438315892623;10281.126104281146;10307.896921030806;10330.7417314567;10334.689959301233;10388.948055259712;10171.338862973884;10233.283670143093;10234;10242.28304018719;10243.38539687621;7458.776236712907;7743.7676869694;7744.574048427335;9827.361221520578;10337.069663730224;40110.79944600288;40472.79763601193;40487.392689109685;40494.79752601247;40550.594494054974;2961.8667159977854;3085.8656244885506;3130.1235654016914;3385.64450732672;3479.1128262293205;29817.701822981926;29899.70100298991;30197.09408717742;30324.393512129634;30843.07470775858;3475.7740746851373;3496.7936062058548;3539.866920057754;3574.7318951078773;3643.744937854351;256909;257455;257656;259604;259684;45680.77159614247;51350.22974655383;52540.47459525432;52829.471705282456;58091.4190858086;55569;55700.44299557034;55779.16331255034;55878;56030.719846400505;14746.778798318033;14919.328630211667;14923.701525969636;14932.32804523799;14944.70110597782;10517;11451.942740286246;11556.479958401893;11577.073834093253;11649.301041937511;15411.845881541265;15618.76571851423;15683;16360.263788129325;16371.754423683655;5563.443655634404;5652.491275785117;5652.802151924745;5653.943460565341;5658.34928983164;827.5696637748338;939.3706216834601;955.460165006769;967.5645959318335;977.3354119199013;27798.861005694842;28218.85890570534;29025.85487072551;29051.85474072616;29343;956.861255118004;966.5553845231132;980.2990861534038;995.3231802374455;1023.82083135451;14694.926525367518;14986.62533436651;15515.689686206213;15840.287187076608;16499.17504124789;391991;397116;399726;400122;400696;51952;52013.219801703;52036;52066.73966630142;52087.21869171965;1077.876044254905;1091.0671375973586;1191.8629357623984;1201.4413297816557;1272.1222356573935;27314.453710926067;29985;30350.089497315115;31032.800270845906;31159.376812464077;44234;44968.32547511724;45100.32349514694;45269.54730452653;45324.32013519734;347504;350659;354144;354856;355477;32697.509537357433;38227;38958;39696.801515992236;40497;43334.78332608317;43531.78234108809;43560.78219608882;44151;44395.556044439145;36081.458778118875;36969;37502.81248593739;37866;37940.430893537174;36531.115034361435;36954.44568331423;37266;37429;37868.810655946545;35845.64154358423;36465;36822.63177368192;36948.815255923546;37034.444483332234;31661;33468.832655836566;33863.42097559258;33879;33996.3200735979;25595.872020639777;25627.35931601725;25646.743532564436;25768.226953191435;25859.48281034331 19:43:55 INFO - PROCESS | 16828 | |2;jquery.html;365.37338464533326;370.4147447033688;376.85491085931926;383.2258837148961;384.6826368246196;16425;17524.912375438136;17949.910250448746;18002.549936251602;18018.63962720745;16010.119443430607;16818.747718784227;16821.243044063045;17147.142642867868;17723;4665.743384113864;4821.758912054401;4825.927611085836;4840.104580652573;4853.878653033685;3487.2153765402836;5126.7436628168625;5380.677159370451;5391.919121213185;5458.4814442627885;5415.810446634368;5422.40353561108;5438.53772429342;5441.319835020622;5448.618596698233;5177.844664660066;5495.587830912677;5507.228987941691;5580.414056524088;5615.6630602164005;3365.74756893234;5032.3961124665275;5316.601254905898;5323.148296272578;5408.59435542332;12785.61643150707;12923.159994600415;12942.676433089155;19637.50906227356;20855;1967.5179581002747;2059.2895451069357;2227.9665805012937;2374.0266490738713;2421.9152329668555;9146.948100968408;9516.524173791282;9772.071653192936;9831.606735730562;13196.736065278641;1703.5059832648517;1708.5472349827305;1765.9646807063916;1788.8837225580296;1813.5738101546126;73147.63426182835;73194.26805731928;73264.26735732627;73365.26634733692;74290.62854685693;10208.387496750218;10248.538815753309;10478.580856765797;10592.417417042137;10635.574577016987;14206.147631141957;14265.78601320981;14278.714425711427;14283.357248923823;14294.499692510712;7505.362044226302;7762.805929851799;7792.493487923381;7814.33578145864;7861.882071768928;7323.487355885037;7404.777856664308;7479.925200747923;7499.887501687479;7511.286427789351;4437.134758722083;4452.2431186697695;4470.2177119004045;4528.479224889114;4580.564846339593;1695.6947749405226;1761.7533545303668;1767.2665843674988;1821.4864277529723;1823.7446757453968;834.1241696218946;836.3643630840484;844.8310337932315;898.142274128219;917.2661870503571;17043;17323.483562201673;17538.649227015387;18190;18422.447326580223;850.8213275212274;858.5835869603237;875.3784812782868;883.3816328570026;908.2597682888556;9635.855462168072;9834.508274586242;10181.389116653025;10246;10773.353598784099;397626;402801;405872;407484;407934;80078.5996070016;82096.58951705204;82545;83241;83557;936.5504557812152;952.3333666433385;952.6332362040664;977.9217662586976;985.2167526816055;16733.2470038851;16969.83030169732;16988.49034528966;17160.65678686444;17436.564085897448;40904;41475;41494.58505415028;41724.374134388614;42057.369139462324;54307;55228.17157742717;55235;55423;55473.44526554683;7680.193579674277;7790.337821285254;7892.171322011106;7906.486078404885;8004.319632831274;11391.886081139082;12020.939895300467;12061.155719099579;12232.449539770554;12508.061895357703;10221.846672300071;10343;10513.316634418738;10834.783304334027;10878.564857405616;10513.211509136692;10628.574857005633;10699;10705.464726763475;10797.190210734383;10300.175985920958;10513.369197848153;10616.203784716023;10719.303245289031;10856.782864342827;7690.884636730341;7762.262585054411;7818.648160832662;7892.0529536456;7990;9592.808143837225;10139.64511242103;10271.178305735673;10422.218333624856;10544 19:43:55 INFO - PROCESS | 16828 | |3;mootools.html;1353.9390727417262;1408.6267139208107;1480.4152359817872;1689.6958547461452;1721.3372851452195;7638.312551870331;8071.192880711926;8174.100848906623;8189.058258300297;8189.099199088103;6663.067170596109;6849.452043836493;6859.074025006623;7050.294970502947;7993.920060799404;2137.4335801012703;2232.118313266259;2243.080337061805;2244.450109723112;2245.236619549353;2214.723159605049;2233.20721143994;2237.630790919496;2252.1441852096264;2254.6843441918063;1911.4743445552444;2181.9890900545556;2190.3976406488264;2196.791304826039;2214.944626384337;2193.2762188477764;2224.5328481019005;2232.3191426614876;2233.687283780272;2234.028197733991;2178.59695956247;2180.6947027416018;2186.5408264264524;2190.4742861713235;2191.7589065202815;7919.208079192093;8034.47775894565;8042.517448953082;8063;8073.031236251629;4647.117047760915;4747.35910652061;4779.283107533863;4785.736784476852;4791.185498465235;2833.164216556121;2856.5429531274895;2897.478453878301;2944.8822047118088;2952.7785416093666;909.8589718593629;912.7763697894059;916.3448134583805;946.9195118414943;951.2817822543935;10717.30337528066;10740.462976851126;10741.624043158452;10766.192535559787;10766.24636275461;4097.262492751273;4228.85199018039;4322.935155972663;4341.261985462415;4341.848035318749;9233.53832308382;9238.214751746176;9307.627694892264;9308.255339572817;9314.767130821649;4751.857444276678;4757.26262429324;4758.547937945889;4764.38063051808;4780.641451891122;4132.710710250314;4327.480702315742;4329.19909816685;4337.284348082531;4338.501072376654;3389.322135572895;3406;3426.880059197916;3472.6353732858192;3493.4934434507363;988.1255089245925;989.2926557511414;996.8853581838036;1003.1523362758458;1022.6522982186092;695.2456584605759;810.7405630198398;823.2631794543969;825.7852958230903;827.3339961331066;4955.876103097451;4999.900001999939;5005.89988200234;5036.949630503648;5152.0211159880255;369.2577918384014;369.68946085288485;375.6206231705997;377.81487071334845;383.34256749674444;3255.57677501928;3434.5191673165778;3463.480477928331;3537.8054207018345;3608.9278214435562;9338.299627527827;9777.799995001067;9809.313348065709;9842.261830362751;9922.0574045467;9809.264305177141;9809.509524523744;9834.164096051916;9834.901650983542;9854.359466634645;6860.451163906875;7159.856802863914;7405.8148546286775;7470.813229669302;7492.7752167435065;5407.78368865241;5455.699936503531;5464.480874316933;5487.917681234864;5616.157576363578;9267.304952128483;9278.58246378928;9283.210927071275;9299.488528131018;9395.06049395055;9179.89841219058;9339.20616747584;9616.711498655051;9699.806003880023;9703.12671859536;6038.184845045863;6197.628142311476;6224.190855188796;6330.841728956813;6332.493400527855;7463.589502577411;7732.033495813023;7739.7678069658;7815.53106813593;7846.725364612211;6865.965670171618;6870.45036397077;6913.654317284217;7065.682044307916;7095.46783991213;6944.756933507303;6951.513394062569;6992.61540615271;7049.894251586128;7054.470914681522;5724.255846739898;5931.406859314034;5934.376890426443;6033.668148251888;6046.788362407295;4421.756803375845;4490.865274041784;4531.071130418322;4534.161180181677;4616.538346165356;4513.1650644630845;4540.182767101954;4589.7705114744795;4596.827808908707;4687.859364219079 19:43:55 INFO - PROCESS | 16828 | |4;prototype.html;286.1798958623156;291.50880765909443;295.1352537066396;307.91766939208685;310.02960732906;4781.90436191276;4837.8790530236765;4840.475250296158;4861.784553861535;4885.120678277917;4636.675432719711;4806.327114204006;4816.253480710487;4821.275979071822;4828.758562071891;3799.4300854871713;3800.239952009609;3801.201747633;3805.9619403806023;3815.5993620669847;3805.5243094613174;3813.3898576227807;3815.3513902636478;3816.332141875175;3822.847086116566;3692.5015122958325;3790.564085130204;3798.601146879579;3799.810009499528;3806.8286927088348;3765.435184722286;3773.8301776420126;3774.1508160663907;3794.4498047782918;3804.4700274317684;3306.123877172551;3309.6028476582724;3313.4426819394844;3327.434336162858;3331.716804071657;4760.09558183944;4793.904121917542;4795.808167673289;4803;4808.903821923577;4225.302825033897;4326.745243879272;4332.653387728974;4348.89127771805;4384.342348647697;5058.671186372874;5063.341765570489;5067.770181120295;5081.79672813087;5087;3629.6007439181667;3634.0551456621206;3640.362936486131;3640.799756013418;3651.214988777399;5189.351331083614;5320.920186197211;5329.946700532983;5335.626506144533;5355.812546560891;3712.6472985066375;3720.311742327678;3724.646158614927;3724.8510059597857;3728.6457786510236;3757.962420375816;3763.1909139535132;3775.244951009809;3780.773153610792;3784.7729136251914;4298.989737411705;4329.242382583036;4339.218940590661;4342.153280110411;4348.2825333819565;4918.385201849769;5084.46613105626;5103.464136265638;5115.590752739772;5126.79492820283;1296.572131196703;1301.5509649171022;1307.6008670722426;1308.483149156097;1309.8100775387516;801.8757092650649;830.5182993863665;832.5753865528624;842.8567143585606;843.0178841649409;3984.880453586339;3991.960080399159;3992.5807790182193;3995.220931918248;3996.8401263949117;4623.3758442609815;4645.5354464553275;4647.419072615923;4661.627069834405;4705.6470764692785;3959.901252336266;3967.4643923070016;3974.324364857981;3994.5406278277787;4035.7982100894837;2323.9651405228933;2478.467129567152;2481.9379515512255;2483.726790053093;2497.325722055035;4430.291153415503;4437.689361744711;4448.865539287461;4451.577100175478;4452.1763473757455;4803.807847686054;4804.591609713214;4810.350602668665;4826.686265392738;5121.718305493234;4423.3837915965005;4792.496787837227;4843.539863712942;4861.368022157097;4913.557779799764;5185.948140518546;5186.481351864783;5200.2199670049795;5209.453007434165;5235.685858848481;5145.735876214454;5170.146925757208;5173.198154286091;5179.404368497671;5179.81870634526;4714.481407045291;4881.3410189625365;4917.950820491749;4940.777665005012;4956.355673762388;3724.8137593119695;3736.6823819975607;3744.925101498009;3756.417755247941;3769.754965927206;5303.867403314948;5310.9468905312;5311.336082989626;5322.935412917354;5331.253624492497;4974.253861920741;5100.311457953278;5125.43620201785;5125.948740512547;5198.532132108128;5074.756684612294;5080.949190508048;5082.745862706924;5085.262636917701;5112;5018.544622059562;5037.496250374933;5050.166722490895;5058.468860769566;5060.139776238122;4904.313396124474;5161.058196827772;5183.611229157753;5186.662866913639;5187.458145508598;5027.723475208899;5050.797968081382;5061.139606267017;5062.784931616459;5089.898202036013 19:43:55 INFO - PROCESS | 16828 | |5;yui.html;632.336047150492;662.6189940784051;668.3350066683647;677.5832862789385;718.9209186989432;12518;12824;13340.866591334096;13341.066125371228;13562;12757.234565926028;12877.420516076776;12879;12897.806532902014;12902.741945161091;615.9692015399235;758.2152472191283;771.8340556780277;786.9213078692143;793.0919097633207;782.503110524818;786.2805532937384;789.0531362365156;789.4118881433341;790.5296348672531;828.6850996621306;829.7386323308139;829.7635173975418;830.4311546590604;830.6511265268572;643.925948515922;663.8108139180358;664.9434798042172;669.4543946683438;825.983480330393;570.9600327977043;592.813263821899;595.1519085303426;596.0463258785951;597.9970100149515;12749.74500509994;12754.74490510194;12755.170913890568;12769;12770.744585108247;11895.643130706092;12060.638180854588;12124.39378031095;12215.633530994084;12266.938665306705;10698;10761.408122553257;11030.50362733679;11146.609868654557;11203.71990700239;4034.23349563582;4046.7774272415004;4083.305838007546;4090.754554726726;4236.682248831319;61804.69097654483;61972.38027619711;62041.06938395928;63278.36721632771;63289.367106328806;9854.113129818208;10022.348547344545;10119.24105692076;10121.746956326151;10397.63608273722;17076;17670.558236044202;17693.115344232738;18569;18928.14823332953;6779.93220067793;6822.590644561342;6824.761133360308;6850.897236541456;7017.754378596725;3390.355832391838;3447.896563103111;3497.7901325920525;3508.964910350915;3512.1921957949817;3038.2860027893425;3135.1691801672573;3147.276126490874;3148.63790664072;3404.097914052778;585.8476796033062;587.5006244691978;590.6367583935935;602.0667964654767;607.1287702147432;454.7794319754916;496.52333759590476;512.403050446226;580.7938181945433;608.8686922688485;7647.235276472308;8009.279164875189;8104.594770261463;8262.793430164174;8292.212239837207;463.57351236862166;522.9163333866563;620.7889317631937;640.091070679636;650.9576877502947;3831.6743076838225;3969.1466334737593;4023.571031083582;4025;4195.97902010488;90381;91309.63035554472;91950;91990.54004730067;96173.51913240389;74861.62569187119;80159;81813;82426;87255.56372218099;45820.083598328514;52392.73803630957;67737.66131169313;71853.28146718466;72220;7623.923760762322;7637.159912409742;7820.139784623573;7840.843183136191;7864.646090925808;41195.38206926839;42881.35677964895;43211.35182972321;44046.77976610096;44617.77691111524;51998.480015200876;53125.20312195243;54897.45102549083;60892.695536522035;61726.69136654288;11363.003896000597;11766;11959.461824217757;12026.879731202926;12261.816072758736;13010.739785204054;13103.475860965455;13177.538786142439;13457.259850708306;13863.168209907439;11843.526258949545;12113;12189.75620487603;12365.258084514959;12504.499820007462;11784.58753943608;12227.75544489123;12240.265584064984;12585.622431327074;12618.369081545703;11758.43021516738;12115.515379384726;12220.51117955272;12366.81449778272;12407.131500794858;9785.315027947976;9838.75403114928;9940.552675129491;10135.239857010607;10137.32734098895;9638.42169469834;9701.52588745289;10237.795244094927;10815.621453249098;10998.835017474905 19:43:55 INFO - PROCESS | 16828 | __end_tp_report 19:43:55 INFO - PROCESS | 16828 | __start_cc_report 19:43:55 INFO - PROCESS | 16828 | _x_x_mozilla_cycle_collect,1088 19:43:55 INFO - PROCESS | 16828 | __end_cc_report 19:43:55 INFO - PROCESS | 16828 | __startTimestamp1467773035140__endTimestamp 19:43:55 INFO - PROCESS | 16828 | 19:43:55 INFO - PROCESS | 16828 | ------- Summary: start ------- 19:43:55 INFO - PROCESS | 16828 | Number of tests: 6 19:43:55 INFO - PROCESS | 16828 | 19:43:55 INFO - PROCESS | 16828 | [#0] dojo.html Cycles:165 Average:4643.54 Median:4784.04 stddev:606.04 (12.7%) stddev-sans-first:586.68 19:43:55 INFO - PROCESS | 16828 | Values: 2617.1 2627.8 2664.2 2664.9 2673.8 4635.3 4705.6 4712.6 4752.8 4784.6 4696.6 4738.1 4768.9 4772.8 4784.0 4281.7 4320.8 4361.1 4405.6 4453.2 76.0 4371.6 4406.4 4461.2 4465.9 4283.2 4312.1 4313.3 4378.5 4398.1 4327.8 4363.9 4364.2 4369.1 4425.7 4330.4 4344.8 4355.5 4373.2 4391.2 4617.6 4640.6 4706.9 4826.2 4854.8 5045.8 5061.1 5118.1 5142.5 5168.8 5208.2 5210.5 5214.2 5215.7 5218.2 4653.5 4700.6 4823.3 4851.4 4855.7 5130.7 5233.9 5235.8 5236.7 5292.0 5006.3 5032.3 5069.7 5071.2 5074.5 4924.8 4930.7 5137.8 5138.9 5142.3 4952.1 4957.1 4959.9 4981.0 4994.8 4892.9 4926.1 4934.7 4942.2 4983.6 4208.6 4240.8 4255.3 4265.6 4295.8 3763.8 3765.9 3789.0 3818.0 3838.2 4245.6 4251.5 4254.1 4281.5 4302.1 4899.5 5044.6 5085.0 5091.5 5100.2 4262.2 4276.8 4298.5 4300.4 4315.3 4586.1 4597.4 4597.4 4605.2 4643.2 4679.0 4702.1 4759.3 4770.0 4776.4 5083.1 5102.2 5110.1 5114.1 5124.7 4703.1 4727.5 4739.1 4753.7 4757.1 4878.5 4883.5 4909.5 4942.3 4991.8 5051.8 5058.0 5065.1 5069.6 5117.1 4792.6 4924.6 4933.4 4935.1 4988.9 4834.0 4844.3 4849.4 4872.5 4893.2 4797.8 4806.6 4817.8 4848.5 4863.4 4783.0 4879.7 4906.3 4908.4 4949.3 4707.2 4728.1 4761.1 4762.0 4801.4 19:43:55 INFO - PROCESS | 16828 | 19:43:55 INFO - PROCESS | 16828 | [#1] ext.html Cycles:180 Average:49883.42 Median:36951.63 stddev:89779.96 (243.0%) stddev-sans-first:89955.47 19:43:55 INFO - PROCESS | 16828 | Values: 570.6 584.7 587.2 589.7 593.1 27723.0 40355.2 41369.6 41458.4 44960.0 42063.8 42334.6 42520.6 42544.0 42570.4 7440.4 7805.9 7961.0 7963.0 7974.7 7447.9 7721.6 7752.1 9931.6 10212.4 10281.1 10307.9 10330.7 10334.7 10388.9 10171.3 10233.3 10234.0 10242.3 10243.4 7458.8 7743.8 7744.6 9827.4 10337.1 40110.8 40472.8 40487.4 40494.8 40550.6 2961.9 3085.9 3130.1 3385.6 3479.1 29817.7 29899.7 30197.1 30324.4 30843.1 3475.8 3496.8 3539.9 3574.7 3643.7 256909.0 257455.0 257656.0 259604.0 259684.0 45680.8 51350.2 52540.5 52829.5 58091.4 55569.0 55700.4 55779.2 55878.0 56030.7 14746.8 14919.3 14923.7 14932.3 14944.7 10517.0 11451.9 11556.5 11577.1 11649.3 15411.8 15618.8 15683.0 16360.3 16371.8 5563.4 5652.5 5652.8 5653.9 5658.3 827.6 939.4 955.5 967.6 977.3 27798.9 28218.9 29025.9 29051.9 29343.0 956.9 966.6 980.3 995.3 1023.8 14694.9 14986.6 15515.7 15840.3 16499.2 391991.0 397116.0 399726.0 400122.0 400696.0 51952.0 52013.2 52036.0 52066.7 52087.2 1077.9 1091.1 1191.9 1201.4 1272.1 27314.5 29985.0 30350.1 31032.8 31159.4 44234.0 44968.3 45100.3 45269.5 45324.3 347504.0 350659.0 354144.0 354856.0 355477.0 32697.5 38227.0 38958.0 39696.8 40497.0 43334.8 43531.8 43560.8 44151.0 44395.6 36081.5 36969.0 37502.8 37866.0 37940.4 36531.1 36954.4 37266.0 37429.0 37868.8 35845.6 36465.0 36822.6 36948.8 37034.4 31661.0 33468.8 33863.4 33879.0 33996.3 25595.9 25627.4 25646.7 25768.2 25859.5 19:43:55 INFO - PROCESS | 16828 | 19:43:55 INFO - PROCESS | 16828 | [#2] jquery.html Cycles:180 Average:25299.73 Median:41189.50 stddev:66932.00 (162.5%) stddev-sans-first:67093.58 19:43:55 INFO - PROCESS | 16828 | Values: 365.4 370.4 376.9 383.2 384.7 16425.0 17524.9 17949.9 18002.5 18018.6 16010.1 16818.7 16821.2 17147.1 17723.0 4665.7 4821.8 4825.9 4840.1 4853.9 3487.2 5126.7 5380.7 5391.9 5458.5 5415.8 5422.4 5438.5 5441.3 5448.6 5177.8 5495.6 5507.2 5580.4 5615.7 3365.7 5032.4 5316.6 5323.1 5408.6 12785.6 12923.2 12942.7 19637.5 20855.0 1967.5 2059.3 2228.0 2374.0 2421.9 9146.9 9516.5 9772.1 9831.6 13196.7 1703.5 1708.5 1766.0 1788.9 1813.6 73147.6 73194.3 73264.3 73365.3 74290.6 10208.4 10248.5 10478.6 10592.4 10635.6 14206.1 14265.8 14278.7 14283.4 14294.5 7505.4 7762.8 7792.5 7814.3 7861.9 7323.5 7404.8 7479.9 7499.9 7511.3 4437.1 4452.2 4470.2 4528.5 4580.6 1695.7 1761.8 1767.3 1821.5 1823.7 834.1 836.4 844.8 898.1 917.3 17043.0 17323.5 17538.6 18190.0 18422.4 850.8 858.6 875.4 883.4 908.3 9635.9 9834.5 10181.4 10246.0 10773.4 397626.0 402801.0 405872.0 407484.0 407934.0 80078.6 82096.6 82545.0 83241.0 83557.0 936.6 952.3 952.6 977.9 985.2 16733.2 16969.8 16988.5 17160.7 17436.6 40904.0 41475.0 41494.6 41724.4 42057.4 54307.0 55228.2 55235.0 55423.0 55473.4 7680.2 7790.3 7892.2 7906.5 8004.3 11391.9 12020.9 12061.2 12232.4 12508.1 10221.8 10343.0 10513.3 10834.8 10878.6 10513.2 10628.6 10699.0 10705.5 10797.2 10300.2 10513.4 10616.2 10719.3 10856.8 7690.9 7762.3 7818.6 7892.1 7990.0 9592.8 10139.6 10271.2 10422.2 10544.0 19:43:55 INFO - PROCESS | 16828 | 19:43:55 INFO - PROCESS | 16828 | [#3] mootools.html Cycles:180 Average:5161.38 Median:5094.49 stddev:2966.68 (58.2%) stddev-sans-first:2961.20 19:43:55 INFO - PROCESS | 16828 | Values: 1353.9 1408.6 1480.4 1689.7 1721.3 7638.3 8071.2 8174.1 8189.1 8189.1 6663.1 6849.5 6859.1 7050.3 7993.9 2137.4 2232.1 2243.1 2244.5 2245.2 2214.7 2233.2 2237.6 2252.1 2254.7 1911.5 2182.0 2190.4 2196.8 2214.9 2193.3 2224.5 2232.3 2233.7 2234.0 2178.6 2180.7 2186.5 2190.5 2191.8 7919.2 8034.5 8042.5 8063.0 8073.0 4647.1 4747.4 4779.3 4785.7 4791.2 2833.2 2856.5 2897.5 2944.9 2952.8 909.9 912.8 916.3 946.9 951.3 10717.3 10740.5 10741.6 10766.2 10766.2 4097.3 4228.9 4322.9 4341.3 4341.8 9233.5 9238.2 9307.6 9308.3 9314.8 4751.9 4757.3 4758.5 4764.4 4780.6 4132.7 4327.5 4329.2 4337.3 4338.5 3389.3 3406.0 3426.9 3472.6 3493.5 988.1 989.3 996.9 1003.2 1022.7 695.2 810.7 823.3 825.8 827.3 4955.9 4999.9 5005.9 5036.9 5152.0 369.3 369.7 375.6 377.8 383.3 3255.6 3434.5 3463.5 3537.8 3608.9 9338.3 9777.8 9809.3 9842.3 9922.1 9809.3 9809.5 9834.2 9834.9 9854.4 6860.5 7159.9 7405.8 7470.8 7492.8 5407.8 5455.7 5464.5 5487.9 5616.2 9267.3 9278.6 9283.2 9299.5 9395.1 9179.9 9339.2 9616.7 9699.8 9703.1 6038.2 6197.6 6224.2 6330.8 6332.5 7463.6 7732.0 7739.8 7815.5 7846.7 6866.0 6870.5 6913.7 7065.7 7095.5 6944.8 6951.5 6992.6 7049.9 7054.5 5724.3 5931.4 5934.4 6033.7 6046.8 4421.8 4490.9 4531.1 4534.2 4616.5 4513.2 4540.2 4589.8 4596.8 4687.9 19:43:55 INFO - PROCESS | 16828 | 19:43:55 INFO - PROCESS | 16828 | [#4] prototype.html Cycles:180 Average:4152.60 Median:4683.64 stddev:1216.48 (26.0%) stddev-sans-first:1184.77 19:43:55 INFO - PROCESS | 16828 | Values: 286.2 291.5 295.1 307.9 310.0 4781.9 4837.9 4840.5 4861.8 4885.1 4636.7 4806.3 4816.3 4821.3 4828.8 3799.4 3800.2 3801.2 3806.0 3815.6 3805.5 3813.4 3815.4 3816.3 3822.8 3692.5 3790.6 3798.6 3799.8 3806.8 3765.4 3773.8 3774.2 3794.4 3804.5 3306.1 3309.6 3313.4 3327.4 3331.7 4760.1 4793.9 4795.8 4803.0 4808.9 4225.3 4326.7 4332.7 4348.9 4384.3 5058.7 5063.3 5067.8 5081.8 5087.0 3629.6 3634.1 3640.4 3640.8 3651.2 5189.4 5320.9 5329.9 5335.6 5355.8 3712.6 3720.3 3724.6 3724.9 3728.6 3758.0 3763.2 3775.2 3780.8 3784.8 4299.0 4329.2 4339.2 4342.2 4348.3 4918.4 5084.5 5103.5 5115.6 5126.8 1296.6 1301.6 1307.6 1308.5 1309.8 801.9 830.5 832.6 842.9 843.0 3984.9 3992.0 3992.6 3995.2 3996.8 4623.4 4645.5 4647.4 4661.6 4705.6 3959.9 3967.5 3974.3 3994.5 4035.8 2324.0 2478.5 2481.9 2483.7 2497.3 4430.3 4437.7 4448.9 4451.6 4452.2 4803.8 4804.6 4810.4 4826.7 5121.7 4423.4 4792.5 4843.5 4861.4 4913.6 5185.9 5186.5 5200.2 5209.5 5235.7 5145.7 5170.1 5173.2 5179.4 5179.8 4714.5 4881.3 4918.0 4940.8 4956.4 3724.8 3736.7 3744.9 3756.4 3769.8 5303.9 5310.9 5311.3 5322.9 5331.3 4974.3 5100.3 5125.4 5125.9 5198.5 5074.8 5080.9 5082.7 5085.3 5112.0 5018.5 5037.5 5050.2 5058.5 5060.1 4904.3 5161.1 5183.6 5186.7 5187.5 5027.7 5050.8 5061.1 5062.8 5089.9 19:43:55 INFO - PROCESS | 16828 | 19:43:55 INFO - PROCESS | 16828 | [#5] yui.html Cycles:180 Average:17037.35 Median:23141.83 stddev:23667.24 (102.3%) stddev-sans-first:23701.58 19:43:55 INFO - PROCESS | 16828 | Values: 632.3 662.6 668.3 677.6 718.9 12518.0 12824.0 13340.9 13341.1 13562.0 12757.2 12877.4 12879.0 12897.8 12902.7 616.0 758.2 771.8 786.9 793.1 782.5 786.3 789.1 789.4 790.5 828.7 829.7 829.8 830.4 830.7 643.9 663.8 664.9 669.5 826.0 571.0 592.8 595.2 596.0 598.0 12749.7 12754.7 12755.2 12769.0 12770.7 11895.6 12060.6 12124.4 12215.6 12266.9 10698.0 10761.4 11030.5 11146.6 11203.7 4034.2 4046.8 4083.3 4090.8 4236.7 61804.7 61972.4 62041.1 63278.4 63289.4 9854.1 10022.3 10119.2 10121.7 10397.6 17076.0 17670.6 17693.1 18569.0 18928.1 6779.9 6822.6 6824.8 6850.9 7017.8 3390.4 3447.9 3497.8 3509.0 3512.2 3038.3 3135.2 3147.3 3148.6 3404.1 585.8 587.5 590.6 602.1 607.1 454.8 496.5 512.4 580.8 608.9 7647.2 8009.3 8104.6 8262.8 8292.2 463.6 522.9 620.8 640.1 651.0 3831.7 3969.1 4023.6 4025.0 4196.0 90381.0 91309.6 91950.0 91990.5 96173.5 74861.6 80159.0 81813.0 82426.0 87255.6 45820.1 52392.7 67737.7 71853.3 72220.0 7623.9 7637.2 7820.1 7840.8 7864.6 41195.4 42881.4 43211.4 44046.8 44617.8 51998.5 53125.2 54897.5 60892.7 61726.7 11363.0 11766.0 11959.5 12026.9 12261.8 13010.7 13103.5 13177.5 13457.3 13863.2 11843.5 12113.0 12189.8 12365.3 12504.5 11784.6 12227.8 12240.3 12585.6 12618.4 11758.4 12115.5 12220.5 12366.8 12407.1 9785.3 9838.8 9940.6 10135.2 10137.3 9638.4 9701.5 10237.8 10815.6 10998.8 19:43:55 INFO - PROCESS | 16828 | -------- Summary: end -------- 19:43:55 INFO - PROCESS | 16828 | 19:43:55 INFO - TEST-INFO | 16828: exit 0 19:43:55 INFO - TEST-OK | dromaeo_css | took 1118620ms 19:43:55 INFO - TEST-START | kraken 19:43:55 INFO - operating with platform_type : linux_ 19:43:55 INFO - Initialising browser for kraken test... 19:43:55 INFO - TEST-INFO | started process 17013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Th5OV/profile http://localhost:41850/getInfo.html) 19:43:59 INFO - PROCESS | 17013 | __metrics Screen width/height:1600/1200 19:43:59 INFO - PROCESS | 17013 | colorDepth:24 19:43:59 INFO - PROCESS | 17013 | Browser inner width/height: 1024/697 19:43:59 INFO - PROCESS | 17013 | __metrics 19:44:00 INFO - PROCESS | 17013 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:44:01 INFO - TEST-INFO | 17013: exit 0 19:44:01 INFO - Browser initialized. 19:44:01 INFO - Running cycle 1/1 for kraken test... 19:44:01 INFO - TEST-INFO | started process 17096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Th5OV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:44:13 INFO - PROCESS | 17096 | RSS: Main: 158920704 19:44:13 INFO - PROCESS | 17096 | 19:44:16 INFO - PROCESS | 17096 | Cycle 1(1): loaded http://localhost:41850/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41850/tests/kraken/driver.html?testName=audio-beat-detection) 19:44:17 INFO - PROCESS | 17096 | RSS: Main: 216981504 19:44:17 INFO - PROCESS | 17096 | 19:44:19 INFO - PROCESS | 17096 | Cycle 1(1): loaded http://localhost:41850/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41850/tests/kraken/driver.html?testName=audio-dft) 19:44:20 INFO - PROCESS | 17096 | RSS: Main: 204775424 19:44:20 INFO - PROCESS | 17096 | 19:44:23 INFO - PROCESS | 17096 | Cycle 1(1): loaded http://localhost:41850/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41850/tests/kraken/driver.html?testName=audio-fft) 19:44:24 INFO - PROCESS | 17096 | RSS: Main: 271085568 19:44:24 INFO - PROCESS | 17096 | 19:44:26 INFO - PROCESS | 17096 | Cycle 1(1): loaded http://localhost:41850/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41850/tests/kraken/driver.html?testName=audio-oscillator) 19:44:27 INFO - PROCESS | 17096 | RSS: Main: 181403648 19:44:27 INFO - PROCESS | 17096 | 19:44:29 INFO - PROCESS | 17096 | Cycle 1(1): loaded http://localhost:41850/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41850/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:44:29 INFO - PROCESS | 17096 | RSS: Main: 184705024 19:44:29 INFO - PROCESS | 17096 | 19:44:33 INFO - PROCESS | 17096 | Cycle 1(1): loaded http://localhost:41850/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41850/tests/kraken/driver.html?testName=imaging-darkroom) 19:44:33 INFO - PROCESS | 17096 | RSS: Main: 220872704 19:44:33 INFO - PROCESS | 17096 | 19:44:37 INFO - PROCESS | 17096 | Cycle 1(1): loaded http://localhost:41850/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41850/tests/kraken/driver.html?testName=imaging-desaturate) 19:44:37 INFO - PROCESS | 17096 | RSS: Main: 217907200 19:44:37 INFO - PROCESS | 17096 | 19:44:40 INFO - PROCESS | 17096 | Cycle 1(1): loaded http://localhost:41850/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41850/tests/kraken/driver.html?testName=json-parse-financial) 19:44:41 INFO - PROCESS | 17096 | RSS: Main: 220344320 19:44:41 INFO - PROCESS | 17096 | 19:44:43 INFO - PROCESS | 17096 | Cycle 1(1): loaded http://localhost:41850/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41850/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:44:43 INFO - PROCESS | 17096 | RSS: Main: 207323136 19:44:43 INFO - PROCESS | 17096 | 19:44:45 INFO - PROCESS | 17096 | Cycle 1(1): loaded http://localhost:41850/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41850/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:44:46 INFO - PROCESS | 17096 | RSS: Main: 211881984 19:44:46 INFO - PROCESS | 17096 | 19:44:48 INFO - PROCESS | 17096 | Cycle 1(1): loaded http://localhost:41850/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41850/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:44:48 INFO - PROCESS | 17096 | RSS: Main: 209940480 19:44:48 INFO - PROCESS | 17096 | 19:44:51 INFO - PROCESS | 17096 | Cycle 1(1): loaded http://localhost:41850/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:44:52 INFO - PROCESS | 17096 | RSS: Main: 223993856 19:44:52 INFO - PROCESS | 17096 | 19:44:55 INFO - PROCESS | 17096 | Cycle 1(1): loaded http://localhost:41850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:44:55 INFO - PROCESS | 17096 | RSS: Main: 224616448 19:44:55 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | Cycle 1(1): loaded http://localhost:41850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41850/tests/kraken/driver.html?testName=ai-astar) 19:44:57 INFO - PROCESS | 17096 | RSS: Main: 266612736 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | __start_tp_report 19:44:57 INFO - PROCESS | 17096 | _x_x_mozilla_page_load 19:44:57 INFO - PROCESS | 17096 | _x_x_mozilla_page_load_details 19:44:57 INFO - PROCESS | 17096 | |i|pagename|runs| 19:44:57 INFO - PROCESS | 17096 | |0;ai-astar;103;114;113;114;112;112;112;112;110;113 19:44:57 INFO - PROCESS | 17096 | |1;audio-beat-detection;168;122;127;180;126;129;145;122;164;123 19:44:57 INFO - PROCESS | 17096 | |2;audio-dft;163;161;162;162;163;163;161;162;163;160 19:44:57 INFO - PROCESS | 17096 | |3;audio-fft;76;76;79;114;77;78;76;76;106;75 19:44:57 INFO - PROCESS | 17096 | |4;audio-oscillator;85;86;112;86;85;86;122;87;86;128 19:44:57 INFO - PROCESS | 17096 | |5;imaging-gaussian-blur;118;117;118;117;117;118;119;117;117;117 19:44:57 INFO - PROCESS | 17096 | |6;imaging-darkroom;148;149;148;147;146;148;148;147;146;146 19:44:57 INFO - PROCESS | 17096 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 19:44:57 INFO - PROCESS | 17096 | |8;json-parse-financial;66;65;66;66;76;66;67;67;66;64 19:44:57 INFO - PROCESS | 17096 | |9;json-stringify-tinderbox;65;64;65;65;66;65;65;64;66;65 19:44:57 INFO - PROCESS | 17096 | |10;stanford-crypto-aes;80;78;78;79;77;79;79;79;79;80 19:44:57 INFO - PROCESS | 17096 | |11;stanford-crypto-ccm;156;129;129;127;128;132;150;137;219;138 19:44:57 INFO - PROCESS | 17096 | |12;stanford-crypto-pbkdf2;175;171;168;166;168;170;165;164;163;164 19:44:57 INFO - PROCESS | 17096 | |13;stanford-crypto-sha256-iterative;71;67;67;67;66;66;66;67;67;72 19:44:57 INFO - PROCESS | 17096 | __end_tp_report 19:44:57 INFO - PROCESS | 17096 | __start_cc_report 19:44:57 INFO - PROCESS | 17096 | _x_x_mozilla_cycle_collect,1873 19:44:57 INFO - PROCESS | 17096 | __end_cc_report 19:44:57 INFO - PROCESS | 17096 | __startTimestamp1467773097910__endTimestamp 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | ------- Summary: start ------- 19:44:57 INFO - PROCESS | 17096 | Number of tests: 14 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:3.21 (2.8%) stddev-sans-first:1.24 19:44:57 INFO - PROCESS | 17096 | Values: 103.0 114.0 113.0 114.0 112.0 112.0 112.0 112.0 110.0 113.0 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:137.00 stddev:22.12 (16.1%) stddev-sans-first:21.13 19:44:57 INFO - PROCESS | 17096 | Values: 168.0 122.0 127.0 180.0 126.0 129.0 145.0 122.0 164.0 123.0 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.05 (0.6%) stddev-sans-first:1.05 19:44:57 INFO - PROCESS | 17096 | Values: 163.0 161.0 162.0 162.0 163.0 163.0 161.0 162.0 163.0 160.0 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:14.24 (18.7%) stddev-sans-first:14.86 19:44:57 INFO - PROCESS | 17096 | Values: 76.0 76.0 79.0 114.0 77.0 78.0 76.0 76.0 106.0 75.0 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:86.00 stddev:17.25 (20.1%) stddev-sans-first:17.81 19:44:57 INFO - PROCESS | 17096 | Values: 85.0 86.0 112.0 86.0 85.0 86.0 122.0 87.0 86.0 128.0 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 19:44:57 INFO - PROCESS | 17096 | Values: 118.0 117.0 118.0 117.0 117.0 118.0 119.0 117.0 117.0 117.0 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 19:44:57 INFO - PROCESS | 17096 | Values: 148.0 149.0 148.0 147.0 146.0 148.0 148.0 147.0 146.0 146.0 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:44:57 INFO - PROCESS | 17096 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:66.00 stddev:3.31 (5.0%) stddev-sans-first:3.50 19:44:57 INFO - PROCESS | 17096 | Values: 66.0 65.0 66.0 66.0 76.0 66.0 67.0 67.0 66.0 64.0 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 19:44:57 INFO - PROCESS | 17096 | Values: 65.0 64.0 65.0 65.0 66.0 65.0 65.0 64.0 66.0 65.0 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:79.00 stddev:0.92 (1.2%) stddev-sans-first:0.87 19:44:57 INFO - PROCESS | 17096 | Values: 80.0 78.0 78.0 79.0 77.0 79.0 79.0 79.0 79.0 80.0 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:137.50 stddev:27.94 (20.3%) stddev-sans-first:29.32 19:44:57 INFO - PROCESS | 17096 | Values: 156.0 129.0 129.0 127.0 128.0 132.0 150.0 137.0 219.0 138.0 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:168.00 stddev:3.78 (2.2%) stddev-sans-first:2.83 19:44:57 INFO - PROCESS | 17096 | Values: 175.0 171.0 168.0 166.0 168.0 170.0 165.0 164.0 163.0 164.0 19:44:57 INFO - PROCESS | 17096 | 19:44:57 INFO - PROCESS | 17096 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:2.12 (3.2%) stddev-sans-first:1.86 19:44:57 INFO - PROCESS | 17096 | Values: 71.0 67.0 67.0 67.0 66.0 66.0 66.0 67.0 67.0 72.0 19:44:57 INFO - PROCESS | 17096 | -------- Summary: end -------- 19:44:57 INFO - PROCESS | 17096 | 19:44:58 INFO - TEST-INFO | 17096: exit 0 19:44:58 INFO - TEST-OK | kraken | took 62960ms 19:44:58 INFO - SUITE-END | took 1181s 19:44:59 INFO - Completed test suite (00:19:41) 19:44:59 INFO - javascript benchmark 19:44:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2617.1232637066582, 2627.842329460232, 2664.200739778067, 2664.933376665583, 2673.8395696258212, 4635.258358662614, 4705.60002399796, 4712.575868171873, 4752.762361881905, 4784.61723062155, 4696.553827386393, 4738.076075165344, 4768.880777980552, 4772.80908763649, 4784.043191361724, 4281.72168809028, 4320.783960801963, 4361.062371590107, 4405.581469760367, 4453.242948698713, 75.97793237964017, 4371.606555410012, 4406.449193850769, 4461.219286624844, 4465.933011004838, 4283.186194623043, 4312.072904325585, 4313.266744653416, 4378.5183629800695, 4398.054418300081, 4327.8485253016, 4363.865394997292, 4364.214441400547, 4369.060651959844, 4425.712328698624, 4330.350447432878, 4344.826206951718, 4355.542668019875, 4373.169097871394, 4391.231534481453, 4617.561331673485, 4640.559146881041, 4706.905861882778, 4826.22780355145, 4854.7572621369145, 5045.772940217699, 5061.089003979282, 5118.129917913963, 5142.51146141116, 5168.793248270064, 5208.218767184915, 5210.478952104797, 5214.243934629458, 5215.687058776485, 5218.165093585008, 4653.488116307203, 4700.623950083985, 4823.27650852375, 4851.369321988154, 4855.708657480563, 5130.743462826844, 5233.869153271199, 5235.816746413857, 5236.6857988520815, 5292.0, 5006.3491746073505, 5032.295478632995, 5069.721165335942, 5071.163258062452, 5074.517920797518, 4924.778384972685, 4930.6795058321095, 5137.845864624067, 5138.871528211825, 5142.254373115952, 4952.108620448354, 4957.082939656175, 4959.876003099951, 4980.950190498049, 4994.775235114428, 4892.8532144035735, 4926.088673595396, 4934.703917764946, 4942.233953737176, 4983.6013118950395, 4208.600182982612, 4240.787960601958, 4255.297875850512, 4265.616094551505, 4295.8496452624, 3763.8118094095184, 3765.9246815064093, 3788.981055094762, 3817.9618203818163, 3838.1939792643857, 4245.57544245573, 4251.4685664291965, 4254.149170165979, 4281.507626622916, 4302.118065796504, 4899.510048995072, 5044.571211447068, 5085.0338435697095, 5091.465396133427, 5100.2349647553165, 4262.168877069003, 4276.8289268429535, 4298.46269216348, 4300.354946757949, 4315.3095504719095, 4586.128635559233, 4597.402337696145, 4597.42532183477, 4605.171069207575, 4643.210654188796, 4679.040796636681, 4702.106599746037, 4759.262314341283, 4769.952300476951, 4776.355192049029, 5083.059633967728, 5102.209157580581, 5110.080185566485, 5114.1305977984575, 5124.666896651705, 4703.082898834695, 4727.4799772025735, 4739.123262196505, 4753.667243292936, 4757.072370887782, 4878.487758785276, 4883.462819089827, 4909.459959404534, 4942.28336891156, 4991.775370108281, 5051.797928082836, 5057.974710126426, 5065.113605119016, 5069.569086627678, 5117.1045067113855, 4792.568668819823, 4924.556789888928, 4933.383327084114, 4935.062338155739, 4988.850334489971, 4834.0, 4844.321794948781, 4849.369581954324, 4872.537108974641, 4893.21708526634, 4797.784099715591, 4806.591439727662, 4817.759112044314, 4848.539388758062, 4863.416390033219, 4782.95217047839, 4879.682820616648, 4906.313116163811, 4908.410990681141, 4949.28235405857, 4707.223308154254, 4728.0543891221205, 4761.1429942609275, 4761.976190119027, 4801.423829140525], "value": 4608.176999864617, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.5948776368778, 584.6784268652242, 587.2483221476512, 589.6609449566498, 593.1132956230437, 27723.0, 40355.192896142056, 41369.58630413695, 41458.37812432816, 44960.0, 42063.789681051625, 42334.576654233446, 42520.57479425205, 42544.0, 42570.36144457835, 7440.441966852481, 7805.882911756314, 7960.960195199045, 7963.0, 7974.7208847690345, 7447.925520744778, 7721.613919304041, 7752.147263800977, 9931.553080111376, 10212.438315892623, 10281.126104281146, 10307.896921030806, 10330.7417314567, 10334.689959301233, 10388.948055259712, 10171.338862973884, 10233.283670143093, 10234.0, 10242.28304018719, 10243.38539687621, 7458.776236712907, 7743.7676869694, 7744.574048427335, 9827.361221520578, 10337.069663730224, 40110.79944600288, 40472.79763601193, 40487.392689109685, 40494.79752601247, 40550.594494054974, 2961.8667159977854, 3085.8656244885506, 3130.1235654016914, 3385.64450732672, 3479.1128262293205, 29817.701822981926, 29899.70100298991, 30197.09408717742, 30324.393512129634, 30843.07470775858, 3475.7740746851373, 3496.7936062058548, 3539.866920057754, 3574.7318951078773, 3643.744937854351, 256909.0, 257455.0, 257656.0, 259604.0, 259684.0, 45680.77159614247, 51350.22974655383, 52540.47459525432, 52829.471705282456, 58091.4190858086, 55569.0, 55700.44299557034, 55779.16331255034, 55878.0, 56030.719846400505, 14746.778798318033, 14919.328630211667, 14923.701525969636, 14932.32804523799, 14944.70110597782, 10517.0, 11451.942740286246, 11556.479958401893, 11577.073834093253, 11649.301041937511, 15411.845881541265, 15618.76571851423, 15683.0, 16360.263788129325, 16371.754423683655, 5563.443655634404, 5652.491275785117, 5652.802151924745, 5653.943460565341, 5658.34928983164, 827.5696637748338, 939.3706216834601, 955.460165006769, 967.5645959318335, 977.3354119199013, 27798.861005694842, 28218.85890570534, 29025.85487072551, 29051.85474072616, 29343.0, 956.861255118004, 966.5553845231132, 980.2990861534038, 995.3231802374455, 1023.82083135451, 14694.926525367518, 14986.62533436651, 15515.689686206213, 15840.287187076608, 16499.17504124789, 391991.0, 397116.0, 399726.0, 400122.0, 400696.0, 51952.0, 52013.219801703, 52036.0, 52066.73966630142, 52087.21869171965, 1077.876044254905, 1091.0671375973586, 1191.8629357623984, 1201.4413297816557, 1272.1222356573935, 27314.453710926067, 29985.0, 30350.089497315115, 31032.800270845906, 31159.376812464077, 44234.0, 44968.32547511724, 45100.32349514694, 45269.54730452653, 45324.32013519734, 347504.0, 350659.0, 354144.0, 354856.0, 355477.0, 32697.509537357433, 38227.0, 38958.0, 39696.801515992236, 40497.0, 43334.78332608317, 43531.78234108809, 43560.78219608882, 44151.0, 44395.556044439145, 36081.458778118875, 36969.0, 37502.81248593739, 37866.0, 37940.430893537174, 36531.115034361435, 36954.44568331423, 37266.0, 37429.0, 37868.810655946545, 35845.64154358423, 36465.0, 36822.63177368192, 36948.815255923546, 37034.444483332234, 31661.0, 33468.832655836566, 33863.42097559258, 33879.0, 33996.3200735979, 25595.872020639777, 25627.35931601725, 25646.743532564436, 25768.226953191435, 25859.48281034331], "value": 18370.567839606825, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.37338464533326, 370.4147447033688, 376.85491085931926, 383.2258837148961, 384.6826368246196, 16425.0, 17524.912375438136, 17949.910250448746, 18002.549936251602, 18018.63962720745, 16010.119443430607, 16818.747718784227, 16821.243044063045, 17147.142642867868, 17723.0, 4665.743384113864, 4821.758912054401, 4825.927611085836, 4840.104580652573, 4853.878653033685, 3487.2153765402836, 5126.7436628168625, 5380.677159370451, 5391.919121213185, 5458.4814442627885, 5415.810446634368, 5422.40353561108, 5438.53772429342, 5441.319835020622, 5448.618596698233, 5177.844664660066, 5495.587830912677, 5507.228987941691, 5580.414056524088, 5615.6630602164005, 3365.74756893234, 5032.3961124665275, 5316.601254905898, 5323.148296272578, 5408.59435542332, 12785.61643150707, 12923.159994600415, 12942.676433089155, 19637.50906227356, 20855.0, 1967.5179581002747, 2059.2895451069357, 2227.9665805012937, 2374.0266490738713, 2421.9152329668555, 9146.948100968408, 9516.524173791282, 9772.071653192936, 9831.606735730562, 13196.736065278641, 1703.5059832648517, 1708.5472349827305, 1765.9646807063916, 1788.8837225580296, 1813.5738101546126, 73147.63426182835, 73194.26805731928, 73264.26735732627, 73365.26634733692, 74290.62854685693, 10208.387496750218, 10248.538815753309, 10478.580856765797, 10592.417417042137, 10635.574577016987, 14206.147631141957, 14265.78601320981, 14278.714425711427, 14283.357248923823, 14294.499692510712, 7505.362044226302, 7762.805929851799, 7792.493487923381, 7814.33578145864, 7861.882071768928, 7323.487355885037, 7404.777856664308, 7479.925200747923, 7499.887501687479, 7511.286427789351, 4437.134758722083, 4452.2431186697695, 4470.2177119004045, 4528.479224889114, 4580.564846339593, 1695.6947749405226, 1761.7533545303668, 1767.2665843674988, 1821.4864277529723, 1823.7446757453968, 834.1241696218946, 836.3643630840484, 844.8310337932315, 898.142274128219, 917.2661870503571, 17043.0, 17323.483562201673, 17538.649227015387, 18190.0, 18422.447326580223, 850.8213275212274, 858.5835869603237, 875.3784812782868, 883.3816328570026, 908.2597682888556, 9635.855462168072, 9834.508274586242, 10181.389116653025, 10246.0, 10773.353598784099, 397626.0, 402801.0, 405872.0, 407484.0, 407934.0, 80078.5996070016, 82096.58951705204, 82545.0, 83241.0, 83557.0, 936.5504557812152, 952.3333666433385, 952.6332362040664, 977.9217662586976, 985.2167526816055, 16733.2470038851, 16969.83030169732, 16988.49034528966, 17160.65678686444, 17436.564085897448, 40904.0, 41475.0, 41494.58505415028, 41724.374134388614, 42057.369139462324, 54307.0, 55228.17157742717, 55235.0, 55423.0, 55473.44526554683, 7680.193579674277, 7790.337821285254, 7892.171322011106, 7906.486078404885, 8004.319632831274, 11391.886081139082, 12020.939895300467, 12061.155719099579, 12232.449539770554, 12508.061895357703, 10221.846672300071, 10343.0, 10513.316634418738, 10834.783304334027, 10878.564857405616, 10513.211509136692, 10628.574857005633, 10699.0, 10705.464726763475, 10797.190210734383, 10300.175985920958, 10513.369197848153, 10616.203784716023, 10719.303245289031, 10856.782864342827, 7690.884636730341, 7762.262585054411, 7818.648160832662, 7892.0529536456, 7990.0, 9592.808143837225, 10139.64511242103, 10271.178305735673, 10422.218333624856, 10544.0], "value": 8402.591728508532, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.9390727417262, 1408.6267139208107, 1480.4152359817872, 1689.6958547461452, 1721.3372851452195, 7638.312551870331, 8071.192880711926, 8174.100848906623, 8189.058258300297, 8189.099199088103, 6663.067170596109, 6849.452043836493, 6859.074025006623, 7050.294970502947, 7993.920060799404, 2137.4335801012703, 2232.118313266259, 2243.080337061805, 2244.450109723112, 2245.236619549353, 2214.723159605049, 2233.20721143994, 2237.630790919496, 2252.1441852096264, 2254.6843441918063, 1911.4743445552444, 2181.9890900545556, 2190.3976406488264, 2196.791304826039, 2214.944626384337, 2193.2762188477764, 2224.5328481019005, 2232.3191426614876, 2233.687283780272, 2234.028197733991, 2178.59695956247, 2180.6947027416018, 2186.5408264264524, 2190.4742861713235, 2191.7589065202815, 7919.208079192093, 8034.47775894565, 8042.517448953082, 8063.0, 8073.031236251629, 4647.117047760915, 4747.35910652061, 4779.283107533863, 4785.736784476852, 4791.185498465235, 2833.164216556121, 2856.5429531274895, 2897.478453878301, 2944.8822047118088, 2952.7785416093666, 909.8589718593629, 912.7763697894059, 916.3448134583805, 946.9195118414943, 951.2817822543935, 10717.30337528066, 10740.462976851126, 10741.624043158452, 10766.192535559787, 10766.24636275461, 4097.262492751273, 4228.85199018039, 4322.935155972663, 4341.261985462415, 4341.848035318749, 9233.53832308382, 9238.214751746176, 9307.627694892264, 9308.255339572817, 9314.767130821649, 4751.857444276678, 4757.26262429324, 4758.547937945889, 4764.38063051808, 4780.641451891122, 4132.710710250314, 4327.480702315742, 4329.19909816685, 4337.284348082531, 4338.501072376654, 3389.322135572895, 3406.0, 3426.880059197916, 3472.6353732858192, 3493.4934434507363, 988.1255089245925, 989.2926557511414, 996.8853581838036, 1003.1523362758458, 1022.6522982186092, 695.2456584605759, 810.7405630198398, 823.2631794543969, 825.7852958230903, 827.3339961331066, 4955.876103097451, 4999.900001999939, 5005.89988200234, 5036.949630503648, 5152.0211159880255, 369.2577918384014, 369.68946085288485, 375.6206231705997, 377.81487071334845, 383.34256749674444, 3255.57677501928, 3434.5191673165778, 3463.480477928331, 3537.8054207018345, 3608.9278214435562, 9338.299627527827, 9777.799995001067, 9809.313348065709, 9842.261830362751, 9922.0574045467, 9809.264305177141, 9809.509524523744, 9834.164096051916, 9834.901650983542, 9854.359466634645, 6860.451163906875, 7159.856802863914, 7405.8148546286775, 7470.813229669302, 7492.7752167435065, 5407.78368865241, 5455.699936503531, 5464.480874316933, 5487.917681234864, 5616.157576363578, 9267.304952128483, 9278.58246378928, 9283.210927071275, 9299.488528131018, 9395.06049395055, 9179.89841219058, 9339.20616747584, 9616.711498655051, 9699.806003880023, 9703.12671859536, 6038.184845045863, 6197.628142311476, 6224.190855188796, 6330.841728956813, 6332.493400527855, 7463.589502577411, 7732.033495813023, 7739.7678069658, 7815.53106813593, 7846.725364612211, 6865.965670171618, 6870.45036397077, 6913.654317284217, 7065.682044307916, 7095.46783991213, 6944.756933507303, 6951.513394062569, 6992.61540615271, 7049.894251586128, 7054.470914681522, 5724.255846739898, 5931.406859314034, 5934.376890426443, 6033.668148251888, 6046.788362407295, 4421.756803375845, 4490.865274041784, 4531.071130418322, 4534.161180181677, 4616.538346165356, 4513.1650644630845, 4540.182767101954, 4589.7705114744795, 4596.827808908707, 4687.859364219079], "value": 4044.423806047905, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.1798958623156, 291.50880765909443, 295.1352537066396, 307.91766939208685, 310.02960732906, 4781.90436191276, 4837.8790530236765, 4840.475250296158, 4861.784553861535, 4885.120678277917, 4636.675432719711, 4806.327114204006, 4816.253480710487, 4821.275979071822, 4828.758562071891, 3799.4300854871713, 3800.239952009609, 3801.201747633, 3805.9619403806023, 3815.5993620669847, 3805.5243094613174, 3813.3898576227807, 3815.3513902636478, 3816.332141875175, 3822.847086116566, 3692.5015122958325, 3790.564085130204, 3798.601146879579, 3799.810009499528, 3806.8286927088348, 3765.435184722286, 3773.8301776420126, 3774.1508160663907, 3794.4498047782918, 3804.4700274317684, 3306.123877172551, 3309.6028476582724, 3313.4426819394844, 3327.434336162858, 3331.716804071657, 4760.09558183944, 4793.904121917542, 4795.808167673289, 4803.0, 4808.903821923577, 4225.302825033897, 4326.745243879272, 4332.653387728974, 4348.89127771805, 4384.342348647697, 5058.671186372874, 5063.341765570489, 5067.770181120295, 5081.79672813087, 5087.0, 3629.6007439181667, 3634.0551456621206, 3640.362936486131, 3640.799756013418, 3651.214988777399, 5189.351331083614, 5320.920186197211, 5329.946700532983, 5335.626506144533, 5355.812546560891, 3712.6472985066375, 3720.311742327678, 3724.646158614927, 3724.8510059597857, 3728.6457786510236, 3757.962420375816, 3763.1909139535132, 3775.244951009809, 3780.773153610792, 3784.7729136251914, 4298.989737411705, 4329.242382583036, 4339.218940590661, 4342.153280110411, 4348.2825333819565, 4918.385201849769, 5084.46613105626, 5103.464136265638, 5115.590752739772, 5126.79492820283, 1296.572131196703, 1301.5509649171022, 1307.6008670722426, 1308.483149156097, 1309.8100775387516, 801.8757092650649, 830.5182993863665, 832.5753865528624, 842.8567143585606, 843.0178841649409, 3984.880453586339, 3991.960080399159, 3992.5807790182193, 3995.220931918248, 3996.8401263949117, 4623.3758442609815, 4645.5354464553275, 4647.419072615923, 4661.627069834405, 4705.6470764692785, 3959.901252336266, 3967.4643923070016, 3974.324364857981, 3994.5406278277787, 4035.7982100894837, 2323.9651405228933, 2478.467129567152, 2481.9379515512255, 2483.726790053093, 2497.325722055035, 4430.291153415503, 4437.689361744711, 4448.865539287461, 4451.577100175478, 4452.1763473757455, 4803.807847686054, 4804.591609713214, 4810.350602668665, 4826.686265392738, 5121.718305493234, 4423.3837915965005, 4792.496787837227, 4843.539863712942, 4861.368022157097, 4913.557779799764, 5185.948140518546, 5186.481351864783, 5200.2199670049795, 5209.453007434165, 5235.685858848481, 5145.735876214454, 5170.146925757208, 5173.198154286091, 5179.404368497671, 5179.81870634526, 4714.481407045291, 4881.3410189625365, 4917.950820491749, 4940.777665005012, 4956.355673762388, 3724.8137593119695, 3736.6823819975607, 3744.925101498009, 3756.417755247941, 3769.754965927206, 5303.867403314948, 5310.9468905312, 5311.336082989626, 5322.935412917354, 5331.253624492497, 4974.253861920741, 5100.311457953278, 5125.43620201785, 5125.948740512547, 5198.532132108128, 5074.756684612294, 5080.949190508048, 5082.745862706924, 5085.262636917701, 5112.0, 5018.544622059562, 5037.496250374933, 5050.166722490895, 5058.468860769566, 5060.139776238122, 4904.313396124474, 5161.058196827772, 5183.611229157753, 5186.662866913639, 5187.458145508598, 5027.723475208899, 5050.797968081382, 5061.139606267017, 5062.784931616459, 5089.898202036013], "value": 3765.887118632402, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.336047150492, 662.6189940784051, 668.3350066683647, 677.5832862789385, 718.9209186989432, 12518.0, 12824.0, 13340.866591334096, 13341.066125371228, 13562.0, 12757.234565926028, 12877.420516076776, 12879.0, 12897.806532902014, 12902.741945161091, 615.9692015399235, 758.2152472191283, 771.8340556780277, 786.9213078692143, 793.0919097633207, 782.503110524818, 786.2805532937384, 789.0531362365156, 789.4118881433341, 790.5296348672531, 828.6850996621306, 829.7386323308139, 829.7635173975418, 830.4311546590604, 830.6511265268572, 643.925948515922, 663.8108139180358, 664.9434798042172, 669.4543946683438, 825.983480330393, 570.9600327977043, 592.813263821899, 595.1519085303426, 596.0463258785951, 597.9970100149515, 12749.74500509994, 12754.74490510194, 12755.170913890568, 12769.0, 12770.744585108247, 11895.643130706092, 12060.638180854588, 12124.39378031095, 12215.633530994084, 12266.938665306705, 10698.0, 10761.408122553257, 11030.50362733679, 11146.609868654557, 11203.71990700239, 4034.23349563582, 4046.7774272415004, 4083.305838007546, 4090.754554726726, 4236.682248831319, 61804.69097654483, 61972.38027619711, 62041.06938395928, 63278.36721632771, 63289.367106328806, 9854.113129818208, 10022.348547344545, 10119.24105692076, 10121.746956326151, 10397.63608273722, 17076.0, 17670.558236044202, 17693.115344232738, 18569.0, 18928.14823332953, 6779.93220067793, 6822.590644561342, 6824.761133360308, 6850.897236541456, 7017.754378596725, 3390.355832391838, 3447.896563103111, 3497.7901325920525, 3508.964910350915, 3512.1921957949817, 3038.2860027893425, 3135.1691801672573, 3147.276126490874, 3148.63790664072, 3404.097914052778, 585.8476796033062, 587.5006244691978, 590.6367583935935, 602.0667964654767, 607.1287702147432, 454.7794319754916, 496.52333759590476, 512.403050446226, 580.7938181945433, 608.8686922688485, 7647.235276472308, 8009.279164875189, 8104.594770261463, 8262.793430164174, 8292.212239837207, 463.57351236862166, 522.9163333866563, 620.7889317631937, 640.091070679636, 650.9576877502947, 3831.6743076838225, 3969.1466334737593, 4023.571031083582, 4025.0, 4195.97902010488, 90381.0, 91309.63035554472, 91950.0, 91990.54004730067, 96173.51913240389, 74861.62569187119, 80159.0, 81813.0, 82426.0, 87255.56372218099, 45820.083598328514, 52392.73803630957, 67737.66131169313, 71853.28146718466, 72220.0, 7623.923760762322, 7637.159912409742, 7820.139784623573, 7840.843183136191, 7864.646090925808, 41195.38206926839, 42881.35677964895, 43211.35182972321, 44046.77976610096, 44617.77691111524, 51998.480015200876, 53125.20312195243, 54897.45102549083, 60892.695536522035, 61726.69136654288, 11363.003896000597, 11766.0, 11959.461824217757, 12026.879731202926, 12261.816072758736, 13010.739785204054, 13103.475860965455, 13177.538786142439, 13457.259850708306, 13863.168209907439, 11843.526258949545, 12113.0, 12189.75620487603, 12365.258084514959, 12504.499820007462, 11784.58753943608, 12227.75544489123, 12240.265584064984, 12585.622431327074, 12618.369081545703, 11758.43021516738, 12115.515379384726, 12220.51117955272, 12366.81449778272, 12407.131500794858, 9785.315027947976, 9838.75403114928, 9940.552675129491, 10135.239857010607, 10137.32734098895, 9638.42169469834, 9701.52588745289, 10237.795244094927, 10815.621453249098, 10998.835017474905], "value": 6524.263037056627, "unit": "score"}], "name": "dromaeo_css", "value": 6430.266916280891, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 113.0, 114.0, 112.0, 112.0, 112.0, 112.0, 110.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 122.0, 127.0, 180.0, 126.0, 129.0, 145.0, 122.0, 164.0, 123.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 162.0, 163.0, 163.0, 161.0, 162.0, 163.0, 160.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 79.0, 114.0, 77.0, 78.0, 76.0, 76.0, 106.0, 75.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 112.0, 86.0, 85.0, 86.0, 122.0, 87.0, 86.0, 128.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 147.0, 146.0, 148.0, 148.0, 147.0, 146.0, 146.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 76.0, 66.0, 67.0, 67.0, 66.0, 64.0], "value": 66.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 64.0, 66.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 79.0, 77.0, 79.0, 79.0, 79.0, 79.0, 80.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 129.0, 127.0, 128.0, 132.0, 150.0, 137.0, 219.0, 138.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 168.0, 166.0, 168.0, 170.0, 165.0, 164.0, 163.0, 164.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0, 72.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1543.6, "alertThreshold": 2.0}]} 19:44:59 INFO - Return code: 0 19:44:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:44:59 INFO - # TBPL SUCCESS # 19:44:59 INFO - Running post-action listener: _resource_record_post_action 19:44:59 INFO - ##### 19:44:59 INFO - ##### Finished run-tests step (success) 19:44:59 INFO - ##### 19:44:59 INFO - Running post-run listener: _resource_record_post_run 19:44:59 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 535465984; Read time: 0; Write time: 536752 19:44:59 INFO - TinderboxPrint: CPU usage
13.0% 19:44:59 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:44:59 INFO - TinderboxPrint: I/O write bytes / time
535,465,984 / 536,752 19:44:59 INFO - TinderboxPrint: CPU idle
8,313.5 (87.0%) 19:44:59 INFO - TinderboxPrint: CPU user
1,203.6 (12.6%) 19:44:59 INFO - TinderboxPrint: Swap in / out
0 / 0 19:44:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253026304; Read time: 0; Write time: 340020 19:44:59 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 282439680; Read time: 0; Write time: 196732 19:44:59 INFO - Running post-run listener: _upload_blobber_files 19:44:59 INFO - Blob upload gear active. 19:44:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:44:59 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:44:59 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:44:59 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:45:00 INFO - (blobuploader) - INFO - Open directory for files ... 19:45:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:45:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:45:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:45:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:45:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:45:03 INFO - (blobuploader) - INFO - Done attempting. 19:45:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:45:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:45:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:45:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:45:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:45:04 INFO - (blobuploader) - INFO - Done attempting. 19:45:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:45:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:45:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:45:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:45:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:45:05 INFO - (blobuploader) - INFO - Done attempting. 19:45:05 INFO - (blobuploader) - INFO - Iteration through files over. 19:45:05 INFO - Return code: 0 19:45:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:45:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:45:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f56fac618163e9cf50705ba842b5e6906761ce35a994055e13d57295e98f9fd066d2c9db7e5efd03749e2323d5cc50616da61c4c7dd6c1a340d0888187d3b631", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e93bccf0ae4e9b8f60662653cfd1669899142a007fd4e8e25de11b4f9f856d185615d7fd45470c8e89854aa44d72832871654f4d44c62fad1d5ab6e87fb7f91c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/19f6ac6fb49b49626ae810b751db88a1460e9e59aa24166e7b4efb43af45d8d2ec3fce7e2fc8ee1940e289e24fa181bf6de972b81bde4783e35f55d1c78ea5f5"} 19:45:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:45:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:45:05 INFO - Contents: 19:45:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f56fac618163e9cf50705ba842b5e6906761ce35a994055e13d57295e98f9fd066d2c9db7e5efd03749e2323d5cc50616da61c4c7dd6c1a340d0888187d3b631", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e93bccf0ae4e9b8f60662653cfd1669899142a007fd4e8e25de11b4f9f856d185615d7fd45470c8e89854aa44d72832871654f4d44c62fad1d5ab6e87fb7f91c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/19f6ac6fb49b49626ae810b751db88a1460e9e59aa24166e7b4efb43af45d8d2ec3fce7e2fc8ee1940e289e24fa181bf6de972b81bde4783e35f55d1c78ea5f5"} 19:45:05 INFO - Running post-run listener: copy_logs_to_upload_dir 19:45:05 INFO - Copying logs to upload dir... 19:45:05 INFO - mkdir: /builds/slave/test/build/upload/logs 19:45:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.337744 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-05 19:45:05.323958) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:05.328479) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f56fac618163e9cf50705ba842b5e6906761ce35a994055e13d57295e98f9fd066d2c9db7e5efd03749e2323d5cc50616da61c4c7dd6c1a340d0888187d3b631", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e93bccf0ae4e9b8f60662653cfd1669899142a007fd4e8e25de11b4f9f856d185615d7fd45470c8e89854aa44d72832871654f4d44c62fad1d5ab6e87fb7f91c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/19f6ac6fb49b49626ae810b751db88a1460e9e59aa24166e7b4efb43af45d8d2ec3fce7e2fc8ee1940e289e24fa181bf6de972b81bde4783e35f55d1c78ea5f5"} build_url:https://queue.taskcluster.net/v1/task/COSorXfrTdOOu5VTzZeONA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011189 build_url: 'https://queue.taskcluster.net/v1/task/COSorXfrTdOOu5VTzZeONA/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/Autoland-Non-PGO/sha512/f56fac618163e9cf50705ba842b5e6906761ce35a994055e13d57295e98f9fd066d2c9db7e5efd03749e2323d5cc50616da61c4c7dd6c1a340d0888187d3b631", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e93bccf0ae4e9b8f60662653cfd1669899142a007fd4e8e25de11b4f9f856d185615d7fd45470c8e89854aa44d72832871654f4d44c62fad1d5ab6e87fb7f91c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/19f6ac6fb49b49626ae810b751db88a1460e9e59aa24166e7b4efb43af45d8d2ec3fce7e2fc8ee1940e289e24fa181bf6de972b81bde4783e35f55d1c78ea5f5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:05.353517) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:05.355403) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467771830.232897-499338122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:05.439126) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 19:45:05.439437) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 19:45:05.439752) ========= ========= Total master_lag: 0.20 =========