builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1468894740.75 results: success (0) buildid: 20160718163032 builduid: 4bd2f579fa7d4c45b91d9fd4e80327cd revision: feaaf1af1065257b9178faca8b67eed9657b4a17 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.747469) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.747841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.748139) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.764627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.764890) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 19:19:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.3M=0s 2016-07-18 19:19:01 (40.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085717 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.879598) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.879909) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016079 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.936483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 19:19:00.936797) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev feaaf1af1065257b9178faca8b67eed9657b4a17 --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 feaaf1af1065257b9178faca8b67eed9657b4a17 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 19:19:01,238 truncating revision to first 12 chars 2016-07-18 19:19:01,238 Setting DEBUG logging. 2016-07-18 19:19:01,238 attempt 1/10 2016-07-18 19:19:01,238 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/feaaf1af1065?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 19:19:02,231 unpacking tar archive at: mozilla-central-feaaf1af1065/testing/mozharness/ program finished with exit code 0 elapsedTime=1.428610 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 19:19:02.379303) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:02.379620) ========= script_repo_revision: feaaf1af1065257b9178faca8b67eed9657b4a17 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:02.380005) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:02.380320) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:02.389821) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-18 19:19:02.390233) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:19:02 INFO - MultiFileLogger online at 20160718 19:19:02 in /builds/slave/test 19:19:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:19:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:19:02 INFO - {'append_to_log': False, 19:19:02 INFO - 'base_work_dir': '/builds/slave/test', 19:19:02 INFO - 'blob_upload_branch': 'Firefox', 19:19:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:19:02 INFO - 'branch': 'Firefox', 19:19:02 INFO - 'buildbot_json_path': 'buildprops.json', 19:19:02 INFO - 'config_files': ('talos/linux_config.py',), 19:19:02 INFO - 'default_actions': ('clobber', 19:19:02 INFO - 'read-buildbot-config', 19:19:02 INFO - 'download-and-extract', 19:19:02 INFO - 'populate-webroot', 19:19:02 INFO - 'create-virtualenv', 19:19:02 INFO - 'install', 19:19:02 INFO - 'run-tests'), 19:19:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:19:02 INFO - 'download_minidump_stackwalk': True, 19:19:02 INFO - 'download_symbols': 'ondemand', 19:19:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:19:02 INFO - 'tooltool.py': '/tools/tooltool.py', 19:19:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:19:02 INFO - '/tools/misc-python/virtualenv.py')}, 19:19:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:19:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:19:02 INFO - 'installer_path': 'installer.exe', 19:19:02 INFO - 'log_level': 'info', 19:19:02 INFO - 'log_name': 'talos', 19:19:02 INFO - 'log_to_console': True, 19:19:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:19:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:19:02 INFO - 'opt_config_files': (), 19:19:02 INFO - 'pip_index': False, 19:19:02 INFO - 'sps_profile': False, 19:19:02 INFO - 'sps_profile_interval': 0, 19:19:02 INFO - 'suite': 'dromaeojs', 19:19:02 INFO - 'system_bits': '32', 19:19:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:19:02 INFO - 'title': 'talos-linux64-ix-048', 19:19:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:19:02 INFO - 'use_talos_json': True, 19:19:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:19:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:19:02 INFO - 'work_dir': 'build'} 19:19:02 INFO - ##### 19:19:02 INFO - ##### Running clobber step. 19:19:02 INFO - ##### 19:19:02 INFO - Running pre-action listener: _resource_record_pre_action 19:19:02 INFO - Running main action method: clobber 19:19:02 INFO - rmtree: /builds/slave/test/build 19:19:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:19:03 INFO - Running post-action listener: _resource_record_post_action 19:19:03 INFO - ##### 19:19:03 INFO - ##### Finished clobber step (success) 19:19:03 INFO - ##### 19:19:03 INFO - ##### 19:19:03 INFO - ##### Running read-buildbot-config step. 19:19:03 INFO - ##### 19:19:03 INFO - Running pre-action listener: _resource_record_pre_action 19:19:03 INFO - Running main action method: read_buildbot_config 19:19:03 INFO - Using buildbot properties: 19:19:03 INFO - { 19:19:03 INFO - "project": "", 19:19:03 INFO - "product": "firefox", 19:19:03 INFO - "script_repo_revision": "production", 19:19:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:19:03 INFO - "repository": "", 19:19:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 19:19:03 INFO - "buildid": "20160718163032", 19:19:03 INFO - "pgo_build": "True", 19:19:03 INFO - "basedir": "/builds/slave/test", 19:19:03 INFO - "buildnumber": 399, 19:19:03 INFO - "slavename": "talos-linux64-ix-048", 19:19:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:19:03 INFO - "platform": "ubuntu64_hw", 19:19:03 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:19:03 INFO - "branch": "mozilla-central", 19:19:03 INFO - "repo_path": "mozilla-central", 19:19:03 INFO - "revision": "feaaf1af1065257b9178faca8b67eed9657b4a17", 19:19:03 INFO - "stage_platform": "linux64-pgo", 19:19:03 INFO - "builduid": "4bd2f579fa7d4c45b91d9fd4e80327cd", 19:19:03 INFO - "slavebuilddir": "test" 19:19:03 INFO - } 19:19:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:19:03 INFO - Running post-action listener: _resource_record_post_action 19:19:03 INFO - ##### 19:19:03 INFO - ##### Finished read-buildbot-config step (success) 19:19:03 INFO - ##### 19:19:03 INFO - ##### 19:19:03 INFO - ##### Running download-and-extract step. 19:19:03 INFO - ##### 19:19:03 INFO - Running pre-action listener: _resource_record_pre_action 19:19:03 INFO - Running main action method: download_and_extract 19:19:03 INFO - mkdir: /builds/slave/test/build/tests 19:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:03 INFO - https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:19:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:19:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:19:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:19:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:19:04 INFO - Downloaded 1361 bytes. 19:19:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:19:04 INFO - Using the following test package requirements: 19:19:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:19:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:19:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:19:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'jsshell-linux-x86_64.zip'], 19:19:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:19:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:19:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:19:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:19:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:19:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:19:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:04 INFO - https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:19:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:19:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:19:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:19:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:19:06 INFO - Downloaded 24333956 bytes. 19:19:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:19:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:19:07 INFO - Return code: 0 19:19:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:07 INFO - https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:19:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:19:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:19:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:19:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:19:10 INFO - Downloaded 24333956 bytes. 19:19:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:19:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:19:12 INFO - Return code: 0 19:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:12 INFO - https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:19:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:19:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:19:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:19:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:19:13 INFO - Downloaded 14403317 bytes. 19:19:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:19:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:19:13 INFO - Return code: 0 19:19: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')]} 19:19:13 INFO - https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:19:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:19:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:19:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:19:14 INFO - Downloaded 60836145 bytes. 19:19:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:19:14 INFO - mkdir: /builds/slave/test/properties 19:19:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:19:14 INFO - Writing to file /builds/slave/test/properties/build_url 19:19:14 INFO - Contents: 19:19:14 INFO - build_url:https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:19:15 INFO - Running post-action listener: _resource_record_post_action 19:19:15 INFO - Running post-action listener: set_extra_try_arguments 19:19:15 INFO - ##### 19:19:15 INFO - ##### Finished download-and-extract step (success) 19:19:15 INFO - ##### 19:19:15 INFO - ##### 19:19:15 INFO - ##### Running populate-webroot step. 19:19:15 INFO - ##### 19:19:15 INFO - Running pre-action listener: _resource_record_pre_action 19:19:15 INFO - Running main action method: populate_webroot 19:19:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:19:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:19:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:19:15 INFO - '--tppagecycles', 19:19:15 INFO - '7'], 19:19:15 INFO - 'tests': ['tsvgm']}}, 19:19:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:19:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:19:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:19:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:19:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:19:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:19:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:15 INFO - 'talos_options': ['--disable-e10s'], 19:19:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:19:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:19:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:15 INFO - 'talos_options': ['--disable-e10s'], 19:19:15 INFO - 'tests': ['damp', 'tps']}, 19:19:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:15 INFO - 'tests': ['damp', 'tps']}, 19:19:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:19:15 INFO - 'tests': ['dromaeo_dom']}, 19:19:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:19:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:19:15 INFO - 'tests': ['basic_compositor_video']}, 19:19:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:19:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:19:15 INFO - 'tests': ['a11yr', 19:19:15 INFO - 'ts_paint', 19:19:15 INFO - 'tpaint', 19:19:15 INFO - 'sessionrestore', 19:19:15 INFO - 'sessionrestore_no_auto_restore', 19:19:15 INFO - 'tabpaint']}, 19:19:15 INFO - 'other-e10s': {'tests': ['a11yr', 19:19:15 INFO - 'ts_paint', 19:19:15 INFO - 'tpaint', 19:19:15 INFO - 'sessionrestore', 19:19:15 INFO - 'sessionrestore_no_auto_restore', 19:19:15 INFO - 'tabpaint']}, 19:19:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:19:15 INFO - 'ts_paint', 19:19:15 INFO - 'tpaint', 19:19:15 INFO - 'sessionrestore', 19:19:15 INFO - 'sessionrestore_no_auto_restore', 19:19:15 INFO - 'tabpaint']}, 19:19:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:19:15 INFO - 'ts_paint', 19:19:15 INFO - 'tpaint', 19:19:15 INFO - 'sessionrestore', 19:19:15 INFO - 'sessionrestore_no_auto_restore', 19:19:15 INFO - 'tabpaint']}, 19:19:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:19:15 INFO - 'tests': ['a11yr', 19:19:15 INFO - 'ts_paint', 19:19:15 INFO - 'tpaint', 19:19:15 INFO - 'sessionrestore', 19:19:15 INFO - 'sessionrestore_no_auto_restore', 19:19:15 INFO - 'tabpaint']}, 19:19:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:19:15 INFO - 'tests': ['a11yr', 19:19:15 INFO - 'ts_paint', 19:19:15 INFO - 'tpaint', 19:19:15 INFO - 'sessionrestore', 19:19:15 INFO - 'sessionrestore_no_auto_restore', 19:19:15 INFO - 'tabpaint']}, 19:19:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:19:15 INFO - 'tests': ['tsvgx', 19:19:15 INFO - 'tsvgr_opacity', 19:19:15 INFO - 'tart', 19:19:15 INFO - 'tscrollx', 19:19:15 INFO - 'cart']}, 19:19:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:19:15 INFO - 'tsvgr_opacity', 19:19:15 INFO - 'tart', 19:19:15 INFO - 'tscrollx', 19:19:15 INFO - 'cart']}, 19:19:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:15 INFO - 'talos_options': ['--disable-e10s'], 19:19:15 INFO - 'tests': ['tp5o']}, 19:19:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:15 INFO - 'tests': ['tp5o']}, 19:19:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:15 INFO - 'talos_options': ['--disable-e10s', 19:19:15 INFO - '--xperf_path', 19:19:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:19:15 INFO - 'tests': ['tp5n']}, 19:19:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:15 INFO - 'talos_options': ['--xperf_path', 19:19:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:19:15 INFO - 'tests': ['tp5n']}}, 19:19:15 INFO - 'talos.zip': {'path': '', 19:19:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:19:15 INFO - Running post-action listener: _resource_record_post_action 19:19:15 INFO - ##### 19:19:15 INFO - ##### Finished populate-webroot step (success) 19:19:15 INFO - ##### 19:19:15 INFO - ##### 19:19:15 INFO - ##### Running create-virtualenv step. 19:19:15 INFO - ##### 19:19:15 INFO - Running pre-action listener: _resource_record_pre_action 19:19:15 INFO - Running main action method: create_virtualenv 19:19:15 INFO - Creating virtualenv /builds/slave/test/build/venv 19:19:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:19:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:19:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:19:15 INFO - Using real prefix '/usr' 19:19:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:19:16 INFO - Installing distribute.............................................................................................................................................................................................done. 19:19:18 INFO - Installing pip.................done. 19:19:18 INFO - Return code: 0 19:19:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:19: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')]} 19:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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')]} 19:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2681180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f3b0>, '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 0x26802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2680740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:19:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:19:18 INFO - Using env: {'DISPLAY': ':0', 19:19:18 INFO - 'HOME': '/home/cltbld', 19:19:18 INFO - 'LANG': 'en_US.UTF-8', 19:19:18 INFO - 'LANGUAGE': 'en_US:en', 19:19:18 INFO - 'LOGNAME': 'cltbld', 19:19:18 INFO - 'MAIL': '/var/mail/cltbld', 19:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:18 INFO - 'MOZ_NO_REMOTE': '1', 19:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:18 INFO - 'NO_EM_RESTART': '1', 19:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:18 INFO - 'PWD': '/builds/slave/test', 19:19:18 INFO - 'SHELL': '/bin/bash', 19:19:18 INFO - 'SHLVL': '1', 19:19:18 INFO - 'TERM': 'linux', 19:19:18 INFO - 'TMOUT': '86400', 19:19:18 INFO - 'USER': 'cltbld', 19:19:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 19:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:18 INFO - '_': '/tools/buildbot/bin/python'} 19:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:19:18 INFO - Cleaning up... 19:19:18 INFO - Return code: 0 19:19:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:19: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')]} 19:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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')]} 19:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2681180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f3b0>, '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 0x26802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2680740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:19:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:19:18 INFO - Using env: {'DISPLAY': ':0', 19:19:18 INFO - 'HOME': '/home/cltbld', 19:19:18 INFO - 'LANG': 'en_US.UTF-8', 19:19:18 INFO - 'LANGUAGE': 'en_US:en', 19:19:18 INFO - 'LOGNAME': 'cltbld', 19:19:18 INFO - 'MAIL': '/var/mail/cltbld', 19:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:18 INFO - 'MOZ_NO_REMOTE': '1', 19:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:18 INFO - 'NO_EM_RESTART': '1', 19:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:18 INFO - 'PWD': '/builds/slave/test', 19:19:18 INFO - 'SHELL': '/bin/bash', 19:19:18 INFO - 'SHLVL': '1', 19:19:18 INFO - 'TERM': 'linux', 19:19:18 INFO - 'TMOUT': '86400', 19:19:18 INFO - 'USER': 'cltbld', 19:19:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 19:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:18 INFO - '_': '/tools/buildbot/bin/python'} 19:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:18 INFO - Downloading/unpacking psutil>=3.1.1 19:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:19:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:19:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:19:20 INFO - Installing collected packages: psutil 19:19:20 INFO - Running setup.py install for psutil 19:19:20 INFO - building 'psutil._psutil_linux' extension 19:19:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:19:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:19:20 INFO - building 'psutil._psutil_posix' extension 19:19:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:19:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:19:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:19:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:19:21 INFO - Successfully installed psutil 19:19:21 INFO - Cleaning up... 19:19:21 INFO - Return code: 0 19:19:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2681180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f3b0>, '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 0x26802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2680740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:19:21 INFO - Using env: {'DISPLAY': ':0', 19:19:21 INFO - 'HOME': '/home/cltbld', 19:19:21 INFO - 'LANG': 'en_US.UTF-8', 19:19:21 INFO - 'LANGUAGE': 'en_US:en', 19:19:21 INFO - 'LOGNAME': 'cltbld', 19:19:21 INFO - 'MAIL': '/var/mail/cltbld', 19:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:21 INFO - 'MOZ_NO_REMOTE': '1', 19:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:21 INFO - 'NO_EM_RESTART': '1', 19:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:21 INFO - 'PWD': '/builds/slave/test', 19:19:21 INFO - 'SHELL': '/bin/bash', 19:19:21 INFO - 'SHLVL': '1', 19:19:21 INFO - 'TERM': 'linux', 19:19:21 INFO - 'TMOUT': '86400', 19:19:21 INFO - 'USER': 'cltbld', 19:19:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 19:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:21 INFO - '_': '/tools/buildbot/bin/python'} 19:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:19:23 INFO - Installing collected packages: mozsystemmonitor 19:19:23 INFO - Running setup.py install for mozsystemmonitor 19:19:23 INFO - Successfully installed mozsystemmonitor 19:19:23 INFO - Cleaning up... 19:19:23 INFO - Return code: 0 19:19:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:23 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 0x23c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2681180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f3b0>, '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 0x26802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2680740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:19:23 INFO - Using env: {'DISPLAY': ':0', 19:19:23 INFO - 'HOME': '/home/cltbld', 19:19:23 INFO - 'LANG': 'en_US.UTF-8', 19:19:23 INFO - 'LANGUAGE': 'en_US:en', 19:19:23 INFO - 'LOGNAME': 'cltbld', 19:19:23 INFO - 'MAIL': '/var/mail/cltbld', 19:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:23 INFO - 'MOZ_NO_REMOTE': '1', 19:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:23 INFO - 'NO_EM_RESTART': '1', 19:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:23 INFO - 'PWD': '/builds/slave/test', 19:19:23 INFO - 'SHELL': '/bin/bash', 19:19:23 INFO - 'SHLVL': '1', 19:19:23 INFO - 'TERM': 'linux', 19:19:23 INFO - 'TMOUT': '86400', 19:19:23 INFO - 'USER': 'cltbld', 19:19:23 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 19:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:23 INFO - '_': '/tools/buildbot/bin/python'} 19:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:23 INFO - Downloading/unpacking jsonschema==2.5.1 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:19:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19:25 INFO - Downloading functools32-3.2.3-2.tar.gz 19:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:19:25 INFO - warning: no files found matching '*.txt' 19:19:25 INFO - no previously-included directories found matching 'build' 19:19:25 INFO - no previously-included directories found matching 'dist' 19:19:25 INFO - no previously-included directories found matching '.git*' 19:19:25 INFO - Installing collected packages: jsonschema, functools32 19:19:26 INFO - Running setup.py install for functools32 19:19:26 INFO - warning: no files found matching '*.txt' 19:19:26 INFO - no previously-included directories found matching 'build' 19:19:26 INFO - no previously-included directories found matching 'dist' 19:19:26 INFO - no previously-included directories found matching '.git*' 19:19:26 INFO - Successfully installed jsonschema functools32 19:19:26 INFO - Cleaning up... 19:19:26 INFO - Return code: 0 19:19:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2681180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f3b0>, '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 0x26802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2680740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:19:26 INFO - Using env: {'DISPLAY': ':0', 19:19:26 INFO - 'HOME': '/home/cltbld', 19:19:26 INFO - 'LANG': 'en_US.UTF-8', 19:19:26 INFO - 'LANGUAGE': 'en_US:en', 19:19:26 INFO - 'LOGNAME': 'cltbld', 19:19:26 INFO - 'MAIL': '/var/mail/cltbld', 19:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:26 INFO - 'MOZ_NO_REMOTE': '1', 19:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:26 INFO - 'NO_EM_RESTART': '1', 19:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:26 INFO - 'PWD': '/builds/slave/test', 19:19:26 INFO - 'SHELL': '/bin/bash', 19:19:26 INFO - 'SHLVL': '1', 19:19:26 INFO - 'TERM': 'linux', 19:19:26 INFO - 'TMOUT': '86400', 19:19:26 INFO - 'USER': 'cltbld', 19:19:26 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 19:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:26 INFO - '_': '/tools/buildbot/bin/python'} 19:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:26 INFO - Downloading/unpacking blobuploader==1.2.4 19:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:28 INFO - Downloading blobuploader-1.2.4.tar.gz 19:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:19:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:19:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19:29 INFO - Downloading docopt-0.6.1.tar.gz 19:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:19:29 INFO - Installing collected packages: blobuploader, requests, docopt 19:19:29 INFO - Running setup.py install for blobuploader 19:19:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:19:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:19:29 INFO - Running setup.py install for requests 19:19:29 INFO - Running setup.py install for docopt 19:19:29 INFO - Successfully installed blobuploader requests docopt 19:19:29 INFO - Cleaning up... 19:19:29 INFO - Return code: 0 19:19:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2681180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f3b0>, '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 0x26802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2680740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:19:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:19:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:19:29 INFO - Using env: {'DISPLAY': ':0', 19:19:29 INFO - 'HOME': '/home/cltbld', 19:19:29 INFO - 'LANG': 'en_US.UTF-8', 19:19:29 INFO - 'LANGUAGE': 'en_US:en', 19:19:29 INFO - 'LOGNAME': 'cltbld', 19:19:29 INFO - 'MAIL': '/var/mail/cltbld', 19:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:29 INFO - 'MOZ_NO_REMOTE': '1', 19:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:29 INFO - 'NO_EM_RESTART': '1', 19:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:29 INFO - 'PWD': '/builds/slave/test', 19:19:29 INFO - 'SHELL': '/bin/bash', 19:19:29 INFO - 'SHLVL': '1', 19:19:29 INFO - 'TERM': 'linux', 19:19:29 INFO - 'TMOUT': '86400', 19:19:29 INFO - 'USER': 'cltbld', 19:19:29 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 19:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:29 INFO - '_': '/tools/buildbot/bin/python'} 19:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:19:29 INFO - Running setup.py (path:/tmp/pip-KuXnKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:19:30 INFO - Running setup.py (path:/tmp/pip-nNUjri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:19:30 INFO - Running setup.py (path:/tmp/pip-TCMBZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:19:30 INFO - Running setup.py (path:/tmp/pip-fdAuwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:19:30 INFO - Running setup.py (path:/tmp/pip-L2_neV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:19:30 INFO - Running setup.py (path:/tmp/pip-G8SB1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:19:30 INFO - Running setup.py (path:/tmp/pip-gLg7IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:19:30 INFO - Running setup.py (path:/tmp/pip-KbQwkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:19:30 INFO - Running setup.py (path:/tmp/pip-xVFR8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:19:30 INFO - Running setup.py (path:/tmp/pip-6caHBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:19:30 INFO - Running setup.py (path:/tmp/pip-a_AweD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:19:30 INFO - Running setup.py (path:/tmp/pip-ciq563-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:19:30 INFO - Running setup.py (path:/tmp/pip-roKmzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:19:30 INFO - Running setup.py (path:/tmp/pip-FnSJgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:30 INFO - Running setup.py (path:/tmp/pip-KxrqAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:19:31 INFO - Running setup.py (path:/tmp/pip-3PyBnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:19:31 INFO - Running setup.py (path:/tmp/pip-5iZ0B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:19:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:19:31 INFO - Running setup.py install for manifestparser 19:19:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:19:31 INFO - Running setup.py install for mozcrash 19:19:31 INFO - Running setup.py install for mozdebug 19:19:31 INFO - Running setup.py install for mozdevice 19:19:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:19:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:19:31 INFO - Running setup.py install for mozfile 19:19:31 INFO - Running setup.py install for mozhttpd 19:19:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:19:31 INFO - Running setup.py install for mozinfo 19:19:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:19:31 INFO - Running setup.py install for mozInstall 19:19:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:19:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:19:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:19:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:19:32 INFO - Running setup.py install for mozleak 19:19:32 INFO - Running setup.py install for mozlog 19:19:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:19:32 INFO - Running setup.py install for moznetwork 19:19:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:19:32 INFO - Running setup.py install for mozprocess 19:19:32 INFO - Running setup.py install for mozprofile 19:19:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:19:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:19:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:19:32 INFO - Running setup.py install for mozrunner 19:19:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:19:32 INFO - Running setup.py install for mozscreenshot 19:19:32 INFO - Running setup.py install for moztest 19:19:32 INFO - Running setup.py install for mozversion 19:19:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:19:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:19:33 INFO - Cleaning up... 19:19:33 INFO - Return code: 0 19:19:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2681180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f3b0>, '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 0x26802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2680740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:19:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:19:33 INFO - Using env: {'DISPLAY': ':0', 19:19:33 INFO - 'HOME': '/home/cltbld', 19:19:33 INFO - 'LANG': 'en_US.UTF-8', 19:19:33 INFO - 'LANGUAGE': 'en_US:en', 19:19:33 INFO - 'LOGNAME': 'cltbld', 19:19:33 INFO - 'MAIL': '/var/mail/cltbld', 19:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:33 INFO - 'MOZ_NO_REMOTE': '1', 19:19:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:33 INFO - 'NO_EM_RESTART': '1', 19:19:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:33 INFO - 'PWD': '/builds/slave/test', 19:19:33 INFO - 'SHELL': '/bin/bash', 19:19:33 INFO - 'SHLVL': '1', 19:19:33 INFO - 'TERM': 'linux', 19:19:33 INFO - 'TMOUT': '86400', 19:19:33 INFO - 'USER': 'cltbld', 19:19:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 19:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:33 INFO - '_': '/tools/buildbot/bin/python'} 19:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:19:33 INFO - Running setup.py (path:/tmp/pip-Ik2vzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:19:33 INFO - Running setup.py (path:/tmp/pip-FIM24H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:19:33 INFO - Running setup.py (path:/tmp/pip-g4FUdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:19:33 INFO - Running setup.py (path:/tmp/pip-uQHjVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:19:33 INFO - Running setup.py (path:/tmp/pip-vLhcwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:19:33 INFO - Running setup.py (path:/tmp/pip-w_di5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:19:33 INFO - Running setup.py (path:/tmp/pip-RspyI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:19:33 INFO - Running setup.py (path:/tmp/pip-HH7ZYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:19:33 INFO - Running setup.py (path:/tmp/pip-TWHkgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:19:33 INFO - Running setup.py (path:/tmp/pip-yvHyCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:19:33 INFO - Running setup.py (path:/tmp/pip-Kg2iiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:19:34 INFO - Running setup.py (path:/tmp/pip-STILPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:19:34 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)) 19:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:19:34 INFO - Running setup.py (path:/tmp/pip-wYisNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:19:34 INFO - Running setup.py (path:/tmp/pip-gKA4PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:19:34 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)) 19:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:34 INFO - Running setup.py (path:/tmp/pip-LBNZtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:19:34 INFO - Running setup.py (path:/tmp/pip-dzM7PU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:19:34 INFO - Running setup.py (path:/tmp/pip-KFI5JU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:19:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:36 INFO - Downloading blessings-1.6.tar.gz 19:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:19:36 INFO - Installing collected packages: blessings 19:19:36 INFO - Running setup.py install for blessings 19:19:36 INFO - Successfully installed blessings 19:19:36 INFO - Cleaning up... 19:19:36 INFO - Return code: 0 19:19:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:19:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:19:36 INFO - Reading from file tmpfile_stdout 19:19:36 INFO - Current package versions: 19:19:36 INFO - argparse == 1.2.1 19:19:36 INFO - blessings == 1.6 19:19:36 INFO - blobuploader == 1.2.4 19:19:36 INFO - docopt == 0.6.1 19:19:36 INFO - functools32 == 3.2.3-2 19:19:36 INFO - jsonschema == 2.5.1 19:19:36 INFO - manifestparser == 1.1 19:19:36 INFO - mozInstall == 1.12 19:19:36 INFO - mozcrash == 0.17 19:19:36 INFO - mozdebug == 0.1 19:19:36 INFO - mozdevice == 0.48 19:19:36 INFO - mozfile == 1.2 19:19:36 INFO - mozhttpd == 0.7 19:19:36 INFO - mozinfo == 0.9 19:19:36 INFO - mozleak == 0.1 19:19:36 INFO - mozlog == 3.2 19:19:36 INFO - moznetwork == 0.27 19:19:36 INFO - mozprocess == 0.23 19:19:36 INFO - mozprofile == 0.28 19:19:36 INFO - mozrunner == 6.12 19:19:36 INFO - mozscreenshot == 0.1 19:19:36 INFO - mozsystemmonitor == 0.3 19:19:36 INFO - moztest == 0.7 19:19:36 INFO - mozversion == 1.4 19:19:36 INFO - psutil == 3.1.1 19:19:36 INFO - requests == 1.2.3 19:19:36 INFO - wsgiref == 0.1.2 19:19:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2681180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f3b0>, '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 0x26802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2680740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:19:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:19:36 INFO - Using env: {'DISPLAY': ':0', 19:19:36 INFO - 'HOME': '/home/cltbld', 19:19:36 INFO - 'LANG': 'en_US.UTF-8', 19:19:36 INFO - 'LANGUAGE': 'en_US:en', 19:19:36 INFO - 'LOGNAME': 'cltbld', 19:19:36 INFO - 'MAIL': '/var/mail/cltbld', 19:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:36 INFO - 'MOZ_NO_REMOTE': '1', 19:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:36 INFO - 'NO_EM_RESTART': '1', 19:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:36 INFO - 'PWD': '/builds/slave/test', 19:19:36 INFO - 'SHELL': '/bin/bash', 19:19:36 INFO - 'SHLVL': '1', 19:19:36 INFO - 'TERM': 'linux', 19:19:36 INFO - 'TMOUT': '86400', 19:19:36 INFO - 'USER': 'cltbld', 19:19:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 19:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:36 INFO - '_': '/tools/buildbot/bin/python'} 19:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:19:37 INFO - Cleaning up... 19:19:37 INFO - Return code: 0 19:19:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:19: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')]} 19:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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')]} 19:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2681180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f3b0>, '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 0x26802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2680740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:19:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:19:37 INFO - Using env: {'DISPLAY': ':0', 19:19:37 INFO - 'HOME': '/home/cltbld', 19:19:37 INFO - 'LANG': 'en_US.UTF-8', 19:19:37 INFO - 'LANGUAGE': 'en_US:en', 19:19:37 INFO - 'LOGNAME': 'cltbld', 19:19:37 INFO - 'MAIL': '/var/mail/cltbld', 19:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:37 INFO - 'MOZ_NO_REMOTE': '1', 19:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:37 INFO - 'NO_EM_RESTART': '1', 19:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:37 INFO - 'PWD': '/builds/slave/test', 19:19:37 INFO - 'SHELL': '/bin/bash', 19:19:37 INFO - 'SHLVL': '1', 19:19:37 INFO - 'TERM': 'linux', 19:19:37 INFO - 'TMOUT': '86400', 19:19:37 INFO - 'USER': 'cltbld', 19:19:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 19:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:37 INFO - '_': '/tools/buildbot/bin/python'} 19:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:19:37 INFO - Cleaning up... 19:19:37 INFO - Return code: 0 19:19:37 INFO - Running post-action listener: _resource_record_post_action 19:19:37 INFO - Running post-action listener: _start_resource_monitoring 19:19:37 INFO - Starting resource monitoring. 19:19:37 INFO - ##### 19:19:37 INFO - ##### Finished create-virtualenv step (success) 19:19:37 INFO - ##### 19:19:37 INFO - ##### 19:19:37 INFO - ##### Running install step. 19:19:37 INFO - ##### 19:19:37 INFO - Running pre-action listener: _resource_record_pre_action 19:19:37 INFO - Running main action method: install 19:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:19:37 INFO - Reading from file tmpfile_stdout 19:19:37 INFO - Detecting whether we're running mozinstall >=1.0... 19:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:19:37 INFO - Reading from file tmpfile_stdout 19:19:37 INFO - Output received: 19:19:37 INFO - Usage: mozinstall [options] installer 19:19:37 INFO - Options: 19:19:37 INFO - -h, --help show this help message and exit 19:19:37 INFO - -d DEST, --destination=DEST 19:19:37 INFO - Directory to install application into. [default: 19:19:37 INFO - "/builds/slave/test"] 19:19:37 INFO - --app=APP Application being installed. [default: firefox] 19:19:37 INFO - mkdir: /builds/slave/test/build/application 19:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:19:54 INFO - Reading from file tmpfile_stdout 19:19:54 INFO - Output received: 19:19:54 INFO - /builds/slave/test/build/application/firefox/firefox 19:19:54 INFO - Running post-action listener: _resource_record_post_action 19:19:54 INFO - ##### 19:19:54 INFO - ##### Finished install step (success) 19:19:54 INFO - ##### 19:19:54 INFO - ##### 19:19:54 INFO - ##### Running run-tests step. 19:19:54 INFO - ##### 19:19:54 INFO - Running pre-action listener: _resource_record_pre_action 19:19:54 INFO - Running main action method: run_tests 19:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:19:54 INFO - Python 2.7.3 19:19:54 INFO - Return code: 0 19:19:54 INFO - grabbing minidump binary from tooltool 19:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f3b0>, '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 0x26802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2680740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:19:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:19:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:19:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:19:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:19:54 INFO - Return code: 0 19:19:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:19:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:19:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:19:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:19:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:19:54 INFO - Using env: {'DISPLAY': ':0', 19:19:54 INFO - 'HOME': '/home/cltbld', 19:19:54 INFO - 'LANG': 'en_US.UTF-8', 19:19:54 INFO - 'LANGUAGE': 'en_US:en', 19:19:54 INFO - 'LOGNAME': 'cltbld', 19:19:54 INFO - 'MAIL': '/var/mail/cltbld', 19:19:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:19:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:54 INFO - 'MOZ_NO_REMOTE': '1', 19:19:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:54 INFO - 'NO_EM_RESTART': '1', 19:19:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:54 INFO - 'PWD': '/builds/slave/test', 19:19:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:19:54 INFO - 'SHELL': '/bin/bash', 19:19:54 INFO - 'SHLVL': '1', 19:19:54 INFO - 'TERM': 'linux', 19:19:54 INFO - 'TMOUT': '86400', 19:19:54 INFO - 'USER': 'cltbld', 19:19:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427', 19:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:54 INFO - '_': '/tools/buildbot/bin/python'} 19:19:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:19:55 INFO - mozversion application_buildid: 20160718163032 19:19:55 INFO - mozversion application_changeset: feaaf1af1065257b9178faca8b67eed9657b4a17 19:19:55 INFO - mozversion application_display_name: Nightly 19:19:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:19:55 INFO - mozversion application_name: Firefox 19:19:55 INFO - mozversion application_remotingname: firefox 19:19:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:19:55 INFO - mozversion application_vendor: Mozilla 19:19:55 INFO - mozversion application_version: 50.0a1 19:19:55 INFO - mozversion platform_buildid: 20160718163032 19:19:55 INFO - mozversion platform_changeset: feaaf1af1065257b9178faca8b67eed9657b4a17 19:19:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:19:55 INFO - mozversion platform_version: 50.0a1 19:19:55 INFO - using testdate: 1468894795 19:19:55 INFO - actual date: 1468894795 19:19:55 INFO - starting webserver on 'localhost:54013' 19:19:55 INFO - SUITE-START | Running 2 tests 19:19:55 INFO - TEST-START | dromaeo_css 19:19:55 INFO - operating with platform_type : linux_ 19:19:55 INFO - Initialising browser for dromaeo_css test... 19:19:55 INFO - TEST-INFO | started process 14574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb700z3/profile http://localhost:54013/getInfo.html) 19:19:59 INFO - PROCESS | 14574 | __metrics Screen width/height:1600/1200 19:19:59 INFO - PROCESS | 14574 | colorDepth:24 19:19:59 INFO - PROCESS | 14574 | Browser inner width/height: 1024/697 19:19:59 INFO - PROCESS | 14574 | __metrics 19:20:00 INFO - PROCESS | 14574 | 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" 19:20:00 INFO - PROCESS | 14574 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:20:01 INFO - TEST-INFO | 14574: exit 0 19:20:01 INFO - Browser initialized. 19:20:01 INFO - Running cycle 1/1 for dromaeo_css test... 19:20:01 INFO - TEST-INFO | started process 14656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb700z3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:20:13 INFO - PROCESS | 14656 | RSS: Main: 157929472 19:20:13 INFO - PROCESS | 14656 | 19:21:04 INFO - PROCESS | 14656 | 1468894864588 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:23:12 INFO - PROCESS | 14656 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54013/tests/dromaeo/cssquery-ext.html) 19:23:13 INFO - PROCESS | 14656 | RSS: Main: 268750848 19:23:13 INFO - PROCESS | 14656 | 19:26:16 INFO - PROCESS | 14656 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-ext.html (next: http://localhost:54013/tests/dromaeo/cssquery-jquery.html) 19:26:16 INFO - PROCESS | 14656 | RSS: Main: 249176064 19:26:16 INFO - PROCESS | 14656 | 19:29:18 INFO - PROCESS | 14656 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54013/tests/dromaeo/cssquery-mootools.html) 19:29:19 INFO - PROCESS | 14656 | RSS: Main: 248692736 19:29:19 INFO - PROCESS | 14656 | 19:32:21 INFO - PROCESS | 14656 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54013/tests/dromaeo/cssquery-prototype.html) 19:32:21 INFO - PROCESS | 14656 | RSS: Main: 237821952 19:32:21 INFO - PROCESS | 14656 | 19:35:24 INFO - PROCESS | 14656 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54013/tests/dromaeo/cssquery-yui.html) 19:35:25 INFO - PROCESS | 14656 | RSS: Main: 228638720 19:35:25 INFO - PROCESS | 14656 | 19:38:28 INFO - PROCESS | 14656 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-yui.html (next: http://localhost:54013/tests/dromaeo/cssquery-dojo.html) 19:38:28 INFO - PROCESS | 14656 | RSS: Main: 279273472 19:38:28 INFO - PROCESS | 14656 | 19:38:28 INFO - PROCESS | 14656 | __start_tp_report 19:38:28 INFO - PROCESS | 14656 | _x_x_mozilla_page_load 19:38:28 INFO - PROCESS | 14656 | _x_x_mozilla_page_load_details 19:38:28 INFO - PROCESS | 14656 | |i|pagename|runs| 19:38:28 INFO - PROCESS | 14656 | |0;dojo.html;3037.1344166912436;3042.2698552347438;3085.059056987618;3092.2733157707935;3103.8758449662014;5140;5183.948160518394;5289.259503669489;5345.572354211664;5353.14349704047;5246.842594722155;5295.205719142131;5305.495977882095;5328.813491527797;5339.599530035243;4777.784999675015;4847.733374664392;4859.173940430118;4870.951290487085;4974.477679843619;4910.705357678533;4918.950810491885;4923.630727695419;4980.477049909761;5001.049800537904;4784.736839473828;4797.90404191916;4817.807287708488;4837.661363704525;4864.100141473803;4794.424669039703;4828;4838.056578967103;4852.296417019547;4896.387951506062;4848.830290939835;4872.244802055687;4876.561109500127;4877.561019508261;4881.170201065827;5232.215167724834;5253.711045892474;5330.173823057394;5376.4085950545405;5412.56699464042;5751.654900705971;5774.133879918004;5787.074068149118;5800.680962547058;5807.912881306784;5482.890342193174;5789.363170051291;5833.562482813763;5840.561957853178;5844.912326315109;5323.920141197885;5368.8389348319615;5383.730813459311;5446.972765136188;5464.726763661881;5951.523878089829;5963.344032156459;5964.582479226413;5966.671833049224;5970.283565972111;5494.532964697965;5531.308586426697;5654.46282603152;5697.686627235542;5705.144228365695;5641.294838145232;5686.744096515667;5688.288963879515;5691.77232910679;5694.857628559319;5684.7157642118555;5697.857553561112;5700.087985922232;5712.714364281769;5726.226959360433;5693.829185124453;5738.311402631711;5743;5745.339285982165;5783.4794868461195;4379.4525684289465;4384.714993525411;4388.71473354231;4389.100234451994;4425.336199570091;3851.326017946904;3859.0931131184147;3914.3149948758855;3929.174873276644;3935.4883865097354;5368.463153684678;5371.194320851903;5374.274472946102;5379.67721936685;5428.864278392993;5782.913256301159;5784.363719990798;5785.566082543742;5819;5832.825015249549;5256.763445644879;5375.596830237748;5398.028354896078;5414.052540805344;5434.103372943499;4967.3542439482635;4970.329005584272;4973.577245934136;4974.626902982291;5016.0971025215085;5679.545636349082;5922.200502932135;5929.851753706105;5932.466078052909;5937.435943585352;5656.066748986371;5680.4319568042865;5716.342620598518;5751.137329400456;5756.280464941882;5880.323762767336;5888.970555147197;5891.469767720926;5903.026000709835;5908.3796201399955;5440.619156658996;5631.7184140793615;5636.520895723909;5649.152627105803;5649.830505084854;5667.489925906688;5705.942940570541;5726.770929162787;5739.770409183586;5748;5570.777168913198;5612.074007788832;5618.7190640467;5620.74706638194;5624.100143976944;5309.867253318698;5456.154296084113;5579.414161512983;5622.662640241435;5645.350784659817;5532.612717109924;5554.305711786027;5555.916596263852;5568.94190103879;5614.85962850932;5574.888502230014;5614.831555053355;5614.989301925692;5662.716864156693;5668.149777533403;5420.593455490775;5462.890742185214;5469.808556700496;5492.505674489315;5500.064988951968 19:38:28 INFO - PROCESS | 14656 | |1;ext.html;588.4351023017903;628.8899442597545;638.1608185236414;648.7761722205837;661.2759028863398;31193;44279.55720442795;44904.1019179617;45033.32450013253;45062.774686126606;46701.766491167495;47208.52791472084;47218.52781472184;47247.29129063067;47256.291155632694;9135.81728365434;9260.629574817;9281.118293762116;9293.907060929405;9304.62781488743;9118.224950879183;9195.816083678323;9202.861957070649;9209.309301802357;9211.861822072675;9237.676681316156;9302.86045709315;9306.208972237368;9309.767255818591;9315.487648179347;9244.16802487776;9281.860772088425;9295.349325547215;9301.488418137;9301.767455813591;9106.180443760028;9113.134252246025;9184.219341355993;9187.67843125494;9201.861972070425;43758;43975.340369894475;44140.55859441397;44153.77923110396;44171.77914110409;3423.5720534933134;3507.7719948203285;3548.6628770266784;3565.3047655707146;3574.660407261306;33558.3288334232;33611.32777344464;34028.31943361119;34632;35583;3654.5614526256754;3697.3159965406485;3751.118487155516;3755.6244375562223;3826.0626146594263;374066;374402;375161;376690;376822;57385.42614573884;57430.138547921815;57751.711241443525;57799.711001444724;57840;54077.45922540803;55284;55315.72342138264;58974.11538826921;60951.08573371403;14589.85410145885;15526.689466210613;15572;16078.678426431406;16109.516714498584;12090.335031573171;12180.878191218151;12181.573644922386;12183.390830458442;12191.634250972485;14356;14702.191379474018;14723.779143312859;15939.362425503083;16098.597535061717;5429.809956651498;6765.42493888025;6893.862122757517;6914.2637293454145;6930.861382772317;1007.5919252702668;1034.6637342863598;1118.4743170709753;1132.932024078558;1195.713028873064;32810.67189328076;33022.17444563905;33070.338593228;33546;34237;1080.9135269178446;1094.3543309447464;1144.6337172104847;1174.5947648061406;1278.5908509277128;17460.30158793634;17592.824071759118;17663.73504397435;17696;17705.29178832858;157926;158147;158424;158571;158610;60524.697376513715;60671;60691;60723.69638151869;60747.69626151841;1347.615929460099;1398.8181536400407;1408.5985494134327;1409.1122592766492;1422.3172877018883;32163.67836321607;33321.667133315364;33407.164820879676;33435.33129337351;33878;51350.22974655309;51661.22508162456;51679.22481162861;51733.7413312931;51859.481405186976;442330;442881;443203;444370;444997;40635;41865.58134418617;42729.572704272556;42829.571704282556;42884.571154289304;49040.75479622579;49345;49392.753036234586;49966.25050624171;50301.496985029684;41388.37917431301;42370.15259694851;42613.57386426096;42825;43463.56536434595;41875;41895.7905210472;41902;42476.78761606172;43449;41914.58085419229;42321.365179522945;42419.363709543766;42859.57140428556;43130.353044704985;35280;36544.45183322199;37246.88259352224;37354.252914942095;37826.24347513089;28349.716502835534;28707.712922870505;29015.56476652894;29063.418731625672;29138.56292155662 19:38:28 INFO - PROCESS | 14656 | |2;jquery.html;370.68862155789134;395.3042644944898;397.66993395481774;403.0769537758533;410.50944121774484;14528.418863245472;17304.48086557402;19583;19905.104270307835;19931.501712457215;18327.450176494694;18389.26442942281;18564.814351856476;18604.255829766826;18616.627667446675;4200.201961627281;5622.8313150605445;5815.82552523425;5816.302043754734;5831;6232.345603711613;6582.341765823403;6601.306862779411;6665.533412661116;6668.333166683341;6297.3387794281625;6485.448736857373;6502.7724029658975;6516.869662606745;6618.503612229102;6358.237011558643;6540.345965403493;6565.212174539038;6579.835504112388;6625.17185351831;5769.1923130761725;5805.36141024487;5807.128930660435;5814.651120932757;5815.709214539256;23872.64191037136;24234.15180468675;24506.387340316636;25067.498650026897;25122.874385628136;2242.2824696097255;2392.114917480526;2401.219603628828;2428.611422172444;3048.8719173905574;14292.499762508261;14425.927870360685;15306.770398444032;15784.842151578567;15972.201389930573;1931.5364312565023;1952.4142757172933;1961.1861077652757;1964.4499540128786;2024.9696254556193;85612;87962.5601871993;88116;88392.5580372094;88586.55706721489;11127.499262533205;11333.376664283378;11370.31778093317;11462.713432164262;11495.770084598262;15973.361065557248;15990.840091598935;16059.518214453585;16078.276477558538;16079.839201608069;7701.961490192513;7855.567943763148;7885.723999659985;7944.285014348737;7986.081600616004;7268.745593904188;7303.831386978058;7325.4139668826365;7410.962945185347;7467.3652739516665;4891.877703057381;4914.213725803854;4926.8768280793265;4950.094213727741;5037.269595908646;1986.8673159827813;1992.8804271743743;2008.136501304424;2035.1757538197053;2043.1929387891996;809.0978558906777;836.4730219961507;850.3154960257052;949.2832911152036;1008.2287050406445;17048.31806727717;17353;17407.303707851544;17523.211455484277;17709.114544272736;946.9309558614312;954.9809003819885;977.2231076294363;977.4184360305607;978.8629591857145;10885.945570272099;11348.571827572045;11377.37424441647;11452.54189832414;11516.596919107958;593873;599755;601104;605816;608616;65214.673926630065;72055;77381;98834.5058274704;101469.49265253627;1003.4330603209163;1003.8142943555465;1040.0587468341164;1040.0847254416065;1047.0785708576404;18728.625427491646;18815.811841881405;19081.618367632847;19104.33134840274;19308.903455482632;39865.601343986185;40894.182116358104;43433.78283108691;44107.33838992482;44643.55356446394;61515;62295.377046228954;62621;62751;63381.683091584244;8571.4000019998;8650.178233067849;8688.304935605263;8747.65009399617;8835.779105522157;9685.806283874143;13407.195568265935;13782.86217137856;13800.861991379958;13867.514636987657;11055.944720276348;11201.775964480828;11278.830817537908;11281.43592820372;11455.427228638702;10840.211365124665;11035.944820275847;11194.944025279821;11219.326840389604;11504.654860354203;11483.138764592522;11530;11650.30098194111;11701.473433695333;11711.1802173847;8671.523066231166;8724.738257852274;8763.693270735494;8775.385722999328;8874.600642970952;8837;11197.328160310408;11313.321200727984;11461.140414468782;11564.595239166589 19:38:28 INFO - PROCESS | 14656 | |3;mootools.html;1495.499007832376;1536.331695712365;1678.9328426862926;1775.1213149491005;1814.582645991422;8364.749057528275;8875.112488751121;8893.155150260724;8896.243819275362;8902.376833621649;7660.463767536275;8354.791130221747;8458.32333413327;8497.1502849715;8803.075677053914;2362.066983541504;2390.7011623547055;2394.5450364430703;2394.844335118212;2402.7717366850206;2337.7895989360954;2347.4600841806396;2382.0352757133387;2386.2125498585424;2392.4138586046442;2090.25795842476;2278.7949084582383;2348.8942997565064;2363.8108951283857;2381.4879800842814;2338.754430784769;2352.8117750579913;2369.099742098009;2371.703537057868;2385.9284221473386;2349.588821956168;2350.9647355289685;2352.5765362234793;2356.057576969209;2358.988205058981;8984.505852178192;9020.143086406846;9028.77428064297;9045.638174473013;9049;4998.300237966688;5172.793088276464;5224.582033437354;5245.1869960155855;5256.342957130359;3357.1271469417884;3457.3258214648154;3506.4389697648253;3519.7008254298416;3534.169470174507;1119.8264269038311;1141.746147474722;1155.3299086529792;1158.3165932100017;1161.163961947405;12400.069994750429;12400.503979840796;12406.565770198;12410;12416.317102559356;4394.978025109854;4566.315052742115;4643.628509719282;4713.080949214938;4732.0772449372735;10300.948495257475;10304.072633463024;10304.690859274233;10310.587576496857;10320.277580569438;5311.256424100629;5323.334583177103;5326.201069839555;5330.360356757214;5332.413434522199;4756.334113224151;4827.155247831685;4844.32179494871;4864.416270047617;4870.561649451566;3874.9806250968563;3934.5278566572197;3943.073377756225;3993.4808474898077;4033.173199494155;1170.2393444261297;1192.5349113845607;1264.2730430002784;1264.6711854917787;1272.6118533847266;828.7555171224383;854.3122786157079;913.0641092879852;1001.8647482589757;1047.1361127070045;6152.600080994721;6188.535859810532;6217.937820621826;6297.149884765589;6363.5863668861375;977.333646133341;978.3396207559869;1029.7425643589104;1034.9223808214263;1055.3193190392153;4054.189162167578;4317.805698743564;4320;4392.428984232093;4415.205263052681;10756.08573271265;11091.611793587186;11208.271462355084;11236.101111911028;11238.606648767254;9654.806903861883;11090.112790976864;11112.16658750597;11121.443927803577;11128.49921753523;7640.388768898475;7939.483933544301;7954.681812727426;8165.673373065011;8167.918320816716;6199.938000620116;6295.779647712308;6383.5212359074185;6417;6419.933163160768;10127.44299063529;10159.339642923187;10300.124489418484;10337.069663729999;10381.221408394249;10329.9483502582;10347.611169799455;10526.368417894952;10527.473626318806;10628.04347608688;7344.8898266524975;7395.18652948186;7457.776266712007;7465.9920910676365;7471.663775130023;8333;8442.746717598482;8460.91539084626;8521.872171917303;8528.658853645784;7531.133919599316;7608.8478230436185;7618.542887426772;7751.496152750054;7752.4573279869865;7542.773716788505;7545.283198096172;7573.129090154703;7627.809304767426;7729.3430058445665;6810.965945170441;7070.151581810215;7098.538594991515;7116.964415177891;7135.464840137114;4965.851024469272;5074.416442109205;5125.1799712045895;5140.794368225229;5239.947600523946;5176.792928282826;5183.170692689152;5253.1088808029845;5442.374126975448;5445.047116754473 19:38:28 INFO - PROCESS | 14656 | |4;prototype.html;324.31083946613444;328.91119397762606;341.6446895228962;343.20205522160967;343.4247635211021;5203.557697595709;5304.575633949285;5314.2560041594115;5369.771544808909;5403.2705584746045;5368.785248590061;5382.757775900084;5388.7305634718305;5392.595555333356;5406.459354064592;4274.358846173076;4278.7218830776055;4285.550017248191;4289.249381358265;4341.761203133827;4023.195360927826;4135.986683262605;4258.7870606469705;4261.573842615745;4270.761479171037;4239.300515414953;4240.851570195044;4248.702590818644;4265.509466411356;4267.679924005696;4247.299195632717;4253.936190957138;4255.936160957588;4270.765107919063;4273.333399973982;3641.4719865619336;3791.374423220165;3798.1074447504816;3804;3833.4249862520564;5196.714180720059;5203.505666961632;5216.921746173811;5233.162693968947;5235.476452354772;4841.837958889876;4844;4859.319695242669;4869.318295438641;4872.439669437989;5273.657212281228;5577.163425486169;5586.888262234733;5595.440455954413;5652.858678533028;4009.8195581198916;4026.503567787961;4040.676745860324;4041.9191616167805;4045.271851066807;5777.468970722762;5808.88382232353;5809.796657116981;5816.534677225812;5872.7063646817915;3969.186316805048;4169.958300416957;4175.728577642443;4180.122174343422;4182.853600124042;4212.936805947913;4219.966108303485;4232.322828347511;4236.978815105905;4250.702450828474;4783.378160839069;4784.564630610803;4821.228603423436;4825.396825396825;4845.685030473008;5524.353926408551;5663.876046482569;5672.858178545487;5683.857903552362;5713.685747283939;1376.986230137706;1425.6507155746701;1440.3086518471193;1454.1057249791513;1462.8975971682094;980.2305190425624;988.7577543501889;1003.8845532763826;1006.0291818395137;1014.4420568687193;5382.461753824587;5384.946150538444;5394.568434525307;5396.379416367089;5422.593305502024;5675.602707810413;5675.943240567624;5691.146328050825;5695.601307908407;5718.7426565804635;5193.078560932479;5365.892682146336;5443.319585051869;5461.644993075437;5465.207544905967;2686.6775986881307;2718.4834881372476;2718.6329845471005;2743.5747459143863;2749.9450010999667;5139.254808052811;5271.1550957165455;5280.81517146898;5306.230596563477;5322.414534401213;5237.554807841376;5593.664380137205;5919;5939.406059394112;5967.433093856077;5970.731317090741;5991.400859914061;5994.062909174473;5996.67018313997;6018.398160183947;5589.031787430969;5790.507806836466;5844.47399734026;5900.468957793819;5903.524118970257;5723.656580605177;5724.942750572441;5728.2266893970445;5756.625819321731;5764.7405866736935;6025.367336429612;6061.333013474057;6063.72713227897;6066.211392518944;6077.179580756541;4058.85785171785;4069.9593004070766;4156.91686166281;4216.283231850532;4226.112516371596;5631.352394474688;5794.913076303943;5877.941220587911;5896.557758168069;5938.524918006636;5504.587155963239;5658.575606829422;5663.603547751618;5666.4333566644655;5706.543476521952;5640.633358831663;5696.515796157373;5698.54411647059;5743.885122297447;5764.6829424380385;5537.907824158928;5567.972160139173;5632.831015069554;5650.389638952879;5655.575831812713;5612.943870561406;5632.915506267491;5638.4925356718095;5638.577106716931;5692.743826527733;5461.481159289861;5558.166275058774;5571.437138916144;5624.915626265692;5643.1535269709875 19:38:28 INFO - PROCESS | 14656 | |5;yui.html;825.8430898129355;837.330135891287;839.9454035487689;845.4124383553433;877.9165979231973;14400.495982640596;15345.769813452807;15350.923245383758;15360.078395296276;15392.153431561259;14623.268836558183;14765.335559899804;14785.556433307018;15817.84182158178;15875.126868022255;678.0778141727247;839.3495041342946;852.1223140165639;852.8251708399763;854.3250831842837;807.7899746066036;845.0957475501216;847.063994286314;847.3052097280232;848.6053984897021;893.696143311274;894.7181637784109;895.6865097215955;895.7536677413731;895.9104089591054;709.9787006389816;858.0904241504026;893.1158153428092;893.3478560650728;893.5175005497024;637.7417146055855;638.9744410223585;641.0512441586478;643.3534298030496;643.6524276890474;16311.102889341082;16381.91809040959;16403.83596164047;16426.096564688938;16435.83564164355;14384.568462946128;14661.780073298909;14710.55868323952;14744.852551474456;14851.2574371281;13591.116577422436;13712.794308085387;13768.793468097987;13842.792358114535;13945.02384833062;4500;4557.088582283556;4618.35343051973;4687.530949787079;4694.554017368345;79705.60147199227;80522.15561677264;80632.59683701544;80669.19330806735;80753.59623201846;11961.64115076549;12009.63971080869;12191.51233950632;12291.323977181162;12360.567380141652;19579.60840783205;19806;19868.801311986983;19914.800851991586;20072.799272007385;8524.038006407483;8601.913980860112;8618.095100014534;8883.42257753244;8932.330075244383;4638.072385522909;4831.4685384607665;4850.902981940341;4877.5366340197625;4977.65156439053;3495.9825200874343;3607.549056367954;3610.981945090258;3621.9637803621627;3624.9275014499563;631.3654776949229;656.8128083496276;691.0498065160405;704.1128178495132;706.3184027413571;571.5399103721461;664.9135612370361;677.5799004617169;692.8809971895353;720.8233982674278;10395.376277423378;10539;10658.147348212124;10862.239643224899;10943.124550035978;585.464300165344;600.6156060121526;655.8917778566483;663.1644128398253;673.7151715092011;4960.917144346056;5223.399309079428;5237.921431178535;5250.606204534599;5254.97372513135;75930.62034689791;118133.4093329545;120863.39568302278;125950;126438;106836;109286;109635;109643;109891;90767.54616227008;93504.53247733854;95427;96390.43314802129;96647.51676241573;9619.615215391306;9830.705078847646;9856.437326295072;9864.632488202637;9968.202543796624;52416;52941.52709066008;53473;53561.73219134035;54158.72920635372;54238;77218.6139069301;77767.61116194383;78171.6091419562;78468.60765696135;11875.346855923008;11970.700732481757;12259.448324825225;12501.499940002663;12894.742105158031;13852.852807814805;14278;14367.13797172173;14433.7834932474;15051.397944082115;12738.745225095632;12752.298623575793;12838.935805320914;12918.418671159632;13283.601491955256;13420.530281440102;13431.798523022358;13474.124181928144;13889.722205556034;14210.147391156564;13237.602871913858;13394.873024435912;13832.170069795844;14022.789658154932;14341.426342946166;10708.464576771286;10807.945960270463;10879.891201087888;11207.887921120684;11274.830877537008;11075.446227688422;11285.887141128484;11468.31190128595;11548.364839933549;11568.305901645928 19:38:28 INFO - PROCESS | 14656 | __end_tp_report 19:38:28 INFO - PROCESS | 14656 | __start_cc_report 19:38:28 INFO - PROCESS | 14656 | _x_x_mozilla_cycle_collect,902 19:38:28 INFO - PROCESS | 14656 | __end_cc_report 19:38:28 INFO - PROCESS | 14656 | __startTimestamp1468895908447__endTimestamp 19:38:28 INFO - PROCESS | 14656 | 19:38:28 INFO - PROCESS | 14656 | ------- Summary: start ------- 19:38:28 INFO - PROCESS | 14656 | Number of tests: 6 19:38:28 INFO - PROCESS | 14656 | 19:38:28 INFO - PROCESS | 14656 | [#0] dojo.html Cycles:165 Average:5314.65 Median:5492.51 stddev:607.86 (11.1%) stddev-sans-first:582.87 19:38:28 INFO - PROCESS | 14656 | Values: 3037.1 3042.3 3085.1 3092.3 3103.9 5140.0 5183.9 5289.3 5345.6 5353.1 5246.8 5295.2 5305.5 5328.8 5339.6 4777.8 4847.7 4859.2 4871.0 4974.5 4910.7 4919.0 4923.6 4980.5 5001.0 4784.7 4797.9 4817.8 4837.7 4864.1 4794.4 4828.0 4838.1 4852.3 4896.4 4848.8 4872.2 4876.6 4877.6 4881.2 5232.2 5253.7 5330.2 5376.4 5412.6 5751.7 5774.1 5787.1 5800.7 5807.9 5482.9 5789.4 5833.6 5840.6 5844.9 5323.9 5368.8 5383.7 5447.0 5464.7 5951.5 5963.3 5964.6 5966.7 5970.3 5494.5 5531.3 5654.5 5697.7 5705.1 5641.3 5686.7 5688.3 5691.8 5694.9 5684.7 5697.9 5700.1 5712.7 5726.2 5693.8 5738.3 5743.0 5745.3 5783.5 4379.5 4384.7 4388.7 4389.1 4425.3 3851.3 3859.1 3914.3 3929.2 3935.5 5368.5 5371.2 5374.3 5379.7 5428.9 5782.9 5784.4 5785.6 5819.0 5832.8 5256.8 5375.6 5398.0 5414.1 5434.1 4967.4 4970.3 4973.6 4974.6 5016.1 5679.5 5922.2 5929.9 5932.5 5937.4 5656.1 5680.4 5716.3 5751.1 5756.3 5880.3 5889.0 5891.5 5903.0 5908.4 5440.6 5631.7 5636.5 5649.2 5649.8 5667.5 5705.9 5726.8 5739.8 5748.0 5570.8 5612.1 5618.7 5620.7 5624.1 5309.9 5456.2 5579.4 5622.7 5645.4 5532.6 5554.3 5555.9 5568.9 5614.9 5574.9 5614.8 5615.0 5662.7 5668.1 5420.6 5462.9 5469.8 5492.5 5500.1 19:38:28 INFO - PROCESS | 14656 | 19:38:28 INFO - PROCESS | 14656 | [#1] ext.html Cycles:180 Average:51334.90 Median:42448.08 stddev:92065.30 (216.9%) stddev-sans-first:92244.72 19:38:28 INFO - PROCESS | 14656 | Values: 588.4 628.9 638.2 648.8 661.3 31193.0 44279.6 44904.1 45033.3 45062.8 46701.8 47208.5 47218.5 47247.3 47256.3 9135.8 9260.6 9281.1 9293.9 9304.6 9118.2 9195.8 9202.9 9209.3 9211.9 9237.7 9302.9 9306.2 9309.8 9315.5 9244.2 9281.9 9295.3 9301.5 9301.8 9106.2 9113.1 9184.2 9187.7 9201.9 43758.0 43975.3 44140.6 44153.8 44171.8 3423.6 3507.8 3548.7 3565.3 3574.7 33558.3 33611.3 34028.3 34632.0 35583.0 3654.6 3697.3 3751.1 3755.6 3826.1 374066.0 374402.0 375161.0 376690.0 376822.0 57385.4 57430.1 57751.7 57799.7 57840.0 54077.5 55284.0 55315.7 58974.1 60951.1 14589.9 15526.7 15572.0 16078.7 16109.5 12090.3 12180.9 12181.6 12183.4 12191.6 14356.0 14702.2 14723.8 15939.4 16098.6 5429.8 6765.4 6893.9 6914.3 6930.9 1007.6 1034.7 1118.5 1132.9 1195.7 32810.7 33022.2 33070.3 33546.0 34237.0 1080.9 1094.4 1144.6 1174.6 1278.6 17460.3 17592.8 17663.7 17696.0 17705.3 157926.0 158147.0 158424.0 158571.0 158610.0 60524.7 60671.0 60691.0 60723.7 60747.7 1347.6 1398.8 1408.6 1409.1 1422.3 32163.7 33321.7 33407.2 33435.3 33878.0 51350.2 51661.2 51679.2 51733.7 51859.5 442330.0 442881.0 443203.0 444370.0 444997.0 40635.0 41865.6 42729.6 42829.6 42884.6 49040.8 49345.0 49392.8 49966.3 50301.5 41388.4 42370.2 42613.6 42825.0 43463.6 41875.0 41895.8 41902.0 42476.8 43449.0 41914.6 42321.4 42419.4 42859.6 43130.4 35280.0 36544.5 37246.9 37354.3 37826.2 28349.7 28707.7 29015.6 29063.4 29138.6 19:38:28 INFO - PROCESS | 14656 | 19:38:28 INFO - PROCESS | 14656 | [#2] jquery.html Cycles:180 Average:32369.21 Median:383.00 stddev:98721.04 (25776.0%) stddev-sans-first:98968.74 19:38:28 INFO - PROCESS | 14656 | Values: 370.7 395.3 397.7 403.1 410.5 14528.4 17304.5 19583.0 19905.1 19931.5 18327.5 18389.3 18564.8 18604.3 18616.6 4200.2 5622.8 5815.8 5816.3 5831.0 6232.3 6582.3 6601.3 6665.5 6668.3 6297.3 6485.4 6502.8 6516.9 6618.5 6358.2 6540.3 6565.2 6579.8 6625.2 5769.2 5805.4 5807.1 5814.7 5815.7 23872.6 24234.2 24506.4 25067.5 25122.9 2242.3 2392.1 2401.2 2428.6 3048.9 14292.5 14425.9 15306.8 15784.8 15972.2 1931.5 1952.4 1961.2 1964.4 2025.0 85612.0 87962.6 88116.0 88392.6 88586.6 11127.5 11333.4 11370.3 11462.7 11495.8 15973.4 15990.8 16059.5 16078.3 16079.8 7702.0 7855.6 7885.7 7944.3 7986.1 7268.7 7303.8 7325.4 7411.0 7467.4 4891.9 4914.2 4926.9 4950.1 5037.3 1986.9 1992.9 2008.1 2035.2 2043.2 809.1 836.5 850.3 949.3 1008.2 17048.3 17353.0 17407.3 17523.2 17709.1 946.9 955.0 977.2 977.4 978.9 10885.9 11348.6 11377.4 11452.5 11516.6 593873.0 599755.0 601104.0 605816.0 608616.0 65214.7 72055.0 77381.0 98834.5 101469.5 1003.4 1003.8 1040.1 1040.1 1047.1 18728.6 18815.8 19081.6 19104.3 19308.9 39865.6 40894.2 43433.8 44107.3 44643.6 61515.0 62295.4 62621.0 62751.0 63381.7 8571.4 8650.2 8688.3 8747.7 8835.8 9685.8 13407.2 13782.9 13800.9 13867.5 11055.9 11201.8 11278.8 11281.4 11455.4 10840.2 11035.9 11194.9 11219.3 11504.7 11483.1 11530.0 11650.3 11701.5 11711.2 8671.5 8724.7 8763.7 8775.4 8874.6 8837.0 11197.3 11313.3 11461.1 11564.6 19:38:28 INFO - PROCESS | 14656 | 19:38:28 INFO - PROCESS | 14656 | [#3] mootools.html Cycles:180 Average:5836.92 Median:4604.97 stddev:3297.28 (71.6%) stddev-sans-first:3290.39 19:38:28 INFO - PROCESS | 14656 | Values: 1495.5 1536.3 1678.9 1775.1 1814.6 8364.7 8875.1 8893.2 8896.2 8902.4 7660.5 8354.8 8458.3 8497.2 8803.1 2362.1 2390.7 2394.5 2394.8 2402.8 2337.8 2347.5 2382.0 2386.2 2392.4 2090.3 2278.8 2348.9 2363.8 2381.5 2338.8 2352.8 2369.1 2371.7 2385.9 2349.6 2351.0 2352.6 2356.1 2359.0 8984.5 9020.1 9028.8 9045.6 9049.0 4998.3 5172.8 5224.6 5245.2 5256.3 3357.1 3457.3 3506.4 3519.7 3534.2 1119.8 1141.7 1155.3 1158.3 1161.2 12400.1 12400.5 12406.6 12410.0 12416.3 4395.0 4566.3 4643.6 4713.1 4732.1 10300.9 10304.1 10304.7 10310.6 10320.3 5311.3 5323.3 5326.2 5330.4 5332.4 4756.3 4827.2 4844.3 4864.4 4870.6 3875.0 3934.5 3943.1 3993.5 4033.2 1170.2 1192.5 1264.3 1264.7 1272.6 828.8 854.3 913.1 1001.9 1047.1 6152.6 6188.5 6217.9 6297.1 6363.6 977.3 978.3 1029.7 1034.9 1055.3 4054.2 4317.8 4320.0 4392.4 4415.2 10756.1 11091.6 11208.3 11236.1 11238.6 9654.8 11090.1 11112.2 11121.4 11128.5 7640.4 7939.5 7954.7 8165.7 8167.9 6199.9 6295.8 6383.5 6417.0 6419.9 10127.4 10159.3 10300.1 10337.1 10381.2 10329.9 10347.6 10526.4 10527.5 10628.0 7344.9 7395.2 7457.8 7466.0 7471.7 8333.0 8442.7 8460.9 8521.9 8528.7 7531.1 7608.8 7618.5 7751.5 7752.5 7542.8 7545.3 7573.1 7627.8 7729.3 6811.0 7070.2 7098.5 7117.0 7135.5 4965.9 5074.4 5125.2 5140.8 5239.9 5176.8 5183.2 5253.1 5442.4 5445.0 19:38:28 INFO - PROCESS | 14656 | 19:38:28 INFO - PROCESS | 14656 | [#4] prototype.html Cycles:180 Average:4735.35 Median:5369.28 stddev:1390.84 (25.9%) stddev-sans-first:1354.77 19:38:28 INFO - PROCESS | 14656 | Values: 324.3 328.9 341.6 343.2 343.4 5203.6 5304.6 5314.3 5369.8 5403.3 5368.8 5382.8 5388.7 5392.6 5406.5 4274.4 4278.7 4285.6 4289.2 4341.8 4023.2 4136.0 4258.8 4261.6 4270.8 4239.3 4240.9 4248.7 4265.5 4267.7 4247.3 4253.9 4255.9 4270.8 4273.3 3641.5 3791.4 3798.1 3804.0 3833.4 5196.7 5203.5 5216.9 5233.2 5235.5 4841.8 4844.0 4859.3 4869.3 4872.4 5273.7 5577.2 5586.9 5595.4 5652.9 4009.8 4026.5 4040.7 4041.9 4045.3 5777.5 5808.9 5809.8 5816.5 5872.7 3969.2 4170.0 4175.7 4180.1 4182.9 4212.9 4220.0 4232.3 4237.0 4250.7 4783.4 4784.6 4821.2 4825.4 4845.7 5524.4 5663.9 5672.9 5683.9 5713.7 1377.0 1425.7 1440.3 1454.1 1462.9 980.2 988.8 1003.9 1006.0 1014.4 5382.5 5384.9 5394.6 5396.4 5422.6 5675.6 5675.9 5691.1 5695.6 5718.7 5193.1 5365.9 5443.3 5461.6 5465.2 2686.7 2718.5 2718.6 2743.6 2749.9 5139.3 5271.2 5280.8 5306.2 5322.4 5237.6 5593.7 5919.0 5939.4 5967.4 5970.7 5991.4 5994.1 5996.7 6018.4 5589.0 5790.5 5844.5 5900.5 5903.5 5723.7 5724.9 5728.2 5756.6 5764.7 6025.4 6061.3 6063.7 6066.2 6077.2 4058.9 4070.0 4156.9 4216.3 4226.1 5631.4 5794.9 5877.9 5896.6 5938.5 5504.6 5658.6 5663.6 5666.4 5706.5 5640.6 5696.5 5698.5 5743.9 5764.7 5537.9 5568.0 5632.8 5650.4 5655.6 5612.9 5632.9 5638.5 5638.6 5692.7 5461.5 5558.2 5571.4 5624.9 5643.2 19:38:28 INFO - PROCESS | 14656 | 19:38:28 INFO - PROCESS | 14656 | [#5] yui.html Cycles:180 Average:21525.71 Median:4587.72 stddev:31427.55 (685.0%) stddev-sans-first:31477.28 19:38:28 INFO - PROCESS | 14656 | Values: 825.8 837.3 839.9 845.4 877.9 14400.5 15345.8 15350.9 15360.1 15392.2 14623.3 14765.3 14785.6 15817.8 15875.1 678.1 839.3 852.1 852.8 854.3 807.8 845.1 847.1 847.3 848.6 893.7 894.7 895.7 895.8 895.9 710.0 858.1 893.1 893.3 893.5 637.7 639.0 641.1 643.4 643.7 16311.1 16381.9 16403.8 16426.1 16435.8 14384.6 14661.8 14710.6 14744.9 14851.3 13591.1 13712.8 13768.8 13842.8 13945.0 4500.0 4557.1 4618.4 4687.5 4694.6 79705.6 80522.2 80632.6 80669.2 80753.6 11961.6 12009.6 12191.5 12291.3 12360.6 19579.6 19806.0 19868.8 19914.8 20072.8 8524.0 8601.9 8618.1 8883.4 8932.3 4638.1 4831.5 4850.9 4877.5 4977.7 3496.0 3607.5 3611.0 3622.0 3624.9 631.4 656.8 691.0 704.1 706.3 571.5 664.9 677.6 692.9 720.8 10395.4 10539.0 10658.1 10862.2 10943.1 585.5 600.6 655.9 663.2 673.7 4960.9 5223.4 5237.9 5250.6 5255.0 75930.6 118133.4 120863.4 125950.0 126438.0 106836.0 109286.0 109635.0 109643.0 109891.0 90767.5 93504.5 95427.0 96390.4 96647.5 9619.6 9830.7 9856.4 9864.6 9968.2 52416.0 52941.5 53473.0 53561.7 54158.7 54238.0 77218.6 77767.6 78171.6 78468.6 11875.3 11970.7 12259.4 12501.5 12894.7 13852.9 14278.0 14367.1 14433.8 15051.4 12738.7 12752.3 12838.9 12918.4 13283.6 13420.5 13431.8 13474.1 13889.7 14210.1 13237.6 13394.9 13832.2 14022.8 14341.4 10708.5 10807.9 10879.9 11207.9 11274.8 11075.4 11285.9 11468.3 11548.4 11568.3 19:38:28 INFO - PROCESS | 14656 | -------- Summary: end -------- 19:38:28 INFO - PROCESS | 14656 | 19:38:29 INFO - TEST-INFO | 14656: exit 0 19:38:29 INFO - TEST-OK | dromaeo_css | took 1114067ms 19:38:29 INFO - TEST-START | kraken 19:38:29 INFO - operating with platform_type : linux_ 19:38:29 INFO - Initialising browser for kraken test... 19:38:29 INFO - TEST-INFO | started process 14851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUDs85W/profile http://localhost:54013/getInfo.html) 19:38:33 INFO - PROCESS | 14851 | __metrics Screen width/height:1600/1200 19:38:33 INFO - PROCESS | 14851 | colorDepth:24 19:38:33 INFO - PROCESS | 14851 | Browser inner width/height: 1024/697 19:38:33 INFO - PROCESS | 14851 | __metrics 19:38:34 INFO - PROCESS | 14851 | 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" 19:38:34 INFO - PROCESS | 14851 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:38:35 INFO - TEST-INFO | 14851: exit 0 19:38:35 INFO - Browser initialized. 19:38:35 INFO - Running cycle 1/1 for kraken test... 19:38:35 INFO - TEST-INFO | started process 14934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUDs85W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:38:46 INFO - PROCESS | 14934 | RSS: Main: 158765056 19:38:46 INFO - PROCESS | 14934 | 19:38:49 INFO - PROCESS | 14934 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54013/tests/kraken/driver.html?testName=audio-beat-detection) 19:38:50 INFO - PROCESS | 14934 | RSS: Main: 217812992 19:38:50 INFO - PROCESS | 14934 | 19:38:52 INFO - PROCESS | 14934 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54013/tests/kraken/driver.html?testName=audio-dft) 19:38:53 INFO - PROCESS | 14934 | RSS: Main: 206217216 19:38:53 INFO - PROCESS | 14934 | 19:38:56 INFO - PROCESS | 14934 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54013/tests/kraken/driver.html?testName=audio-fft) 19:38:56 INFO - PROCESS | 14934 | RSS: Main: 270561280 19:38:56 INFO - PROCESS | 14934 | 19:38:59 INFO - PROCESS | 14934 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54013/tests/kraken/driver.html?testName=audio-oscillator) 19:38:59 INFO - PROCESS | 14934 | RSS: Main: 181002240 19:38:59 INFO - PROCESS | 14934 | 19:39:01 INFO - PROCESS | 14934 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54013/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:39:02 INFO - PROCESS | 14934 | RSS: Main: 184532992 19:39:02 INFO - PROCESS | 14934 | 19:39:05 INFO - PROCESS | 14934 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54013/tests/kraken/driver.html?testName=imaging-darkroom) 19:39:06 INFO - PROCESS | 14934 | RSS: Main: 221032448 19:39:06 INFO - PROCESS | 14934 | 19:39:09 INFO - PROCESS | 14934 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54013/tests/kraken/driver.html?testName=imaging-desaturate) 19:39:09 INFO - PROCESS | 14934 | RSS: Main: 221536256 19:39:09 INFO - PROCESS | 14934 | 19:39:12 INFO - PROCESS | 14934 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54013/tests/kraken/driver.html?testName=json-parse-financial) 19:39:13 INFO - PROCESS | 14934 | RSS: Main: 222339072 19:39:13 INFO - PROCESS | 14934 | 19:39:14 INFO - PROCESS | 14934 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54013/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:39:15 INFO - PROCESS | 14934 | RSS: Main: 210710528 19:39:15 INFO - PROCESS | 14934 | 19:39:17 INFO - PROCESS | 14934 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:39:17 INFO - PROCESS | 14934 | RSS: Main: 215871488 19:39:17 INFO - PROCESS | 14934 | 19:39:19 INFO - PROCESS | 14934 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:39:20 INFO - PROCESS | 14934 | RSS: Main: 212430848 19:39:20 INFO - PROCESS | 14934 | 19:39:22 INFO - PROCESS | 14934 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:39:23 INFO - PROCESS | 14934 | RSS: Main: 224636928 19:39:23 INFO - PROCESS | 14934 | 19:39:26 INFO - PROCESS | 14934 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:39:26 INFO - PROCESS | 14934 | RSS: Main: 226222080 19:39:26 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54013/tests/kraken/driver.html?testName=ai-astar) 19:39:28 INFO - PROCESS | 14934 | RSS: Main: 268529664 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | __start_tp_report 19:39:28 INFO - PROCESS | 14934 | _x_x_mozilla_page_load 19:39:28 INFO - PROCESS | 14934 | _x_x_mozilla_page_load_details 19:39:28 INFO - PROCESS | 14934 | |i|pagename|runs| 19:39:28 INFO - PROCESS | 14934 | |0;ai-astar;102;112;113;111;112;113;112;111;114;111 19:39:28 INFO - PROCESS | 14934 | |1;audio-beat-detection;141;116;122;177;117;120;144;122;153;118 19:39:28 INFO - PROCESS | 14934 | |2;audio-dft;162;161;162;161;161;160;160;160;161;161 19:39:28 INFO - PROCESS | 14934 | |3;audio-fft;76;75;75;130;76;76;75;75;103;75 19:39:28 INFO - PROCESS | 14934 | |4;audio-oscillator;84;83;113;83;83;84;126;84;84;127 19:39:28 INFO - PROCESS | 14934 | |5;imaging-gaussian-blur;117;117;116;117;117;118;117;116;118;117 19:39:28 INFO - PROCESS | 14934 | |6;imaging-darkroom;145;146;147;146;146;146;146;146;146;145 19:39:28 INFO - PROCESS | 14934 | |7;imaging-desaturate;95;95;95;95;95;94;95;94;95;94 19:39:28 INFO - PROCESS | 14934 | |8;json-parse-financial;50;50;50;50;52;50;49;49;51;49 19:39:28 INFO - PROCESS | 14934 | |9;json-stringify-tinderbox;62;62;61;62;62;61;62;62;62;62 19:39:28 INFO - PROCESS | 14934 | |10;stanford-crypto-aes;75;75;75;74;74;74;78;75;74;73 19:39:28 INFO - PROCESS | 14934 | |11;stanford-crypto-ccm;119;117;132;119;119;118;117;123;193;129 19:39:28 INFO - PROCESS | 14934 | |12;stanford-crypto-pbkdf2;151;153;159;153;153;151;151;155;153;150 19:39:28 INFO - PROCESS | 14934 | |13;stanford-crypto-sha256-iterative;62;62;63;62;65;62;61;64;62;61 19:39:28 INFO - PROCESS | 14934 | __end_tp_report 19:39:28 INFO - PROCESS | 14934 | __start_cc_report 19:39:28 INFO - PROCESS | 14934 | _x_x_mozilla_cycle_collect,1647 19:39:28 INFO - PROCESS | 14934 | __end_cc_report 19:39:28 INFO - PROCESS | 14934 | __startTimestamp1468895968631__endTimestamp 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | ------- Summary: start ------- 19:39:28 INFO - PROCESS | 14934 | Number of tests: 14 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:3.35 (3.0%) stddev-sans-first:1.05 19:39:28 INFO - PROCESS | 14934 | Values: 102.0 112.0 113.0 111.0 112.0 113.0 112.0 111.0 114.0 111.0 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:131.50 stddev:20.28 (15.4%) stddev-sans-first:21.30 19:39:28 INFO - PROCESS | 14934 | Values: 141.0 116.0 122.0 177.0 117.0 120.0 144.0 122.0 153.0 118.0 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 19:39:28 INFO - PROCESS | 14934 | Values: 162.0 161.0 162.0 161.0 161.0 160.0 160.0 160.0 161.0 161.0 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | [#3] audio-fft Cycles:10 Average:83.60 Median:75.00 stddev:18.48 (24.6%) stddev-sans-first:19.39 19:39:28 INFO - PROCESS | 14934 | Values: 76.0 75.0 75.0 130.0 76.0 76.0 75.0 75.0 103.0 75.0 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:83.50 stddev:18.93 (22.7%) stddev-sans-first:19.65 19:39:28 INFO - PROCESS | 14934 | Values: 84.0 83.0 113.0 83.0 83.0 84.0 126.0 84.0 84.0 127.0 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 19:39:28 INFO - PROCESS | 14934 | Values: 117.0 117.0 116.0 117.0 117.0 118.0 117.0 116.0 118.0 117.0 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 19:39:28 INFO - PROCESS | 14934 | Values: 145.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:39:28 INFO - PROCESS | 14934 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:0.94 (1.9%) stddev-sans-first:1.00 19:39:28 INFO - PROCESS | 14934 | Values: 50.0 50.0 50.0 50.0 52.0 50.0 49.0 49.0 51.0 49.0 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 19:39:28 INFO - PROCESS | 14934 | Values: 62.0 62.0 61.0 62.0 62.0 61.0 62.0 62.0 62.0 62.0 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:75.00 stddev:1.34 (1.8%) stddev-sans-first:1.41 19:39:28 INFO - PROCESS | 14934 | Values: 75.0 75.0 75.0 74.0 74.0 74.0 78.0 75.0 74.0 73.0 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:121.00 stddev:23.21 (19.2%) stddev-sans-first:24.36 19:39:28 INFO - PROCESS | 14934 | Values: 119.0 117.0 132.0 119.0 119.0 118.0 117.0 123.0 193.0 129.0 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.90 Median:153.00 stddev:2.60 (1.7%) stddev-sans-first:2.67 19:39:28 INFO - PROCESS | 14934 | Values: 151.0 153.0 159.0 153.0 153.0 151.0 151.0 155.0 153.0 150.0 19:39:28 INFO - PROCESS | 14934 | 19:39:28 INFO - PROCESS | 14934 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.26 (2.0%) stddev-sans-first:1.33 19:39:28 INFO - PROCESS | 14934 | Values: 62.0 62.0 63.0 62.0 65.0 62.0 61.0 64.0 62.0 61.0 19:39:28 INFO - PROCESS | 14934 | -------- Summary: end -------- 19:39:28 INFO - PROCESS | 14934 | 19:39:29 INFO - TEST-INFO | 14934: exit 0 19:39:29 INFO - TEST-OK | kraken | took 60455ms 19:39:29 INFO - SUITE-END | took 1174s 19:39:29 INFO - Completed test suite (00:19:34) 19:39:29 INFO - javascript benchmark 19:39:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3037.1344166912436, 3042.2698552347438, 3085.059056987618, 3092.2733157707935, 3103.8758449662014, 5140.0, 5183.948160518394, 5289.259503669489, 5345.572354211664, 5353.14349704047, 5246.842594722155, 5295.205719142131, 5305.495977882095, 5328.813491527797, 5339.599530035243, 4777.784999675015, 4847.733374664392, 4859.173940430118, 4870.951290487085, 4974.477679843619, 4910.705357678533, 4918.950810491885, 4923.630727695419, 4980.477049909761, 5001.049800537904, 4784.736839473828, 4797.90404191916, 4817.807287708488, 4837.661363704525, 4864.100141473803, 4794.424669039703, 4828.0, 4838.056578967103, 4852.296417019547, 4896.387951506062, 4848.830290939835, 4872.244802055687, 4876.561109500127, 4877.561019508261, 4881.170201065827, 5232.215167724834, 5253.711045892474, 5330.173823057394, 5376.4085950545405, 5412.56699464042, 5751.654900705971, 5774.133879918004, 5787.074068149118, 5800.680962547058, 5807.912881306784, 5482.890342193174, 5789.363170051291, 5833.562482813763, 5840.561957853178, 5844.912326315109, 5323.920141197885, 5368.8389348319615, 5383.730813459311, 5446.972765136188, 5464.726763661881, 5951.523878089829, 5963.344032156459, 5964.582479226413, 5966.671833049224, 5970.283565972111, 5494.532964697965, 5531.308586426697, 5654.46282603152, 5697.686627235542, 5705.144228365695, 5641.294838145232, 5686.744096515667, 5688.288963879515, 5691.77232910679, 5694.857628559319, 5684.7157642118555, 5697.857553561112, 5700.087985922232, 5712.714364281769, 5726.226959360433, 5693.829185124453, 5738.311402631711, 5743.0, 5745.339285982165, 5783.4794868461195, 4379.4525684289465, 4384.714993525411, 4388.71473354231, 4389.100234451994, 4425.336199570091, 3851.326017946904, 3859.0931131184147, 3914.3149948758855, 3929.174873276644, 3935.4883865097354, 5368.463153684678, 5371.194320851903, 5374.274472946102, 5379.67721936685, 5428.864278392993, 5782.913256301159, 5784.363719990798, 5785.566082543742, 5819.0, 5832.825015249549, 5256.763445644879, 5375.596830237748, 5398.028354896078, 5414.052540805344, 5434.103372943499, 4967.3542439482635, 4970.329005584272, 4973.577245934136, 4974.626902982291, 5016.0971025215085, 5679.545636349082, 5922.200502932135, 5929.851753706105, 5932.466078052909, 5937.435943585352, 5656.066748986371, 5680.4319568042865, 5716.342620598518, 5751.137329400456, 5756.280464941882, 5880.323762767336, 5888.970555147197, 5891.469767720926, 5903.026000709835, 5908.3796201399955, 5440.619156658996, 5631.7184140793615, 5636.520895723909, 5649.152627105803, 5649.830505084854, 5667.489925906688, 5705.942940570541, 5726.770929162787, 5739.770409183586, 5748.0, 5570.777168913198, 5612.074007788832, 5618.7190640467, 5620.74706638194, 5624.100143976944, 5309.867253318698, 5456.154296084113, 5579.414161512983, 5622.662640241435, 5645.350784659817, 5532.612717109924, 5554.305711786027, 5555.916596263852, 5568.94190103879, 5614.85962850932, 5574.888502230014, 5614.831555053355, 5614.989301925692, 5662.716864156693, 5668.149777533403, 5420.593455490775, 5462.890742185214, 5469.808556700496, 5492.505674489315, 5500.064988951968], "value": 5273.254289182032, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.4351023017903, 628.8899442597545, 638.1608185236414, 648.7761722205837, 661.2759028863398, 31193.0, 44279.55720442795, 44904.1019179617, 45033.32450013253, 45062.774686126606, 46701.766491167495, 47208.52791472084, 47218.52781472184, 47247.29129063067, 47256.291155632694, 9135.81728365434, 9260.629574817, 9281.118293762116, 9293.907060929405, 9304.62781488743, 9118.224950879183, 9195.816083678323, 9202.861957070649, 9209.309301802357, 9211.861822072675, 9237.676681316156, 9302.86045709315, 9306.208972237368, 9309.767255818591, 9315.487648179347, 9244.16802487776, 9281.860772088425, 9295.349325547215, 9301.488418137, 9301.767455813591, 9106.180443760028, 9113.134252246025, 9184.219341355993, 9187.67843125494, 9201.861972070425, 43758.0, 43975.340369894475, 44140.55859441397, 44153.77923110396, 44171.77914110409, 3423.5720534933134, 3507.7719948203285, 3548.6628770266784, 3565.3047655707146, 3574.660407261306, 33558.3288334232, 33611.32777344464, 34028.31943361119, 34632.0, 35583.0, 3654.5614526256754, 3697.3159965406485, 3751.118487155516, 3755.6244375562223, 3826.0626146594263, 374066.0, 374402.0, 375161.0, 376690.0, 376822.0, 57385.42614573884, 57430.138547921815, 57751.711241443525, 57799.711001444724, 57840.0, 54077.45922540803, 55284.0, 55315.72342138264, 58974.11538826921, 60951.08573371403, 14589.85410145885, 15526.689466210613, 15572.0, 16078.678426431406, 16109.516714498584, 12090.335031573171, 12180.878191218151, 12181.573644922386, 12183.390830458442, 12191.634250972485, 14356.0, 14702.191379474018, 14723.779143312859, 15939.362425503083, 16098.597535061717, 5429.809956651498, 6765.42493888025, 6893.862122757517, 6914.2637293454145, 6930.861382772317, 1007.5919252702668, 1034.6637342863598, 1118.4743170709753, 1132.932024078558, 1195.713028873064, 32810.67189328076, 33022.17444563905, 33070.338593228, 33546.0, 34237.0, 1080.9135269178446, 1094.3543309447464, 1144.6337172104847, 1174.5947648061406, 1278.5908509277128, 17460.30158793634, 17592.824071759118, 17663.73504397435, 17696.0, 17705.29178832858, 157926.0, 158147.0, 158424.0, 158571.0, 158610.0, 60524.697376513715, 60671.0, 60691.0, 60723.69638151869, 60747.69626151841, 1347.615929460099, 1398.8181536400407, 1408.5985494134327, 1409.1122592766492, 1422.3172877018883, 32163.67836321607, 33321.667133315364, 33407.164820879676, 33435.33129337351, 33878.0, 51350.22974655309, 51661.22508162456, 51679.22481162861, 51733.7413312931, 51859.481405186976, 442330.0, 442881.0, 443203.0, 444370.0, 444997.0, 40635.0, 41865.58134418617, 42729.572704272556, 42829.571704282556, 42884.571154289304, 49040.75479622579, 49345.0, 49392.753036234586, 49966.25050624171, 50301.496985029684, 41388.37917431301, 42370.15259694851, 42613.57386426096, 42825.0, 43463.56536434595, 41875.0, 41895.7905210472, 41902.0, 42476.78761606172, 43449.0, 41914.58085419229, 42321.365179522945, 42419.363709543766, 42859.57140428556, 43130.353044704985, 35280.0, 36544.45183322199, 37246.88259352224, 37354.252914942095, 37826.24347513089, 28349.716502835534, 28707.712922870505, 29015.56476652894, 29063.418731625672, 29138.56292155662], "value": 19834.613329209293, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.68862155789134, 395.3042644944898, 397.66993395481774, 403.0769537758533, 410.50944121774484, 14528.418863245472, 17304.48086557402, 19583.0, 19905.104270307835, 19931.501712457215, 18327.450176494694, 18389.26442942281, 18564.814351856476, 18604.255829766826, 18616.627667446675, 4200.201961627281, 5622.8313150605445, 5815.82552523425, 5816.302043754734, 5831.0, 6232.345603711613, 6582.341765823403, 6601.306862779411, 6665.533412661116, 6668.333166683341, 6297.3387794281625, 6485.448736857373, 6502.7724029658975, 6516.869662606745, 6618.503612229102, 6358.237011558643, 6540.345965403493, 6565.212174539038, 6579.835504112388, 6625.17185351831, 5769.1923130761725, 5805.36141024487, 5807.128930660435, 5814.651120932757, 5815.709214539256, 23872.64191037136, 24234.15180468675, 24506.387340316636, 25067.498650026897, 25122.874385628136, 2242.2824696097255, 2392.114917480526, 2401.219603628828, 2428.611422172444, 3048.8719173905574, 14292.499762508261, 14425.927870360685, 15306.770398444032, 15784.842151578567, 15972.201389930573, 1931.5364312565023, 1952.4142757172933, 1961.1861077652757, 1964.4499540128786, 2024.9696254556193, 85612.0, 87962.5601871993, 88116.0, 88392.5580372094, 88586.55706721489, 11127.499262533205, 11333.376664283378, 11370.31778093317, 11462.713432164262, 11495.770084598262, 15973.361065557248, 15990.840091598935, 16059.518214453585, 16078.276477558538, 16079.839201608069, 7701.961490192513, 7855.567943763148, 7885.723999659985, 7944.285014348737, 7986.081600616004, 7268.745593904188, 7303.831386978058, 7325.4139668826365, 7410.962945185347, 7467.3652739516665, 4891.877703057381, 4914.213725803854, 4926.8768280793265, 4950.094213727741, 5037.269595908646, 1986.8673159827813, 1992.8804271743743, 2008.136501304424, 2035.1757538197053, 2043.1929387891996, 809.0978558906777, 836.4730219961507, 850.3154960257052, 949.2832911152036, 1008.2287050406445, 17048.31806727717, 17353.0, 17407.303707851544, 17523.211455484277, 17709.114544272736, 946.9309558614312, 954.9809003819885, 977.2231076294363, 977.4184360305607, 978.8629591857145, 10885.945570272099, 11348.571827572045, 11377.37424441647, 11452.54189832414, 11516.596919107958, 593873.0, 599755.0, 601104.0, 605816.0, 608616.0, 65214.673926630065, 72055.0, 77381.0, 98834.5058274704, 101469.49265253627, 1003.4330603209163, 1003.8142943555465, 1040.0587468341164, 1040.0847254416065, 1047.0785708576404, 18728.625427491646, 18815.811841881405, 19081.618367632847, 19104.33134840274, 19308.903455482632, 39865.601343986185, 40894.182116358104, 43433.78283108691, 44107.33838992482, 44643.55356446394, 61515.0, 62295.377046228954, 62621.0, 62751.0, 63381.683091584244, 8571.4000019998, 8650.178233067849, 8688.304935605263, 8747.65009399617, 8835.779105522157, 9685.806283874143, 13407.195568265935, 13782.86217137856, 13800.861991379958, 13867.514636987657, 11055.944720276348, 11201.775964480828, 11278.830817537908, 11281.43592820372, 11455.427228638702, 10840.211365124665, 11035.944820275847, 11194.944025279821, 11219.326840389604, 11504.654860354203, 11483.138764592522, 11530.0, 11650.30098194111, 11701.473433695333, 11711.1802173847, 8671.523066231166, 8724.738257852274, 8763.693270735494, 8775.385722999328, 8874.600642970952, 8837.0, 11197.328160310408, 11313.321200727984, 11461.140414468782, 11564.595239166589], "value": 9462.699515388817, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.499007832376, 1536.331695712365, 1678.9328426862926, 1775.1213149491005, 1814.582645991422, 8364.749057528275, 8875.112488751121, 8893.155150260724, 8896.243819275362, 8902.376833621649, 7660.463767536275, 8354.791130221747, 8458.32333413327, 8497.1502849715, 8803.075677053914, 2362.066983541504, 2390.7011623547055, 2394.5450364430703, 2394.844335118212, 2402.7717366850206, 2337.7895989360954, 2347.4600841806396, 2382.0352757133387, 2386.2125498585424, 2392.4138586046442, 2090.25795842476, 2278.7949084582383, 2348.8942997565064, 2363.8108951283857, 2381.4879800842814, 2338.754430784769, 2352.8117750579913, 2369.099742098009, 2371.703537057868, 2385.9284221473386, 2349.588821956168, 2350.9647355289685, 2352.5765362234793, 2356.057576969209, 2358.988205058981, 8984.505852178192, 9020.143086406846, 9028.77428064297, 9045.638174473013, 9049.0, 4998.300237966688, 5172.793088276464, 5224.582033437354, 5245.1869960155855, 5256.342957130359, 3357.1271469417884, 3457.3258214648154, 3506.4389697648253, 3519.7008254298416, 3534.169470174507, 1119.8264269038311, 1141.746147474722, 1155.3299086529792, 1158.3165932100017, 1161.163961947405, 12400.069994750429, 12400.503979840796, 12406.565770198, 12410.0, 12416.317102559356, 4394.978025109854, 4566.315052742115, 4643.628509719282, 4713.080949214938, 4732.0772449372735, 10300.948495257475, 10304.072633463024, 10304.690859274233, 10310.587576496857, 10320.277580569438, 5311.256424100629, 5323.334583177103, 5326.201069839555, 5330.360356757214, 5332.413434522199, 4756.334113224151, 4827.155247831685, 4844.32179494871, 4864.416270047617, 4870.561649451566, 3874.9806250968563, 3934.5278566572197, 3943.073377756225, 3993.4808474898077, 4033.173199494155, 1170.2393444261297, 1192.5349113845607, 1264.2730430002784, 1264.6711854917787, 1272.6118533847266, 828.7555171224383, 854.3122786157079, 913.0641092879852, 1001.8647482589757, 1047.1361127070045, 6152.600080994721, 6188.535859810532, 6217.937820621826, 6297.149884765589, 6363.5863668861375, 977.333646133341, 978.3396207559869, 1029.7425643589104, 1034.9223808214263, 1055.3193190392153, 4054.189162167578, 4317.805698743564, 4320.0, 4392.428984232093, 4415.205263052681, 10756.08573271265, 11091.611793587186, 11208.271462355084, 11236.101111911028, 11238.606648767254, 9654.806903861883, 11090.112790976864, 11112.16658750597, 11121.443927803577, 11128.49921753523, 7640.388768898475, 7939.483933544301, 7954.681812727426, 8165.673373065011, 8167.918320816716, 6199.938000620116, 6295.779647712308, 6383.5212359074185, 6417.0, 6419.933163160768, 10127.44299063529, 10159.339642923187, 10300.124489418484, 10337.069663729999, 10381.221408394249, 10329.9483502582, 10347.611169799455, 10526.368417894952, 10527.473626318806, 10628.04347608688, 7344.8898266524975, 7395.18652948186, 7457.776266712007, 7465.9920910676365, 7471.663775130023, 8333.0, 8442.746717598482, 8460.91539084626, 8521.872171917303, 8528.658853645784, 7531.133919599316, 7608.8478230436185, 7618.542887426772, 7751.496152750054, 7752.4573279869865, 7542.773716788505, 7545.283198096172, 7573.129090154703, 7627.809304767426, 7729.3430058445665, 6810.965945170441, 7070.151581810215, 7098.538594991515, 7116.964415177891, 7135.464840137114, 4965.851024469272, 5074.416442109205, 5125.1799712045895, 5140.794368225229, 5239.947600523946, 5176.792928282826, 5183.170692689152, 5253.1088808029845, 5442.374126975448, 5445.047116754473], "value": 4685.459125124917, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.31083946613444, 328.91119397762606, 341.6446895228962, 343.20205522160967, 343.4247635211021, 5203.557697595709, 5304.575633949285, 5314.2560041594115, 5369.771544808909, 5403.2705584746045, 5368.785248590061, 5382.757775900084, 5388.7305634718305, 5392.595555333356, 5406.459354064592, 4274.358846173076, 4278.7218830776055, 4285.550017248191, 4289.249381358265, 4341.761203133827, 4023.195360927826, 4135.986683262605, 4258.7870606469705, 4261.573842615745, 4270.761479171037, 4239.300515414953, 4240.851570195044, 4248.702590818644, 4265.509466411356, 4267.679924005696, 4247.299195632717, 4253.936190957138, 4255.936160957588, 4270.765107919063, 4273.333399973982, 3641.4719865619336, 3791.374423220165, 3798.1074447504816, 3804.0, 3833.4249862520564, 5196.714180720059, 5203.505666961632, 5216.921746173811, 5233.162693968947, 5235.476452354772, 4841.837958889876, 4844.0, 4859.319695242669, 4869.318295438641, 4872.439669437989, 5273.657212281228, 5577.163425486169, 5586.888262234733, 5595.440455954413, 5652.858678533028, 4009.8195581198916, 4026.503567787961, 4040.676745860324, 4041.9191616167805, 4045.271851066807, 5777.468970722762, 5808.88382232353, 5809.796657116981, 5816.534677225812, 5872.7063646817915, 3969.186316805048, 4169.958300416957, 4175.728577642443, 4180.122174343422, 4182.853600124042, 4212.936805947913, 4219.966108303485, 4232.322828347511, 4236.978815105905, 4250.702450828474, 4783.378160839069, 4784.564630610803, 4821.228603423436, 4825.396825396825, 4845.685030473008, 5524.353926408551, 5663.876046482569, 5672.858178545487, 5683.857903552362, 5713.685747283939, 1376.986230137706, 1425.6507155746701, 1440.3086518471193, 1454.1057249791513, 1462.8975971682094, 980.2305190425624, 988.7577543501889, 1003.8845532763826, 1006.0291818395137, 1014.4420568687193, 5382.461753824587, 5384.946150538444, 5394.568434525307, 5396.379416367089, 5422.593305502024, 5675.602707810413, 5675.943240567624, 5691.146328050825, 5695.601307908407, 5718.7426565804635, 5193.078560932479, 5365.892682146336, 5443.319585051869, 5461.644993075437, 5465.207544905967, 2686.6775986881307, 2718.4834881372476, 2718.6329845471005, 2743.5747459143863, 2749.9450010999667, 5139.254808052811, 5271.1550957165455, 5280.81517146898, 5306.230596563477, 5322.414534401213, 5237.554807841376, 5593.664380137205, 5919.0, 5939.406059394112, 5967.433093856077, 5970.731317090741, 5991.400859914061, 5994.062909174473, 5996.67018313997, 6018.398160183947, 5589.031787430969, 5790.507806836466, 5844.47399734026, 5900.468957793819, 5903.524118970257, 5723.656580605177, 5724.942750572441, 5728.2266893970445, 5756.625819321731, 5764.7405866736935, 6025.367336429612, 6061.333013474057, 6063.72713227897, 6066.211392518944, 6077.179580756541, 4058.85785171785, 4069.9593004070766, 4156.91686166281, 4216.283231850532, 4226.112516371596, 5631.352394474688, 5794.913076303943, 5877.941220587911, 5896.557758168069, 5938.524918006636, 5504.587155963239, 5658.575606829422, 5663.603547751618, 5666.4333566644655, 5706.543476521952, 5640.633358831663, 5696.515796157373, 5698.54411647059, 5743.885122297447, 5764.6829424380385, 5537.907824158928, 5567.972160139173, 5632.831015069554, 5650.389638952879, 5655.575831812713, 5612.943870561406, 5632.915506267491, 5638.4925356718095, 5638.577106716931, 5692.743826527733, 5461.481159289861, 5558.166275058774, 5571.437138916144, 5624.915626265692, 5643.1535269709875], "value": 4292.854646680179, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.8430898129355, 837.330135891287, 839.9454035487689, 845.4124383553433, 877.9165979231973, 14400.495982640596, 15345.769813452807, 15350.923245383758, 15360.078395296276, 15392.153431561259, 14623.268836558183, 14765.335559899804, 14785.556433307018, 15817.84182158178, 15875.126868022255, 678.0778141727247, 839.3495041342946, 852.1223140165639, 852.8251708399763, 854.3250831842837, 807.7899746066036, 845.0957475501216, 847.063994286314, 847.3052097280232, 848.6053984897021, 893.696143311274, 894.7181637784109, 895.6865097215955, 895.7536677413731, 895.9104089591054, 709.9787006389816, 858.0904241504026, 893.1158153428092, 893.3478560650728, 893.5175005497024, 637.7417146055855, 638.9744410223585, 641.0512441586478, 643.3534298030496, 643.6524276890474, 16311.102889341082, 16381.91809040959, 16403.83596164047, 16426.096564688938, 16435.83564164355, 14384.568462946128, 14661.780073298909, 14710.55868323952, 14744.852551474456, 14851.2574371281, 13591.116577422436, 13712.794308085387, 13768.793468097987, 13842.792358114535, 13945.02384833062, 4500.0, 4557.088582283556, 4618.35343051973, 4687.530949787079, 4694.554017368345, 79705.60147199227, 80522.15561677264, 80632.59683701544, 80669.19330806735, 80753.59623201846, 11961.64115076549, 12009.63971080869, 12191.51233950632, 12291.323977181162, 12360.567380141652, 19579.60840783205, 19806.0, 19868.801311986983, 19914.800851991586, 20072.799272007385, 8524.038006407483, 8601.913980860112, 8618.095100014534, 8883.42257753244, 8932.330075244383, 4638.072385522909, 4831.4685384607665, 4850.902981940341, 4877.5366340197625, 4977.65156439053, 3495.9825200874343, 3607.549056367954, 3610.981945090258, 3621.9637803621627, 3624.9275014499563, 631.3654776949229, 656.8128083496276, 691.0498065160405, 704.1128178495132, 706.3184027413571, 571.5399103721461, 664.9135612370361, 677.5799004617169, 692.8809971895353, 720.8233982674278, 10395.376277423378, 10539.0, 10658.147348212124, 10862.239643224899, 10943.124550035978, 585.464300165344, 600.6156060121526, 655.8917778566483, 663.1644128398253, 673.7151715092011, 4960.917144346056, 5223.399309079428, 5237.921431178535, 5250.606204534599, 5254.97372513135, 75930.62034689791, 118133.4093329545, 120863.39568302278, 125950.0, 126438.0, 106836.0, 109286.0, 109635.0, 109643.0, 109891.0, 90767.54616227008, 93504.53247733854, 95427.0, 96390.43314802129, 96647.51676241573, 9619.615215391306, 9830.705078847646, 9856.437326295072, 9864.632488202637, 9968.202543796624, 52416.0, 52941.52709066008, 53473.0, 53561.73219134035, 54158.72920635372, 54238.0, 77218.6139069301, 77767.61116194383, 78171.6091419562, 78468.60765696135, 11875.346855923008, 11970.700732481757, 12259.448324825225, 12501.499940002663, 12894.742105158031, 13852.852807814805, 14278.0, 14367.13797172173, 14433.7834932474, 15051.397944082115, 12738.745225095632, 12752.298623575793, 12838.935805320914, 12918.418671159632, 13283.601491955256, 13420.530281440102, 13431.798523022358, 13474.124181928144, 13889.722205556034, 14210.147391156564, 13237.602871913858, 13394.873024435912, 13832.170069795844, 14022.789658154932, 14341.426342946166, 10708.464576771286, 10807.945960270463, 10879.891201087888, 11207.887921120684, 11274.830877537008, 11075.446227688422, 11285.887141128484, 11468.31190128595, 11548.364839933549, 11568.305901645928], "value": 7768.58382758403, "unit": "score"}], "name": "dromaeo_css", "value": 7326.563572574445, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 113.0, 111.0, 112.0, 113.0, 112.0, 111.0, 114.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 122.0, 177.0, 117.0, 120.0, 144.0, 122.0, 153.0, 118.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 160.0, 160.0, 160.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 130.0, 76.0, 76.0, 75.0, 75.0, 103.0, 75.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 113.0, 83.0, 83.0, 84.0, 126.0, 84.0, 84.0, 127.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 116.0, 118.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 50.0, 52.0, 50.0, 49.0, 49.0, 51.0, 49.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 74.0, 74.0, 74.0, 78.0, 75.0, 74.0, 73.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 132.0, 119.0, 119.0, 118.0, 117.0, 123.0, 193.0, 129.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 159.0, 153.0, 153.0, 151.0, 151.0, 155.0, 153.0, 150.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 65.0, 62.0, 61.0, 64.0, 62.0, 61.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1471.7000000000003, "alertThreshold": 2.0}]} 19:39:29 INFO - Return code: 0 19:39:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:39:29 INFO - # TBPL SUCCESS # 19:39:29 INFO - Running post-action listener: _resource_record_post_action 19:39:29 INFO - ##### 19:39:29 INFO - ##### Finished run-tests step (success) 19:39:29 INFO - ##### 19:39:29 INFO - Running post-run listener: _resource_record_post_run 19:39:30 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 566415360; Read time: 12; Write time: 609192 19:39:30 INFO - TinderboxPrint: CPU usage
13.0% 19:39:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:39:30 INFO - TinderboxPrint: I/O write bytes / time
566,415,360 / 609,192 19:39:30 INFO - TinderboxPrint: CPU idle
8,274.9 (87.0%) 19:39:30 INFO - TinderboxPrint: CPU user
1,194.7 (12.6%) 19:39:30 INFO - TinderboxPrint: Swap in / out
0 / 0 19:39:30 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 269279232; Read time: 0; Write time: 311540 19:39:30 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 297136128; Read time: 0; Write time: 297652 19:39:30 INFO - Running post-run listener: _upload_blobber_files 19:39:30 INFO - Blob upload gear active. 19:39:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:39:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:39:30 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:39:30 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:39:30 INFO - (blobuploader) - INFO - Open directory for files ... 19:39:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:39:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:39:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:48 INFO - (blobuploader) - INFO - Done attempting. 19:39:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:39:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:39:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:49 INFO - (blobuploader) - INFO - Done attempting. 19:39:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:39:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:39:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:49 INFO - (blobuploader) - INFO - Done attempting. 19:39:49 INFO - (blobuploader) - INFO - Iteration through files over. 19:39:49 INFO - Return code: 0 19:39:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:39:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:39:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b33249891c962e31b6d467cc44290912dc6bc9a4758a7d5db25fd8a636901a6f8399c0cf9e174af7cee422b3904a6c575704a16562d7312b534870ac847e42d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfe4bfaeb3a5fe453c58e409a541045992b58ace144836d4b1a3b8f48b4c7e5ce5d5ee0aa3c447a1229626192cf8f47adb263e3f9fa705fc4608930bd8cf0138", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cabb5e9f7a3c9cc367f9096dd06dd1baed5da16669af77da1500ddb357b74de037e9c8cb0079f5765580c6feabd5f53d576ffa94a3b7b291c3df58ebbf1340c"} 19:39:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:39:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:39:49 INFO - Contents: 19:39:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b33249891c962e31b6d467cc44290912dc6bc9a4758a7d5db25fd8a636901a6f8399c0cf9e174af7cee422b3904a6c575704a16562d7312b534870ac847e42d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfe4bfaeb3a5fe453c58e409a541045992b58ace144836d4b1a3b8f48b4c7e5ce5d5ee0aa3c447a1229626192cf8f47adb263e3f9fa705fc4608930bd8cf0138", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cabb5e9f7a3c9cc367f9096dd06dd1baed5da16669af77da1500ddb357b74de037e9c8cb0079f5765580c6feabd5f53d576ffa94a3b7b291c3df58ebbf1340c"} 19:39:49 INFO - Running post-run listener: copy_logs_to_upload_dir 19:39:49 INFO - Copying logs to upload dir... 19:39:49 INFO - mkdir: /builds/slave/test/build/upload/logs 19:39:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.275604 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-18 19:39:49.669277) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 19:39:49.672768) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427 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/sha512/b33249891c962e31b6d467cc44290912dc6bc9a4758a7d5db25fd8a636901a6f8399c0cf9e174af7cee422b3904a6c575704a16562d7312b534870ac847e42d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfe4bfaeb3a5fe453c58e409a541045992b58ace144836d4b1a3b8f48b4c7e5ce5d5ee0aa3c447a1229626192cf8f47adb263e3f9fa705fc4608930bd8cf0138", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cabb5e9f7a3c9cc367f9096dd06dd1baed5da16669af77da1500ddb357b74de037e9c8cb0079f5765580c6feabd5f53d576ffa94a3b7b291c3df58ebbf1340c"} build_url:https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011162 build_url: 'https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/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/sha512/b33249891c962e31b6d467cc44290912dc6bc9a4758a7d5db25fd8a636901a6f8399c0cf9e174af7cee422b3904a6c575704a16562d7312b534870ac847e42d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfe4bfaeb3a5fe453c58e409a541045992b58ace144836d4b1a3b8f48b4c7e5ce5d5ee0aa3c447a1229626192cf8f47adb263e3f9fa705fc4608930bd8cf0138", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cabb5e9f7a3c9cc367f9096dd06dd1baed5da16669af77da1500ddb357b74de037e9c8cb0079f5765580c6feabd5f53d576ffa94a3b7b291c3df58ebbf1340c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 19:39:49.701144) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 19:39:49.701490) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1468886903.20704-1215879427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 19:39:49.786060) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 19:39:49.786386) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 19:39:49.786679) ========= ========= Total master_lag: 0.18 =========