builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-062 starttime: 1468747317.79 results: success (0) buildid: 20160717010853 builduid: 9e863a19fac64e50a016e772a3f82a7f revision: 711963e8daa312ae06409f8ab5c06612cb0b8f7b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:57.787584) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:57.788007) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:57.788315) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:57.836600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:57.836904) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-17 02:21:58-- 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% 67.3M=0s 2016-07-17 02:21:59 (67.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173233 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.024705) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.025027) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022046 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.079311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.079698) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 711963e8daa312ae06409f8ab5c06612cb0b8f7b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 711963e8daa312ae06409f8ab5c06612cb0b8f7b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-17 02:21:59,276 truncating revision to first 12 chars 2016-07-17 02:21:59,276 Setting DEBUG logging. 2016-07-17 02:21:59,276 attempt 1/10 2016-07-17 02:21:59,276 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/711963e8daa3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-17 02:21:59,593 unpacking tar archive at: mozilla-central-711963e8daa3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655603 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.751371) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.751679) ========= script_repo_revision: 711963e8daa312ae06409f8ab5c06612cb0b8f7b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.752101) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.752533) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.763325) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-07-17 02:21:58.763643) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:22:00 INFO - MultiFileLogger online at 20160717 02:22:00 in /builds/slave/test 02:22:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:22:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:22:00 INFO - {'append_to_log': False, 02:22:00 INFO - 'base_work_dir': '/builds/slave/test', 02:22:00 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:22:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:22:00 INFO - 'branch': 'Firefox-Non-PGO', 02:22:00 INFO - 'buildbot_json_path': 'buildprops.json', 02:22:00 INFO - 'config_files': ('talos/linux_config.py',), 02:22:00 INFO - 'default_actions': ('clobber', 02:22:00 INFO - 'read-buildbot-config', 02:22:00 INFO - 'download-and-extract', 02:22:00 INFO - 'populate-webroot', 02:22:00 INFO - 'create-virtualenv', 02:22:00 INFO - 'install', 02:22:00 INFO - 'run-tests'), 02:22:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:22:00 INFO - 'download_minidump_stackwalk': True, 02:22:00 INFO - 'download_symbols': 'ondemand', 02:22:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:22:00 INFO - 'tooltool.py': '/tools/tooltool.py', 02:22:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:22:00 INFO - '/tools/misc-python/virtualenv.py')}, 02:22:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:22:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:22:00 INFO - 'installer_path': 'installer.exe', 02:22:00 INFO - 'log_level': 'info', 02:22:00 INFO - 'log_name': 'talos', 02:22:00 INFO - 'log_to_console': True, 02:22:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:22:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:22:00 INFO - 'opt_config_files': (), 02:22:00 INFO - 'pip_index': False, 02:22:00 INFO - 'sps_profile': False, 02:22:00 INFO - 'sps_profile_interval': 0, 02:22:00 INFO - 'suite': 'dromaeojs', 02:22:00 INFO - 'system_bits': '32', 02:22:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:22:00 INFO - 'title': 'talos-linux64-ix-062', 02:22:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:22:00 INFO - 'use_talos_json': True, 02:22:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:22:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:22:00 INFO - 'work_dir': 'build'} 02:22:00 INFO - ##### 02:22:00 INFO - ##### Running clobber step. 02:22:00 INFO - ##### 02:22:00 INFO - Running pre-action listener: _resource_record_pre_action 02:22:00 INFO - Running main action method: clobber 02:22:00 INFO - rmtree: /builds/slave/test/build 02:22:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:22:01 INFO - Running post-action listener: _resource_record_post_action 02:22:01 INFO - ##### 02:22:01 INFO - ##### Finished clobber step (success) 02:22:01 INFO - ##### 02:22:01 INFO - ##### 02:22:01 INFO - ##### Running read-buildbot-config step. 02:22:01 INFO - ##### 02:22:01 INFO - Running pre-action listener: _resource_record_pre_action 02:22:01 INFO - Running main action method: read_buildbot_config 02:22:01 INFO - Using buildbot properties: 02:22:01 INFO - { 02:22:01 INFO - "project": "", 02:22:01 INFO - "product": "firefox", 02:22:01 INFO - "script_repo_revision": "production", 02:22:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 02:22:01 INFO - "repository": "", 02:22:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 02:22:01 INFO - "buildid": "20160717010853", 02:22:01 INFO - "pgo_build": "False", 02:22:01 INFO - "basedir": "/builds/slave/test", 02:22:01 INFO - "buildnumber": 652, 02:22:01 INFO - "slavename": "talos-linux64-ix-062", 02:22:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:22:01 INFO - "platform": "ubuntu64_hw", 02:22:01 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 02:22:01 INFO - "branch": "mozilla-central", 02:22:01 INFO - "repo_path": "mozilla-central", 02:22:01 INFO - "revision": "711963e8daa312ae06409f8ab5c06612cb0b8f7b", 02:22:01 INFO - "stage_platform": "linux64", 02:22:01 INFO - "builduid": "9e863a19fac64e50a016e772a3f82a7f", 02:22:01 INFO - "slavebuilddir": "test" 02:22:01 INFO - } 02:22:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:22:01 INFO - Running post-action listener: _resource_record_post_action 02:22:01 INFO - ##### 02:22:01 INFO - ##### Finished read-buildbot-config step (success) 02:22:01 INFO - ##### 02:22:01 INFO - ##### 02:22:01 INFO - ##### Running download-and-extract step. 02:22:01 INFO - ##### 02:22:01 INFO - Running pre-action listener: _resource_record_pre_action 02:22:01 INFO - Running main action method: download_and_extract 02:22:01 INFO - mkdir: /builds/slave/test/build/tests 02:22:01 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:22:01 INFO - https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:22:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:22:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:22:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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:22:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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:22:09 INFO - Downloaded 1361 bytes. 02:22:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:22:09 INFO - Using the following test package requirements: 02:22:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:22:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:22:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:22:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:09 INFO - u'jsshell-linux-x86_64.zip'], 02:22:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:22:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:22:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:22:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:22:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:22:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:22:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:22: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:22:09 INFO - https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:22:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:22:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:22:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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:22:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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:22:12 INFO - Downloaded 22763773 bytes. 02:22:12 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:22:12 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:22:13 INFO - Return code: 0 02:22:13 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:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:13 INFO - https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:22:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:22:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:22:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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:22:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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:22:15 INFO - Downloaded 22763773 bytes. 02:22:15 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:22:15 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:22:16 INFO - Return code: 0 02:22:16 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:22:16 INFO - https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:22:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:22:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:22:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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:22:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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:22:17 INFO - Downloaded 14403317 bytes. 02:22:17 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:22:17 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:22:18 INFO - Return code: 0 02:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:18 INFO - https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:22:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:22:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:22:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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:22:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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:22:19 INFO - Downloaded 57075538 bytes. 02:22:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:22:19 INFO - mkdir: /builds/slave/test/properties 02:22:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:22:19 INFO - Writing to file /builds/slave/test/properties/build_url 02:22:19 INFO - Contents: 02:22:19 INFO - build_url:https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:22:20 INFO - Running post-action listener: _resource_record_post_action 02:22:20 INFO - Running post-action listener: set_extra_try_arguments 02:22:20 INFO - ##### 02:22:20 INFO - ##### Finished download-and-extract step (success) 02:22:20 INFO - ##### 02:22:20 INFO - ##### 02:22:20 INFO - ##### Running populate-webroot step. 02:22:20 INFO - ##### 02:22:20 INFO - Running pre-action listener: _resource_record_pre_action 02:22:20 INFO - Running main action method: populate_webroot 02:22:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:22:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:22:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:22:20 INFO - '--tppagecycles', 02:22:20 INFO - '7'], 02:22:20 INFO - 'tests': ['tsvgm']}}, 02:22:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:22:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:22:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:22:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:22:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:22:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:22:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:20 INFO - 'talos_options': ['--disable-e10s'], 02:22:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:20 INFO - 'talos_options': ['--disable-e10s'], 02:22:20 INFO - 'tests': ['damp', 'tps']}, 02:22:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:20 INFO - 'tests': ['damp', 'tps']}, 02:22:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:22:20 INFO - 'tests': ['dromaeo_dom']}, 02:22:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:22:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:22:20 INFO - 'tests': ['basic_compositor_video']}, 02:22:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:22:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:22:20 INFO - 'tests': ['a11yr', 02:22:20 INFO - 'ts_paint', 02:22:20 INFO - 'tpaint', 02:22:20 INFO - 'sessionrestore', 02:22:20 INFO - 'sessionrestore_no_auto_restore', 02:22:20 INFO - 'tabpaint']}, 02:22:20 INFO - 'other-e10s': {'tests': ['a11yr', 02:22:20 INFO - 'ts_paint', 02:22:20 INFO - 'tpaint', 02:22:20 INFO - 'sessionrestore', 02:22:20 INFO - 'sessionrestore_no_auto_restore', 02:22:20 INFO - 'tabpaint']}, 02:22:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:22:20 INFO - 'ts_paint', 02:22:20 INFO - 'tpaint', 02:22:20 INFO - 'sessionrestore', 02:22:20 INFO - 'sessionrestore_no_auto_restore', 02:22:20 INFO - 'tabpaint']}, 02:22:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:22:20 INFO - 'ts_paint', 02:22:20 INFO - 'tpaint', 02:22:20 INFO - 'sessionrestore', 02:22:20 INFO - 'sessionrestore_no_auto_restore', 02:22:20 INFO - 'tabpaint']}, 02:22:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:22:20 INFO - 'tests': ['a11yr', 02:22:20 INFO - 'ts_paint', 02:22:20 INFO - 'tpaint', 02:22:20 INFO - 'sessionrestore', 02:22:20 INFO - 'sessionrestore_no_auto_restore', 02:22:20 INFO - 'tabpaint']}, 02:22:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:22:20 INFO - 'tests': ['a11yr', 02:22:20 INFO - 'ts_paint', 02:22:20 INFO - 'tpaint', 02:22:20 INFO - 'sessionrestore', 02:22:20 INFO - 'sessionrestore_no_auto_restore', 02:22:20 INFO - 'tabpaint']}, 02:22:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:22:20 INFO - 'tests': ['tsvgx', 02:22:20 INFO - 'tsvgr_opacity', 02:22:20 INFO - 'tart', 02:22:20 INFO - 'tscrollx', 02:22:20 INFO - 'cart']}, 02:22:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:22:20 INFO - 'tsvgr_opacity', 02:22:20 INFO - 'tart', 02:22:20 INFO - 'tscrollx', 02:22:20 INFO - 'cart']}, 02:22:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:20 INFO - 'talos_options': ['--disable-e10s'], 02:22:20 INFO - 'tests': ['tp5o']}, 02:22:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:20 INFO - 'tests': ['tp5o']}, 02:22:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:20 INFO - 'talos_options': ['--disable-e10s', 02:22:20 INFO - '--xperf_path', 02:22:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:20 INFO - 'tests': ['tp5n']}, 02:22:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:20 INFO - 'talos_options': ['--xperf_path', 02:22:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:20 INFO - 'tests': ['tp5n']}}, 02:22:20 INFO - 'talos.zip': {'path': '', 02:22:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:22:20 INFO - Running post-action listener: _resource_record_post_action 02:22:20 INFO - ##### 02:22:20 INFO - ##### Finished populate-webroot step (success) 02:22:20 INFO - ##### 02:22:20 INFO - ##### 02:22:20 INFO - ##### Running create-virtualenv step. 02:22:20 INFO - ##### 02:22:20 INFO - Running pre-action listener: _resource_record_pre_action 02:22:20 INFO - Running main action method: create_virtualenv 02:22:20 INFO - Creating virtualenv /builds/slave/test/build/venv 02:22:20 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:22:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:22:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:22:20 INFO - Using real prefix '/usr' 02:22:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:22:20 INFO - Installing distribute.............................................................................................................................................................................................done. 02:22:22 INFO - Installing pip.................done. 02:22:22 INFO - Return code: 0 02:22:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:22: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:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5f3b0>, '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 0x2a602b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a60740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', '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:22: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', 'pip>=1.5'] in /builds/slave/test/build 02:22: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 pip>=1.5 02:22:22 INFO - Using env: {'DISPLAY': ':0', 02:22:22 INFO - 'HOME': '/home/cltbld', 02:22:22 INFO - 'LANG': 'en_US.UTF-8', 02:22:22 INFO - 'LANGUAGE': 'en_US:en', 02:22:22 INFO - 'LOGNAME': 'cltbld', 02:22:22 INFO - 'MAIL': '/var/mail/cltbld', 02:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:22 INFO - 'MOZ_NO_REMOTE': '1', 02:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:22 INFO - 'NO_EM_RESTART': '1', 02:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:22 INFO - 'PWD': '/builds/slave/test', 02:22:22 INFO - 'SHELL': '/bin/bash', 02:22:22 INFO - 'SHLVL': '1', 02:22:22 INFO - 'TERM': 'linux', 02:22:22 INFO - 'TMOUT': '86400', 02:22:22 INFO - 'USER': 'cltbld', 02:22:22 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', 02:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:22 INFO - '_': '/tools/buildbot/bin/python'} 02:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:22 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:22:22 INFO - Cleaning up... 02:22:22 INFO - Return code: 0 02:22:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:22: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:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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', '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 0x27a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5f3b0>, '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 0x2a602b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a60740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', '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:22: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:22: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 psutil>=3.1.1 02:22:22 INFO - Using env: {'DISPLAY': ':0', 02:22:22 INFO - 'HOME': '/home/cltbld', 02:22:22 INFO - 'LANG': 'en_US.UTF-8', 02:22:22 INFO - 'LANGUAGE': 'en_US:en', 02:22:22 INFO - 'LOGNAME': 'cltbld', 02:22:22 INFO - 'MAIL': '/var/mail/cltbld', 02:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:22 INFO - 'MOZ_NO_REMOTE': '1', 02:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:22 INFO - 'NO_EM_RESTART': '1', 02:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:22 INFO - 'PWD': '/builds/slave/test', 02:22:22 INFO - 'SHELL': '/bin/bash', 02:22:22 INFO - 'SHLVL': '1', 02:22:22 INFO - 'TERM': 'linux', 02:22:22 INFO - 'TMOUT': '86400', 02:22:22 INFO - 'USER': 'cltbld', 02:22:22 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', 02:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:22 INFO - '_': '/tools/buildbot/bin/python'} 02:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:23 INFO - Downloading/unpacking psutil>=3.1.1 02:22: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:22: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:22: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:22: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:22: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:22: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:22:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:22:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:25 INFO - Installing collected packages: psutil 02:22:25 INFO - Running setup.py install for psutil 02:22:25 INFO - building 'psutil._psutil_linux' extension 02:22:25 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:22:25 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:22:25 INFO - building 'psutil._psutil_posix' extension 02:22:25 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:22:25 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:22:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:25 INFO - Successfully installed psutil 02:22:25 INFO - Cleaning up... 02:22:25 INFO - Return code: 0 02:22:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:22: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:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5f3b0>, '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 0x2a602b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a60740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', '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:22: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:22: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 mozsystemmonitor==0.3 02:22:25 INFO - Using env: {'DISPLAY': ':0', 02:22:25 INFO - 'HOME': '/home/cltbld', 02:22:25 INFO - 'LANG': 'en_US.UTF-8', 02:22:25 INFO - 'LANGUAGE': 'en_US:en', 02:22:25 INFO - 'LOGNAME': 'cltbld', 02:22:25 INFO - 'MAIL': '/var/mail/cltbld', 02:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:25 INFO - 'MOZ_NO_REMOTE': '1', 02:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:25 INFO - 'NO_EM_RESTART': '1', 02:22:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:25 INFO - 'PWD': '/builds/slave/test', 02:22:25 INFO - 'SHELL': '/bin/bash', 02:22:25 INFO - 'SHLVL': '1', 02:22:25 INFO - 'TERM': 'linux', 02:22:25 INFO - 'TMOUT': '86400', 02:22:25 INFO - 'USER': 'cltbld', 02:22:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', 02:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:25 INFO - '_': '/tools/buildbot/bin/python'} 02:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:22: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:22: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:22: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:22: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:22: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:22: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:22:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:22:27 INFO - Installing collected packages: mozsystemmonitor 02:22:27 INFO - Running setup.py install for mozsystemmonitor 02:22:28 INFO - Successfully installed mozsystemmonitor 02:22:28 INFO - Cleaning up... 02:22:28 INFO - Return code: 0 02:22:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:28 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 0x27a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5f3b0>, '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 0x2a602b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a60740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', '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:22:28 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:22:28 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:22:28 INFO - Using env: {'DISPLAY': ':0', 02:22:28 INFO - 'HOME': '/home/cltbld', 02:22:28 INFO - 'LANG': 'en_US.UTF-8', 02:22:28 INFO - 'LANGUAGE': 'en_US:en', 02:22:28 INFO - 'LOGNAME': 'cltbld', 02:22:28 INFO - 'MAIL': '/var/mail/cltbld', 02:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:28 INFO - 'MOZ_NO_REMOTE': '1', 02:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:28 INFO - 'NO_EM_RESTART': '1', 02:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:28 INFO - 'PWD': '/builds/slave/test', 02:22:28 INFO - 'SHELL': '/bin/bash', 02:22:28 INFO - 'SHLVL': '1', 02:22:28 INFO - 'TERM': 'linux', 02:22:28 INFO - 'TMOUT': '86400', 02:22:28 INFO - 'USER': 'cltbld', 02:22:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', 02:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:28 INFO - '_': '/tools/buildbot/bin/python'} 02:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:28 INFO - Downloading/unpacking jsonschema==2.5.1 02:22: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:22: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:22: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:22: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:22: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:22: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:22:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:22:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:30 INFO - Downloading functools32-3.2.3-2.tar.gz 02:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:22:30 INFO - warning: no files found matching '*.txt' 02:22:30 INFO - no previously-included directories found matching 'build' 02:22:30 INFO - no previously-included directories found matching 'dist' 02:22:30 INFO - no previously-included directories found matching '.git*' 02:22:30 INFO - Installing collected packages: jsonschema, functools32 02:22:30 INFO - Running setup.py install for functools32 02:22:30 INFO - warning: no files found matching '*.txt' 02:22:30 INFO - no previously-included directories found matching 'build' 02:22:30 INFO - no previously-included directories found matching 'dist' 02:22:30 INFO - no previously-included directories found matching '.git*' 02:22:30 INFO - Successfully installed jsonschema functools32 02:22:30 INFO - Cleaning up... 02:22:30 INFO - Return code: 0 02:22:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:30 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 0x27a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5f3b0>, '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 0x2a602b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a60740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', '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:22:30 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:22:30 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:22:30 INFO - Using env: {'DISPLAY': ':0', 02:22:30 INFO - 'HOME': '/home/cltbld', 02:22:30 INFO - 'LANG': 'en_US.UTF-8', 02:22:30 INFO - 'LANGUAGE': 'en_US:en', 02:22:30 INFO - 'LOGNAME': 'cltbld', 02:22:30 INFO - 'MAIL': '/var/mail/cltbld', 02:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:30 INFO - 'MOZ_NO_REMOTE': '1', 02:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:30 INFO - 'NO_EM_RESTART': '1', 02:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:30 INFO - 'PWD': '/builds/slave/test', 02:22:30 INFO - 'SHELL': '/bin/bash', 02:22:30 INFO - 'SHLVL': '1', 02:22:30 INFO - 'TERM': 'linux', 02:22:30 INFO - 'TMOUT': '86400', 02:22:30 INFO - 'USER': 'cltbld', 02:22:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', 02:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:30 INFO - '_': '/tools/buildbot/bin/python'} 02:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:30 INFO - Downloading/unpacking blobuploader==1.2.4 02:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:32 INFO - Downloading blobuploader-1.2.4.tar.gz 02:22:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:22:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:22:32 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:22:32 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:22:32 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:22:32 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:22:32 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:22:32 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:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:22:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:22:33 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:22:33 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:22:33 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:22:33 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:22:33 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:22:33 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:22:33 INFO - Downloading docopt-0.6.1.tar.gz 02:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:22:33 INFO - Installing collected packages: blobuploader, requests, docopt 02:22:33 INFO - Running setup.py install for blobuploader 02:22:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:22:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:22:33 INFO - Running setup.py install for requests 02:22:34 INFO - Running setup.py install for docopt 02:22:34 INFO - Successfully installed blobuploader requests docopt 02:22:34 INFO - Cleaning up... 02:22:34 INFO - Return code: 0 02:22:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:34 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:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:34 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:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:34 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 0x27a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5f3b0>, '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 0x2a602b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a60740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', '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:22:34 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:22:34 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:22:34 INFO - Using env: {'DISPLAY': ':0', 02:22:34 INFO - 'HOME': '/home/cltbld', 02:22:34 INFO - 'LANG': 'en_US.UTF-8', 02:22:34 INFO - 'LANGUAGE': 'en_US:en', 02:22:34 INFO - 'LOGNAME': 'cltbld', 02:22:34 INFO - 'MAIL': '/var/mail/cltbld', 02:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:34 INFO - 'MOZ_NO_REMOTE': '1', 02:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:34 INFO - 'NO_EM_RESTART': '1', 02:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:34 INFO - 'PWD': '/builds/slave/test', 02:22:34 INFO - 'SHELL': '/bin/bash', 02:22:34 INFO - 'SHLVL': '1', 02:22:34 INFO - 'TERM': 'linux', 02:22:34 INFO - 'TMOUT': '86400', 02:22:34 INFO - 'USER': 'cltbld', 02:22:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', 02:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:34 INFO - '_': '/tools/buildbot/bin/python'} 02:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:34 INFO - Running setup.py (path:/tmp/pip-HkLjx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:34 INFO - Running setup.py (path:/tmp/pip-IS5Kml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:34 INFO - Running setup.py (path:/tmp/pip-3451s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:34 INFO - Running setup.py (path:/tmp/pip-mvgpFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:34 INFO - Running setup.py (path:/tmp/pip-PW_yi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:34 INFO - Running setup.py (path:/tmp/pip-zeehNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:34 INFO - Running setup.py (path:/tmp/pip-rWyUtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:34 INFO - Running setup.py (path:/tmp/pip-Dq44Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:34 INFO - Running setup.py (path:/tmp/pip-j7FVbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:35 INFO - Running setup.py (path:/tmp/pip-IRTweT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:35 INFO - Running setup.py (path:/tmp/pip-nYXGoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:35 INFO - Running setup.py (path:/tmp/pip-JGn9p_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:35 INFO - Running setup.py (path:/tmp/pip-Pf3Rl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:35 INFO - Running setup.py (path:/tmp/pip-BfuxGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:35 INFO - Running setup.py (path:/tmp/pip-nPT3Vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:35 INFO - Running setup.py (path:/tmp/pip-AEw2Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:35 INFO - Running setup.py (path:/tmp/pip-RdjJe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:22:35 INFO - Running setup.py install for manifestparser 02:22:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:22:35 INFO - Running setup.py install for mozcrash 02:22:35 INFO - Running setup.py install for mozdebug 02:22:35 INFO - Running setup.py install for mozdevice 02:22:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:22:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:22:36 INFO - Running setup.py install for mozfile 02:22:36 INFO - Running setup.py install for mozhttpd 02:22:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:22:36 INFO - Running setup.py install for mozinfo 02:22:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:22:36 INFO - Running setup.py install for mozInstall 02:22:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:22:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:22:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:22:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:22:36 INFO - Running setup.py install for mozleak 02:22:36 INFO - Running setup.py install for mozlog 02:22:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:22:36 INFO - Running setup.py install for moznetwork 02:22:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:22:36 INFO - Running setup.py install for mozprocess 02:22:36 INFO - Running setup.py install for mozprofile 02:22:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:22:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:22:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:22:36 INFO - Running setup.py install for mozrunner 02:22:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:22:37 INFO - Running setup.py install for mozscreenshot 02:22:37 INFO - Running setup.py install for moztest 02:22:37 INFO - Running setup.py install for mozversion 02:22:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:22:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:22:37 INFO - Cleaning up... 02:22:37 INFO - Return code: 0 02:22:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:37 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 0x27a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5f3b0>, '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 0x2a602b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a60740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', '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:22:37 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:22:37 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:22:37 INFO - Using env: {'DISPLAY': ':0', 02:22:37 INFO - 'HOME': '/home/cltbld', 02:22:37 INFO - 'LANG': 'en_US.UTF-8', 02:22:37 INFO - 'LANGUAGE': 'en_US:en', 02:22:37 INFO - 'LOGNAME': 'cltbld', 02:22:37 INFO - 'MAIL': '/var/mail/cltbld', 02:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:37 INFO - 'MOZ_NO_REMOTE': '1', 02:22:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:37 INFO - 'NO_EM_RESTART': '1', 02:22:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:37 INFO - 'PWD': '/builds/slave/test', 02:22:37 INFO - 'SHELL': '/bin/bash', 02:22:37 INFO - 'SHLVL': '1', 02:22:37 INFO - 'TERM': 'linux', 02:22:37 INFO - 'TMOUT': '86400', 02:22:37 INFO - 'USER': 'cltbld', 02:22:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', 02:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:37 INFO - '_': '/tools/buildbot/bin/python'} 02:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:37 INFO - Running setup.py (path:/tmp/pip-MReJ0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:37 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:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:37 INFO - Running setup.py (path:/tmp/pip-8NCmJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:37 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:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:37 INFO - Running setup.py (path:/tmp/pip-ujOOQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:37 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:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:37 INFO - Running setup.py (path:/tmp/pip-vYk34l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:37 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:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:37 INFO - Running setup.py (path:/tmp/pip-fs6dg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:38 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:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:38 INFO - Running setup.py (path:/tmp/pip-7dr6UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:38 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:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:38 INFO - Running setup.py (path:/tmp/pip-BfF3fS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:38 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:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:38 INFO - Running setup.py (path:/tmp/pip-v3OXTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:38 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:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:38 INFO - Running setup.py (path:/tmp/pip-tKWTGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:38 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:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:38 INFO - Running setup.py (path:/tmp/pip-U59Uhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:38 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:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:38 INFO - Running setup.py (path:/tmp/pip-okzUex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:38 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:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:38 INFO - Running setup.py (path:/tmp/pip-MHH6Vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:38 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:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:38 INFO - Running setup.py (path:/tmp/pip-AdK8ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:38 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:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:38 INFO - Running setup.py (path:/tmp/pip-HRLdZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:38 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:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:38 INFO - Running setup.py (path:/tmp/pip-EPPQ_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:38 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:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:38 INFO - Running setup.py (path:/tmp/pip-3f_hCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:38 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:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:38 INFO - Running setup.py (path:/tmp/pip-LB7gOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:38 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:22:38 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:22:38 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:22:38 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:22:38 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:22:38 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:22:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:22:38 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:22:38 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:22:38 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:22:38 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:22:38 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:22:38 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:22:40 INFO - Downloading blessings-1.6.tar.gz 02:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:22:40 INFO - Installing collected packages: blessings 02:22:40 INFO - Running setup.py install for blessings 02:22:40 INFO - Successfully installed blessings 02:22:41 INFO - Cleaning up... 02:22:41 INFO - Return code: 0 02:22:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:22:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:22:41 INFO - Reading from file tmpfile_stdout 02:22:41 INFO - Current package versions: 02:22:41 INFO - argparse == 1.2.1 02:22:41 INFO - blessings == 1.6 02:22:41 INFO - blobuploader == 1.2.4 02:22:41 INFO - docopt == 0.6.1 02:22:41 INFO - functools32 == 3.2.3-2 02:22:41 INFO - jsonschema == 2.5.1 02:22:41 INFO - manifestparser == 1.1 02:22:41 INFO - mozInstall == 1.12 02:22:41 INFO - mozcrash == 0.17 02:22:41 INFO - mozdebug == 0.1 02:22:41 INFO - mozdevice == 0.48 02:22:41 INFO - mozfile == 1.2 02:22:41 INFO - mozhttpd == 0.7 02:22:41 INFO - mozinfo == 0.9 02:22:41 INFO - mozleak == 0.1 02:22:41 INFO - mozlog == 3.2 02:22:41 INFO - moznetwork == 0.27 02:22:41 INFO - mozprocess == 0.23 02:22:41 INFO - mozprofile == 0.28 02:22:41 INFO - mozrunner == 6.12 02:22:41 INFO - mozscreenshot == 0.1 02:22:41 INFO - mozsystemmonitor == 0.3 02:22:41 INFO - moztest == 0.7 02:22:41 INFO - mozversion == 1.4 02:22:41 INFO - psutil == 3.1.1 02:22:41 INFO - requests == 1.2.3 02:22:41 INFO - wsgiref == 0.1.2 02:22:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:41 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 0x27a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5f3b0>, '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 0x2a602b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a60740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', '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:22:41 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:22:41 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:22:41 INFO - Using env: {'DISPLAY': ':0', 02:22:41 INFO - 'HOME': '/home/cltbld', 02:22:41 INFO - 'LANG': 'en_US.UTF-8', 02:22:41 INFO - 'LANGUAGE': 'en_US:en', 02:22:41 INFO - 'LOGNAME': 'cltbld', 02:22:41 INFO - 'MAIL': '/var/mail/cltbld', 02:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:41 INFO - 'MOZ_NO_REMOTE': '1', 02:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:41 INFO - 'NO_EM_RESTART': '1', 02:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:41 INFO - 'PWD': '/builds/slave/test', 02:22:41 INFO - 'SHELL': '/bin/bash', 02:22:41 INFO - 'SHLVL': '1', 02:22:41 INFO - 'TERM': 'linux', 02:22:41 INFO - 'TMOUT': '86400', 02:22:41 INFO - 'USER': 'cltbld', 02:22:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', 02:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:41 INFO - '_': '/tools/buildbot/bin/python'} 02:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:41 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:22:41 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:22:41 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:22:41 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:22:41 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:22:41 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:22:41 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:22:41 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:22:41 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:22:41 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:22:41 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:22:41 INFO - Cleaning up... 02:22:41 INFO - Return code: 0 02:22:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5f3b0>, '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 0x2a602b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a60740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', '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:22:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:22:41 INFO - Using env: {'DISPLAY': ':0', 02:22:41 INFO - 'HOME': '/home/cltbld', 02:22:41 INFO - 'LANG': 'en_US.UTF-8', 02:22:41 INFO - 'LANGUAGE': 'en_US:en', 02:22:41 INFO - 'LOGNAME': 'cltbld', 02:22:41 INFO - 'MAIL': '/var/mail/cltbld', 02:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:41 INFO - 'MOZ_NO_REMOTE': '1', 02:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:41 INFO - 'NO_EM_RESTART': '1', 02:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:41 INFO - 'PWD': '/builds/slave/test', 02:22:41 INFO - 'SHELL': '/bin/bash', 02:22:41 INFO - 'SHLVL': '1', 02:22:41 INFO - 'TERM': 'linux', 02:22:41 INFO - 'TMOUT': '86400', 02:22:41 INFO - 'USER': 'cltbld', 02:22:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', 02:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:41 INFO - '_': '/tools/buildbot/bin/python'} 02:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:22:41 INFO - Cleaning up... 02:22:41 INFO - Return code: 0 02:22:41 INFO - Running post-action listener: _resource_record_post_action 02:22:41 INFO - Running post-action listener: _start_resource_monitoring 02:22:41 INFO - Starting resource monitoring. 02:22:41 INFO - ##### 02:22:41 INFO - ##### Finished create-virtualenv step (success) 02:22:41 INFO - ##### 02:22:41 INFO - ##### 02:22:41 INFO - ##### Running install step. 02:22:41 INFO - ##### 02:22:41 INFO - Running pre-action listener: _resource_record_pre_action 02:22:41 INFO - Running main action method: install 02:22:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:22:41 INFO - Reading from file tmpfile_stdout 02:22:41 INFO - Detecting whether we're running mozinstall >=1.0... 02:22:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:22:42 INFO - Reading from file tmpfile_stdout 02:22:42 INFO - Output received: 02:22:42 INFO - Usage: mozinstall [options] installer 02:22:42 INFO - Options: 02:22:42 INFO - -h, --help show this help message and exit 02:22:42 INFO - -d DEST, --destination=DEST 02:22:42 INFO - Directory to install application into. [default: 02:22:42 INFO - "/builds/slave/test"] 02:22:42 INFO - --app=APP Application being installed. [default: firefox] 02:22:42 INFO - mkdir: /builds/slave/test/build/application 02:22:42 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:22:42 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:22:58 INFO - Reading from file tmpfile_stdout 02:22:58 INFO - Output received: 02:22:58 INFO - /builds/slave/test/build/application/firefox/firefox 02:22:58 INFO - Running post-action listener: _resource_record_post_action 02:22:58 INFO - ##### 02:22:58 INFO - ##### Finished install step (success) 02:22:58 INFO - ##### 02:22:58 INFO - ##### 02:22:58 INFO - ##### Running run-tests step. 02:22:58 INFO - ##### 02:22:58 INFO - Running pre-action listener: _resource_record_pre_action 02:22:58 INFO - Running main action method: run_tests 02:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:22:58 INFO - Python 2.7.3 02:22:58 INFO - Return code: 0 02:22:58 INFO - grabbing minidump binary from tooltool 02:22:58 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:22:58 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 0x2a5f3b0>, '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 0x2a602b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a60740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:22:58 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:22:58 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:22:58 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:22:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:22:58 INFO - Return code: 0 02:22:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:22:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:22:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:22:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:22:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:22:58 INFO - Using env: {'DISPLAY': ':0', 02:22:58 INFO - 'HOME': '/home/cltbld', 02:22:58 INFO - 'LANG': 'en_US.UTF-8', 02:22:58 INFO - 'LANGUAGE': 'en_US:en', 02:22:58 INFO - 'LOGNAME': 'cltbld', 02:22:58 INFO - 'MAIL': '/var/mail/cltbld', 02:22:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:22:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:58 INFO - 'MOZ_NO_REMOTE': '1', 02:22:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:58 INFO - 'NO_EM_RESTART': '1', 02:22:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:58 INFO - 'PWD': '/builds/slave/test', 02:22:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:22:58 INFO - 'SHELL': '/bin/bash', 02:22:58 INFO - 'SHLVL': '1', 02:22:58 INFO - 'TERM': 'linux', 02:22:58 INFO - 'TMOUT': '86400', 02:22:58 INFO - 'USER': 'cltbld', 02:22:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588', 02:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:58 INFO - '_': '/tools/buildbot/bin/python'} 02:22:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:22:58 INFO - mozversion application_buildid: 20160717010853 02:22:58 INFO - mozversion application_changeset: 711963e8daa312ae06409f8ab5c06612cb0b8f7b 02:22:58 INFO - mozversion application_display_name: Nightly 02:22:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:22:58 INFO - mozversion application_name: Firefox 02:22:58 INFO - mozversion application_remotingname: firefox 02:22:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:22:58 INFO - mozversion application_vendor: Mozilla 02:22:58 INFO - mozversion application_version: 50.0a1 02:22:58 INFO - mozversion platform_buildid: 20160717010853 02:22:58 INFO - mozversion platform_changeset: 711963e8daa312ae06409f8ab5c06612cb0b8f7b 02:22:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:22:58 INFO - mozversion platform_version: 50.0a1 02:22:58 INFO - using testdate: 1468747378 02:22:58 INFO - actual date: 1468747378 02:22:58 INFO - starting webserver on 'localhost:53457' 02:22:58 INFO - SUITE-START | Running 2 tests 02:22:58 INFO - TEST-START | dromaeo_css 02:22:58 INFO - operating with platform_type : linux_ 02:22:58 INFO - Initialising browser for dromaeo_css test... 02:22:58 INFO - TEST-INFO | started process 7933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX8Vup3/profile http://localhost:53457/getInfo.html) 02:23:01 INFO - PROCESS | 7933 | JavaScript error: , line 0: uncaught exception: undefined 02:23:02 INFO - PROCESS | 7933 | __metrics Screen width/height:1600/1200 02:23:02 INFO - PROCESS | 7933 | colorDepth:24 02:23:02 INFO - PROCESS | 7933 | Browser inner width/height: 1024/697 02:23:02 INFO - PROCESS | 7933 | __metrics 02:23:03 INFO - PROCESS | 7933 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:23:03 INFO - PROCESS | 7933 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:23:04 INFO - TEST-INFO | 7933: exit 0 02:23:04 INFO - Browser initialized. 02:23:04 INFO - Running cycle 1/1 for dromaeo_css test... 02:23:04 INFO - TEST-INFO | started process 8017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX8Vup3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:23:16 INFO - PROCESS | 8017 | RSS: Main: 160059392 02:23:16 INFO - PROCESS | 8017 | 02:24:06 INFO - PROCESS | 8017 | 1468747446914 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:26:21 INFO - PROCESS | 8017 | Cycle 1(1): loaded http://localhost:53457/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53457/tests/dromaeo/cssquery-ext.html) 02:26:22 INFO - PROCESS | 8017 | RSS: Main: 241147904 02:26:22 INFO - PROCESS | 8017 | 02:29:24 INFO - PROCESS | 8017 | Cycle 1(1): loaded http://localhost:53457/tests/dromaeo/cssquery-ext.html (next: http://localhost:53457/tests/dromaeo/cssquery-jquery.html) 02:29:25 INFO - PROCESS | 8017 | RSS: Main: 246730752 02:29:25 INFO - PROCESS | 8017 | 02:32:27 INFO - PROCESS | 8017 | Cycle 1(1): loaded http://localhost:53457/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53457/tests/dromaeo/cssquery-mootools.html) 02:32:28 INFO - PROCESS | 8017 | RSS: Main: 244154368 02:32:28 INFO - PROCESS | 8017 | 02:35:30 INFO - PROCESS | 8017 | Cycle 1(1): loaded http://localhost:53457/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53457/tests/dromaeo/cssquery-prototype.html) 02:35:31 INFO - PROCESS | 8017 | RSS: Main: 238055424 02:35:31 INFO - PROCESS | 8017 | 02:38:34 INFO - PROCESS | 8017 | Cycle 1(1): loaded http://localhost:53457/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53457/tests/dromaeo/cssquery-yui.html) 02:38:34 INFO - PROCESS | 8017 | RSS: Main: 230289408 02:38:34 INFO - PROCESS | 8017 | 02:41:37 INFO - PROCESS | 8017 | Cycle 1(1): loaded http://localhost:53457/tests/dromaeo/cssquery-yui.html (next: http://localhost:53457/tests/dromaeo/cssquery-dojo.html) 02:41:37 INFO - PROCESS | 8017 | RSS: Main: 283070464 02:41:37 INFO - PROCESS | 8017 | 02:41:37 INFO - PROCESS | 8017 | __start_tp_report 02:41:37 INFO - PROCESS | 8017 | _x_x_mozilla_page_load 02:41:37 INFO - PROCESS | 8017 | _x_x_mozilla_page_load_details 02:41:37 INFO - PROCESS | 8017 | |i|pagename|runs| 02:41:37 INFO - PROCESS | 8017 | |0;dojo.html;2597.7142514323423;2606.2572166932428;2610.751978562036;2620.5021046001257;2652.602109683547;4536.569025942538;4625.514320996297;4641.419822522184;4690.460597031342;4719.150552900476;4589.219832628452;4623.884402889929;4627.143978364005;4651.4418269807675;4667.159911215988;4230.302000169968;4255.468066491689;4307.483102027761;4335.197988372145;4459.732416055031;4376.584224498683;4392.187445322609;4425.800838962255;4432.445944256968;4459.598636122749;4192.958070419318;4268.338407546804;4271.807768650418;4272.188284226018;4278.679099067583;4303.956960430387;4322.481302243751;4365.80353884076;4375.343698445226;4376.824927002916;4366.912661746779;4367.497737760166;4377.255866502702;4412.602865742067;4413.404190434282;4515.096980603859;4559.452865656142;4621.191291524004;4623.768811559408;4704.200285951362;5012.423571289312;5013.222950442687;5019.0463811875625;5032.04391165681;5033.84898453047;4892.119418504668;5006.173981293082;5020.523050310215;5063.569596584295;5072.0616685912855;4634.050019745944;4696.107739529479;4712.9057418851435;4775.474697783241;4780;5201.817936372209;5234.895302093937;5239.895202095937;5258.211268309784;5258.39528454225;4773.522647735268;4918.631102667243;5000.6999580024585;5020.673656212334;5064;5007.1988481843455;5027.597792176617;5037.496250375007;5054.317667114892;5083.135866902636;4981.601471882241;5046.34397528319;5055.797768089235;5057.595392368602;5062.443131255559;4863.513648635108;4931.038447502702;4977.029479251583;5020;5031.245313203049;4336.414584031116;4354.085642015212;4389.846355377546;4396.296592545177;4402.075564131568;3771.0949372150485;3772.358699021173;3791.1659434924823;3825.8087095645105;3827.3110840048503;4176.227397931331;4230.238557059759;4230.61924426803;4324.17840610283;4360.890977725582;5019.447860735316;5056.6207534434325;5063.594912407072;5075.2387141929;5085.466026067284;4313.331433627793;4316.6546676265825;4317.136572685476;4344;4351.97824010878;4466.90560812603;4523.638108951276;4538.160440318552;4539.364488971547;4571.040081582905;4798.664093513421;4821.059893320768;4822.9758851206925;4864.635152363658;4872.074305881871;5112.105381558287;5122.820701275437;5127.128388173945;5138.07514647367;5141.974290128525;4545.113702828049;4736.17117004516;4760.619150468024;4796.088743138793;4878.438979517401;5029.823956161516;5033.47148549397;5043;5070.036693028313;5097.337346144977;5061.620378471555;5061.797528098835;5063.3417655704525;5070.594352451869;5096.566791822736;4681.859544213679;4808.2547205183255;4838.225883858566;4856.78144483492;4869.074875773592;4803.1354356214815;4821.783019764189;4822.276658501253;4838.346823178967;4871.756412179306;4651.558101980307;4772.475027747015;4827;4840.7337596432535;4856.8300109495995;4798.592119669727;4849.660523763303;4863.975680121577;4870.488598697086;4875.853724388274;4785.976070119627;4861.440934292602;4861.95138048615;4870.439899411472;4882.560569548616 02:41:37 INFO - PROCESS | 8017 | |1;ext.html;572.3046498504318;580.2456806152002;582.6038293960108;592.875496145809;601.7442586900567;38515.22969540611;40083.39874901879;40279.79860100703;44371.77814110925;44440.3333949991;41174.7941260294;42076.579234207646;42077.36883946736;42080.36879446811;42111;7305.525140865853;7691.961540192306;7807.609619519029;7835.569043702594;9896.604135834557;9771.21830253578;10189.898101019005;10194.133498652624;10194.490275486196;10211.591536338574;10230.795384092313;10260.333078349884;10272.383656980568;10283.074523292902;10286.485675716222;7235.710571577157;7402.037735094404;7404.111506619186;9847.113759761583;10199.23505737069;9516.809663806755;9836.704898853046;9924.702258932244;9937;9967.352122112039;38807.22385552273;39122.21755564901;39124.21751564981;39544.40683389751;39588;2800.383915538578;2852.8288302701903;2932.926676833075;2938.5445255985355;3402.6767457091537;29314;29963.400731985457;29994.40011199764;30025.249368765737;30726.078217653507;3055.4805683033937;3152.889648862302;3156.684331566848;3266.2324353776844;3279.311344617633;267567;267615;267725.9999999981;267730;269731;31621.5256771144;55557;55937;56196.43803561994;56266.437335626935;32373.838130809665;34070.82964585161;34156.82921585376;34391.312173756385;34460.31079378398;13221.405036773369;13396.866031339561;13404.798928016087;13405.530806421728;13421.328933553283;9577.952110239405;9794.853077203848;10039.69880903574;10072.345297555781;10455.477226138662;7939.444238903337;7952.2842944134145;7971.163027882105;8025.598720063974;8042.919570804334;3060.342026464321;3080.29153294739;3101.7828751987595;3117.875284988575;3130.8591113399953;850.9829803403898;879.8284334554701;886.9379143459896;937.3391758810159;944.6552008516842;27174.5923811143;28430;28904.42191156165;29077.127686169024;29390.853045734635;881.5592203898051;907.5054095517959;951.7144856543009;977.6187286958092;991.0634450444405;15104.773428398583;15641.06153630763;15875.603109922344;16434.589135271715;16537.255823487973;417107;422668;423194;423592;423597;50073.49926500761;51348.48651513512;51802.48197517976;51837;51917;1098.9560417583207;1104.7569534702352;1152.4065106470007;1208.7159517513378;1243.6704273367566;28719.42561148807;29894.402111957203;30048.098557043322;30370.39625061812;30642.540361894142;37724.24551509009;37755.81122094372;38094.23811523809;38247.36650018244;38285.808570956964;334411;337882;338036;338276;338797;25482.490350192522;25524.10665626694;26294.34264143335;26375.34061648474;27110.72889271082;42143.36784948289;42609.573904260564;43302.350464743686;43618.34572481352;43634.127317454106;36108.27783444264;36486.08784780402;36493.45259821158;37074.25851483009;37264.25471490609;36179.45730813987;36381.63618363783;36581.817090914374;36705.44941825821;36839.44740828836;35594.46608300826;36265.45601816028;36422.27155456823;36759;37060.81469592635;31462.370752585277;32187.839060805483;32578.51132232971;32855.67144328622;32926.17684557905;25415.36461588475;25619.029050497204;25622;25688.743112569384;25894.482110357312 02:41:37 INFO - PROCESS | 8017 | |2;jquery.html;352.63678411236435;373.8074891430913;376.27191384670664;384.7326108354693;394.0739262732577;12986.41561129749;13436.932815335922;16229.594260143502;17362.39231626893;17377.826221737778;16180.27188776505;16208.83791162088;16595.83404165961;16596.50210493684;16809;4941.703497790126;5149.124648809692;5149.76826042829;5151.6136289778415;5157.8452646420665;3611.1694310308644;5835.533157347423;6134.202553668017;6141.600795948271;6156.445919867211;5140.228965655144;6057.878842423149;6079.148919151322;6098.603590766608;6109.5723299369065;5398.757055932473;5482.150266708666;5500.367457742371;5508.3114610673665;5523.033469142904;5162.7351298932;5200.713960732158;5237.292965449654;5300.867478313073;5306.310179676656;11908.34504102274;11927.463264153133;12030.81953770694;12068.577599783965;13222.471101156038;1730.4981555348934;1877.2303355624128;1924.441911845563;1931.4688460673287;2472.938176545583;8927.196552310259;9105.817883642356;9277.907220927771;9434.85847712278;9436.433813971184;1643.589102724319;1705.2923036939656;1731.6969530332267;1760.5246583422404;1769.0800783592588;67440.6627966857;67603.32396676019;67678.32321676769;72882.63558682172;76472.23527764707;9554.570044347882;9628.229741620653;9910.702678919644;10107.595696172071;10190.490475476197;13472.797908031387;13545.322733863268;13577.52478663242;13596.59210223695;13623.386947587382;7103.076600041962;7112.0754301940415;7360.77917662471;7441.85116297671;7505.812354691067;7168.964155179191;7171.713131474787;7198.96986454519;7271.091113610799;7279.308465695751;4297.67767417445;4313.935290970638;4329.805158767863;4376.212281789309;4428.490723566767;1788.7138057910672;1854.7681539807525;1854.9536261593569;1889.2726300374454;1930.3050901675385;819.4427789103466;836.1471299274706;862.9989212513455;889.6130183370254;910.4719262827545;16709.248083836013;17247.223874925658;17320.566985825455;17904.462866114038;18536.536586585175;857.8670306102564;882.8278485695228;889.9911000889908;904.0913881549001;951.6621599332276;9300.674476393293;9701.6604418845;9726.221902247944;9878.901210987799;10194;404800;405051;410230;410267;411204;64069.679651602375;73465;75118.87321690179;76335.61832190915;86191;905.0723008915783;919.9586018629178;941.8869735631631;952.4190243951184;953.93322467428;15954.202289885692;15959.44141955026;15968.361265549247;16080.035197888164;16113.67772644564;37366;37829.43255851219;38060.80969595134;38539;38913.22173556456;50909;51499.227511588106;52738.47261527336;53108.73445632902;53673.19490207728;7125.67934442941;7137.10786151731;7324.450666199949;7331.340179383881;7404.407647388303;9558.952205239208;11108.722281943015;11244.493997769956;11405.429728513707;11645.708857278636;9177.632894684139;9376.499760038361;9717.368371055858;9795.461249631338;10207.234457415872;8833.602487888189;8999.730008099768;9589.184919281939;9659.130678238993;9767.609295628095;9917.256205784452;10047.949760251153;10189.847152292574;10222.897771022195;10256.333338332985;7179.533330333512;7213.458990575623;7239.167495737847;7347.742829000959;7670;7725.22747725223;9766.121049105615;9781.75545611337;9938.602455901682;10201.97980201974 02:41:37 INFO - PROCESS | 8017 | |3;mootools.html;1349.9392527336272;1381.834179898412;1415.1155527795129;1677.370985880295;1681.17622365041;7653.272939070786;7939.92060079399;8145.266925976668;8147.592620368988;8160.836783264331;6747.595144291334;6963.617001064939;6976.720931162748;7147.785566433003;7900.130985591581;1897.952551186221;2081.2299449203742;2173.3588591365506;2181.1711549611205;2184.4648061224943;2206.6579680149603;2224.63293556563;2238.7985081342676;2243.876586787726;2250.1674380479244;2199.1643175593254;2224.165937773335;2225.143319821864;2225.2322948582714;2228.075348730275;2150.967735483977;2188.387251569563;2202.526456811793;2205.6801763744165;2211.579799838026;2136.8717876927435;2139.058814121797;2146.023559280524;2146.806787389127;2169.0673010605433;7873.881891771628;7919.802004949865;7936.404769642242;7937.960310198412;7941.24558166979;4626.190416677068;4644.094401591691;4666;4796.688215265996;4802.471728109905;2959.2453924249394;2961.4804501682365;3070.5394190871325;3074.3851229754137;3080.199148221456;852.9061803201643;867.8611422172485;905.904879987605;913.5067063785548;926.4395041000232;10676.466176691212;10988.560457581687;11019.559217631206;11021.44892755359;11031.503582338813;4163.167366526646;4187.288161012635;4271.252530807096;4284.907348626143;4369.038811461473;9444;9455.014446966214;9464.195543378752;9465.952670236606;9472;4723.126221648938;4727.030958653468;4728.692634978715;4732.266498692708;4732.881677958078;4082.1223436960604;4302.677299202573;4305.82776688929;4311.76285304305;4315.180115777992;3493.3537295600395;3543.539339885798;3556.05764472415;3582.408902531053;3629.3467175908063;1083.756154865149;1092.1972350322508;1093.7375029992745;1096.2107282756403;1120.456578559398;752.3830459023549;764.2319468933797;779.4465929190338;785.9882101768478;793.6785601831267;4970.304157417892;5167.044096842096;5305.363356397257;5431.131019036935;5435.891282174334;396.92656858481274;896.8027034052498;904.0946675248747;906.7959709065408;909.686158275394;3697.2605478904325;3751.456038874348;3755.6807671348242;3778.3199024175365;3834.4631751554803;9611.519424028771;9824.508774561244;9964.05341492557;9977.501124943723;10057.195424366033;9847.753806154904;9916.206703463706;9922.206223502102;9936.801263974825;9946.104850563339;7178.497505174588;7275.454340924452;7452.478326517092;7459.067616547932;7460.216677248811;5195.29863468442;5241.921371179512;5266.710330931683;5308.203769434615;5434.184872269191;8956.596953136994;9026.684066057656;9100.590473428843;9113.908860911306;9123.726288211365;8341.45780524264;8622.051574326944;8650.178233067849;9054.637814487347;9141.862872056792;6202.4417802398;6656.73373065072;6896.103506544117;6908.378245957888;7059.047028651272;7552.773416797505;7575.621218939141;7592.582407967615;7622.5426474411715;7643.1974642663945;6622.701978410887;6760.290169532128;6861.965690171717;6887.173539175331;6978.930210697828;6508.9349106508325;6600.570962887397;6611.702473388806;6670.39966403026;6715.3620406061345;6185.350538193425;6225.066240064027;6229.4393504584805;6276.340984196594;6278.6546739929745;4590.150822097922;4682.180618391836;4711.081339138835;4715.764211789328;4760.666753327234;4583.427071616048;4652.278896771006;4684.508126646653;4723.197056500472;4760.880977975578 02:41:37 INFO - PROCESS | 8017 | |4;prototype.html;300.90070276808655;310.5559050557703;311.2359158266456;318.0442769477719;319.38358967193307;4906.411230652322;4914.606831453484;4929.0141971605735;4956.653034287601;4969.850904472863;4827.817184789731;4847.345608342873;4874.171390863553;4876.536729010747;4881.096997055547;3638.472421498881;3759.856881577502;3777.9055523611855;3778.244351129771;3786.7159963002746;3729.216864458467;3791.791451470168;3886.378179491282;3890.474785903895;3892.4355968384707;3772.3775577029755;3785.7474802492475;3809.3904975203973;3814.370628846237;3823.2162406706557;3612.747107702462;3764.9058773530605;3800.3349413852466;3802.9619703802887;3806.333891568964;3315;3322.318924620447;3324.4680851063713;3328.417526932777;3352.2625022495013;4709.9276318420125;4720.693154944952;4728.172569800271;4729.432468103815;4739.4075740532435;4317.201317756194;4334.0280172521425;4336.34954756789;4351.804168812379;4356;4989.276554899519;5024.944761600032;5036.571891389236;5068.822591209327;5086;3622.0763705255254;3623.8369273382496;3653.3606618841864;3661.938037968986;3662.34077865984;5297;5323.22813192085;5351.785928562853;5370.865728356823;5372.5433338166695;3637.5453068366455;3724.497192878981;3731.813409329577;3744.85020599173;3750.5686846012513;3734.7759134451476;3756.6431189037;3776.4146557283116;3788.0340513169517;3789.5642001170218;4291.957080429156;4297.871063868089;4326.675499337499;4327.675424343187;4328.394024836525;4951.455339912607;5022.24035504964;5102.336696229467;5112.795488180505;5147.7683504242395;1288.3365066990507;1292.6380613428255;1297.3059413213884;1300.8146314192247;1303.2571434282559;812.2080971053176;822.2229992656881;828.5981299069946;833.6536493562974;850.1753299299669;4364;4380.824767009348;4388.551777913281;4408.4930233023615;4427.557244275611;5138.614603904722;5159.968006398735;5174.844754657366;5200.60995425337;5204.687718736888;4394.8242070317465;4394.868153955386;4419;4437.933430998538;4467.664925130628;2615.215435369382;2747.738964798341;2771.4457108578363;2776.986115069412;2790.4419116176846;4901.485344038896;4914.729689867092;4921.311016457699;4926.211806111005;4930.13722598551;5196.094490690422;5281.260623512711;5334.733263336818;5339.439358867263;5352.170413585901;4917.901641967141;4928.802847886044;4945.2582112683385;4951.702897826142;4960.231164169487;5213.322268105122;5233.188855727369;5251.36983561975;5256.947430525645;5266.42069372361;4878.268259761065;5107.157319042465;5125.564327032095;5137.768800404066;5140.691558506502;4891.706497610155;4915.778789954389;4931.654784165074;4939.320630985482;4961.875953101201;3670.5134420559716;3670.541182352206;3713.665770080706;3733.2160246347485;3735.6637902588895;5067.949320506747;5276.920846187387;5294.205869119663;5295.947040529545;5322.707251101227;5020.397552293602;5054.444011158696;5061.645684802029;5064.113780088396;5099.2860999460845;5033.924491132562;5035.974820125876;5053.166227572557;5086.855457522028;5092.337996060489;4736.644751643709;4988.750562471934;5014;5017.122003649274;5019.422766381913;4879.756012199447;4988.27669987857;4993.950060499348;5000.374953130859;5108.131617624938;4818.638602104927;4857.344258525195;4859.59071869154;4955.1576232039915;4963.429205641398 02:41:37 INFO - PROCESS | 8017 | |5;yui.html;632.9493640508759;653.2291895563234;673.3502170405558;713.986139681652;714.3213946750585;12584.559540416087;13066.346682665853;13639.113457625248;13737.107088039284;13792.517261895835;13186.67033324165;13251.734965300713;13318.93340533296;13374.197548147094;13379.598612041655;627.6359711367396;734.8126227811928;760.7375455467868;768.642581199742;777.9649915753805;769.3844924060757;771.0323543952331;772.5055964182927;773.5320131320555;776.006711409394;817.7873752824279;822.5845947796355;823.6417158536055;824.3652387661497;825.9256666899978;652.8596351784389;788.5229436191079;811.8335741173105;814.2183503836325;819.4837252530926;596.0760820727854;596.9910850662367;597.4622839444535;597.5279529171949;599.2060519811224;11906;11945.283283003047;11959.282443053444;11963.1625786195;11968.10239232061;11360.431978401048;12021.879781202164;12734.363281835964;12814.679633009157;13036.478540858354;10371.844422333672;10457.79084418315;10840.457977101114;10847.132229421628;11044.447777611087;3987.5414327352146;3989.4414781930554;4019.055521952339;4072.0634254121424;4103.179364127157;62708.37291627071;62712.05931911025;62749.68625156845;62916;62944.68527657333;9861.654842080636;9901.851472227921;10106.949465252774;10355.17110796637;10602.151827853753;15017;15301.46444874424;15307.61730956735;15338.386464541294;15376.538703838904;6454.580452270588;6595.175603049619;6632.2704502504685;6853.657317134123;6909.965450172817;3638.4542318652416;3673.1368128489785;3678.576963649161;3718.5537735471917;3831.8658846940225;2836.4610723962383;2931.1060126661146;2932.398858234057;2933.3546619743624;2935.4569404660206;486.06917752503557;500.0324372339462;503.08689728143304;508.2604810001439;513.9460356662571;530.6206062665212;546.4944925943565;566.3402136511;613.3988691082675;613.9662318572522;7590.924090759132;7927.722529711433;8047.666176808777;8260.710875119343;8603.483790972561;537.532346858228;555.6360583817606;557.3646043510402;570.6176861502803;590.748931704024;3869.555001174901;3966.4446977423186;4040.252553277653;4067.7762723049923;4146.263466112351;53833.46166538284;54458;93212.53393732988;96115.51942240384;96612.51693741487;75599.62200188964;76615;77934.61032694914;77948.22051779523;78798.6060069696;58090.4190958085;70839;72988.63505682438;74277.62861185659;75089;7497.850042999218;7580.1661817198965;7827.84344313122;7868.01015614063;7936.761897143095;44000.55999439965;44169.45406910743;44472.555274446844;44525.777371112934;44806.77596611996;59351.703241485244;61922.380776193466;61988.38011619826;62038.689806550676;62272.37727622847;8987.685431009882;9622.085901839315;9817;9911.405315681082;10084.14284785772;10994.560217591206;11160.497777599865;11161.665150045512;11165.715942666697;11670.649880503599;9213.815723685622;9614.759631009281;9772.26707996889;9780.217582593517;9942.204623630238;9533.094356036165;9992.600295988079;10002.8499572505;10203.540840662039;10222.48887555634;9638.518074096408;9722.465264410243;9818.950905245429;9904;10044.899551004397;8128.227818357246;8346.081930987466;8356.415050946618;8363.581820909052;8508.702195423131;8069.273765361146;8215.712450064219;8448.957755211184;8471.788205294917;8757.5183364913 02:41:37 INFO - PROCESS | 8017 | __end_tp_report 02:41:37 INFO - PROCESS | 8017 | __start_cc_report 02:41:37 INFO - PROCESS | 8017 | _x_x_mozilla_cycle_collect,904 02:41:37 INFO - PROCESS | 8017 | __end_cc_report 02:41:37 INFO - PROCESS | 8017 | __startTimestamp1468748497938__endTimestamp 02:41:37 INFO - PROCESS | 8017 | 02:41:37 INFO - PROCESS | 8017 | ------- Summary: start ------- 02:41:37 INFO - PROCESS | 8017 | Number of tests: 6 02:41:37 INFO - PROCESS | 8017 | 02:41:37 INFO - PROCESS | 8017 | [#0] dojo.html Cycles:165 Average:4652.80 Median:4785.98 stddev:488.18 (10.2%) stddev-sans-first:462.29 02:41:37 INFO - PROCESS | 8017 | Values: 2597.7 2606.3 2610.8 2620.5 2652.6 4536.6 4625.5 4641.4 4690.5 4719.2 4589.2 4623.9 4627.1 4651.4 4667.2 4230.3 4255.5 4307.5 4335.2 4459.7 4376.6 4392.2 4425.8 4432.4 4459.6 4193.0 4268.3 4271.8 4272.2 4278.7 4304.0 4322.5 4365.8 4375.3 4376.8 4366.9 4367.5 4377.3 4412.6 4413.4 4515.1 4559.5 4621.2 4623.8 4704.2 5012.4 5013.2 5019.0 5032.0 5033.8 4892.1 5006.2 5020.5 5063.6 5072.1 4634.1 4696.1 4712.9 4775.5 4780.0 5201.8 5234.9 5239.9 5258.2 5258.4 4773.5 4918.6 5000.7 5020.7 5064.0 5007.2 5027.6 5037.5 5054.3 5083.1 4981.6 5046.3 5055.8 5057.6 5062.4 4863.5 4931.0 4977.0 5020.0 5031.2 4336.4 4354.1 4389.8 4396.3 4402.1 3771.1 3772.4 3791.2 3825.8 3827.3 4176.2 4230.2 4230.6 4324.2 4360.9 5019.4 5056.6 5063.6 5075.2 5085.5 4313.3 4316.7 4317.1 4344.0 4352.0 4466.9 4523.6 4538.2 4539.4 4571.0 4798.7 4821.1 4823.0 4864.6 4872.1 5112.1 5122.8 5127.1 5138.1 5142.0 4545.1 4736.2 4760.6 4796.1 4878.4 5029.8 5033.5 5043.0 5070.0 5097.3 5061.6 5061.8 5063.3 5070.6 5096.6 4681.9 4808.3 4838.2 4856.8 4869.1 4803.1 4821.8 4822.3 4838.3 4871.8 4651.6 4772.5 4827.0 4840.7 4856.8 4798.6 4849.7 4864.0 4870.5 4875.9 4786.0 4861.4 4862.0 4870.4 4882.6 02:41:37 INFO - PROCESS | 8017 | 02:41:37 INFO - PROCESS | 8017 | [#1] ext.html Cycles:180 Average:48805.41 Median:36143.87 stddev:92004.30 (254.6%) stddev-sans-first:92191.13 02:41:37 INFO - PROCESS | 8017 | Values: 572.3 580.2 582.6 592.9 601.7 38515.2 40083.4 40279.8 44371.8 44440.3 41174.8 42076.6 42077.4 42080.4 42111.0 7305.5 7692.0 7807.6 7835.6 9896.6 9771.2 10189.9 10194.1 10194.5 10211.6 10230.8 10260.3 10272.4 10283.1 10286.5 7235.7 7402.0 7404.1 9847.1 10199.2 9516.8 9836.7 9924.7 9937.0 9967.4 38807.2 39122.2 39124.2 39544.4 39588.0 2800.4 2852.8 2932.9 2938.5 3402.7 29314.0 29963.4 29994.4 30025.2 30726.1 3055.5 3152.9 3156.7 3266.2 3279.3 267567.0 267615.0 267726.0 267730.0 269731.0 31621.5 55557.0 55937.0 56196.4 56266.4 32373.8 34070.8 34156.8 34391.3 34460.3 13221.4 13396.9 13404.8 13405.5 13421.3 9578.0 9794.9 10039.7 10072.3 10455.5 7939.4 7952.3 7971.2 8025.6 8042.9 3060.3 3080.3 3101.8 3117.9 3130.9 851.0 879.8 886.9 937.3 944.7 27174.6 28430.0 28904.4 29077.1 29390.9 881.6 907.5 951.7 977.6 991.1 15104.8 15641.1 15875.6 16434.6 16537.3 417107.0 422668.0 423194.0 423592.0 423597.0 50073.5 51348.5 51802.5 51837.0 51917.0 1099.0 1104.8 1152.4 1208.7 1243.7 28719.4 29894.4 30048.1 30370.4 30642.5 37724.2 37755.8 38094.2 38247.4 38285.8 334411.0 337882.0 338036.0 338276.0 338797.0 25482.5 25524.1 26294.3 26375.3 27110.7 42143.4 42609.6 43302.4 43618.3 43634.1 36108.3 36486.1 36493.5 37074.3 37264.3 36179.5 36381.6 36581.8 36705.4 36839.4 35594.5 36265.5 36422.3 36759.0 37060.8 31462.4 32187.8 32578.5 32855.7 32926.2 25415.4 25619.0 25622.0 25688.7 25894.5 02:41:37 INFO - PROCESS | 8017 | 02:41:37 INFO - PROCESS | 8017 | [#2] jquery.html Cycles:180 Average:24542.22 Median:29019.67 stddev:67367.94 (232.1%) stddev-sans-first:67532.44 02:41:37 INFO - PROCESS | 8017 | Values: 352.6 373.8 376.3 384.7 394.1 12986.4 13436.9 16229.6 17362.4 17377.8 16180.3 16208.8 16595.8 16596.5 16809.0 4941.7 5149.1 5149.8 5151.6 5157.8 3611.2 5835.5 6134.2 6141.6 6156.4 5140.2 6057.9 6079.1 6098.6 6109.6 5398.8 5482.2 5500.4 5508.3 5523.0 5162.7 5200.7 5237.3 5300.9 5306.3 11908.3 11927.5 12030.8 12068.6 13222.5 1730.5 1877.2 1924.4 1931.5 2472.9 8927.2 9105.8 9277.9 9434.9 9436.4 1643.6 1705.3 1731.7 1760.5 1769.1 67440.7 67603.3 67678.3 72882.6 76472.2 9554.6 9628.2 9910.7 10107.6 10190.5 13472.8 13545.3 13577.5 13596.6 13623.4 7103.1 7112.1 7360.8 7441.9 7505.8 7169.0 7171.7 7199.0 7271.1 7279.3 4297.7 4313.9 4329.8 4376.2 4428.5 1788.7 1854.8 1855.0 1889.3 1930.3 819.4 836.1 863.0 889.6 910.5 16709.2 17247.2 17320.6 17904.5 18536.5 857.9 882.8 890.0 904.1 951.7 9300.7 9701.7 9726.2 9878.9 10194.0 404800.0 405051.0 410230.0 410267.0 411204.0 64069.7 73465.0 75118.9 76335.6 86191.0 905.1 920.0 941.9 952.4 953.9 15954.2 15959.4 15968.4 16080.0 16113.7 37366.0 37829.4 38060.8 38539.0 38913.2 50909.0 51499.2 52738.5 53108.7 53673.2 7125.7 7137.1 7324.5 7331.3 7404.4 9559.0 11108.7 11244.5 11405.4 11645.7 9177.6 9376.5 9717.4 9795.5 10207.2 8833.6 8999.7 9589.2 9659.1 9767.6 9917.3 10047.9 10189.8 10222.9 10256.3 7179.5 7213.5 7239.2 7347.7 7670.0 7725.2 9766.1 9781.8 9938.6 10202.0 02:41:37 INFO - PROCESS | 8017 | 02:41:37 INFO - PROCESS | 8017 | [#3] mootools.html Cycles:180 Average:5186.14 Median:5254.32 stddev:2928.79 (55.7%) stddev-sans-first:2922.82 02:41:37 INFO - PROCESS | 8017 | Values: 1349.9 1381.8 1415.1 1677.4 1681.2 7653.3 7939.9 8145.3 8147.6 8160.8 6747.6 6963.6 6976.7 7147.8 7900.1 1898.0 2081.2 2173.4 2181.2 2184.5 2206.7 2224.6 2238.8 2243.9 2250.2 2199.2 2224.2 2225.1 2225.2 2228.1 2151.0 2188.4 2202.5 2205.7 2211.6 2136.9 2139.1 2146.0 2146.8 2169.1 7873.9 7919.8 7936.4 7938.0 7941.2 4626.2 4644.1 4666.0 4796.7 4802.5 2959.2 2961.5 3070.5 3074.4 3080.2 852.9 867.9 905.9 913.5 926.4 10676.5 10988.6 11019.6 11021.4 11031.5 4163.2 4187.3 4271.3 4284.9 4369.0 9444.0 9455.0 9464.2 9466.0 9472.0 4723.1 4727.0 4728.7 4732.3 4732.9 4082.1 4302.7 4305.8 4311.8 4315.2 3493.4 3543.5 3556.1 3582.4 3629.3 1083.8 1092.2 1093.7 1096.2 1120.5 752.4 764.2 779.4 786.0 793.7 4970.3 5167.0 5305.4 5431.1 5435.9 396.9 896.8 904.1 906.8 909.7 3697.3 3751.5 3755.7 3778.3 3834.5 9611.5 9824.5 9964.1 9977.5 10057.2 9847.8 9916.2 9922.2 9936.8 9946.1 7178.5 7275.5 7452.5 7459.1 7460.2 5195.3 5241.9 5266.7 5308.2 5434.2 8956.6 9026.7 9100.6 9113.9 9123.7 8341.5 8622.1 8650.2 9054.6 9141.9 6202.4 6656.7 6896.1 6908.4 7059.0 7552.8 7575.6 7592.6 7622.5 7643.2 6622.7 6760.3 6862.0 6887.2 6978.9 6508.9 6600.6 6611.7 6670.4 6715.4 6185.4 6225.1 6229.4 6276.3 6278.7 4590.2 4682.2 4711.1 4715.8 4760.7 4583.4 4652.3 4684.5 4723.2 4760.9 02:41:37 INFO - PROCESS | 8017 | 02:41:37 INFO - PROCESS | 8017 | [#4] prototype.html Cycles:180 Average:4214.73 Median:4866.88 stddev:1223.07 (25.1%) stddev-sans-first:1190.70 02:41:37 INFO - PROCESS | 8017 | Values: 300.9 310.6 311.2 318.0 319.4 4906.4 4914.6 4929.0 4956.7 4969.9 4827.8 4847.3 4874.2 4876.5 4881.1 3638.5 3759.9 3777.9 3778.2 3786.7 3729.2 3791.8 3886.4 3890.5 3892.4 3772.4 3785.7 3809.4 3814.4 3823.2 3612.7 3764.9 3800.3 3803.0 3806.3 3315.0 3322.3 3324.5 3328.4 3352.3 4709.9 4720.7 4728.2 4729.4 4739.4 4317.2 4334.0 4336.3 4351.8 4356.0 4989.3 5024.9 5036.6 5068.8 5086.0 3622.1 3623.8 3653.4 3661.9 3662.3 5297.0 5323.2 5351.8 5370.9 5372.5 3637.5 3724.5 3731.8 3744.9 3750.6 3734.8 3756.6 3776.4 3788.0 3789.6 4292.0 4297.9 4326.7 4327.7 4328.4 4951.5 5022.2 5102.3 5112.8 5147.8 1288.3 1292.6 1297.3 1300.8 1303.3 812.2 822.2 828.6 833.7 850.2 4364.0 4380.8 4388.6 4408.5 4427.6 5138.6 5160.0 5174.8 5200.6 5204.7 4394.8 4394.9 4419.0 4437.9 4467.7 2615.2 2747.7 2771.4 2777.0 2790.4 4901.5 4914.7 4921.3 4926.2 4930.1 5196.1 5281.3 5334.7 5339.4 5352.2 4917.9 4928.8 4945.3 4951.7 4960.2 5213.3 5233.2 5251.4 5256.9 5266.4 4878.3 5107.2 5125.6 5137.8 5140.7 4891.7 4915.8 4931.7 4939.3 4961.9 3670.5 3670.5 3713.7 3733.2 3735.7 5067.9 5276.9 5294.2 5295.9 5322.7 5020.4 5054.4 5061.6 5064.1 5099.3 5033.9 5036.0 5053.2 5086.9 5092.3 4736.6 4988.8 5014.0 5017.1 5019.4 4879.8 4988.3 4994.0 5000.4 5108.1 4818.6 4857.3 4859.6 4955.2 4963.4 02:41:37 INFO - PROCESS | 8017 | 02:41:37 INFO - PROCESS | 8017 | [#5] yui.html Cycles:180 Average:16463.73 Median:613.68 stddev:23347.49 (3804.5%) stddev-sans-first:23382.72 02:41:37 INFO - PROCESS | 8017 | Values: 632.9 653.2 673.4 714.0 714.3 12584.6 13066.3 13639.1 13737.1 13792.5 13186.7 13251.7 13318.9 13374.2 13379.6 627.6 734.8 760.7 768.6 778.0 769.4 771.0 772.5 773.5 776.0 817.8 822.6 823.6 824.4 825.9 652.9 788.5 811.8 814.2 819.5 596.1 597.0 597.5 597.5 599.2 11906.0 11945.3 11959.3 11963.2 11968.1 11360.4 12021.9 12734.4 12814.7 13036.5 10371.8 10457.8 10840.5 10847.1 11044.4 3987.5 3989.4 4019.1 4072.1 4103.2 62708.4 62712.1 62749.7 62916.0 62944.7 9861.7 9901.9 10106.9 10355.2 10602.2 15017.0 15301.5 15307.6 15338.4 15376.5 6454.6 6595.2 6632.3 6853.7 6910.0 3638.5 3673.1 3678.6 3718.6 3831.9 2836.5 2931.1 2932.4 2933.4 2935.5 486.1 500.0 503.1 508.3 513.9 530.6 546.5 566.3 613.4 614.0 7590.9 7927.7 8047.7 8260.7 8603.5 537.5 555.6 557.4 570.6 590.7 3869.6 3966.4 4040.3 4067.8 4146.3 53833.5 54458.0 93212.5 96115.5 96612.5 75599.6 76615.0 77934.6 77948.2 78798.6 58090.4 70839.0 72988.6 74277.6 75089.0 7497.9 7580.2 7827.8 7868.0 7936.8 44000.6 44169.5 44472.6 44525.8 44806.8 59351.7 61922.4 61988.4 62038.7 62272.4 8987.7 9622.1 9817.0 9911.4 10084.1 10994.6 11160.5 11161.7 11165.7 11670.6 9213.8 9614.8 9772.3 9780.2 9942.2 9533.1 9992.6 10002.8 10203.5 10222.5 9638.5 9722.5 9819.0 9904.0 10044.9 8128.2 8346.1 8356.4 8363.6 8508.7 8069.3 8215.7 8449.0 8471.8 8757.5 02:41:37 INFO - PROCESS | 8017 | -------- Summary: end -------- 02:41:37 INFO - PROCESS | 8017 | 02:41:38 INFO - TEST-INFO | 8017: exit 0 02:41:38 INFO - TEST-OK | dromaeo_css | took 1120010ms 02:41:38 INFO - TEST-START | kraken 02:41:38 INFO - operating with platform_type : linux_ 02:41:38 INFO - Initialising browser for kraken test... 02:41:38 INFO - TEST-INFO | started process 8204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpldd4zB/profile http://localhost:53457/getInfo.html) 02:41:42 INFO - PROCESS | 8204 | JavaScript error: , line 0: uncaught exception: undefined 02:41:42 INFO - PROCESS | 8204 | __metrics Screen width/height:1600/1200 02:41:42 INFO - PROCESS | 8204 | colorDepth:24 02:41:42 INFO - PROCESS | 8204 | Browser inner width/height: 1024/697 02:41:42 INFO - PROCESS | 8204 | __metrics 02:41:43 INFO - PROCESS | 8204 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:41:43 INFO - PROCESS | 8204 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:41:44 INFO - TEST-INFO | 8204: exit 0 02:41:44 INFO - Browser initialized. 02:41:44 INFO - Running cycle 1/1 for kraken test... 02:41:44 INFO - TEST-INFO | started process 8290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpldd4zB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:41:56 INFO - PROCESS | 8290 | RSS: Main: 159744000 02:41:56 INFO - PROCESS | 8290 | 02:41:58 INFO - PROCESS | 8290 | Cycle 1(1): loaded http://localhost:53457/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53457/tests/kraken/driver.html?testName=audio-beat-detection) 02:41:59 INFO - PROCESS | 8290 | RSS: Main: 218816512 02:41:59 INFO - PROCESS | 8290 | 02:42:02 INFO - PROCESS | 8290 | Cycle 1(1): loaded http://localhost:53457/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53457/tests/kraken/driver.html?testName=audio-dft) 02:42:03 INFO - PROCESS | 8290 | RSS: Main: 205504512 02:42:03 INFO - PROCESS | 8290 | 02:42:06 INFO - PROCESS | 8290 | Cycle 1(1): loaded http://localhost:53457/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53457/tests/kraken/driver.html?testName=audio-fft) 02:42:07 INFO - PROCESS | 8290 | RSS: Main: 273444864 02:42:07 INFO - PROCESS | 8290 | 02:42:09 INFO - PROCESS | 8290 | Cycle 1(1): loaded http://localhost:53457/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53457/tests/kraken/driver.html?testName=audio-oscillator) 02:42:09 INFO - PROCESS | 8290 | RSS: Main: 182329344 02:42:09 INFO - PROCESS | 8290 | 02:42:12 INFO - PROCESS | 8290 | Cycle 1(1): loaded http://localhost:53457/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53457/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:42:12 INFO - PROCESS | 8290 | RSS: Main: 186232832 02:42:12 INFO - PROCESS | 8290 | 02:42:16 INFO - PROCESS | 8290 | Cycle 1(1): loaded http://localhost:53457/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53457/tests/kraken/driver.html?testName=imaging-darkroom) 02:42:16 INFO - PROCESS | 8290 | RSS: Main: 222527488 02:42:16 INFO - PROCESS | 8290 | 02:42:20 INFO - PROCESS | 8290 | Cycle 1(1): loaded http://localhost:53457/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53457/tests/kraken/driver.html?testName=imaging-desaturate) 02:42:20 INFO - PROCESS | 8290 | RSS: Main: 218361856 02:42:20 INFO - PROCESS | 8290 | 02:42:23 INFO - PROCESS | 8290 | Cycle 1(1): loaded http://localhost:53457/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53457/tests/kraken/driver.html?testName=json-parse-financial) 02:42:24 INFO - PROCESS | 8290 | RSS: Main: 221265920 02:42:24 INFO - PROCESS | 8290 | 02:42:25 INFO - PROCESS | 8290 | Cycle 1(1): loaded http://localhost:53457/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53457/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:42:26 INFO - PROCESS | 8290 | RSS: Main: 211488768 02:42:26 INFO - PROCESS | 8290 | 02:42:28 INFO - PROCESS | 8290 | Cycle 1(1): loaded http://localhost:53457/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53457/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:42:29 INFO - PROCESS | 8290 | RSS: Main: 214958080 02:42:29 INFO - PROCESS | 8290 | 02:42:31 INFO - PROCESS | 8290 | Cycle 1(1): loaded http://localhost:53457/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53457/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:42:31 INFO - PROCESS | 8290 | RSS: Main: 210919424 02:42:31 INFO - PROCESS | 8290 | 02:42:34 INFO - PROCESS | 8290 | Cycle 1(1): loaded http://localhost:53457/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53457/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:42:35 INFO - PROCESS | 8290 | RSS: Main: 224899072 02:42:35 INFO - PROCESS | 8290 | 02:42:38 INFO - PROCESS | 8290 | Cycle 1(1): loaded http://localhost:53457/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53457/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:42:38 INFO - PROCESS | 8290 | RSS: Main: 226074624 02:42:38 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | Cycle 1(1): loaded http://localhost:53457/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53457/tests/kraken/driver.html?testName=ai-astar) 02:42:40 INFO - PROCESS | 8290 | RSS: Main: 267878400 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | __start_tp_report 02:42:40 INFO - PROCESS | 8290 | _x_x_mozilla_page_load 02:42:40 INFO - PROCESS | 8290 | _x_x_mozilla_page_load_details 02:42:40 INFO - PROCESS | 8290 | |i|pagename|runs| 02:42:40 INFO - PROCESS | 8290 | |0;ai-astar;109;117;115;114;116;115;113;114;113;114 02:42:40 INFO - PROCESS | 8290 | |1;audio-beat-detection;156;122;124;179;125;125;154;123;168;127 02:42:40 INFO - PROCESS | 8290 | |2;audio-dft;161;163;162;161;164;163;162;165;163;162 02:42:40 INFO - PROCESS | 8290 | |3;audio-fft;77;77;78;121;75;78;75;76;99;78 02:42:40 INFO - PROCESS | 8290 | |4;audio-oscillator;85;86;127;86;86;89;124;85;85;126 02:42:40 INFO - PROCESS | 8290 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;117 02:42:40 INFO - PROCESS | 8290 | |6;imaging-darkroom;147;148;147;148;147;147;148;147;148;148 02:42:40 INFO - PROCESS | 8290 | |7;imaging-desaturate;95;96;95;95;94;95;95;95;96;95 02:42:40 INFO - PROCESS | 8290 | |8;json-parse-financial;63;61;61;61;61;63;61;62;62;61 02:42:40 INFO - PROCESS | 8290 | |9;json-stringify-tinderbox;66;66;66;66;66;65;66;66;65;67 02:42:40 INFO - PROCESS | 8290 | |10;stanford-crypto-aes;80;79;79;79;79;80;79;79;78;79 02:42:40 INFO - PROCESS | 8290 | |11;stanford-crypto-ccm;137;131;135;131;133;138;130;136;209;155 02:42:40 INFO - PROCESS | 8290 | |12;stanford-crypto-pbkdf2;166;170;163;163;166;165;165;164;163;165 02:42:40 INFO - PROCESS | 8290 | |13;stanford-crypto-sha256-iterative;71;67;67;67;68;71;66;65;65;72 02:42:40 INFO - PROCESS | 8290 | __end_tp_report 02:42:40 INFO - PROCESS | 8290 | __start_cc_report 02:42:40 INFO - PROCESS | 8290 | _x_x_mozilla_cycle_collect,1861 02:42:40 INFO - PROCESS | 8290 | __end_cc_report 02:42:40 INFO - PROCESS | 8290 | __startTimestamp1468748560842__endTimestamp 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | ------- Summary: start ------- 02:42:40 INFO - PROCESS | 8290 | Number of tests: 14 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.50 stddev:2.16 (1.9%) stddev-sans-first:1.33 02:42:40 INFO - PROCESS | 8290 | Values: 109.0 117.0 115.0 114.0 116.0 115.0 113.0 114.0 113.0 114.0 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:140.50 stddev:21.72 (15.5%) stddev-sans-first:22.28 02:42:40 INFO - PROCESS | 8290 | Values: 156.0 122.0 124.0 179.0 125.0 125.0 154.0 123.0 168.0 127.0 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.26 (0.8%) stddev-sans-first:1.20 02:42:40 INFO - PROCESS | 8290 | Values: 161.0 163.0 162.0 161.0 164.0 163.0 162.0 165.0 163.0 162.0 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | [#3] audio-fft Cycles:10 Average:83.40 Median:77.50 stddev:14.99 (19.3%) stddev-sans-first:15.72 02:42:40 INFO - PROCESS | 8290 | Values: 77.0 77.0 78.0 121.0 75.0 78.0 75.0 76.0 99.0 78.0 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:85.50 stddev:19.21 (22.5%) stddev-sans-first:19.80 02:42:40 INFO - PROCESS | 8290 | Values: 85.0 86.0 127.0 86.0 86.0 89.0 124.0 85.0 85.0 126.0 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:42:40 INFO - PROCESS | 8290 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 02:42:40 INFO - PROCESS | 8290 | Values: 147.0 148.0 147.0 148.0 147.0 147.0 148.0 147.0 148.0 148.0 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 02:42:40 INFO - PROCESS | 8290 | Values: 95.0 96.0 95.0 95.0 94.0 95.0 95.0 95.0 96.0 95.0 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.73 02:42:40 INFO - PROCESS | 8290 | Values: 63.0 61.0 61.0 61.0 61.0 63.0 61.0 62.0 62.0 61.0 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 02:42:40 INFO - PROCESS | 8290 | Values: 66.0 66.0 66.0 66.0 66.0 65.0 66.0 66.0 65.0 67.0 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:0.57 (0.7%) stddev-sans-first:0.50 02:42:40 INFO - PROCESS | 8290 | Values: 80.0 79.0 79.0 79.0 79.0 80.0 79.0 79.0 78.0 79.0 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:136.50 stddev:24.10 (17.7%) stddev-sans-first:25.45 02:42:40 INFO - PROCESS | 8290 | Values: 137.0 131.0 135.0 131.0 133.0 138.0 130.0 136.0 209.0 155.0 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:165.00 stddev:2.11 (1.3%) stddev-sans-first:2.20 02:42:40 INFO - PROCESS | 8290 | Values: 166.0 170.0 163.0 163.0 166.0 165.0 165.0 164.0 163.0 165.0 02:42:40 INFO - PROCESS | 8290 | 02:42:40 INFO - PROCESS | 8290 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:2.56 (3.8%) stddev-sans-first:2.46 02:42:40 INFO - PROCESS | 8290 | Values: 71.0 67.0 67.0 67.0 68.0 71.0 66.0 65.0 65.0 72.0 02:42:40 INFO - PROCESS | 8290 | -------- Summary: end -------- 02:42:40 INFO - PROCESS | 8290 | 02:42:41 INFO - TEST-INFO | 8290: exit 0 02:42:41 INFO - TEST-OK | kraken | took 63134ms 02:42:41 INFO - SUITE-END | took 1183s 02:42:41 INFO - Completed test suite (00:19:43) 02:42:41 INFO - javascript benchmark 02:42:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2597.7142514323423, 2606.2572166932428, 2610.751978562036, 2620.5021046001257, 2652.602109683547, 4536.569025942538, 4625.514320996297, 4641.419822522184, 4690.460597031342, 4719.150552900476, 4589.219832628452, 4623.884402889929, 4627.143978364005, 4651.4418269807675, 4667.159911215988, 4230.302000169968, 4255.468066491689, 4307.483102027761, 4335.197988372145, 4459.732416055031, 4376.584224498683, 4392.187445322609, 4425.800838962255, 4432.445944256968, 4459.598636122749, 4192.958070419318, 4268.338407546804, 4271.807768650418, 4272.188284226018, 4278.679099067583, 4303.956960430387, 4322.481302243751, 4365.80353884076, 4375.343698445226, 4376.824927002916, 4366.912661746779, 4367.497737760166, 4377.255866502702, 4412.602865742067, 4413.404190434282, 4515.096980603859, 4559.452865656142, 4621.191291524004, 4623.768811559408, 4704.200285951362, 5012.423571289312, 5013.222950442687, 5019.0463811875625, 5032.04391165681, 5033.84898453047, 4892.119418504668, 5006.173981293082, 5020.523050310215, 5063.569596584295, 5072.0616685912855, 4634.050019745944, 4696.107739529479, 4712.9057418851435, 4775.474697783241, 4780.0, 5201.817936372209, 5234.895302093937, 5239.895202095937, 5258.211268309784, 5258.39528454225, 4773.522647735268, 4918.631102667243, 5000.6999580024585, 5020.673656212334, 5064.0, 5007.1988481843455, 5027.597792176617, 5037.496250375007, 5054.317667114892, 5083.135866902636, 4981.601471882241, 5046.34397528319, 5055.797768089235, 5057.595392368602, 5062.443131255559, 4863.513648635108, 4931.038447502702, 4977.029479251583, 5020.0, 5031.245313203049, 4336.414584031116, 4354.085642015212, 4389.846355377546, 4396.296592545177, 4402.075564131568, 3771.0949372150485, 3772.358699021173, 3791.1659434924823, 3825.8087095645105, 3827.3110840048503, 4176.227397931331, 4230.238557059759, 4230.61924426803, 4324.17840610283, 4360.890977725582, 5019.447860735316, 5056.6207534434325, 5063.594912407072, 5075.2387141929, 5085.466026067284, 4313.331433627793, 4316.6546676265825, 4317.136572685476, 4344.0, 4351.97824010878, 4466.90560812603, 4523.638108951276, 4538.160440318552, 4539.364488971547, 4571.040081582905, 4798.664093513421, 4821.059893320768, 4822.9758851206925, 4864.635152363658, 4872.074305881871, 5112.105381558287, 5122.820701275437, 5127.128388173945, 5138.07514647367, 5141.974290128525, 4545.113702828049, 4736.17117004516, 4760.619150468024, 4796.088743138793, 4878.438979517401, 5029.823956161516, 5033.47148549397, 5043.0, 5070.036693028313, 5097.337346144977, 5061.620378471555, 5061.797528098835, 5063.3417655704525, 5070.594352451869, 5096.566791822736, 4681.859544213679, 4808.2547205183255, 4838.225883858566, 4856.78144483492, 4869.074875773592, 4803.1354356214815, 4821.783019764189, 4822.276658501253, 4838.346823178967, 4871.756412179306, 4651.558101980307, 4772.475027747015, 4827.0, 4840.7337596432535, 4856.8300109495995, 4798.592119669727, 4849.660523763303, 4863.975680121577, 4870.488598697086, 4875.853724388274, 4785.976070119627, 4861.440934292602, 4861.95138048615, 4870.439899411472, 4882.560569548616], "value": 4621.654522440691, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.3046498504318, 580.2456806152002, 582.6038293960108, 592.875496145809, 601.7442586900567, 38515.22969540611, 40083.39874901879, 40279.79860100703, 44371.77814110925, 44440.3333949991, 41174.7941260294, 42076.579234207646, 42077.36883946736, 42080.36879446811, 42111.0, 7305.525140865853, 7691.961540192306, 7807.609619519029, 7835.569043702594, 9896.604135834557, 9771.21830253578, 10189.898101019005, 10194.133498652624, 10194.490275486196, 10211.591536338574, 10230.795384092313, 10260.333078349884, 10272.383656980568, 10283.074523292902, 10286.485675716222, 7235.710571577157, 7402.037735094404, 7404.111506619186, 9847.113759761583, 10199.23505737069, 9516.809663806755, 9836.704898853046, 9924.702258932244, 9937.0, 9967.352122112039, 38807.22385552273, 39122.21755564901, 39124.21751564981, 39544.40683389751, 39588.0, 2800.383915538578, 2852.8288302701903, 2932.926676833075, 2938.5445255985355, 3402.6767457091537, 29314.0, 29963.400731985457, 29994.40011199764, 30025.249368765737, 30726.078217653507, 3055.4805683033937, 3152.889648862302, 3156.684331566848, 3266.2324353776844, 3279.311344617633, 267567.0, 267615.0, 267725.9999999981, 267730.0, 269731.0, 31621.5256771144, 55557.0, 55937.0, 56196.43803561994, 56266.437335626935, 32373.838130809665, 34070.82964585161, 34156.82921585376, 34391.312173756385, 34460.31079378398, 13221.405036773369, 13396.866031339561, 13404.798928016087, 13405.530806421728, 13421.328933553283, 9577.952110239405, 9794.853077203848, 10039.69880903574, 10072.345297555781, 10455.477226138662, 7939.444238903337, 7952.2842944134145, 7971.163027882105, 8025.598720063974, 8042.919570804334, 3060.342026464321, 3080.29153294739, 3101.7828751987595, 3117.875284988575, 3130.8591113399953, 850.9829803403898, 879.8284334554701, 886.9379143459896, 937.3391758810159, 944.6552008516842, 27174.5923811143, 28430.0, 28904.42191156165, 29077.127686169024, 29390.853045734635, 881.5592203898051, 907.5054095517959, 951.7144856543009, 977.6187286958092, 991.0634450444405, 15104.773428398583, 15641.06153630763, 15875.603109922344, 16434.589135271715, 16537.255823487973, 417107.0, 422668.0, 423194.0, 423592.0, 423597.0, 50073.49926500761, 51348.48651513512, 51802.48197517976, 51837.0, 51917.0, 1098.9560417583207, 1104.7569534702352, 1152.4065106470007, 1208.7159517513378, 1243.6704273367566, 28719.42561148807, 29894.402111957203, 30048.098557043322, 30370.39625061812, 30642.540361894142, 37724.24551509009, 37755.81122094372, 38094.23811523809, 38247.36650018244, 38285.808570956964, 334411.0, 337882.0, 338036.0, 338276.0, 338797.0, 25482.490350192522, 25524.10665626694, 26294.34264143335, 26375.34061648474, 27110.72889271082, 42143.36784948289, 42609.573904260564, 43302.350464743686, 43618.34572481352, 43634.127317454106, 36108.27783444264, 36486.08784780402, 36493.45259821158, 37074.25851483009, 37264.25471490609, 36179.45730813987, 36381.63618363783, 36581.817090914374, 36705.44941825821, 36839.44740828836, 35594.46608300826, 36265.45601816028, 36422.27155456823, 36759.0, 37060.81469592635, 31462.370752585277, 32187.839060805483, 32578.51132232971, 32855.67144328622, 32926.17684557905, 25415.36461588475, 25619.029050497204, 25622.0, 25688.743112569384, 25894.482110357312], "value": 17026.62697928987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.63678411236435, 373.8074891430913, 376.27191384670664, 384.7326108354693, 394.0739262732577, 12986.41561129749, 13436.932815335922, 16229.594260143502, 17362.39231626893, 17377.826221737778, 16180.27188776505, 16208.83791162088, 16595.83404165961, 16596.50210493684, 16809.0, 4941.703497790126, 5149.124648809692, 5149.76826042829, 5151.6136289778415, 5157.8452646420665, 3611.1694310308644, 5835.533157347423, 6134.202553668017, 6141.600795948271, 6156.445919867211, 5140.228965655144, 6057.878842423149, 6079.148919151322, 6098.603590766608, 6109.5723299369065, 5398.757055932473, 5482.150266708666, 5500.367457742371, 5508.3114610673665, 5523.033469142904, 5162.7351298932, 5200.713960732158, 5237.292965449654, 5300.867478313073, 5306.310179676656, 11908.34504102274, 11927.463264153133, 12030.81953770694, 12068.577599783965, 13222.471101156038, 1730.4981555348934, 1877.2303355624128, 1924.441911845563, 1931.4688460673287, 2472.938176545583, 8927.196552310259, 9105.817883642356, 9277.907220927771, 9434.85847712278, 9436.433813971184, 1643.589102724319, 1705.2923036939656, 1731.6969530332267, 1760.5246583422404, 1769.0800783592588, 67440.6627966857, 67603.32396676019, 67678.32321676769, 72882.63558682172, 76472.23527764707, 9554.570044347882, 9628.229741620653, 9910.702678919644, 10107.595696172071, 10190.490475476197, 13472.797908031387, 13545.322733863268, 13577.52478663242, 13596.59210223695, 13623.386947587382, 7103.076600041962, 7112.0754301940415, 7360.77917662471, 7441.85116297671, 7505.812354691067, 7168.964155179191, 7171.713131474787, 7198.96986454519, 7271.091113610799, 7279.308465695751, 4297.67767417445, 4313.935290970638, 4329.805158767863, 4376.212281789309, 4428.490723566767, 1788.7138057910672, 1854.7681539807525, 1854.9536261593569, 1889.2726300374454, 1930.3050901675385, 819.4427789103466, 836.1471299274706, 862.9989212513455, 889.6130183370254, 910.4719262827545, 16709.248083836013, 17247.223874925658, 17320.566985825455, 17904.462866114038, 18536.536586585175, 857.8670306102564, 882.8278485695228, 889.9911000889908, 904.0913881549001, 951.6621599332276, 9300.674476393293, 9701.6604418845, 9726.221902247944, 9878.901210987799, 10194.0, 404800.0, 405051.0, 410230.0, 410267.0, 411204.0, 64069.679651602375, 73465.0, 75118.87321690179, 76335.61832190915, 86191.0, 905.0723008915783, 919.9586018629178, 941.8869735631631, 952.4190243951184, 953.93322467428, 15954.202289885692, 15959.44141955026, 15968.361265549247, 16080.035197888164, 16113.67772644564, 37366.0, 37829.43255851219, 38060.80969595134, 38539.0, 38913.22173556456, 50909.0, 51499.227511588106, 52738.47261527336, 53108.73445632902, 53673.19490207728, 7125.67934442941, 7137.10786151731, 7324.450666199949, 7331.340179383881, 7404.407647388303, 9558.952205239208, 11108.722281943015, 11244.493997769956, 11405.429728513707, 11645.708857278636, 9177.632894684139, 9376.499760038361, 9717.368371055858, 9795.461249631338, 10207.234457415872, 8833.602487888189, 8999.730008099768, 9589.184919281939, 9659.130678238993, 9767.609295628095, 9917.256205784452, 10047.949760251153, 10189.847152292574, 10222.897771022195, 10256.333338332985, 7179.533330333512, 7213.458990575623, 7239.167495737847, 7347.742829000959, 7670.0, 7725.22747725223, 9766.121049105615, 9781.75545611337, 9938.602455901682, 10201.97980201974], "value": 8072.711905041327, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.9392527336272, 1381.834179898412, 1415.1155527795129, 1677.370985880295, 1681.17622365041, 7653.272939070786, 7939.92060079399, 8145.266925976668, 8147.592620368988, 8160.836783264331, 6747.595144291334, 6963.617001064939, 6976.720931162748, 7147.785566433003, 7900.130985591581, 1897.952551186221, 2081.2299449203742, 2173.3588591365506, 2181.1711549611205, 2184.4648061224943, 2206.6579680149603, 2224.63293556563, 2238.7985081342676, 2243.876586787726, 2250.1674380479244, 2199.1643175593254, 2224.165937773335, 2225.143319821864, 2225.2322948582714, 2228.075348730275, 2150.967735483977, 2188.387251569563, 2202.526456811793, 2205.6801763744165, 2211.579799838026, 2136.8717876927435, 2139.058814121797, 2146.023559280524, 2146.806787389127, 2169.0673010605433, 7873.881891771628, 7919.802004949865, 7936.404769642242, 7937.960310198412, 7941.24558166979, 4626.190416677068, 4644.094401591691, 4666.0, 4796.688215265996, 4802.471728109905, 2959.2453924249394, 2961.4804501682365, 3070.5394190871325, 3074.3851229754137, 3080.199148221456, 852.9061803201643, 867.8611422172485, 905.904879987605, 913.5067063785548, 926.4395041000232, 10676.466176691212, 10988.560457581687, 11019.559217631206, 11021.44892755359, 11031.503582338813, 4163.167366526646, 4187.288161012635, 4271.252530807096, 4284.907348626143, 4369.038811461473, 9444.0, 9455.014446966214, 9464.195543378752, 9465.952670236606, 9472.0, 4723.126221648938, 4727.030958653468, 4728.692634978715, 4732.266498692708, 4732.881677958078, 4082.1223436960604, 4302.677299202573, 4305.82776688929, 4311.76285304305, 4315.180115777992, 3493.3537295600395, 3543.539339885798, 3556.05764472415, 3582.408902531053, 3629.3467175908063, 1083.756154865149, 1092.1972350322508, 1093.7375029992745, 1096.2107282756403, 1120.456578559398, 752.3830459023549, 764.2319468933797, 779.4465929190338, 785.9882101768478, 793.6785601831267, 4970.304157417892, 5167.044096842096, 5305.363356397257, 5431.131019036935, 5435.891282174334, 396.92656858481274, 896.8027034052498, 904.0946675248747, 906.7959709065408, 909.686158275394, 3697.2605478904325, 3751.456038874348, 3755.6807671348242, 3778.3199024175365, 3834.4631751554803, 9611.519424028771, 9824.508774561244, 9964.05341492557, 9977.501124943723, 10057.195424366033, 9847.753806154904, 9916.206703463706, 9922.206223502102, 9936.801263974825, 9946.104850563339, 7178.497505174588, 7275.454340924452, 7452.478326517092, 7459.067616547932, 7460.216677248811, 5195.29863468442, 5241.921371179512, 5266.710330931683, 5308.203769434615, 5434.184872269191, 8956.596953136994, 9026.684066057656, 9100.590473428843, 9113.908860911306, 9123.726288211365, 8341.45780524264, 8622.051574326944, 8650.178233067849, 9054.637814487347, 9141.862872056792, 6202.4417802398, 6656.73373065072, 6896.103506544117, 6908.378245957888, 7059.047028651272, 7552.773416797505, 7575.621218939141, 7592.582407967615, 7622.5426474411715, 7643.1974642663945, 6622.701978410887, 6760.290169532128, 6861.965690171717, 6887.173539175331, 6978.930210697828, 6508.9349106508325, 6600.570962887397, 6611.702473388806, 6670.39966403026, 6715.3620406061345, 6185.350538193425, 6225.066240064027, 6229.4393504584805, 6276.340984196594, 6278.6546739929745, 4590.150822097922, 4682.180618391836, 4711.081339138835, 4715.764211789328, 4760.666753327234, 4583.427071616048, 4652.278896771006, 4684.508126646653, 4723.197056500472, 4760.880977975578], "value": 4148.710917476526, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.90070276808655, 310.5559050557703, 311.2359158266456, 318.0442769477719, 319.38358967193307, 4906.411230652322, 4914.606831453484, 4929.0141971605735, 4956.653034287601, 4969.850904472863, 4827.817184789731, 4847.345608342873, 4874.171390863553, 4876.536729010747, 4881.096997055547, 3638.472421498881, 3759.856881577502, 3777.9055523611855, 3778.244351129771, 3786.7159963002746, 3729.216864458467, 3791.791451470168, 3886.378179491282, 3890.474785903895, 3892.4355968384707, 3772.3775577029755, 3785.7474802492475, 3809.3904975203973, 3814.370628846237, 3823.2162406706557, 3612.747107702462, 3764.9058773530605, 3800.3349413852466, 3802.9619703802887, 3806.333891568964, 3315.0, 3322.318924620447, 3324.4680851063713, 3328.417526932777, 3352.2625022495013, 4709.9276318420125, 4720.693154944952, 4728.172569800271, 4729.432468103815, 4739.4075740532435, 4317.201317756194, 4334.0280172521425, 4336.34954756789, 4351.804168812379, 4356.0, 4989.276554899519, 5024.944761600032, 5036.571891389236, 5068.822591209327, 5086.0, 3622.0763705255254, 3623.8369273382496, 3653.3606618841864, 3661.938037968986, 3662.34077865984, 5297.0, 5323.22813192085, 5351.785928562853, 5370.865728356823, 5372.5433338166695, 3637.5453068366455, 3724.497192878981, 3731.813409329577, 3744.85020599173, 3750.5686846012513, 3734.7759134451476, 3756.6431189037, 3776.4146557283116, 3788.0340513169517, 3789.5642001170218, 4291.957080429156, 4297.871063868089, 4326.675499337499, 4327.675424343187, 4328.394024836525, 4951.455339912607, 5022.24035504964, 5102.336696229467, 5112.795488180505, 5147.7683504242395, 1288.3365066990507, 1292.6380613428255, 1297.3059413213884, 1300.8146314192247, 1303.2571434282559, 812.2080971053176, 822.2229992656881, 828.5981299069946, 833.6536493562974, 850.1753299299669, 4364.0, 4380.824767009348, 4388.551777913281, 4408.4930233023615, 4427.557244275611, 5138.614603904722, 5159.968006398735, 5174.844754657366, 5200.60995425337, 5204.687718736888, 4394.8242070317465, 4394.868153955386, 4419.0, 4437.933430998538, 4467.664925130628, 2615.215435369382, 2747.738964798341, 2771.4457108578363, 2776.986115069412, 2790.4419116176846, 4901.485344038896, 4914.729689867092, 4921.311016457699, 4926.211806111005, 4930.13722598551, 5196.094490690422, 5281.260623512711, 5334.733263336818, 5339.439358867263, 5352.170413585901, 4917.901641967141, 4928.802847886044, 4945.2582112683385, 4951.702897826142, 4960.231164169487, 5213.322268105122, 5233.188855727369, 5251.36983561975, 5256.947430525645, 5266.42069372361, 4878.268259761065, 5107.157319042465, 5125.564327032095, 5137.768800404066, 5140.691558506502, 4891.706497610155, 4915.778789954389, 4931.654784165074, 4939.320630985482, 4961.875953101201, 3670.5134420559716, 3670.541182352206, 3713.665770080706, 3733.2160246347485, 3735.6637902588895, 5067.949320506747, 5276.920846187387, 5294.205869119663, 5295.947040529545, 5322.707251101227, 5020.397552293602, 5054.444011158696, 5061.645684802029, 5064.113780088396, 5099.2860999460845, 5033.924491132562, 5035.974820125876, 5053.166227572557, 5086.855457522028, 5092.337996060489, 4736.644751643709, 4988.750562471934, 5014.0, 5017.122003649274, 5019.422766381913, 4879.756012199447, 4988.27669987857, 4993.950060499348, 5000.374953130859, 5108.131617624938, 4818.638602104927, 4857.344258525195, 4859.59071869154, 4955.1576232039915, 4963.429205641398], "value": 3826.505642824579, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.9493640508759, 653.2291895563234, 673.3502170405558, 713.986139681652, 714.3213946750585, 12584.559540416087, 13066.346682665853, 13639.113457625248, 13737.107088039284, 13792.517261895835, 13186.67033324165, 13251.734965300713, 13318.93340533296, 13374.197548147094, 13379.598612041655, 627.6359711367396, 734.8126227811928, 760.7375455467868, 768.642581199742, 777.9649915753805, 769.3844924060757, 771.0323543952331, 772.5055964182927, 773.5320131320555, 776.006711409394, 817.7873752824279, 822.5845947796355, 823.6417158536055, 824.3652387661497, 825.9256666899978, 652.8596351784389, 788.5229436191079, 811.8335741173105, 814.2183503836325, 819.4837252530926, 596.0760820727854, 596.9910850662367, 597.4622839444535, 597.5279529171949, 599.2060519811224, 11906.0, 11945.283283003047, 11959.282443053444, 11963.1625786195, 11968.10239232061, 11360.431978401048, 12021.879781202164, 12734.363281835964, 12814.679633009157, 13036.478540858354, 10371.844422333672, 10457.79084418315, 10840.457977101114, 10847.132229421628, 11044.447777611087, 3987.5414327352146, 3989.4414781930554, 4019.055521952339, 4072.0634254121424, 4103.179364127157, 62708.37291627071, 62712.05931911025, 62749.68625156845, 62916.0, 62944.68527657333, 9861.654842080636, 9901.851472227921, 10106.949465252774, 10355.17110796637, 10602.151827853753, 15017.0, 15301.46444874424, 15307.61730956735, 15338.386464541294, 15376.538703838904, 6454.580452270588, 6595.175603049619, 6632.2704502504685, 6853.657317134123, 6909.965450172817, 3638.4542318652416, 3673.1368128489785, 3678.576963649161, 3718.5537735471917, 3831.8658846940225, 2836.4610723962383, 2931.1060126661146, 2932.398858234057, 2933.3546619743624, 2935.4569404660206, 486.06917752503557, 500.0324372339462, 503.08689728143304, 508.2604810001439, 513.9460356662571, 530.6206062665212, 546.4944925943565, 566.3402136511, 613.3988691082675, 613.9662318572522, 7590.924090759132, 7927.722529711433, 8047.666176808777, 8260.710875119343, 8603.483790972561, 537.532346858228, 555.6360583817606, 557.3646043510402, 570.6176861502803, 590.748931704024, 3869.555001174901, 3966.4446977423186, 4040.252553277653, 4067.7762723049923, 4146.263466112351, 53833.46166538284, 54458.0, 93212.53393732988, 96115.51942240384, 96612.51693741487, 75599.62200188964, 76615.0, 77934.61032694914, 77948.22051779523, 78798.6060069696, 58090.4190958085, 70839.0, 72988.63505682438, 74277.62861185659, 75089.0, 7497.850042999218, 7580.1661817198965, 7827.84344313122, 7868.01015614063, 7936.761897143095, 44000.55999439965, 44169.45406910743, 44472.555274446844, 44525.777371112934, 44806.77596611996, 59351.703241485244, 61922.380776193466, 61988.38011619826, 62038.689806550676, 62272.37727622847, 8987.685431009882, 9622.085901839315, 9817.0, 9911.405315681082, 10084.14284785772, 10994.560217591206, 11160.497777599865, 11161.665150045512, 11165.715942666697, 11670.649880503599, 9213.815723685622, 9614.759631009281, 9772.26707996889, 9780.217582593517, 9942.204623630238, 9533.094356036165, 9992.600295988079, 10002.8499572505, 10203.540840662039, 10222.48887555634, 9638.518074096408, 9722.465264410243, 9818.950905245429, 9904.0, 10044.899551004397, 8128.227818357246, 8346.081930987466, 8356.415050946618, 8363.581820909052, 8508.702195423131, 8069.273765361146, 8215.712450064219, 8448.957755211184, 8471.788205294917, 8757.5183364913], "value": 6234.642477181853, "unit": "score"}], "name": "dromaeo_css", "value": 6305.9920542771015, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 117.0, 115.0, 114.0, 116.0, 115.0, 113.0, 114.0, 113.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 122.0, 124.0, 179.0, 125.0, 125.0, 154.0, 123.0, 168.0, 127.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 161.0, 164.0, 163.0, 162.0, 165.0, 163.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 121.0, 75.0, 78.0, 75.0, 76.0, 99.0, 78.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 127.0, 86.0, 86.0, 89.0, 124.0, 85.0, 85.0, 126.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 61.0, 61.0, 63.0, 61.0, 62.0, 62.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0, 67.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 79.0, 80.0, 79.0, 79.0, 78.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 135.0, 131.0, 133.0, 138.0, 130.0, 136.0, 209.0, 155.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 163.0, 163.0, 166.0, 165.0, 165.0, 164.0, 163.0, 165.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 67.0, 67.0, 68.0, 71.0, 66.0, 65.0, 65.0, 72.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1540.9, "alertThreshold": 2.0}]} 02:42:42 INFO - Return code: 0 02:42:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:42:42 INFO - # TBPL SUCCESS # 02:42:42 INFO - Running post-action listener: _resource_record_post_action 02:42:42 INFO - ##### 02:42:42 INFO - ##### Finished run-tests step (success) 02:42:42 INFO - ##### 02:42:42 INFO - Running post-run listener: _resource_record_post_run 02:42:42 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535789568; Read time: 8; Write time: 488804 02:42:42 INFO - TinderboxPrint: CPU usage
13.0% 02:42:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:42:42 INFO - TinderboxPrint: I/O write bytes / time
535,789,568 / 488,804 02:42:42 INFO - TinderboxPrint: CPU idle
8,331.4 (87.0%) 02:42:42 INFO - TinderboxPrint: CPU user
1,203.6 (12.6%) 02:42:42 INFO - TinderboxPrint: Swap in / out
0 / 0 02:42:42 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246988800; Read time: 0; Write time: 309380 02:42:42 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288800768; Read time: 8; Write time: 179424 02:42:42 INFO - Running post-run listener: _upload_blobber_files 02:42:42 INFO - Blob upload gear active. 02:42:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:42:42 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:42:42 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:42:42 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:42:43 INFO - (blobuploader) - INFO - Open directory for files ... 02:42:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:42:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:42:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:58 INFO - (blobuploader) - INFO - Done attempting. 02:42:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:42:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:42:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:59 INFO - (blobuploader) - INFO - Done attempting. 02:42:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:42:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:42:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:59 INFO - (blobuploader) - INFO - Done attempting. 02:42:59 INFO - (blobuploader) - INFO - Iteration through files over. 02:42:59 INFO - Return code: 0 02:42:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:42:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:42:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/258a2b1ab6db8a4225a671be0883ed9221f66e3a0d7f155671b462cf91bb58517c3f0cc250cc23219137b7e9d6d23c2f98096943f803d03c773ac025051effab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7c3fb1f5d5aed15be093dd7ae31ad916d189b999bb93fae3c20f67e5504b5a15922bc1588789a564b042d3d8e6759d2815623169a10636bfd42fbd4c5819cad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73dfb1c1034e4e8dc7f343e2f25cd68ea67484349a6402825cee7b3b8c0cd54486a841a48c2c1b1c9394984207fd3b50594d9e00f7cc8ba6b75e1555ad89abf5"} 02:42:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:42:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:42:59 INFO - Contents: 02:42:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/258a2b1ab6db8a4225a671be0883ed9221f66e3a0d7f155671b462cf91bb58517c3f0cc250cc23219137b7e9d6d23c2f98096943f803d03c773ac025051effab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7c3fb1f5d5aed15be093dd7ae31ad916d189b999bb93fae3c20f67e5504b5a15922bc1588789a564b042d3d8e6759d2815623169a10636bfd42fbd4c5819cad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73dfb1c1034e4e8dc7f343e2f25cd68ea67484349a6402825cee7b3b8c0cd54486a841a48c2c1b1c9394984207fd3b50594d9e00f7cc8ba6b75e1555ad89abf5"} 02:42:59 INFO - Running post-run listener: copy_logs_to_upload_dir 02:42:59 INFO - Copying logs to upload dir... 02:42:59 INFO - mkdir: /builds/slave/test/build/upload/logs 02:42:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.983464 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-07-17 02:42:58.757892) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 02:42:58.761848) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/258a2b1ab6db8a4225a671be0883ed9221f66e3a0d7f155671b462cf91bb58517c3f0cc250cc23219137b7e9d6d23c2f98096943f803d03c773ac025051effab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7c3fb1f5d5aed15be093dd7ae31ad916d189b999bb93fae3c20f67e5504b5a15922bc1588789a564b042d3d8e6759d2815623169a10636bfd42fbd4c5819cad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73dfb1c1034e4e8dc7f343e2f25cd68ea67484349a6402825cee7b3b8c0cd54486a841a48c2c1b1c9394984207fd3b50594d9e00f7cc8ba6b75e1555ad89abf5"} build_url:https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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/Firefox-Non-PGO/sha512/258a2b1ab6db8a4225a671be0883ed9221f66e3a0d7f155671b462cf91bb58517c3f0cc250cc23219137b7e9d6d23c2f98096943f803d03c773ac025051effab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7c3fb1f5d5aed15be093dd7ae31ad916d189b999bb93fae3c20f67e5504b5a15922bc1588789a564b042d3d8e6759d2815623169a10636bfd42fbd4c5819cad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73dfb1c1034e4e8dc7f343e2f25cd68ea67484349a6402825cee7b3b8c0cd54486a841a48c2c1b1c9394984207fd3b50594d9e00f7cc8ba6b75e1555ad89abf5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 02:42:58.787442) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:42:58.787768) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468746913.808880-289459588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:42:58.870121) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 02:42:58.870463) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 02:42:58.870733) ========= ========= Total master_lag: 0.17 =========