builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1468055640.53 results: success (0) buildid: 20160709013039 builduid: 33c116035c834f1e971421a4bab83389 revision: fe0ea08656ec28e9d33e381e0653ba65713a7db4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 02:14:00.530388) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 02:14:00.531227) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 02:14:00.531785) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 02:14:00.553763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:14:00.554240) ========= 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=fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-09 02:14:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 35.8M=0s 2016-07-09 02:14:01 (35.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113440 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:14:00.706079) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:14:00.706365) ========= 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=fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015143 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:14:00.756019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-09 02:14:00.756356) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fe0ea08656ec28e9d33e381e0653ba65713a7db4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fe0ea08656ec28e9d33e381e0653ba65713a7db4 --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=fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-09 02:14:01,297 truncating revision to first 12 chars 2016-07-09 02:14:01,298 Setting DEBUG logging. 2016-07-09 02:14:01,298 attempt 1/10 2016-07-09 02:14:01,298 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fe0ea08656ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-09 02:14:02,339 unpacking tar archive at: fx-team-fe0ea08656ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.368036 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-09 02:14:02.137997) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 02:14:02.138326) ========= script_repo_revision: fe0ea08656ec28e9d33e381e0653ba65713a7db4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 02:14:02.138803) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 02:14:02.139125) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 02:14:02.149570) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-09 02:14:02.149903) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:14:02 INFO - MultiFileLogger online at 20160709 02:14:02 in /builds/slave/test 02:14:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:14:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:14:02 INFO - {'append_to_log': False, 02:14:02 INFO - 'base_work_dir': '/builds/slave/test', 02:14:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:14:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:14:02 INFO - 'branch': 'Fx-Team-Non-PGO', 02:14:02 INFO - 'buildbot_json_path': 'buildprops.json', 02:14:02 INFO - 'config_files': ('talos/linux_config.py',), 02:14:02 INFO - 'default_actions': ('clobber', 02:14:02 INFO - 'read-buildbot-config', 02:14:02 INFO - 'download-and-extract', 02:14:02 INFO - 'populate-webroot', 02:14:02 INFO - 'create-virtualenv', 02:14:02 INFO - 'install', 02:14:02 INFO - 'run-tests'), 02:14:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:14:02 INFO - 'download_minidump_stackwalk': True, 02:14:02 INFO - 'download_symbols': 'ondemand', 02:14:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:14:02 INFO - 'tooltool.py': '/tools/tooltool.py', 02:14:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:14:02 INFO - '/tools/misc-python/virtualenv.py')}, 02:14:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:14:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:14:02 INFO - 'installer_path': 'installer.exe', 02:14:02 INFO - 'log_level': 'info', 02:14:02 INFO - 'log_name': 'talos', 02:14:02 INFO - 'log_to_console': True, 02:14:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:14:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:14:02 INFO - 'opt_config_files': (), 02:14:02 INFO - 'pip_index': False, 02:14:02 INFO - 'sps_profile': False, 02:14:02 INFO - 'sps_profile_interval': 0, 02:14:02 INFO - 'suite': 'dromaeojs', 02:14:02 INFO - 'system_bits': '32', 02:14:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:14:02 INFO - 'title': 'talos-linux64-ix-048', 02:14:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:14:02 INFO - 'use_talos_json': True, 02:14:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:14:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:14:02 INFO - 'work_dir': 'build'} 02:14:02 INFO - ##### 02:14:02 INFO - ##### Running clobber step. 02:14:02 INFO - ##### 02:14:02 INFO - Running pre-action listener: _resource_record_pre_action 02:14:02 INFO - Running main action method: clobber 02:14:02 INFO - rmtree: /builds/slave/test/build 02:14:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:14:03 INFO - Running post-action listener: _resource_record_post_action 02:14:03 INFO - ##### 02:14:03 INFO - ##### Finished clobber step (success) 02:14:03 INFO - ##### 02:14:03 INFO - ##### 02:14:03 INFO - ##### Running read-buildbot-config step. 02:14:03 INFO - ##### 02:14:03 INFO - Running pre-action listener: _resource_record_pre_action 02:14:03 INFO - Running main action method: read_buildbot_config 02:14:03 INFO - Using buildbot properties: 02:14:03 INFO - { 02:14:03 INFO - "project": "", 02:14:03 INFO - "product": "firefox", 02:14:03 INFO - "script_repo_revision": "production", 02:14:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:14:03 INFO - "repository": "", 02:14:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:14:03 INFO - "buildid": "20160709013039", 02:14:03 INFO - "pgo_build": "False", 02:14:03 INFO - "basedir": "/builds/slave/test", 02:14:03 INFO - "buildnumber": 1960, 02:14:03 INFO - "slavename": "talos-linux64-ix-048", 02:14:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:14:03 INFO - "platform": "ubuntu64_hw", 02:14:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:14:03 INFO - "branch": "fx-team", 02:14:03 INFO - "repo_path": "integration/fx-team", 02:14:03 INFO - "revision": "fe0ea08656ec28e9d33e381e0653ba65713a7db4", 02:14:03 INFO - "stage_platform": "linux64", 02:14:03 INFO - "builduid": "33c116035c834f1e971421a4bab83389", 02:14:03 INFO - "slavebuilddir": "test" 02:14:03 INFO - } 02:14:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:14:03 INFO - Running post-action listener: _resource_record_post_action 02:14:03 INFO - ##### 02:14:03 INFO - ##### Finished read-buildbot-config step (success) 02:14:03 INFO - ##### 02:14:03 INFO - ##### 02:14:03 INFO - ##### Running download-and-extract step. 02:14:03 INFO - ##### 02:14:03 INFO - Running pre-action listener: _resource_record_pre_action 02:14:03 INFO - Running main action method: download_and_extract 02:14:03 INFO - mkdir: /builds/slave/test/build/tests 02:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:03 INFO - https://queue.taskcluster.net/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:14:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:14:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:14:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:14:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:14:06 INFO - Downloaded 1361 bytes. 02:14:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:14:06 INFO - Using the following test package requirements: 02:14:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:14:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:14:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:14:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:06 INFO - u'jsshell-linux-x86_64.zip'], 02:14:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:14:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:14:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:14:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:14:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:14:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:14:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:06 INFO - https://queue.taskcluster.net/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:14:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:14:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:14:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:14:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:14:08 INFO - Downloaded 22735409 bytes. 02:14:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:14:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:14:09 INFO - Return code: 0 02:14:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:09 INFO - https://queue.taskcluster.net/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:14:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:14:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:14:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:14:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:14:10 INFO - Downloaded 22735409 bytes. 02:14:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:14:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:14:11 INFO - Return code: 0 02:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:11 INFO - https://queue.taskcluster.net/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:14:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:14:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:14:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:14:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:14:12 INFO - Downloaded 14403333 bytes. 02:14:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:14:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:14:12 INFO - Return code: 0 02:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:12 INFO - https://queue.taskcluster.net/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:14:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:14:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:14:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:14:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:14:14 INFO - Downloaded 56645814 bytes. 02:14:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:14:14 INFO - mkdir: /builds/slave/test/properties 02:14:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:14:14 INFO - Writing to file /builds/slave/test/properties/build_url 02:14:14 INFO - Contents: 02:14:14 INFO - build_url:https://queue.taskcluster.net/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:14:15 INFO - Running post-action listener: _resource_record_post_action 02:14:15 INFO - Running post-action listener: set_extra_try_arguments 02:14:15 INFO - ##### 02:14:15 INFO - ##### Finished download-and-extract step (success) 02:14:15 INFO - ##### 02:14:15 INFO - ##### 02:14:15 INFO - ##### Running populate-webroot step. 02:14:15 INFO - ##### 02:14:15 INFO - Running pre-action listener: _resource_record_pre_action 02:14:15 INFO - Running main action method: populate_webroot 02:14:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:14:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:14:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:14:15 INFO - '--tppagecycles', 02:14:15 INFO - '7'], 02:14:15 INFO - 'tests': ['tsvgm']}}, 02:14:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:14:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:14:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:14:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:14:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:14:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:14:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:15 INFO - 'talos_options': ['--disable-e10s'], 02:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:14:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:14:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:15 INFO - 'talos_options': ['--disable-e10s'], 02:14:15 INFO - 'tests': ['damp', 'tps']}, 02:14:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:15 INFO - 'tests': ['damp', 'tps']}, 02:14:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:14:15 INFO - 'tests': ['dromaeo_dom']}, 02:14:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:14:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:14:15 INFO - 'tests': ['basic_compositor_video']}, 02:14:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:14:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:14:15 INFO - 'tests': ['a11yr', 02:14:15 INFO - 'ts_paint', 02:14:15 INFO - 'tpaint', 02:14:15 INFO - 'sessionrestore', 02:14:15 INFO - 'sessionrestore_no_auto_restore', 02:14:15 INFO - 'tabpaint']}, 02:14:15 INFO - 'other-e10s': {'tests': ['a11yr', 02:14:15 INFO - 'ts_paint', 02:14:15 INFO - 'tpaint', 02:14:15 INFO - 'sessionrestore', 02:14:15 INFO - 'sessionrestore_no_auto_restore', 02:14:15 INFO - 'tabpaint']}, 02:14:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:14:15 INFO - 'ts_paint', 02:14:15 INFO - 'tpaint', 02:14:15 INFO - 'sessionrestore', 02:14:15 INFO - 'sessionrestore_no_auto_restore', 02:14:15 INFO - 'tabpaint']}, 02:14:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:14:15 INFO - 'ts_paint', 02:14:15 INFO - 'tpaint', 02:14:15 INFO - 'sessionrestore', 02:14:15 INFO - 'sessionrestore_no_auto_restore', 02:14:15 INFO - 'tabpaint']}, 02:14:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:14:15 INFO - 'tests': ['a11yr', 02:14:15 INFO - 'ts_paint', 02:14:15 INFO - 'tpaint', 02:14:15 INFO - 'sessionrestore', 02:14:15 INFO - 'sessionrestore_no_auto_restore', 02:14:15 INFO - 'tabpaint']}, 02:14:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:14:15 INFO - 'tests': ['a11yr', 02:14:15 INFO - 'ts_paint', 02:14:15 INFO - 'tpaint', 02:14:15 INFO - 'sessionrestore', 02:14:15 INFO - 'sessionrestore_no_auto_restore', 02:14:15 INFO - 'tabpaint']}, 02:14:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:14:15 INFO - 'tests': ['tsvgx', 02:14:15 INFO - 'tsvgr_opacity', 02:14:15 INFO - 'tart', 02:14:15 INFO - 'tscrollx', 02:14:15 INFO - 'cart']}, 02:14:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:14:15 INFO - 'tsvgr_opacity', 02:14:15 INFO - 'tart', 02:14:15 INFO - 'tscrollx', 02:14:15 INFO - 'cart']}, 02:14:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:15 INFO - 'talos_options': ['--disable-e10s'], 02:14:15 INFO - 'tests': ['tp5o']}, 02:14:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:15 INFO - 'tests': ['tp5o']}, 02:14:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:15 INFO - 'talos_options': ['--disable-e10s', 02:14:15 INFO - '--xperf_path', 02:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:14:15 INFO - 'tests': ['tp5n']}, 02:14:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:15 INFO - 'talos_options': ['--xperf_path', 02:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:14:15 INFO - 'tests': ['tp5n']}}, 02:14:15 INFO - 'talos.zip': {'path': '', 02:14:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:14:15 INFO - Running post-action listener: _resource_record_post_action 02:14:15 INFO - ##### 02:14:15 INFO - ##### Finished populate-webroot step (success) 02:14:15 INFO - ##### 02:14:15 INFO - ##### 02:14:15 INFO - ##### Running create-virtualenv step. 02:14:15 INFO - ##### 02:14:15 INFO - Running pre-action listener: _resource_record_pre_action 02:14:15 INFO - Running main action method: create_virtualenv 02:14:15 INFO - Creating virtualenv /builds/slave/test/build/venv 02:14:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:14:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:14:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:14:15 INFO - Using real prefix '/usr' 02:14:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:14:15 INFO - Installing distribute.............................................................................................................................................................................................done. 02:14:17 INFO - Installing pip.................done. 02:14:17 INFO - Return code: 0 02:14:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:14: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')]} 02:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14: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')]} 02:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e593b0>, '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 0x1e5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:14:17 INFO - Using env: {'DISPLAY': ':0', 02:14:17 INFO - 'HOME': '/home/cltbld', 02:14:17 INFO - 'LANG': 'en_US.UTF-8', 02:14:17 INFO - 'LANGUAGE': 'en_US:en', 02:14:17 INFO - 'LOGNAME': 'cltbld', 02:14:17 INFO - 'MAIL': '/var/mail/cltbld', 02:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:17 INFO - 'MOZ_NO_REMOTE': '1', 02:14:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:17 INFO - 'NO_EM_RESTART': '1', 02:14:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:17 INFO - 'PWD': '/builds/slave/test', 02:14:17 INFO - 'SHELL': '/bin/bash', 02:14:17 INFO - 'SHLVL': '1', 02:14:17 INFO - 'TERM': 'linux', 02:14:17 INFO - 'TMOUT': '86400', 02:14:17 INFO - 'USER': 'cltbld', 02:14:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 02:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:17 INFO - '_': '/tools/buildbot/bin/python'} 02:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:14:17 INFO - Cleaning up... 02:14:17 INFO - Return code: 0 02:14:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:14: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')]} 02:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14: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')]} 02:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e593b0>, '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 0x1e5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:14:17 INFO - Using env: {'DISPLAY': ':0', 02:14:17 INFO - 'HOME': '/home/cltbld', 02:14:17 INFO - 'LANG': 'en_US.UTF-8', 02:14:17 INFO - 'LANGUAGE': 'en_US:en', 02:14:17 INFO - 'LOGNAME': 'cltbld', 02:14:17 INFO - 'MAIL': '/var/mail/cltbld', 02:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:17 INFO - 'MOZ_NO_REMOTE': '1', 02:14:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:17 INFO - 'NO_EM_RESTART': '1', 02:14:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:17 INFO - 'PWD': '/builds/slave/test', 02:14:17 INFO - 'SHELL': '/bin/bash', 02:14:17 INFO - 'SHLVL': '1', 02:14:17 INFO - 'TERM': 'linux', 02:14:17 INFO - 'TMOUT': '86400', 02:14:17 INFO - 'USER': 'cltbld', 02:14:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 02:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:17 INFO - '_': '/tools/buildbot/bin/python'} 02:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:18 INFO - Downloading/unpacking psutil>=3.1.1 02:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:14:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:20 INFO - Installing collected packages: psutil 02:14:20 INFO - Running setup.py install for psutil 02:14:20 INFO - building 'psutil._psutil_linux' extension 02:14:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:14:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:14:20 INFO - building 'psutil._psutil_posix' extension 02:14:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:14:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:14:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:20 INFO - Successfully installed psutil 02:14:20 INFO - Cleaning up... 02:14:20 INFO - Return code: 0 02:14:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:20 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 0x1b9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e593b0>, '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 0x1e5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:14:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:14:20 INFO - Using env: {'DISPLAY': ':0', 02:14:20 INFO - 'HOME': '/home/cltbld', 02:14:20 INFO - 'LANG': 'en_US.UTF-8', 02:14:20 INFO - 'LANGUAGE': 'en_US:en', 02:14:20 INFO - 'LOGNAME': 'cltbld', 02:14:20 INFO - 'MAIL': '/var/mail/cltbld', 02:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:20 INFO - 'MOZ_NO_REMOTE': '1', 02:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:20 INFO - 'NO_EM_RESTART': '1', 02:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:20 INFO - 'PWD': '/builds/slave/test', 02:14:20 INFO - 'SHELL': '/bin/bash', 02:14:20 INFO - 'SHLVL': '1', 02:14:20 INFO - 'TERM': 'linux', 02:14:20 INFO - 'TMOUT': '86400', 02:14:20 INFO - 'USER': 'cltbld', 02:14:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 02:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:20 INFO - '_': '/tools/buildbot/bin/python'} 02:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:14:22 INFO - Installing collected packages: mozsystemmonitor 02:14:22 INFO - Running setup.py install for mozsystemmonitor 02:14:22 INFO - Successfully installed mozsystemmonitor 02:14:22 INFO - Cleaning up... 02:14:22 INFO - Return code: 0 02:14:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e593b0>, '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 0x1e5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:14:22 INFO - Using env: {'DISPLAY': ':0', 02:14:22 INFO - 'HOME': '/home/cltbld', 02:14:22 INFO - 'LANG': 'en_US.UTF-8', 02:14:22 INFO - 'LANGUAGE': 'en_US:en', 02:14:22 INFO - 'LOGNAME': 'cltbld', 02:14:22 INFO - 'MAIL': '/var/mail/cltbld', 02:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:22 INFO - 'MOZ_NO_REMOTE': '1', 02:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:22 INFO - 'NO_EM_RESTART': '1', 02:14:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:22 INFO - 'PWD': '/builds/slave/test', 02:14:22 INFO - 'SHELL': '/bin/bash', 02:14:22 INFO - 'SHLVL': '1', 02:14:22 INFO - 'TERM': 'linux', 02:14:22 INFO - 'TMOUT': '86400', 02:14:22 INFO - 'USER': 'cltbld', 02:14:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 02:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:22 INFO - '_': '/tools/buildbot/bin/python'} 02:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:23 INFO - Downloading/unpacking jsonschema==2.5.1 02:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:14:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:25 INFO - Downloading functools32-3.2.3-2.tar.gz 02:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:14:25 INFO - warning: no files found matching '*.txt' 02:14:25 INFO - no previously-included directories found matching 'build' 02:14:25 INFO - no previously-included directories found matching 'dist' 02:14:25 INFO - no previously-included directories found matching '.git*' 02:14:25 INFO - Installing collected packages: jsonschema, functools32 02:14:25 INFO - Running setup.py install for functools32 02:14:25 INFO - warning: no files found matching '*.txt' 02:14:25 INFO - no previously-included directories found matching 'build' 02:14:25 INFO - no previously-included directories found matching 'dist' 02:14:25 INFO - no previously-included directories found matching '.git*' 02:14:25 INFO - Successfully installed jsonschema functools32 02:14:25 INFO - Cleaning up... 02:14:25 INFO - Return code: 0 02:14:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:14: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')]} 02:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14: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')]} 02:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:25 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 0x1b9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e593b0>, '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 0x1e5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:14:25 INFO - Using env: {'DISPLAY': ':0', 02:14:25 INFO - 'HOME': '/home/cltbld', 02:14:25 INFO - 'LANG': 'en_US.UTF-8', 02:14:25 INFO - 'LANGUAGE': 'en_US:en', 02:14:25 INFO - 'LOGNAME': 'cltbld', 02:14:25 INFO - 'MAIL': '/var/mail/cltbld', 02:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:25 INFO - 'MOZ_NO_REMOTE': '1', 02:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:25 INFO - 'NO_EM_RESTART': '1', 02:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:25 INFO - 'PWD': '/builds/slave/test', 02:14:25 INFO - 'SHELL': '/bin/bash', 02:14:25 INFO - 'SHLVL': '1', 02:14:25 INFO - 'TERM': 'linux', 02:14:25 INFO - 'TMOUT': '86400', 02:14:25 INFO - 'USER': 'cltbld', 02:14:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 02:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:25 INFO - '_': '/tools/buildbot/bin/python'} 02:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:25 INFO - Downloading/unpacking blobuploader==1.2.4 02:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:27 INFO - Downloading blobuploader-1.2.4.tar.gz 02:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:14:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:14:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:28 INFO - Downloading docopt-0.6.1.tar.gz 02:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:14:28 INFO - Installing collected packages: blobuploader, requests, docopt 02:14:28 INFO - Running setup.py install for blobuploader 02:14:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:14:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:14:28 INFO - Running setup.py install for requests 02:14:29 INFO - Running setup.py install for docopt 02:14:29 INFO - Successfully installed blobuploader requests docopt 02:14:29 INFO - Cleaning up... 02:14:29 INFO - Return code: 0 02:14:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:29 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 0x1b9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e593b0>, '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 0x1e5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:14:29 INFO - Using env: {'DISPLAY': ':0', 02:14:29 INFO - 'HOME': '/home/cltbld', 02:14:29 INFO - 'LANG': 'en_US.UTF-8', 02:14:29 INFO - 'LANGUAGE': 'en_US:en', 02:14:29 INFO - 'LOGNAME': 'cltbld', 02:14:29 INFO - 'MAIL': '/var/mail/cltbld', 02:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:29 INFO - 'MOZ_NO_REMOTE': '1', 02:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:29 INFO - 'NO_EM_RESTART': '1', 02:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:29 INFO - 'PWD': '/builds/slave/test', 02:14:29 INFO - 'SHELL': '/bin/bash', 02:14:29 INFO - 'SHLVL': '1', 02:14:29 INFO - 'TERM': 'linux', 02:14:29 INFO - 'TMOUT': '86400', 02:14:29 INFO - 'USER': 'cltbld', 02:14:29 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 02:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:29 INFO - '_': '/tools/buildbot/bin/python'} 02:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:29 INFO - Running setup.py (path:/tmp/pip-FExt31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:29 INFO - Running setup.py (path:/tmp/pip-39k6tJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:29 INFO - Running setup.py (path:/tmp/pip-CBTRD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:29 INFO - Running setup.py (path:/tmp/pip-dA4fyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:29 INFO - Running setup.py (path:/tmp/pip-sGDlZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:29 INFO - Running setup.py (path:/tmp/pip-arSdT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:29 INFO - Running setup.py (path:/tmp/pip-ZNKea_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:30 INFO - Running setup.py (path:/tmp/pip-Xfbwfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:30 INFO - Running setup.py (path:/tmp/pip-aIYXxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:30 INFO - Running setup.py (path:/tmp/pip-NKjMFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:30 INFO - Running setup.py (path:/tmp/pip-QQmkfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:30 INFO - Running setup.py (path:/tmp/pip-OTTqp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:30 INFO - Running setup.py (path:/tmp/pip-IDSokN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:30 INFO - Running setup.py (path:/tmp/pip-x5Wlam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:30 INFO - Running setup.py (path:/tmp/pip-ZSfTI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:30 INFO - Running setup.py (path:/tmp/pip-ygKBZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:30 INFO - Running setup.py (path:/tmp/pip-fNZNNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:14:30 INFO - Running setup.py install for manifestparser 02:14:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:14:30 INFO - Running setup.py install for mozcrash 02:14:30 INFO - Running setup.py install for mozdebug 02:14:31 INFO - Running setup.py install for mozdevice 02:14:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:14:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:14:31 INFO - Running setup.py install for mozfile 02:14:31 INFO - Running setup.py install for mozhttpd 02:14:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:14:31 INFO - Running setup.py install for mozinfo 02:14:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:14:31 INFO - Running setup.py install for mozInstall 02:14:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:14:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:14:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:14:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:14:31 INFO - Running setup.py install for mozleak 02:14:31 INFO - Running setup.py install for mozlog 02:14:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:14:31 INFO - Running setup.py install for moznetwork 02:14:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:14:31 INFO - Running setup.py install for mozprocess 02:14:32 INFO - Running setup.py install for mozprofile 02:14:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:14:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:14:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:14:32 INFO - Running setup.py install for mozrunner 02:14:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:14:32 INFO - Running setup.py install for mozscreenshot 02:14:32 INFO - Running setup.py install for moztest 02:14:32 INFO - Running setup.py install for mozversion 02:14:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:14:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:14:32 INFO - Cleaning up... 02:14:32 INFO - Return code: 0 02:14:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14: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')]} 02:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14: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')]} 02:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:32 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 0x1b9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e593b0>, '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 0x1e5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:14:32 INFO - Using env: {'DISPLAY': ':0', 02:14:32 INFO - 'HOME': '/home/cltbld', 02:14:32 INFO - 'LANG': 'en_US.UTF-8', 02:14:32 INFO - 'LANGUAGE': 'en_US:en', 02:14:32 INFO - 'LOGNAME': 'cltbld', 02:14:32 INFO - 'MAIL': '/var/mail/cltbld', 02:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:32 INFO - 'MOZ_NO_REMOTE': '1', 02:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:32 INFO - 'NO_EM_RESTART': '1', 02:14:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:32 INFO - 'PWD': '/builds/slave/test', 02:14:32 INFO - 'SHELL': '/bin/bash', 02:14:32 INFO - 'SHLVL': '1', 02:14:32 INFO - 'TERM': 'linux', 02:14:32 INFO - 'TMOUT': '86400', 02:14:32 INFO - 'USER': 'cltbld', 02:14:32 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 02:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:32 INFO - '_': '/tools/buildbot/bin/python'} 02:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:32 INFO - Running setup.py (path:/tmp/pip-4gCpC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:32 INFO - Running setup.py (path:/tmp/pip-dL801Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:32 INFO - Running setup.py (path:/tmp/pip-gziGB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:33 INFO - Running setup.py (path:/tmp/pip-KSoove-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:33 INFO - Running setup.py (path:/tmp/pip-wOrh5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:33 INFO - Running setup.py (path:/tmp/pip-YKN3Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:33 INFO - Running setup.py (path:/tmp/pip-6573jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:33 INFO - Running setup.py (path:/tmp/pip-2XLAog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:33 INFO - Running setup.py (path:/tmp/pip-whsV1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:33 INFO - Running setup.py (path:/tmp/pip-nOT1Lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:33 INFO - Running setup.py (path:/tmp/pip-CzA0PD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:33 INFO - Running setup.py (path:/tmp/pip-7_dWQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:33 INFO - Running setup.py (path:/tmp/pip-4Oj1CV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:33 INFO - Running setup.py (path:/tmp/pip-zQWbJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:33 INFO - Running setup.py (path:/tmp/pip-SKvHuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:33 INFO - Running setup.py (path:/tmp/pip-GWoFmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:34 INFO - Running setup.py (path:/tmp/pip-B3zfgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:14:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:35 INFO - Downloading blessings-1.6.tar.gz 02:14:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:14:36 INFO - Installing collected packages: blessings 02:14:36 INFO - Running setup.py install for blessings 02:14:36 INFO - Successfully installed blessings 02:14:36 INFO - Cleaning up... 02:14:36 INFO - Return code: 0 02:14:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:14:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:36 INFO - Reading from file tmpfile_stdout 02:14:36 INFO - Current package versions: 02:14:36 INFO - argparse == 1.2.1 02:14:36 INFO - blessings == 1.6 02:14:36 INFO - blobuploader == 1.2.4 02:14:36 INFO - docopt == 0.6.1 02:14:36 INFO - functools32 == 3.2.3-2 02:14:36 INFO - jsonschema == 2.5.1 02:14:36 INFO - manifestparser == 1.1 02:14:36 INFO - mozInstall == 1.12 02:14:36 INFO - mozcrash == 0.17 02:14:36 INFO - mozdebug == 0.1 02:14:36 INFO - mozdevice == 0.48 02:14:36 INFO - mozfile == 1.2 02:14:36 INFO - mozhttpd == 0.7 02:14:36 INFO - mozinfo == 0.9 02:14:36 INFO - mozleak == 0.1 02:14:36 INFO - mozlog == 3.2 02:14:36 INFO - moznetwork == 0.27 02:14:36 INFO - mozprocess == 0.23 02:14:36 INFO - mozprofile == 0.28 02:14:36 INFO - mozrunner == 6.12 02:14:36 INFO - mozscreenshot == 0.1 02:14:36 INFO - mozsystemmonitor == 0.3 02:14:36 INFO - moztest == 0.7 02:14:36 INFO - mozversion == 1.4 02:14:36 INFO - psutil == 3.1.1 02:14:36 INFO - requests == 1.2.3 02:14:36 INFO - wsgiref == 0.1.2 02:14:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:36 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 0x1b9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e593b0>, '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 0x1e5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:14:36 INFO - Using env: {'DISPLAY': ':0', 02:14:36 INFO - 'HOME': '/home/cltbld', 02:14:36 INFO - 'LANG': 'en_US.UTF-8', 02:14:36 INFO - 'LANGUAGE': 'en_US:en', 02:14:36 INFO - 'LOGNAME': 'cltbld', 02:14:36 INFO - 'MAIL': '/var/mail/cltbld', 02:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:36 INFO - 'MOZ_NO_REMOTE': '1', 02:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:36 INFO - 'NO_EM_RESTART': '1', 02:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:36 INFO - 'PWD': '/builds/slave/test', 02:14:36 INFO - 'SHELL': '/bin/bash', 02:14:36 INFO - 'SHLVL': '1', 02:14:36 INFO - 'TERM': 'linux', 02:14:36 INFO - 'TMOUT': '86400', 02:14:36 INFO - 'USER': 'cltbld', 02:14:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 02:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:36 INFO - '_': '/tools/buildbot/bin/python'} 02:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:14:36 INFO - Cleaning up... 02:14:36 INFO - Return code: 0 02:14:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:36 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 0x1b9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e593b0>, '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 0x1e5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a740>, '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': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:14:36 INFO - Using env: {'DISPLAY': ':0', 02:14:36 INFO - 'HOME': '/home/cltbld', 02:14:36 INFO - 'LANG': 'en_US.UTF-8', 02:14:36 INFO - 'LANGUAGE': 'en_US:en', 02:14:36 INFO - 'LOGNAME': 'cltbld', 02:14:36 INFO - 'MAIL': '/var/mail/cltbld', 02:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:36 INFO - 'MOZ_NO_REMOTE': '1', 02:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:36 INFO - 'NO_EM_RESTART': '1', 02:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:36 INFO - 'PWD': '/builds/slave/test', 02:14:36 INFO - 'SHELL': '/bin/bash', 02:14:36 INFO - 'SHLVL': '1', 02:14:36 INFO - 'TERM': 'linux', 02:14:36 INFO - 'TMOUT': '86400', 02:14:36 INFO - 'USER': 'cltbld', 02:14:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 02:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:36 INFO - '_': '/tools/buildbot/bin/python'} 02:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:14:36 INFO - Cleaning up... 02:14:36 INFO - Return code: 0 02:14:36 INFO - Running post-action listener: _resource_record_post_action 02:14:36 INFO - Running post-action listener: _start_resource_monitoring 02:14:36 INFO - Starting resource monitoring. 02:14:36 INFO - ##### 02:14:36 INFO - ##### Finished create-virtualenv step (success) 02:14:36 INFO - ##### 02:14:36 INFO - ##### 02:14:36 INFO - ##### Running install step. 02:14:36 INFO - ##### 02:14:36 INFO - Running pre-action listener: _resource_record_pre_action 02:14:36 INFO - Running main action method: install 02:14:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:37 INFO - Reading from file tmpfile_stdout 02:14:37 INFO - Detecting whether we're running mozinstall >=1.0... 02:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:14:37 INFO - Reading from file tmpfile_stdout 02:14:37 INFO - Output received: 02:14:37 INFO - Usage: mozinstall [options] installer 02:14:37 INFO - Options: 02:14:37 INFO - -h, --help show this help message and exit 02:14:37 INFO - -d DEST, --destination=DEST 02:14:37 INFO - Directory to install application into. [default: 02:14:37 INFO - "/builds/slave/test"] 02:14:37 INFO - --app=APP Application being installed. [default: firefox] 02:14:37 INFO - mkdir: /builds/slave/test/build/application 02:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:14:53 INFO - Reading from file tmpfile_stdout 02:14:53 INFO - Output received: 02:14:53 INFO - /builds/slave/test/build/application/firefox/firefox 02:14:53 INFO - Running post-action listener: _resource_record_post_action 02:14:53 INFO - ##### 02:14:53 INFO - ##### Finished install step (success) 02:14:53 INFO - ##### 02:14:53 INFO - ##### 02:14:53 INFO - ##### Running run-tests step. 02:14:53 INFO - ##### 02:14:53 INFO - Running pre-action listener: _resource_record_pre_action 02:14:53 INFO - Running main action method: run_tests 02:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:14:53 INFO - Python 2.7.3 02:14:53 INFO - Return code: 0 02:14:53 INFO - grabbing minidump binary from tooltool 02:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:53 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 0x1e593b0>, '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 0x1e5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:14:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:14:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:14:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:14:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:14:53 INFO - Return code: 0 02:14:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:14:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:14:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:14:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:14:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 02:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 02:14:53 INFO - Using env: {'DISPLAY': ':0', 02:14:53 INFO - 'HOME': '/home/cltbld', 02:14:53 INFO - 'LANG': 'en_US.UTF-8', 02:14:53 INFO - 'LANGUAGE': 'en_US:en', 02:14:53 INFO - 'LOGNAME': 'cltbld', 02:14:53 INFO - 'MAIL': '/var/mail/cltbld', 02:14:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:14:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:53 INFO - 'MOZ_NO_REMOTE': '1', 02:14:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:53 INFO - 'NO_EM_RESTART': '1', 02:14:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:53 INFO - 'PWD': '/builds/slave/test', 02:14:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:14:53 INFO - 'SHELL': '/bin/bash', 02:14:53 INFO - 'SHLVL': '1', 02:14:53 INFO - 'TERM': 'linux', 02:14:53 INFO - 'TMOUT': '86400', 02:14:53 INFO - 'USER': 'cltbld', 02:14:53 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504', 02:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:53 INFO - '_': '/tools/buildbot/bin/python'} 02:14:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 02:14:53 INFO - mozversion application_buildid: 20160709013039 02:14:53 INFO - mozversion application_changeset: fe0ea08656ec28e9d33e381e0653ba65713a7db4 02:14:53 INFO - mozversion application_display_name: Nightly 02:14:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:14:53 INFO - mozversion application_name: Firefox 02:14:53 INFO - mozversion application_remotingname: firefox 02:14:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:14:53 INFO - mozversion application_vendor: Mozilla 02:14:53 INFO - mozversion application_version: 50.0a1 02:14:53 INFO - mozversion platform_buildid: 20160709013039 02:14:53 INFO - mozversion platform_changeset: fe0ea08656ec28e9d33e381e0653ba65713a7db4 02:14:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:14:53 INFO - mozversion platform_version: 50.0a1 02:14:53 INFO - using testdate: 1468055693 02:14:53 INFO - actual date: 1468055693 02:14:53 INFO - starting webserver on 'localhost:34471' 02:14:53 INFO - SUITE-START | Running 2 tests 02:14:53 INFO - TEST-START | dromaeo_css 02:14:53 INFO - operating with platform_type : linux_ 02:14:53 INFO - Initialising browser for dromaeo_css test... 02:14:53 INFO - TEST-INFO | started process 5377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVALtSp/profile http://localhost:34471/getInfo.html) 02:14:58 INFO - PROCESS | 5377 | __metrics Screen width/height:1600/1200 02:14:58 INFO - PROCESS | 5377 | colorDepth:24 02:14:58 INFO - PROCESS | 5377 | Browser inner width/height: 1024/697 02:14:58 INFO - PROCESS | 5377 | __metrics 02:14:59 INFO - PROCESS | 5377 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:15:00 INFO - TEST-INFO | 5377: exit 0 02:15:00 INFO - Browser initialized. 02:15:00 INFO - Running cycle 1/1 for dromaeo_css test... 02:15:00 INFO - TEST-INFO | started process 5458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVALtSp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:15:12 INFO - PROCESS | 5458 | RSS: Main: 159178752 02:15:12 INFO - PROCESS | 5458 | 02:16:03 INFO - PROCESS | 5458 | 1468055763716 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:18:15 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:34471/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34471/tests/dromaeo/cssquery-ext.html) 02:18:16 INFO - PROCESS | 5458 | RSS: Main: 260055040 02:18:16 INFO - PROCESS | 5458 | 02:21:19 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:34471/tests/dromaeo/cssquery-ext.html (next: http://localhost:34471/tests/dromaeo/cssquery-jquery.html) 02:21:20 INFO - PROCESS | 5458 | RSS: Main: 247529472 02:21:20 INFO - PROCESS | 5458 | 02:24:22 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:34471/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34471/tests/dromaeo/cssquery-mootools.html) 02:24:23 INFO - PROCESS | 5458 | RSS: Main: 243412992 02:24:23 INFO - PROCESS | 5458 | 02:27:25 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:34471/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34471/tests/dromaeo/cssquery-prototype.html) 02:27:26 INFO - PROCESS | 5458 | RSS: Main: 243245056 02:27:26 INFO - PROCESS | 5458 | 02:30:29 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:34471/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34471/tests/dromaeo/cssquery-yui.html) 02:30:29 INFO - PROCESS | 5458 | RSS: Main: 221036544 02:30:29 INFO - PROCESS | 5458 | 02:33:32 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:34471/tests/dromaeo/cssquery-yui.html (next: http://localhost:34471/tests/dromaeo/cssquery-dojo.html) 02:33:32 INFO - PROCESS | 5458 | RSS: Main: 283926528 02:33:32 INFO - PROCESS | 5458 | 02:33:32 INFO - PROCESS | 5458 | __start_tp_report 02:33:32 INFO - PROCESS | 5458 | _x_x_mozilla_page_load 02:33:32 INFO - PROCESS | 5458 | _x_x_mozilla_page_load_details 02:33:32 INFO - PROCESS | 5458 | |i|pagename|runs| 02:33:32 INFO - PROCESS | 5458 | |0;dojo.html;2575.5492788761962;2577.1237779155085;2601.3626661467943;2608.139314026371;2618.136015115012;4630.699004564701;4702.9294560581575;4725.503822098682;4731.952680473194;4735.5974742146955;4664.580187783099;4712.90574188516;4721.055788842236;4756.571908528232;4784.473707892129;4357.41174941382;4371.999999999992;4380.123975204956;4386.846460373888;4397.626201772853;4399.890002749925;4424.690271680984;4439.978804874881;4451.5103338632725;4487.259602165655;4385.912281754379;4397;4427.225235583776;4434.467863856342;4437.267850804614;4299.763513006784;4343.261645520269;4361.454818147731;4361.760103194323;4382.583654552813;4256.446661933929;4261.169072030955;4267.893302667427;4274.914501709979;4312.310030395153;4674.7428891410955;4681.274402467623;4719.480857105716;4724.291356296549;4737.810487580493;4857.82997595086;4988.451270360258;5039.4708555601865;5046.62150338726;5053.6967781932835;5077.238414237894;5118.744062796845;5130.48695130484;5133.178691409356;5140.820071297487;4739.786709598076;4751.263554149113;4786.234202527578;4786.976065119652;4791.089692958327;4980.8256711015665;5118.411382691038;5123.641345105882;5127.2052831811125;5144.922826157611;4993.500649934977;5012.122878496249;5027.195648696191;5040.193569028937;5043.193089105725;4913.926291105637;5080.7205603692155;5083.161278389099;5095.439501654815;5119.564836988898;4886.95113048865;4925.13810083234;4935.531124543163;4944.332515110414;4944.332515110486;4931.235658472942;4942.382202224722;4943.3573635427165;4944.456109827916;4989.376327959005;4158.9584104158575;4204.8528301509305;4273.829046838154;4274.893127671833;4333.674974376934;3715.3869611513796;3733.6826369758874;3738.869139580156;3756.5116534850295;3777.905552361213;4247.320428731388;4265.0830071534765;4267.594578515036;4284.89287767802;4295.613394794484;4952.554270115635;5006.799728010838;5009.323741294951;5011.398632164163;5042.09242336383;4229.238737027303;4231.555686652857;4287.335463003239;4300.913981720348;4339.587739164775;4513.842015529441;4545;4550.49944506104;4553.863384098482;4594.540545945379;4534.727916325031;4736.407949006374;4738.289256611536;4744.027474367816;4763.333133361332;5027.271045698426;5076.289319495348;5085.694858308513;5086.287919691172;5088.4148322941855;4743.312219728189;4747.572718455355;4759.452662943806;4761.285807128958;4822.855314340575;4854.417469903634;4876.902461950812;5007.574356179765;5026.472220416804;5027.371578552681;4974.776135073858;4998.350214472095;5020.6234532410945;5024.673396229234;5072.898542029213;4862.367892174137;4872.805087796591;4876.195427754381;4878.56092951636;4923.4584195737725;4730.266808644666;4868.391451068616;4869.537393947569;4898.7550622468025;4918.286848407032;4883.755812209446;4893.290472881484;4900.705957642553;4906.681065730716;4926.827561035347;4936.062148191832;4964.578010869117;4968.2795994579865;4968.527989840959;5030.522100400456;4714.952850471452;4733.266343716729;4779.044191161712;4810.903781924412;4843.685160464559 02:33:32 INFO - PROCESS | 5458 | |1;ext.html;573.1374281706031;573.4007961680044;576.3170642788297;580.8634970781862;589.4930359890495;28370.14889553314;41491.79254103729;42973.71078867639;43012.13975720487;46352.07295854081;42130.36804447936;42936;42988.57011429885;43015.56984430155;43024.35463468043;7431;7660.885086723703;7808.102068262137;7808.687652493893;7825.569593672374;7449.441291903102;7696.769096927102;7708.845823083535;9926.90073099267;10213.846792298084;10270.845937310947;10288.382697038165;10303.536340864679;10303.536340864679;10317.380957142595;10108.241881858854;10187.286889917708;10189.388636681786;10197.49012549377;10210.795784084352;7425.74009909656;7666.425018123663;7684.462087653867;9780.217582593375;10185.745356366077;39423.40864887029;39529.80235098806;39804.60195398038;39920.40517366362;39929.80035099835;3021.728044475986;3034.2717747740385;3053.084074777558;3096.2723759916403;3413.232022794851;30291.242718931982;30419;30570.84714576435;30788.8460557698;30966;3206.6633003534757;3343.498475228711;3354.3626710924846;3354.463285874273;3460.446328587439;264594;265178.67410663015;265495;266020;266637;55205.1719224212;55956.72021639866;56036;56060;56252;57465.71267143638;57663.711681441324;57754.42245577575;57771.422285777444;57840.71079644575;14827.036242644193;15318.923405382902;15318.923405383124;15319.157446340336;15361.155136467602;9663.27525435595;11464.25482343645;11465.426728663533;11468.713282168013;11514.251573647685;16566.6686666266;17194.22625981809;17312.48062558125;17475.64078849339;17769.28922843098;5578.693171875505;5578.888422231614;5623.725968264149;5705.74324155414;5709.858028394337;761.9657115429708;845.450457202823;967.4582233949011;982.3712823792779;989.8229471629711;28317;28480.28799279993;28609;28912.71087289142;29066.7093329064;946.5693109635099;949.4588084791602;976.6874600128033;980.2550061952967;1025.9076683098558;15225.467108651366;15240.237988100773;15263.618409539627;15358.769618455732;15595.220238988006;360054;361220;361423;362384;365539;49895.750521247886;50006;50045.499545004815;50163.24755128676;50268;1130.8303754436736;1166.2535976974743;1190.743990042145;1192.3740036480917;1206.9396530173456;27153;27814;28090.57864131999;28447.43105137927;28756.71243287624;43872;44052.77973610111;44369.33445998248;44413;44512.55487445214;268170;268181;268220;268634;269221;30727.231819203804;31041.68958310388;37903.62096379001;38193.80903095467;38244.80877595594;39567.20865582614;42320.788396057826;42353.152936940474;43281.35077973896;43413.565864340955;35707.642923570435;36317.27365452623;36551;37368.81315593405;37391.25217495689;37153.25693486169;37443.62556374401;37704;37831.24337513289;37983.81008094942;34419.311613768084;37284.62715372811;37718.62281377151;37773.62226377701;37862;31531.369372612877;33766;33847.3230535383;34067.14832129118;34583.308333832676;25580.616290755283;25592.872035639703;25798.75989564388;25972.35069123287;25973.740262597134 02:33:32 INFO - PROCESS | 5458 | |2;jquery.html;341.55427167546344;363.77809536182934;366.1943723807622;368.4050258831986;387.1849756263066;13079.476820927164;16453.917730411347;16488.258028388722;16937.830621693778;17821.465356039338;17353.652926941453;17511.299548018094;17577.82422175778;17987.64024719505;18177.72733409;4886.218205087187;5020.799168033283;5188.351456067991;5192.71440070796;5270.262163297141;3439.8280085995725;5218.347706536683;5280.234366016925;5573.6098473106895;5580.274564306655;5620.4660557247;5631.0708733059;5648.717564121798;5651.180578816069;5656.519195868335;5409.188621706736;5648.181013752983;5660.858478538028;5661.377248502661;5663.886722265573;3307.570015897942;5116.744162791845;5410.756515956791;5420.4850539198715;5458.536024437888;12419.627411177678;12537.623871283784;12564;14259;21152.576948461097;1921.3851567498407;1923.519120219945;1955.9217631294732;2005.5287007553213;2262.739784924738;9035.367524273304;9235.584398702074;9261.305402094802;9633.614655413776;9691;1678.8237235090385;1726.585619451335;1731.7488964100135;1736.328649422716;1756.656158039101;69292.3070769291;71107;72654;72911.63544182245;74011.88982165325;9013.864792028126;9583.712488625353;10000.649977250761;10033;10048.246381521416;12828.679283017813;13763.518276860263;13777.655558611115;14108.788368174486;14214.715705685829;7104.3961263293195;7289.2346303638415;7290.510098841929;7333.706651733871;7365.005724227268;6636.772197143544;6790.5925644461495;6803.421709154678;6897.896531552031;7084.787456376317;4384.364267181241;4403.493598236179;4411.713238639542;4443.6889417741095;4453.1761624099645;1823.972640410395;1826.3060037185785;1836.6051298970785;1892.5930924851223;1914.9138288777037;793.3653077538062;820.4915031127131;947.3605316411395;956.9138777510058;973.1047436358425;17175.398861039805;17205;17525.7371139433;17653.38213162533;18018.36935707244;759.4304271796153;772.8261141243175;800.2837460472845;805.8025783683036;879.3756432932562;9215.49314787693;9402.247820174369;9620.807583848284;9710.514474276259;9741.951290243504;390826;419297;423506;425969;429264;76549.61725191338;76781;77091;78612;79875;894.141624040928;936.4100616611491;961.4904100826573;961.9470929098967;962.0283513651123;16103.919480402992;16221.513354599381;16411.507654770376;16924.40764573234;17044.914775426045;39550.60449395584;40383.1923361537;40591.59408405878;41029.38455923223;41104.38343424791;49711.50288497069;51895;56002.159967601336;56094.43905560892;56163.438365615824;7537.170911199873;7652;7662.7214541351095;7822.413319001212;7970.2826745593175;11713;11777.52889884395;11891.167618266638;12241.755164896831;12268.263904165779;10441.947790261;10513;10550.472476376304;10603.787924241626;10693.786124277316;9886.406815591088;10309.587616495257;10439.895601043892;10517.106045986176;10725.517351719036;9583.233341332816;9681.806363872542;10339.793204136025;10362.896371036495;10664.57341706354;7572.242775722384;7649.31156195945;7694.576798276148;7746.147923728498;7776.88334674969;9906.356086854332;10380.377177369382;10531.578736850746;10621.097206737204;10632.681019569425 02:33:32 INFO - PROCESS | 5458 | |3;mootools.html;1229.7233122547434;1392.519580744643;1440.006395587045;1512.4403970530905;1714.0315721617285;6637.933620663792;7555.962220188905;7795.688172473095;7808.492447990877;7906.407019473548;7672.309492145706;7816.296533312001;7843.80390490238;7847.254510821463;7871.252231038056;1887.8017808130155;1938.873973191745;1943.8639295249338;2187.507810742586;2223.788740069691;2008.768991565974;2182.9563408731815;2264.864108153508;2265.1166045242285;2272.3637381533113;2181.541876205991;2192.9451763705874;2195.5499122679894;2197.4396528885113;2197.461621902628;1872.8876267423861;2149.322963266574;2157.3635777445534;2157.4174972757346;2158.2230397057047;2067.576146889884;2154.7522034965864;2155.5688862227616;2161.0275376080826;2170.6309927312395;7939.841203175962;7980.920190798076;7984.960075199587;7993.480423772437;7994.680212791482;4405.955940440586;4519.751413672247;4532.0709254602725;4539.432570928634;4540.160070386989;2819.619351387557;2837.829730216173;2873.094975082863;2980.4039192161654;2985.7312841844337;883.4125306671056;885.2386947225381;904.6019751309403;912.1425859691868;916.573793186165;10472.057514823626;10497.107745841613;10504.632337868137;10511.106555942753;10517.526711297933;4135.958640413617;4138.337865941435;4321.611055005002;4322.416473776063;4341.5007274163245;9047.366684332164;9056.456612603133;9078.909210907806;9081.54592270384;9092.545372731336;4573.931391029138;4574.290984897346;4576.313552967082;4576.405067341224;4582.19811532987;3629.3467175908063;3663.413853783382;4112.424260603518;4133.276676581586;4147.854825081107;3608.9278214435562;3722.3113723961155;3780.0738818989525;3791.4123310886857;3799.905002374963;1176.805827038529;1183.5147589488267;1192.1476144556511;1196.0670676872053;1197.5091011690502;763.3740332927058;777.8988731464987;784.4234487651571;790.8853216283607;799.328564006226;4819.879503012453;4888.608911287089;4895.559399654048;4929.605631549467;4960.206366981266;389.9025243689078;391.6866506794553;398.4959026831061;401.1795877430661;402.2237082430878;3285.195127193853;3363.486431106012;3366.7643264971216;3375.628680845105;3422.8801991930163;9373.578188981375;9946.751331216632;9961.55173017216;9962.701118966443;9972.700818975442;9616.423014619146;9790.314677972616;9837.508124593742;9842.50787460624;9857.35927164732;7346.889796653055;7394.336274338339;7440.367568756608;7447.664855081426;7454.739084132029;4856.201318154612;4911.263310503453;4919.458859525378;4978.27814966835;4997.125503036881;8827.426217295855;8953.552322383985;9052.50211238362;9062.954685226532;9184.081591840762;9105;9213.631454741735;9318.34771566011;9426.151646351862;9440.85838712406;6141.662208578571;6571.737130514726;6734.4949128816515;6751.122354093936;6983.860322793414;7559.395248380227;7622.885656715042;7637.159912409519;7642.4650274480255;7659.080910290801;6784.321567843176;6870.484713646397;6935.4104901081955;7044.401225895856;7088.397486213524;6844.247132815486;6874.209465911485;6915.412189963909;6993.650317484004;7019;6165.290991535851;6503.674816259263;6505.349465053457;6517.283098859027;6522.28254891971;4300.849470268526;4315.741055536678;4428.446444194476;4477;4481.551844815493;4358.49877264106;4430.712003719748;4462.576055274743;4502.707324023928;4507.954920450754 02:33:32 INFO - PROCESS | 5458 | |4;prototype.html;282.01998056752774;283.4227230231757;287.57295416306783;294.0619424037321;295.22797883534565;4878.463369029409;4881.4630390657;4883.731394773286;4902.534259245371;4908.705477671342;4570.954290457094;4625.560571745687;4694.178518759212;4798.640101992347;4851.151048566504;3749.5125633667585;3778.433235014756;3788.5074940257728;3788.7726736395903;3800.947488356291;3774.8867533974026;3780.527434070741;3783.2811765764554;3783.9054023649355;3786.242751449707;3583.838727257267;3674.210044840359;3784.6026167252453;3799.525059367579;3804.4673745675627;3772.962270377316;3774.735768496206;3775.8867233983024;3794.924101517968;3801.752886062411;3331.716804071657;3343.6656334366367;3344.3645707315777;3345.3142105868483;3351.865925363007;4419.160359531678;4701.576858082789;4742.786574604151;4743.952560474386;4745.715257084551;4222.577742225783;4223.472065991751;4225.746455212697;4227.682923780729;4242.66058715302;5065.696058236517;5071.797128114871;5073.492650734934;5078.6698864574055;5090.261912022736;3528.306412921812;3535.222251104753;3540.451230059345;3543.3976224041717;3543.450765131409;5012.874678133076;5295.947040529622;5307.548858347045;5310.1769225769685;5312.415634280264;3577.982110089485;3580.5524309461316;3598.2983318253214;3626.274745050948;3626.292872889814;3626.165981824195;3638.2723455308515;3642.0712718256673;3658.762180458262;3674.926501469956;4132.173565286955;4188.790560471964;4218.2196293685765;4261.190373828963;4280.72175308604;5024.874378140503;5029.497050295015;5032.144535428986;5039.370078740158;5059.2916991621205;1177.252444697606;1236.6599185224136;1252.311228824143;1272.2239433945285;1275.4133098774482;841.6212704282975;843.7637461510786;854.6495936665937;856.8200677857595;867.3408209760628;4359.1717573661535;4368.541303163122;4373.1472362888935;4383.7588932609015;4387.780610969503;5120.283160357553;5124.820631277962;5124.974375128175;5159.406668233201;5163.225516172604;4339.7830108494445;4354.129174165117;4355.5426680198125;4384.780760962003;4386.276264416336;2317.2121478697322;2430.4358901359237;2443.584590619599;2448.4980578981267;2462.5198086373343;4281.272183728774;4288.292431748727;4313.1158112586845;4330.458692663417;4338.544452832407;4603.872051347441;4657.39186055803;4669.486356500782;4694.2958556216845;4757.595604373667;4107.383892416102;4308.095299986975;4312.870613881589;4321.524632290446;4333;4546.386237857979;4547.636189104797;4573.679842410999;4577.130345234395;4596.471405788244;4476.4180656514445;4478.596926276651;4501.842435514741;4561.37020923756;4588.472325682455;4024.7987600620436;4278.5079715831835;4304.870853874263;4310.331898555729;4361.323994780814;3293.193167673935;3296.1924328539662;3311.8344082795284;3342.1310459280276;3357.966420335765;4662.2307319293295;4689.99165179488;4709.05818836241;4735.550122738335;4740.739259340769;4858.198397264412;4926.137925863031;5076.390833100052;5080.872978175576;5146.176611742103;5055.165897626997;5062.2406639002975;5104.566111880532;5106.285120083117;5163.586913047023;4879.243717223836;5000.424951130521;5002.149634562061;5024.899502009866;5064.164412871983;5120.974395128001;5126.256692779451;5140.43455219918;5152.458991805806;5152.458991805806;4971.477994810492;4977;4982.252662100714;5015.899682006412;5031.974840125776 02:33:32 INFO - PROCESS | 5458 | |5;yui.html;615.2678312807756;623.6725718997526;654.1561385812303;687.2028447001478;701.9085322323784;12079.174420571828;12131;12275.631731048072;12300.200486968351;13451.05842591019;12035.097367697414;12141.15011949164;12161.391930403466;12165.756684866297;12170.087243456732;623.9313675495691;750.4896670264218;756.8448468064062;769.1308821032226;770.0105364606482;771.194102163238;777.7200207925142;780.0366547314063;780.0989856715503;780.282140430805;822.4160845799489;825.63671984327;826.1696994520498;826.2027143806225;828.8176601147737;638.8722255548909;793.4326956226325;819.7212947597845;819.8483280593109;820.3847114664002;597.7877853362037;602.0337358539568;602.4036204157896;602.7528713227599;602.9397060293979;12564.874351256462;12577.685557861036;12607.11750177488;12607.747845043048;12613.243205407705;11300.378479183642;11795.292282462993;11833.644990650295;11843.111766617538;12359;11031.613893513688;11042.558297668083;11095.167862410271;11128.332300062022;11190.328580285128;4067.28822456069;4098.077932465201;4115.609017143366;4158.812853421603;4176.895577610554;56779.716101420054;57058;57290.427095728926;57356;57472.42527574754;9248.953755231316;9452.952735236417;9678.903210967941;9709.757256068655;9770.435614363721;17870.19584118718;17893.821061789477;17962.730559041625;18016.189271482814;18030.098495075195;6478.967605162038;6557.770478033246;6595.406413422815;6599.73601055962;6773.762918297836;3524.5241892344206;3603.4414665726854;3627;3670.302642497917;3763.2285381496727;2587.7541633544784;2671.6126161706443;2673.6123262126885;2675.411409489909;2675.8662066896577;478.19662966216396;481.6989381636477;498.56624736479495;502.56779169913847;521.4759167037104;478.2157262090175;486.28273296887517;524.6615932723372;592.2567178191342;613.098744845077;7677.117131529945;7806.960965195138;7852.803679908048;7861.803454913558;7964.2433968772875;498.0984418203064;575.9337676167295;577.3735496985734;593.7031484257872;604.6795198544778;3635.327464419091;3689.7232707546505;3729.8881033569037;3867.7292589518465;4014.4781178447197;62664.68667656633;85702.57148714217;100438;109296.4535177319;109845;90719;90948;91519.54240228889;94648.52675736578;97902;82067.58966205131;82644.58677706453;83436;83647.5817620908;83731;7201.279872012757;7387.460927389591;7400.777976660709;7498.02525671681;7611.2769286917655;38406.61593384142;45749.31376029429;46633.53366466292;46984.29523557218;48591.27113093236;64051.679741600994;68407.97388039283;70182;70750.64624676843;70949;9829.803403932025;9832;9911.355761875455;9996.800063998824;10161.237907156845;11070.944645276722;11210.775784484427;11225.775484490101;11236.887631123584;11253.606123785956;9442.339036267671;9679.516024198621;9856.655017074369;9874.50627468638;10055.69832905014;10580.788384232426;10786.137109031415;10822.51298691545;10866.456677166268;11003.559857605926;9460.385074970105;9671.081247281498;9697.22422206236;9882.110610044843;10048.196144308584;8746.169113934166;8823.514736627012;9096.1813436791;9191.954040229755;9194.26445884341;7951.7893013911735;8074.152214017444;8223.465474744362;8263.256306932404;8386.161383861565 02:33:32 INFO - PROCESS | 5458 | __end_tp_report 02:33:32 INFO - PROCESS | 5458 | __start_cc_report 02:33:32 INFO - PROCESS | 5458 | _x_x_mozilla_cycle_collect,1013 02:33:32 INFO - PROCESS | 5458 | __end_cc_report 02:33:32 INFO - PROCESS | 5458 | __startTimestamp1468056812846__endTimestamp 02:33:32 INFO - PROCESS | 5458 | 02:33:32 INFO - PROCESS | 5458 | ------- Summary: start ------- 02:33:32 INFO - PROCESS | 5458 | Number of tests: 6 02:33:32 INFO - PROCESS | 5458 | 02:33:32 INFO - PROCESS | 5458 | [#0] dojo.html Cycles:165 Average:4653.18 Median:4763.33 stddev:488.41 (10.3%) stddev-sans-first:461.91 02:33:32 INFO - PROCESS | 5458 | Values: 2575.5 2577.1 2601.4 2608.1 2618.1 4630.7 4702.9 4725.5 4732.0 4735.6 4664.6 4712.9 4721.1 4756.6 4784.5 4357.4 4372.0 4380.1 4386.8 4397.6 4399.9 4424.7 4440.0 4451.5 4487.3 4385.9 4397.0 4427.2 4434.5 4437.3 4299.8 4343.3 4361.5 4361.8 4382.6 4256.4 4261.2 4267.9 4274.9 4312.3 4674.7 4681.3 4719.5 4724.3 4737.8 4857.8 4988.5 5039.5 5046.6 5053.7 5077.2 5118.7 5130.5 5133.2 5140.8 4739.8 4751.3 4786.2 4787.0 4791.1 4980.8 5118.4 5123.6 5127.2 5144.9 4993.5 5012.1 5027.2 5040.2 5043.2 4913.9 5080.7 5083.2 5095.4 5119.6 4887.0 4925.1 4935.5 4944.3 4944.3 4931.2 4942.4 4943.4 4944.5 4989.4 4159.0 4204.9 4273.8 4274.9 4333.7 3715.4 3733.7 3738.9 3756.5 3777.9 4247.3 4265.1 4267.6 4284.9 4295.6 4952.6 5006.8 5009.3 5011.4 5042.1 4229.2 4231.6 4287.3 4300.9 4339.6 4513.8 4545.0 4550.5 4553.9 4594.5 4534.7 4736.4 4738.3 4744.0 4763.3 5027.3 5076.3 5085.7 5086.3 5088.4 4743.3 4747.6 4759.5 4761.3 4822.9 4854.4 4876.9 5007.6 5026.5 5027.4 4974.8 4998.4 5020.6 5024.7 5072.9 4862.4 4872.8 4876.2 4878.6 4923.5 4730.3 4868.4 4869.5 4898.8 4918.3 4883.8 4893.3 4900.7 4906.7 4926.8 4936.1 4964.6 4968.3 4968.5 5030.5 4715.0 4733.3 4779.0 4810.9 4843.7 02:33:32 INFO - PROCESS | 5458 | 02:33:32 INFO - PROCESS | 5458 | [#1] ext.html Cycles:180 Average:46736.36 Median:199350.64 stddev:79100.89 (39.7%) stddev-sans-first:79246.85 02:33:32 INFO - PROCESS | 5458 | Values: 573.1 573.4 576.3 580.9 589.5 28370.1 41491.8 42973.7 43012.1 46352.1 42130.4 42936.0 42988.6 43015.6 43024.4 7431.0 7660.9 7808.1 7808.7 7825.6 7449.4 7696.8 7708.8 9926.9 10213.8 10270.8 10288.4 10303.5 10303.5 10317.4 10108.2 10187.3 10189.4 10197.5 10210.8 7425.7 7666.4 7684.5 9780.2 10185.7 39423.4 39529.8 39804.6 39920.4 39929.8 3021.7 3034.3 3053.1 3096.3 3413.2 30291.2 30419.0 30570.8 30788.8 30966.0 3206.7 3343.5 3354.4 3354.5 3460.4 264594.0 265178.7 265495.0 266020.0 266637.0 55205.2 55956.7 56036.0 56060.0 56252.0 57465.7 57663.7 57754.4 57771.4 57840.7 14827.0 15318.9 15318.9 15319.2 15361.2 9663.3 11464.3 11465.4 11468.7 11514.3 16566.7 17194.2 17312.5 17475.6 17769.3 5578.7 5578.9 5623.7 5705.7 5709.9 762.0 845.5 967.5 982.4 989.8 28317.0 28480.3 28609.0 28912.7 29066.7 946.6 949.5 976.7 980.3 1025.9 15225.5 15240.2 15263.6 15358.8 15595.2 360054.0 361220.0 361423.0 362384.0 365539.0 49895.8 50006.0 50045.5 50163.2 50268.0 1130.8 1166.3 1190.7 1192.4 1206.9 27153.0 27814.0 28090.6 28447.4 28756.7 43872.0 44052.8 44369.3 44413.0 44512.6 268170.0 268181.0 268220.0 268634.0 269221.0 30727.2 31041.7 37903.6 38193.8 38244.8 39567.2 42320.8 42353.2 43281.4 43413.6 35707.6 36317.3 36551.0 37368.8 37391.3 37153.3 37443.6 37704.0 37831.2 37983.8 34419.3 37284.6 37718.6 37773.6 37862.0 31531.4 33766.0 33847.3 34067.1 34583.3 25580.6 25592.9 25798.8 25972.4 25973.7 02:33:32 INFO - PROCESS | 5458 | 02:33:32 INFO - PROCESS | 5458 | [#2] jquery.html Cycles:180 Average:25258.42 Median:4669.70 stddev:68985.12 (1477.3%) stddev-sans-first:69153.28 02:33:32 INFO - PROCESS | 5458 | Values: 341.6 363.8 366.2 368.4 387.2 13079.5 16453.9 16488.3 16937.8 17821.5 17353.7 17511.3 17577.8 17987.6 18177.7 4886.2 5020.8 5188.4 5192.7 5270.3 3439.8 5218.3 5280.2 5573.6 5580.3 5620.5 5631.1 5648.7 5651.2 5656.5 5409.2 5648.2 5660.9 5661.4 5663.9 3307.6 5116.7 5410.8 5420.5 5458.5 12419.6 12537.6 12564.0 14259.0 21152.6 1921.4 1923.5 1955.9 2005.5 2262.7 9035.4 9235.6 9261.3 9633.6 9691.0 1678.8 1726.6 1731.7 1736.3 1756.7 69292.3 71107.0 72654.0 72911.6 74011.9 9013.9 9583.7 10000.6 10033.0 10048.2 12828.7 13763.5 13777.7 14108.8 14214.7 7104.4 7289.2 7290.5 7333.7 7365.0 6636.8 6790.6 6803.4 6897.9 7084.8 4384.4 4403.5 4411.7 4443.7 4453.2 1824.0 1826.3 1836.6 1892.6 1914.9 793.4 820.5 947.4 956.9 973.1 17175.4 17205.0 17525.7 17653.4 18018.4 759.4 772.8 800.3 805.8 879.4 9215.5 9402.2 9620.8 9710.5 9742.0 390826.0 419297.0 423506.0 425969.0 429264.0 76549.6 76781.0 77091.0 78612.0 79875.0 894.1 936.4 961.5 961.9 962.0 16103.9 16221.5 16411.5 16924.4 17044.9 39550.6 40383.2 40591.6 41029.4 41104.4 49711.5 51895.0 56002.2 56094.4 56163.4 7537.2 7652.0 7662.7 7822.4 7970.3 11713.0 11777.5 11891.2 12241.8 12268.3 10441.9 10513.0 10550.5 10603.8 10693.8 9886.4 10309.6 10439.9 10517.1 10725.5 9583.2 9681.8 10339.8 10362.9 10664.6 7572.2 7649.3 7694.6 7746.1 7776.9 9906.4 10380.4 10531.6 10621.1 10632.7 02:33:32 INFO - PROCESS | 5458 | 02:33:32 INFO - PROCESS | 5458 | [#3] mootools.html Cycles:180 Average:5116.72 Median:4838.04 stddev:2950.14 (61.0%) stddev-sans-first:2943.96 02:33:32 INFO - PROCESS | 5458 | Values: 1229.7 1392.5 1440.0 1512.4 1714.0 6637.9 7556.0 7795.7 7808.5 7906.4 7672.3 7816.3 7843.8 7847.3 7871.3 1887.8 1938.9 1943.9 2187.5 2223.8 2008.8 2183.0 2264.9 2265.1 2272.4 2181.5 2192.9 2195.5 2197.4 2197.5 1872.9 2149.3 2157.4 2157.4 2158.2 2067.6 2154.8 2155.6 2161.0 2170.6 7939.8 7980.9 7985.0 7993.5 7994.7 4406.0 4519.8 4532.1 4539.4 4540.2 2819.6 2837.8 2873.1 2980.4 2985.7 883.4 885.2 904.6 912.1 916.6 10472.1 10497.1 10504.6 10511.1 10517.5 4136.0 4138.3 4321.6 4322.4 4341.5 9047.4 9056.5 9078.9 9081.5 9092.5 4573.9 4574.3 4576.3 4576.4 4582.2 3629.3 3663.4 4112.4 4133.3 4147.9 3608.9 3722.3 3780.1 3791.4 3799.9 1176.8 1183.5 1192.1 1196.1 1197.5 763.4 777.9 784.4 790.9 799.3 4819.9 4888.6 4895.6 4929.6 4960.2 389.9 391.7 398.5 401.2 402.2 3285.2 3363.5 3366.8 3375.6 3422.9 9373.6 9946.8 9961.6 9962.7 9972.7 9616.4 9790.3 9837.5 9842.5 9857.4 7346.9 7394.3 7440.4 7447.7 7454.7 4856.2 4911.3 4919.5 4978.3 4997.1 8827.4 8953.6 9052.5 9063.0 9184.1 9105.0 9213.6 9318.3 9426.2 9440.9 6141.7 6571.7 6734.5 6751.1 6983.9 7559.4 7622.9 7637.2 7642.5 7659.1 6784.3 6870.5 6935.4 7044.4 7088.4 6844.2 6874.2 6915.4 6993.7 7019.0 6165.3 6503.7 6505.3 6517.3 6522.3 4300.8 4315.7 4428.4 4477.0 4481.6 4358.5 4430.7 4462.6 4502.7 4508.0 02:33:32 INFO - PROCESS | 5458 | 02:33:32 INFO - PROCESS | 5458 | [#4] prototype.html Cycles:180 Average:4051.27 Median:4378.45 stddev:1180.65 (27.0%) stddev-sans-first:1149.57 02:33:32 INFO - PROCESS | 5458 | Values: 282.0 283.4 287.6 294.1 295.2 4878.5 4881.5 4883.7 4902.5 4908.7 4571.0 4625.6 4694.2 4798.6 4851.2 3749.5 3778.4 3788.5 3788.8 3800.9 3774.9 3780.5 3783.3 3783.9 3786.2 3583.8 3674.2 3784.6 3799.5 3804.5 3773.0 3774.7 3775.9 3794.9 3801.8 3331.7 3343.7 3344.4 3345.3 3351.9 4419.2 4701.6 4742.8 4744.0 4745.7 4222.6 4223.5 4225.7 4227.7 4242.7 5065.7 5071.8 5073.5 5078.7 5090.3 3528.3 3535.2 3540.5 3543.4 3543.5 5012.9 5295.9 5307.5 5310.2 5312.4 3578.0 3580.6 3598.3 3626.3 3626.3 3626.2 3638.3 3642.1 3658.8 3674.9 4132.2 4188.8 4218.2 4261.2 4280.7 5024.9 5029.5 5032.1 5039.4 5059.3 1177.3 1236.7 1252.3 1272.2 1275.4 841.6 843.8 854.6 856.8 867.3 4359.2 4368.5 4373.1 4383.8 4387.8 5120.3 5124.8 5125.0 5159.4 5163.2 4339.8 4354.1 4355.5 4384.8 4386.3 2317.2 2430.4 2443.6 2448.5 2462.5 4281.3 4288.3 4313.1 4330.5 4338.5 4603.9 4657.4 4669.5 4694.3 4757.6 4107.4 4308.1 4312.9 4321.5 4333.0 4546.4 4547.6 4573.7 4577.1 4596.5 4476.4 4478.6 4501.8 4561.4 4588.5 4024.8 4278.5 4304.9 4310.3 4361.3 3293.2 3296.2 3311.8 3342.1 3358.0 4662.2 4690.0 4709.1 4735.6 4740.7 4858.2 4926.1 5076.4 5080.9 5146.2 5055.2 5062.2 5104.6 5106.3 5163.6 4879.2 5000.4 5002.1 5024.9 5064.2 5121.0 5126.3 5140.4 5152.5 5152.5 4971.5 4977.0 4982.3 5015.9 5032.0 02:33:32 INFO - PROCESS | 5458 | 02:33:32 INFO - PROCESS | 5458 | [#5] yui.html Cycles:180 Average:17764.49 Median:602.22 stddev:26647.62 (4424.9%) stddev-sans-first:26691.26 02:33:32 INFO - PROCESS | 5458 | Values: 615.3 623.7 654.2 687.2 701.9 12079.2 12131.0 12275.6 12300.2 13451.1 12035.1 12141.2 12161.4 12165.8 12170.1 623.9 750.5 756.8 769.1 770.0 771.2 777.7 780.0 780.1 780.3 822.4 825.6 826.2 826.2 828.8 638.9 793.4 819.7 819.8 820.4 597.8 602.0 602.4 602.8 602.9 12564.9 12577.7 12607.1 12607.7 12613.2 11300.4 11795.3 11833.6 11843.1 12359.0 11031.6 11042.6 11095.2 11128.3 11190.3 4067.3 4098.1 4115.6 4158.8 4176.9 56779.7 57058.0 57290.4 57356.0 57472.4 9249.0 9453.0 9678.9 9709.8 9770.4 17870.2 17893.8 17962.7 18016.2 18030.1 6479.0 6557.8 6595.4 6599.7 6773.8 3524.5 3603.4 3627.0 3670.3 3763.2 2587.8 2671.6 2673.6 2675.4 2675.9 478.2 481.7 498.6 502.6 521.5 478.2 486.3 524.7 592.3 613.1 7677.1 7807.0 7852.8 7861.8 7964.2 498.1 575.9 577.4 593.7 604.7 3635.3 3689.7 3729.9 3867.7 4014.5 62664.7 85702.6 100438.0 109296.5 109845.0 90719.0 90948.0 91519.5 94648.5 97902.0 82067.6 82644.6 83436.0 83647.6 83731.0 7201.3 7387.5 7400.8 7498.0 7611.3 38406.6 45749.3 46633.5 46984.3 48591.3 64051.7 68408.0 70182.0 70750.6 70949.0 9829.8 9832.0 9911.4 9996.8 10161.2 11070.9 11210.8 11225.8 11236.9 11253.6 9442.3 9679.5 9856.7 9874.5 10055.7 10580.8 10786.1 10822.5 10866.5 11003.6 9460.4 9671.1 9697.2 9882.1 10048.2 8746.2 8823.5 9096.2 9192.0 9194.3 7951.8 8074.2 8223.5 8263.3 8386.2 02:33:32 INFO - PROCESS | 5458 | -------- Summary: end -------- 02:33:32 INFO - PROCESS | 5458 | 02:33:33 INFO - TEST-INFO | 5458: exit 0 02:33:33 INFO - TEST-OK | dromaeo_css | took 1119910ms 02:33:33 INFO - TEST-START | kraken 02:33:33 INFO - operating with platform_type : linux_ 02:33:33 INFO - Initialising browser for kraken test... 02:33:33 INFO - TEST-INFO | started process 5655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpErlUA2/profile http://localhost:34471/getInfo.html) 02:33:38 INFO - PROCESS | 5655 | __metrics Screen width/height:1600/1200 02:33:38 INFO - PROCESS | 5655 | colorDepth:24 02:33:38 INFO - PROCESS | 5655 | Browser inner width/height: 1024/697 02:33:38 INFO - PROCESS | 5655 | __metrics 02:33:39 INFO - PROCESS | 5655 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:33:40 INFO - TEST-INFO | 5655: exit 0 02:33:40 INFO - Browser initialized. 02:33:40 INFO - Running cycle 1/1 for kraken test... 02:33:40 INFO - TEST-INFO | started process 5737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpErlUA2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:52 INFO - PROCESS | 5737 | RSS: Main: 158855168 02:33:52 INFO - PROCESS | 5737 | 02:33:54 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34471/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34471/tests/kraken/driver.html?testName=audio-beat-detection) 02:33:55 INFO - PROCESS | 5737 | RSS: Main: 216838144 02:33:55 INFO - PROCESS | 5737 | 02:33:58 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34471/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34471/tests/kraken/driver.html?testName=audio-dft) 02:33:59 INFO - PROCESS | 5737 | RSS: Main: 203894784 02:33:59 INFO - PROCESS | 5737 | 02:34:02 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34471/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34471/tests/kraken/driver.html?testName=audio-fft) 02:34:03 INFO - PROCESS | 5737 | RSS: Main: 271130624 02:34:03 INFO - PROCESS | 5737 | 02:34:05 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34471/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34471/tests/kraken/driver.html?testName=audio-oscillator) 02:34:05 INFO - PROCESS | 5737 | RSS: Main: 181121024 02:34:05 INFO - PROCESS | 5737 | 02:34:08 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34471/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34471/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:34:08 INFO - PROCESS | 5737 | RSS: Main: 185303040 02:34:08 INFO - PROCESS | 5737 | 02:34:11 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34471/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34471/tests/kraken/driver.html?testName=imaging-darkroom) 02:34:12 INFO - PROCESS | 5737 | RSS: Main: 221827072 02:34:12 INFO - PROCESS | 5737 | 02:34:15 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34471/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34471/tests/kraken/driver.html?testName=imaging-desaturate) 02:34:16 INFO - PROCESS | 5737 | RSS: Main: 217419776 02:34:16 INFO - PROCESS | 5737 | 02:34:19 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34471/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34471/tests/kraken/driver.html?testName=json-parse-financial) 02:34:20 INFO - PROCESS | 5737 | RSS: Main: 220553216 02:34:20 INFO - PROCESS | 5737 | 02:34:21 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34471/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34471/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:34:22 INFO - PROCESS | 5737 | RSS: Main: 206200832 02:34:22 INFO - PROCESS | 5737 | 02:34:24 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34471/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34471/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:34:24 INFO - PROCESS | 5737 | RSS: Main: 212439040 02:34:24 INFO - PROCESS | 5737 | 02:34:26 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34471/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34471/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:34:27 INFO - PROCESS | 5737 | RSS: Main: 210120704 02:34:27 INFO - PROCESS | 5737 | 02:34:30 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34471/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:34:30 INFO - PROCESS | 5737 | RSS: Main: 223309824 02:34:30 INFO - PROCESS | 5737 | 02:34:33 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:34:34 INFO - PROCESS | 5737 | RSS: Main: 224337920 02:34:34 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34471/tests/kraken/driver.html?testName=ai-astar) 02:34:36 INFO - PROCESS | 5737 | RSS: Main: 266600448 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | __start_tp_report 02:34:36 INFO - PROCESS | 5737 | _x_x_mozilla_page_load 02:34:36 INFO - PROCESS | 5737 | _x_x_mozilla_page_load_details 02:34:36 INFO - PROCESS | 5737 | |i|pagename|runs| 02:34:36 INFO - PROCESS | 5737 | |0;ai-astar;103;112;113;112;113;113;111;112;112;112 02:34:36 INFO - PROCESS | 5737 | |1;audio-beat-detection;151;123;126;191;122;122;151;121;168;129 02:34:36 INFO - PROCESS | 5737 | |2;audio-dft;161;162;164;161;161;164;162;162;162;160 02:34:36 INFO - PROCESS | 5737 | |3;audio-fft;76;75;77;103;75;77;76;76;107;77 02:34:36 INFO - PROCESS | 5737 | |4;audio-oscillator;85;85;124;86;85;86;124;85;86;126 02:34:36 INFO - PROCESS | 5737 | |5;imaging-gaussian-blur;117;117;116;118;117;118;118;117;117;117 02:34:36 INFO - PROCESS | 5737 | |6;imaging-darkroom;146;147;146;146;146;146;145;147;147;146 02:34:36 INFO - PROCESS | 5737 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;94;95 02:34:36 INFO - PROCESS | 5737 | |8;json-parse-financial;63;62;64;64;64;67;63;63;63;73 02:34:36 INFO - PROCESS | 5737 | |9;json-stringify-tinderbox;63;64;64;64;64;63;65;63;64;64 02:34:36 INFO - PROCESS | 5737 | |10;stanford-crypto-aes;79;79;80;79;79;79;83;79;79;85 02:34:36 INFO - PROCESS | 5737 | |11;stanford-crypto-ccm;138;131;125;128;130;136;130;127;177;128 02:34:36 INFO - PROCESS | 5737 | |12;stanford-crypto-pbkdf2;169;166;165;164;169;171;169;168;167;169 02:34:36 INFO - PROCESS | 5737 | |13;stanford-crypto-sha256-iterative;70;68;71;67;66;66;66;66;65;65 02:34:36 INFO - PROCESS | 5737 | __end_tp_report 02:34:36 INFO - PROCESS | 5737 | __start_cc_report 02:34:36 INFO - PROCESS | 5737 | _x_x_mozilla_cycle_collect,1898 02:34:36 INFO - PROCESS | 5737 | __end_cc_report 02:34:36 INFO - PROCESS | 5737 | __startTimestamp1468056876508__endTimestamp 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | ------- Summary: start ------- 02:34:36 INFO - PROCESS | 5737 | Number of tests: 14 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.98 (2.7%) stddev-sans-first:0.67 02:34:36 INFO - PROCESS | 5737 | Values: 103.0 112.0 113.0 112.0 113.0 113.0 111.0 112.0 112.0 112.0 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:140.00 stddev:24.13 (17.2%) stddev-sans-first:25.29 02:34:36 INFO - PROCESS | 5737 | Values: 151.0 123.0 126.0 191.0 122.0 122.0 151.0 121.0 168.0 129.0 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.32 02:34:36 INFO - PROCESS | 5737 | Values: 161.0 162.0 164.0 161.0 161.0 164.0 162.0 162.0 162.0 160.0 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:12.23 (16.1%) stddev-sans-first:12.79 02:34:36 INFO - PROCESS | 5737 | Values: 76.0 75.0 77.0 103.0 75.0 77.0 76.0 76.0 107.0 77.0 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:85.00 stddev:18.97 (22.3%) stddev-sans-first:19.60 02:34:36 INFO - PROCESS | 5737 | Values: 85.0 85.0 124.0 86.0 85.0 86.0 124.0 85.0 86.0 126.0 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 02:34:36 INFO - PROCESS | 5737 | Values: 117.0 117.0 116.0 118.0 117.0 118.0 118.0 117.0 117.0 117.0 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 02:34:36 INFO - PROCESS | 5737 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 145.0 147.0 147.0 146.0 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 02:34:36 INFO - PROCESS | 5737 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.00 stddev:3.24 (5.1%) stddev-sans-first:3.38 02:34:36 INFO - PROCESS | 5737 | Values: 63.0 62.0 64.0 64.0 64.0 67.0 63.0 63.0 63.0 73.0 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 02:34:36 INFO - PROCESS | 5737 | Values: 63.0 64.0 64.0 64.0 64.0 63.0 65.0 63.0 64.0 64.0 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.00 stddev:2.13 (2.7%) stddev-sans-first:2.22 02:34:36 INFO - PROCESS | 5737 | Values: 79.0 79.0 80.0 79.0 79.0 79.0 83.0 79.0 79.0 85.0 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:130.50 stddev:15.28 (11.7%) stddev-sans-first:16.17 02:34:36 INFO - PROCESS | 5737 | Values: 138.0 131.0 125.0 128.0 130.0 136.0 130.0 127.0 177.0 128.0 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:169.00 stddev:2.16 (1.3%) stddev-sans-first:2.24 02:34:36 INFO - PROCESS | 5737 | Values: 169.0 166.0 165.0 164.0 169.0 171.0 169.0 168.0 167.0 169.0 02:34:36 INFO - PROCESS | 5737 | 02:34:36 INFO - PROCESS | 5737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:66.50 stddev:2.05 (3.1%) stddev-sans-first:1.87 02:34:36 INFO - PROCESS | 5737 | Values: 70.0 68.0 71.0 67.0 66.0 66.0 66.0 66.0 65.0 65.0 02:34:36 INFO - PROCESS | 5737 | -------- Summary: end -------- 02:34:36 INFO - PROCESS | 5737 | 02:34:37 INFO - TEST-INFO | 5737: exit 0 02:34:37 INFO - TEST-OK | kraken | took 64041ms 02:34:37 INFO - SUITE-END | took 1183s 02:34:38 INFO - Completed test suite (00:19:44) 02:34:38 INFO - javascript benchmark 02:34:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2575.5492788761962, 2577.1237779155085, 2601.3626661467943, 2608.139314026371, 2618.136015115012, 4630.699004564701, 4702.9294560581575, 4725.503822098682, 4731.952680473194, 4735.5974742146955, 4664.580187783099, 4712.90574188516, 4721.055788842236, 4756.571908528232, 4784.473707892129, 4357.41174941382, 4371.999999999992, 4380.123975204956, 4386.846460373888, 4397.626201772853, 4399.890002749925, 4424.690271680984, 4439.978804874881, 4451.5103338632725, 4487.259602165655, 4385.912281754379, 4397.0, 4427.225235583776, 4434.467863856342, 4437.267850804614, 4299.763513006784, 4343.261645520269, 4361.454818147731, 4361.760103194323, 4382.583654552813, 4256.446661933929, 4261.169072030955, 4267.893302667427, 4274.914501709979, 4312.310030395153, 4674.7428891410955, 4681.274402467623, 4719.480857105716, 4724.291356296549, 4737.810487580493, 4857.82997595086, 4988.451270360258, 5039.4708555601865, 5046.62150338726, 5053.6967781932835, 5077.238414237894, 5118.744062796845, 5130.48695130484, 5133.178691409356, 5140.820071297487, 4739.786709598076, 4751.263554149113, 4786.234202527578, 4786.976065119652, 4791.089692958327, 4980.8256711015665, 5118.411382691038, 5123.641345105882, 5127.2052831811125, 5144.922826157611, 4993.500649934977, 5012.122878496249, 5027.195648696191, 5040.193569028937, 5043.193089105725, 4913.926291105637, 5080.7205603692155, 5083.161278389099, 5095.439501654815, 5119.564836988898, 4886.95113048865, 4925.13810083234, 4935.531124543163, 4944.332515110414, 4944.332515110486, 4931.235658472942, 4942.382202224722, 4943.3573635427165, 4944.456109827916, 4989.376327959005, 4158.9584104158575, 4204.8528301509305, 4273.829046838154, 4274.893127671833, 4333.674974376934, 3715.3869611513796, 3733.6826369758874, 3738.869139580156, 3756.5116534850295, 3777.905552361213, 4247.320428731388, 4265.0830071534765, 4267.594578515036, 4284.89287767802, 4295.613394794484, 4952.554270115635, 5006.799728010838, 5009.323741294951, 5011.398632164163, 5042.09242336383, 4229.238737027303, 4231.555686652857, 4287.335463003239, 4300.913981720348, 4339.587739164775, 4513.842015529441, 4545.0, 4550.49944506104, 4553.863384098482, 4594.540545945379, 4534.727916325031, 4736.407949006374, 4738.289256611536, 4744.027474367816, 4763.333133361332, 5027.271045698426, 5076.289319495348, 5085.694858308513, 5086.287919691172, 5088.4148322941855, 4743.312219728189, 4747.572718455355, 4759.452662943806, 4761.285807128958, 4822.855314340575, 4854.417469903634, 4876.902461950812, 5007.574356179765, 5026.472220416804, 5027.371578552681, 4974.776135073858, 4998.350214472095, 5020.6234532410945, 5024.673396229234, 5072.898542029213, 4862.367892174137, 4872.805087796591, 4876.195427754381, 4878.56092951636, 4923.4584195737725, 4730.266808644666, 4868.391451068616, 4869.537393947569, 4898.7550622468025, 4918.286848407032, 4883.755812209446, 4893.290472881484, 4900.705957642553, 4906.681065730716, 4926.827561035347, 4936.062148191832, 4964.578010869117, 4968.2795994579865, 4968.527989840959, 5030.522100400456, 4714.952850471452, 4733.266343716729, 4779.044191161712, 4810.903781924412, 4843.685160464559], "value": 4621.560932776198, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.1374281706031, 573.4007961680044, 576.3170642788297, 580.8634970781862, 589.4930359890495, 28370.14889553314, 41491.79254103729, 42973.71078867639, 43012.13975720487, 46352.07295854081, 42130.36804447936, 42936.0, 42988.57011429885, 43015.56984430155, 43024.35463468043, 7431.0, 7660.885086723703, 7808.102068262137, 7808.687652493893, 7825.569593672374, 7449.441291903102, 7696.769096927102, 7708.845823083535, 9926.90073099267, 10213.846792298084, 10270.845937310947, 10288.382697038165, 10303.536340864679, 10303.536340864679, 10317.380957142595, 10108.241881858854, 10187.286889917708, 10189.388636681786, 10197.49012549377, 10210.795784084352, 7425.74009909656, 7666.425018123663, 7684.462087653867, 9780.217582593375, 10185.745356366077, 39423.40864887029, 39529.80235098806, 39804.60195398038, 39920.40517366362, 39929.80035099835, 3021.728044475986, 3034.2717747740385, 3053.084074777558, 3096.2723759916403, 3413.232022794851, 30291.242718931982, 30419.0, 30570.84714576435, 30788.8460557698, 30966.0, 3206.6633003534757, 3343.498475228711, 3354.3626710924846, 3354.463285874273, 3460.446328587439, 264594.0, 265178.67410663015, 265495.0, 266020.0, 266637.0, 55205.1719224212, 55956.72021639866, 56036.0, 56060.0, 56252.0, 57465.71267143638, 57663.711681441324, 57754.42245577575, 57771.422285777444, 57840.71079644575, 14827.036242644193, 15318.923405382902, 15318.923405383124, 15319.157446340336, 15361.155136467602, 9663.27525435595, 11464.25482343645, 11465.426728663533, 11468.713282168013, 11514.251573647685, 16566.6686666266, 17194.22625981809, 17312.48062558125, 17475.64078849339, 17769.28922843098, 5578.693171875505, 5578.888422231614, 5623.725968264149, 5705.74324155414, 5709.858028394337, 761.9657115429708, 845.450457202823, 967.4582233949011, 982.3712823792779, 989.8229471629711, 28317.0, 28480.28799279993, 28609.0, 28912.71087289142, 29066.7093329064, 946.5693109635099, 949.4588084791602, 976.6874600128033, 980.2550061952967, 1025.9076683098558, 15225.467108651366, 15240.237988100773, 15263.618409539627, 15358.769618455732, 15595.220238988006, 360054.0, 361220.0, 361423.0, 362384.0, 365539.0, 49895.750521247886, 50006.0, 50045.499545004815, 50163.24755128676, 50268.0, 1130.8303754436736, 1166.2535976974743, 1190.743990042145, 1192.3740036480917, 1206.9396530173456, 27153.0, 27814.0, 28090.57864131999, 28447.43105137927, 28756.71243287624, 43872.0, 44052.77973610111, 44369.33445998248, 44413.0, 44512.55487445214, 268170.0, 268181.0, 268220.0, 268634.0, 269221.0, 30727.231819203804, 31041.68958310388, 37903.62096379001, 38193.80903095467, 38244.80877595594, 39567.20865582614, 42320.788396057826, 42353.152936940474, 43281.35077973896, 43413.565864340955, 35707.642923570435, 36317.27365452623, 36551.0, 37368.81315593405, 37391.25217495689, 37153.25693486169, 37443.62556374401, 37704.0, 37831.24337513289, 37983.81008094942, 34419.311613768084, 37284.62715372811, 37718.62281377151, 37773.62226377701, 37862.0, 31531.369372612877, 33766.0, 33847.3230535383, 34067.14832129118, 34583.308333832676, 25580.616290755283, 25592.872035639703, 25798.75989564388, 25972.35069123287, 25973.740262597134], "value": 18116.704421237726, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.55427167546344, 363.77809536182934, 366.1943723807622, 368.4050258831986, 387.1849756263066, 13079.476820927164, 16453.917730411347, 16488.258028388722, 16937.830621693778, 17821.465356039338, 17353.652926941453, 17511.299548018094, 17577.82422175778, 17987.64024719505, 18177.72733409, 4886.218205087187, 5020.799168033283, 5188.351456067991, 5192.71440070796, 5270.262163297141, 3439.8280085995725, 5218.347706536683, 5280.234366016925, 5573.6098473106895, 5580.274564306655, 5620.4660557247, 5631.0708733059, 5648.717564121798, 5651.180578816069, 5656.519195868335, 5409.188621706736, 5648.181013752983, 5660.858478538028, 5661.377248502661, 5663.886722265573, 3307.570015897942, 5116.744162791845, 5410.756515956791, 5420.4850539198715, 5458.536024437888, 12419.627411177678, 12537.623871283784, 12564.0, 14259.0, 21152.576948461097, 1921.3851567498407, 1923.519120219945, 1955.9217631294732, 2005.5287007553213, 2262.739784924738, 9035.367524273304, 9235.584398702074, 9261.305402094802, 9633.614655413776, 9691.0, 1678.8237235090385, 1726.585619451335, 1731.7488964100135, 1736.328649422716, 1756.656158039101, 69292.3070769291, 71107.0, 72654.0, 72911.63544182245, 74011.88982165325, 9013.864792028126, 9583.712488625353, 10000.649977250761, 10033.0, 10048.246381521416, 12828.679283017813, 13763.518276860263, 13777.655558611115, 14108.788368174486, 14214.715705685829, 7104.3961263293195, 7289.2346303638415, 7290.510098841929, 7333.706651733871, 7365.005724227268, 6636.772197143544, 6790.5925644461495, 6803.421709154678, 6897.896531552031, 7084.787456376317, 4384.364267181241, 4403.493598236179, 4411.713238639542, 4443.6889417741095, 4453.1761624099645, 1823.972640410395, 1826.3060037185785, 1836.6051298970785, 1892.5930924851223, 1914.9138288777037, 793.3653077538062, 820.4915031127131, 947.3605316411395, 956.9138777510058, 973.1047436358425, 17175.398861039805, 17205.0, 17525.7371139433, 17653.38213162533, 18018.36935707244, 759.4304271796153, 772.8261141243175, 800.2837460472845, 805.8025783683036, 879.3756432932562, 9215.49314787693, 9402.247820174369, 9620.807583848284, 9710.514474276259, 9741.951290243504, 390826.0, 419297.0, 423506.0, 425969.0, 429264.0, 76549.61725191338, 76781.0, 77091.0, 78612.0, 79875.0, 894.141624040928, 936.4100616611491, 961.4904100826573, 961.9470929098967, 962.0283513651123, 16103.919480402992, 16221.513354599381, 16411.507654770376, 16924.40764573234, 17044.914775426045, 39550.60449395584, 40383.1923361537, 40591.59408405878, 41029.38455923223, 41104.38343424791, 49711.50288497069, 51895.0, 56002.159967601336, 56094.43905560892, 56163.438365615824, 7537.170911199873, 7652.0, 7662.7214541351095, 7822.413319001212, 7970.2826745593175, 11713.0, 11777.52889884395, 11891.167618266638, 12241.755164896831, 12268.263904165779, 10441.947790261, 10513.0, 10550.472476376304, 10603.787924241626, 10693.786124277316, 9886.406815591088, 10309.587616495257, 10439.895601043892, 10517.106045986176, 10725.517351719036, 9583.233341332816, 9681.806363872542, 10339.793204136025, 10362.896371036495, 10664.57341706354, 7572.242775722384, 7649.31156195945, 7694.576798276148, 7746.147923728498, 7776.88334674969, 9906.356086854332, 10380.377177369382, 10531.578736850746, 10621.097206737204, 10632.681019569425], "value": 8222.085252076213, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1229.7233122547434, 1392.519580744643, 1440.006395587045, 1512.4403970530905, 1714.0315721617285, 6637.933620663792, 7555.962220188905, 7795.688172473095, 7808.492447990877, 7906.407019473548, 7672.309492145706, 7816.296533312001, 7843.80390490238, 7847.254510821463, 7871.252231038056, 1887.8017808130155, 1938.873973191745, 1943.8639295249338, 2187.507810742586, 2223.788740069691, 2008.768991565974, 2182.9563408731815, 2264.864108153508, 2265.1166045242285, 2272.3637381533113, 2181.541876205991, 2192.9451763705874, 2195.5499122679894, 2197.4396528885113, 2197.461621902628, 1872.8876267423861, 2149.322963266574, 2157.3635777445534, 2157.4174972757346, 2158.2230397057047, 2067.576146889884, 2154.7522034965864, 2155.5688862227616, 2161.0275376080826, 2170.6309927312395, 7939.841203175962, 7980.920190798076, 7984.960075199587, 7993.480423772437, 7994.680212791482, 4405.955940440586, 4519.751413672247, 4532.0709254602725, 4539.432570928634, 4540.160070386989, 2819.619351387557, 2837.829730216173, 2873.094975082863, 2980.4039192161654, 2985.7312841844337, 883.4125306671056, 885.2386947225381, 904.6019751309403, 912.1425859691868, 916.573793186165, 10472.057514823626, 10497.107745841613, 10504.632337868137, 10511.106555942753, 10517.526711297933, 4135.958640413617, 4138.337865941435, 4321.611055005002, 4322.416473776063, 4341.5007274163245, 9047.366684332164, 9056.456612603133, 9078.909210907806, 9081.54592270384, 9092.545372731336, 4573.931391029138, 4574.290984897346, 4576.313552967082, 4576.405067341224, 4582.19811532987, 3629.3467175908063, 3663.413853783382, 4112.424260603518, 4133.276676581586, 4147.854825081107, 3608.9278214435562, 3722.3113723961155, 3780.0738818989525, 3791.4123310886857, 3799.905002374963, 1176.805827038529, 1183.5147589488267, 1192.1476144556511, 1196.0670676872053, 1197.5091011690502, 763.3740332927058, 777.8988731464987, 784.4234487651571, 790.8853216283607, 799.328564006226, 4819.879503012453, 4888.608911287089, 4895.559399654048, 4929.605631549467, 4960.206366981266, 389.9025243689078, 391.6866506794553, 398.4959026831061, 401.1795877430661, 402.2237082430878, 3285.195127193853, 3363.486431106012, 3366.7643264971216, 3375.628680845105, 3422.8801991930163, 9373.578188981375, 9946.751331216632, 9961.55173017216, 9962.701118966443, 9972.700818975442, 9616.423014619146, 9790.314677972616, 9837.508124593742, 9842.50787460624, 9857.35927164732, 7346.889796653055, 7394.336274338339, 7440.367568756608, 7447.664855081426, 7454.739084132029, 4856.201318154612, 4911.263310503453, 4919.458859525378, 4978.27814966835, 4997.125503036881, 8827.426217295855, 8953.552322383985, 9052.50211238362, 9062.954685226532, 9184.081591840762, 9105.0, 9213.631454741735, 9318.34771566011, 9426.151646351862, 9440.85838712406, 6141.662208578571, 6571.737130514726, 6734.4949128816515, 6751.122354093936, 6983.860322793414, 7559.395248380227, 7622.885656715042, 7637.159912409519, 7642.4650274480255, 7659.080910290801, 6784.321567843176, 6870.484713646397, 6935.4104901081955, 7044.401225895856, 7088.397486213524, 6844.247132815486, 6874.209465911485, 6915.412189963909, 6993.650317484004, 7019.0, 6165.290991535851, 6503.674816259263, 6505.349465053457, 6517.283098859027, 6522.28254891971, 4300.849470268526, 4315.741055536678, 4428.446444194476, 4477.0, 4481.551844815493, 4358.49877264106, 4430.712003719748, 4462.576055274743, 4502.707324023928, 4507.954920450754], "value": 4014.839949745707, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.01998056752774, 283.4227230231757, 287.57295416306783, 294.0619424037321, 295.22797883534565, 4878.463369029409, 4881.4630390657, 4883.731394773286, 4902.534259245371, 4908.705477671342, 4570.954290457094, 4625.560571745687, 4694.178518759212, 4798.640101992347, 4851.151048566504, 3749.5125633667585, 3778.433235014756, 3788.5074940257728, 3788.7726736395903, 3800.947488356291, 3774.8867533974026, 3780.527434070741, 3783.2811765764554, 3783.9054023649355, 3786.242751449707, 3583.838727257267, 3674.210044840359, 3784.6026167252453, 3799.525059367579, 3804.4673745675627, 3772.962270377316, 3774.735768496206, 3775.8867233983024, 3794.924101517968, 3801.752886062411, 3331.716804071657, 3343.6656334366367, 3344.3645707315777, 3345.3142105868483, 3351.865925363007, 4419.160359531678, 4701.576858082789, 4742.786574604151, 4743.952560474386, 4745.715257084551, 4222.577742225783, 4223.472065991751, 4225.746455212697, 4227.682923780729, 4242.66058715302, 5065.696058236517, 5071.797128114871, 5073.492650734934, 5078.6698864574055, 5090.261912022736, 3528.306412921812, 3535.222251104753, 3540.451230059345, 3543.3976224041717, 3543.450765131409, 5012.874678133076, 5295.947040529622, 5307.548858347045, 5310.1769225769685, 5312.415634280264, 3577.982110089485, 3580.5524309461316, 3598.2983318253214, 3626.274745050948, 3626.292872889814, 3626.165981824195, 3638.2723455308515, 3642.0712718256673, 3658.762180458262, 3674.926501469956, 4132.173565286955, 4188.790560471964, 4218.2196293685765, 4261.190373828963, 4280.72175308604, 5024.874378140503, 5029.497050295015, 5032.144535428986, 5039.370078740158, 5059.2916991621205, 1177.252444697606, 1236.6599185224136, 1252.311228824143, 1272.2239433945285, 1275.4133098774482, 841.6212704282975, 843.7637461510786, 854.6495936665937, 856.8200677857595, 867.3408209760628, 4359.1717573661535, 4368.541303163122, 4373.1472362888935, 4383.7588932609015, 4387.780610969503, 5120.283160357553, 5124.820631277962, 5124.974375128175, 5159.406668233201, 5163.225516172604, 4339.7830108494445, 4354.129174165117, 4355.5426680198125, 4384.780760962003, 4386.276264416336, 2317.2121478697322, 2430.4358901359237, 2443.584590619599, 2448.4980578981267, 2462.5198086373343, 4281.272183728774, 4288.292431748727, 4313.1158112586845, 4330.458692663417, 4338.544452832407, 4603.872051347441, 4657.39186055803, 4669.486356500782, 4694.2958556216845, 4757.595604373667, 4107.383892416102, 4308.095299986975, 4312.870613881589, 4321.524632290446, 4333.0, 4546.386237857979, 4547.636189104797, 4573.679842410999, 4577.130345234395, 4596.471405788244, 4476.4180656514445, 4478.596926276651, 4501.842435514741, 4561.37020923756, 4588.472325682455, 4024.7987600620436, 4278.5079715831835, 4304.870853874263, 4310.331898555729, 4361.323994780814, 3293.193167673935, 3296.1924328539662, 3311.8344082795284, 3342.1310459280276, 3357.966420335765, 4662.2307319293295, 4689.99165179488, 4709.05818836241, 4735.550122738335, 4740.739259340769, 4858.198397264412, 4926.137925863031, 5076.390833100052, 5080.872978175576, 5146.176611742103, 5055.165897626997, 5062.2406639002975, 5104.566111880532, 5106.285120083117, 5163.586913047023, 4879.243717223836, 5000.424951130521, 5002.149634562061, 5024.899502009866, 5064.164412871983, 5120.974395128001, 5126.256692779451, 5140.43455219918, 5152.458991805806, 5152.458991805806, 4971.477994810492, 4977.0, 4982.252662100714, 5015.899682006412, 5031.974840125776], "value": 3677.195166268777, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.2678312807756, 623.6725718997526, 654.1561385812303, 687.2028447001478, 701.9085322323784, 12079.174420571828, 12131.0, 12275.631731048072, 12300.200486968351, 13451.05842591019, 12035.097367697414, 12141.15011949164, 12161.391930403466, 12165.756684866297, 12170.087243456732, 623.9313675495691, 750.4896670264218, 756.8448468064062, 769.1308821032226, 770.0105364606482, 771.194102163238, 777.7200207925142, 780.0366547314063, 780.0989856715503, 780.282140430805, 822.4160845799489, 825.63671984327, 826.1696994520498, 826.2027143806225, 828.8176601147737, 638.8722255548909, 793.4326956226325, 819.7212947597845, 819.8483280593109, 820.3847114664002, 597.7877853362037, 602.0337358539568, 602.4036204157896, 602.7528713227599, 602.9397060293979, 12564.874351256462, 12577.685557861036, 12607.11750177488, 12607.747845043048, 12613.243205407705, 11300.378479183642, 11795.292282462993, 11833.644990650295, 11843.111766617538, 12359.0, 11031.613893513688, 11042.558297668083, 11095.167862410271, 11128.332300062022, 11190.328580285128, 4067.28822456069, 4098.077932465201, 4115.609017143366, 4158.812853421603, 4176.895577610554, 56779.716101420054, 57058.0, 57290.427095728926, 57356.0, 57472.42527574754, 9248.953755231316, 9452.952735236417, 9678.903210967941, 9709.757256068655, 9770.435614363721, 17870.19584118718, 17893.821061789477, 17962.730559041625, 18016.189271482814, 18030.098495075195, 6478.967605162038, 6557.770478033246, 6595.406413422815, 6599.73601055962, 6773.762918297836, 3524.5241892344206, 3603.4414665726854, 3627.0, 3670.302642497917, 3763.2285381496727, 2587.7541633544784, 2671.6126161706443, 2673.6123262126885, 2675.411409489909, 2675.8662066896577, 478.19662966216396, 481.6989381636477, 498.56624736479495, 502.56779169913847, 521.4759167037104, 478.2157262090175, 486.28273296887517, 524.6615932723372, 592.2567178191342, 613.098744845077, 7677.117131529945, 7806.960965195138, 7852.803679908048, 7861.803454913558, 7964.2433968772875, 498.0984418203064, 575.9337676167295, 577.3735496985734, 593.7031484257872, 604.6795198544778, 3635.327464419091, 3689.7232707546505, 3729.8881033569037, 3867.7292589518465, 4014.4781178447197, 62664.68667656633, 85702.57148714217, 100438.0, 109296.4535177319, 109845.0, 90719.0, 90948.0, 91519.54240228889, 94648.52675736578, 97902.0, 82067.58966205131, 82644.58677706453, 83436.0, 83647.5817620908, 83731.0, 7201.279872012757, 7387.460927389591, 7400.777976660709, 7498.02525671681, 7611.2769286917655, 38406.61593384142, 45749.31376029429, 46633.53366466292, 46984.29523557218, 48591.27113093236, 64051.679741600994, 68407.97388039283, 70182.0, 70750.64624676843, 70949.0, 9829.803403932025, 9832.0, 9911.355761875455, 9996.800063998824, 10161.237907156845, 11070.944645276722, 11210.775784484427, 11225.775484490101, 11236.887631123584, 11253.606123785956, 9442.339036267671, 9679.516024198621, 9856.655017074369, 9874.50627468638, 10055.69832905014, 10580.788384232426, 10786.137109031415, 10822.51298691545, 10866.456677166268, 11003.559857605926, 9460.385074970105, 9671.081247281498, 9697.22422206236, 9882.110610044843, 10048.196144308584, 8746.169113934166, 8823.514736627012, 9096.1813436791, 9191.954040229755, 9194.26445884341, 7951.7893013911735, 8074.152214017444, 8223.465474744362, 8263.256306932404, 8386.161383861565], "value": 6302.963396589976, "unit": "score"}], "name": "dromaeo_css", "value": 6325.656311913877, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 112.0, 113.0, 113.0, 111.0, 112.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 126.0, 191.0, 122.0, 122.0, 151.0, 121.0, 168.0, 129.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 161.0, 161.0, 164.0, 162.0, 162.0, 162.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 103.0, 75.0, 77.0, 76.0, 76.0, 107.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 124.0, 86.0, 85.0, 86.0, 124.0, 85.0, 86.0, 126.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 147.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 64.0, 64.0, 67.0, 63.0, 63.0, 63.0, 73.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 63.0, 65.0, 63.0, 64.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 79.0, 79.0, 79.0, 83.0, 79.0, 79.0, 85.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 131.0, 125.0, 128.0, 130.0, 136.0, 130.0, 127.0, 177.0, 128.0], "value": 135.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 165.0, 164.0, 169.0, 171.0, 169.0, 168.0, 167.0, 169.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 71.0, 67.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1529.3000000000002, "alertThreshold": 2.0}]} 02:34:38 INFO - Return code: 0 02:34:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:34:38 INFO - # TBPL SUCCESS # 02:34:38 INFO - Running post-action listener: _resource_record_post_action 02:34:38 INFO - ##### 02:34:38 INFO - ##### Finished run-tests step (success) 02:34:38 INFO - ##### 02:34:38 INFO - Running post-run listener: _resource_record_post_run 02:34:38 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557068288; Read time: 16; Write time: 622104 02:34:38 INFO - TinderboxPrint: CPU usage
13.0% 02:34:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:34:38 INFO - TinderboxPrint: I/O write bytes / time
557,068,288 / 622,104 02:34:38 INFO - TinderboxPrint: CPU idle
8,335.4 (86.9%) 02:34:38 INFO - TinderboxPrint: CPU user
1,206.5 (12.6%) 02:34:38 INFO - TinderboxPrint: Swap in / out
0 / 0 02:34:38 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 261349376; Read time: 0; Write time: 317684 02:34:38 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 295718912; Read time: 0; Write time: 304420 02:34:38 INFO - Running post-run listener: _upload_blobber_files 02:34:38 INFO - Blob upload gear active. 02:34:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:34:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:34:39 INFO - (blobuploader) - INFO - Open directory for files ... 02:34:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:34:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:34:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:43 INFO - (blobuploader) - INFO - Done attempting. 02:34:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:34:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:34:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:43 INFO - (blobuploader) - INFO - Done attempting. 02:34:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:34:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:34:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:44 INFO - (blobuploader) - INFO - Done attempting. 02:34:44 INFO - (blobuploader) - INFO - Iteration through files over. 02:34:44 INFO - Return code: 0 02:34:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:34:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:34:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33aeb6f3d6f1f5344b8922ddcfcf67137dfd441024606e34d65d8b1c7cdeefbc5780210635148fe0c64dc3b4de3bd58f09f0b33f6d911bf75cae88256d12f484", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b29bbd9d1aca652a2779a418a6ae0f5e6d7be75af473a662bc2ed22a85019322d3b0db49c5f8ccca8a3acf4beee2bd4488db3ef69a69fe279251bf5b9422f38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d3fcdeea10d40a53042fdc5207527b3982504c54129f0af9e26f82f90661dd98d6244e9b551f49f463fa415db6b717452fe362f571efcdf30d03a6ccb3f897e"} 02:34:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:34:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:34:44 INFO - Contents: 02:34:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33aeb6f3d6f1f5344b8922ddcfcf67137dfd441024606e34d65d8b1c7cdeefbc5780210635148fe0c64dc3b4de3bd58f09f0b33f6d911bf75cae88256d12f484", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b29bbd9d1aca652a2779a418a6ae0f5e6d7be75af473a662bc2ed22a85019322d3b0db49c5f8ccca8a3acf4beee2bd4488db3ef69a69fe279251bf5b9422f38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d3fcdeea10d40a53042fdc5207527b3982504c54129f0af9e26f82f90661dd98d6244e9b551f49f463fa415db6b717452fe362f571efcdf30d03a6ccb3f897e"} 02:34:44 INFO - Running post-run listener: copy_logs_to_upload_dir 02:34:44 INFO - Copying logs to upload dir... 02:34:44 INFO - mkdir: /builds/slave/test/build/upload/logs 02:34:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.128713 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-09 02:34:44.283364) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 02:34:44.287033) ========= 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=fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33aeb6f3d6f1f5344b8922ddcfcf67137dfd441024606e34d65d8b1c7cdeefbc5780210635148fe0c64dc3b4de3bd58f09f0b33f6d911bf75cae88256d12f484", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b29bbd9d1aca652a2779a418a6ae0f5e6d7be75af473a662bc2ed22a85019322d3b0db49c5f8ccca8a3acf4beee2bd4488db3ef69a69fe279251bf5b9422f38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d3fcdeea10d40a53042fdc5207527b3982504c54129f0af9e26f82f90661dd98d6244e9b551f49f463fa415db6b717452fe362f571efcdf30d03a6ccb3f897e"} build_url:https://queue.taskcluster.net/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/affkO8DaSDOIRLlp6N9Iuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33aeb6f3d6f1f5344b8922ddcfcf67137dfd441024606e34d65d8b1c7cdeefbc5780210635148fe0c64dc3b4de3bd58f09f0b33f6d911bf75cae88256d12f484", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b29bbd9d1aca652a2779a418a6ae0f5e6d7be75af473a662bc2ed22a85019322d3b0db49c5f8ccca8a3acf4beee2bd4488db3ef69a69fe279251bf5b9422f38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d3fcdeea10d40a53042fdc5207527b3982504c54129f0af9e26f82f90661dd98d6244e9b551f49f463fa415db6b717452fe362f571efcdf30d03a6ccb3f897e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 02:34:44.312290) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:34:44.312621) ========= 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=fa44defc139c4ba8574fe040000001db-1468054967.55444-1642982504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004389 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:34:44.397225) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 02:34:44.397564) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 02:34:44.397862) ========= ========= Total master_lag: 0.19 =========