builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1467295715.24 results: success (0) buildid: 20160630043019 builduid: 617b4a1dd3d54393989b89c4066a5b7d revision: bcf4ff0c3eef498cd853a88270c75c161e524549 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:35.238660) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:35.239436) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:35.246421) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:35.284507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:35.284839) ========= 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=6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 07:08:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.2M=0s 2016-06-30 07:08:35 (38.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108907 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:35.411565) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:35.412097) ========= 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=6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018277 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:35.463205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:35.463622) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bcf4ff0c3eef498cd853a88270c75c161e524549 --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 bcf4ff0c3eef498cd853a88270c75c161e524549 --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=6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 07:08:35,733 truncating revision to first 12 chars 2016-06-30 07:08:35,734 Setting DEBUG logging. 2016-06-30 07:08:35,734 attempt 1/10 2016-06-30 07:08:35,734 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bcf4ff0c3eef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 07:08:36,044 unpacking tar archive at: mozilla-central-bcf4ff0c3eef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639379 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:36.117387) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:36.117755) ========= script_repo_revision: bcf4ff0c3eef498cd853a88270c75c161e524549 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:36.118229) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:36.118563) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:36.127560) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-30 07:08:36.127889) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:08:36 INFO - MultiFileLogger online at 20160630 07:08:36 in /builds/slave/test 07:08:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:08:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:08:36 INFO - {'append_to_log': False, 07:08:36 INFO - 'base_work_dir': '/builds/slave/test', 07:08:36 INFO - 'blob_upload_branch': 'Firefox', 07:08:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:08:36 INFO - 'branch': 'Firefox', 07:08:36 INFO - 'buildbot_json_path': 'buildprops.json', 07:08:36 INFO - 'config_files': ('talos/linux_config.py',), 07:08:36 INFO - 'default_actions': ('clobber', 07:08:36 INFO - 'read-buildbot-config', 07:08:36 INFO - 'download-and-extract', 07:08:36 INFO - 'populate-webroot', 07:08:36 INFO - 'create-virtualenv', 07:08:36 INFO - 'install', 07:08:36 INFO - 'run-tests'), 07:08:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:08:36 INFO - 'download_minidump_stackwalk': True, 07:08:36 INFO - 'download_symbols': 'ondemand', 07:08:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:08:36 INFO - 'tooltool.py': '/tools/tooltool.py', 07:08:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:08:36 INFO - '/tools/misc-python/virtualenv.py')}, 07:08:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:08:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:08:36 INFO - 'installer_path': 'installer.exe', 07:08:36 INFO - 'log_level': 'info', 07:08:36 INFO - 'log_name': 'talos', 07:08:36 INFO - 'log_to_console': True, 07:08:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:08:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:08:36 INFO - 'opt_config_files': (), 07:08:36 INFO - 'pip_index': False, 07:08:36 INFO - 'sps_profile': False, 07:08:36 INFO - 'sps_profile_interval': 0, 07:08:36 INFO - 'suite': 'dromaeojs-e10s', 07:08:36 INFO - 'system_bits': '32', 07:08:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:08:36 INFO - 'title': 'talos-linux64-ix-050', 07:08:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:08:36 INFO - 'use_talos_json': True, 07:08:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:08:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:08:36 INFO - 'work_dir': 'build'} 07:08:36 INFO - ##### 07:08:36 INFO - ##### Running clobber step. 07:08:36 INFO - ##### 07:08:36 INFO - Running pre-action listener: _resource_record_pre_action 07:08:36 INFO - Running main action method: clobber 07:08:36 INFO - rmtree: /builds/slave/test/build 07:08:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:08:37 INFO - Running post-action listener: _resource_record_post_action 07:08:37 INFO - ##### 07:08:37 INFO - ##### Finished clobber step (success) 07:08:37 INFO - ##### 07:08:37 INFO - ##### 07:08:37 INFO - ##### Running read-buildbot-config step. 07:08:37 INFO - ##### 07:08:37 INFO - Running pre-action listener: _resource_record_pre_action 07:08:37 INFO - Running main action method: read_buildbot_config 07:08:37 INFO - Using buildbot properties: 07:08:37 INFO - { 07:08:37 INFO - "project": "", 07:08:37 INFO - "product": "firefox", 07:08:37 INFO - "script_repo_revision": "production", 07:08:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:08:37 INFO - "repository": "", 07:08:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:08:37 INFO - "buildid": "20160630043019", 07:08:37 INFO - "pgo_build": "True", 07:08:37 INFO - "basedir": "/builds/slave/test", 07:08:37 INFO - "buildnumber": 74, 07:08:37 INFO - "slavename": "talos-linux64-ix-050", 07:08:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:08:37 INFO - "platform": "ubuntu64_hw", 07:08:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:08:37 INFO - "branch": "mozilla-central", 07:08:37 INFO - "repo_path": "mozilla-central", 07:08:37 INFO - "revision": "bcf4ff0c3eef498cd853a88270c75c161e524549", 07:08:37 INFO - "stage_platform": "linux64-pgo", 07:08:37 INFO - "builduid": "617b4a1dd3d54393989b89c4066a5b7d", 07:08:37 INFO - "slavebuilddir": "test" 07:08:37 INFO - } 07:08:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:08:37 INFO - Running post-action listener: _resource_record_post_action 07:08:37 INFO - ##### 07:08:37 INFO - ##### Finished read-buildbot-config step (success) 07:08:37 INFO - ##### 07:08:37 INFO - ##### 07:08:37 INFO - ##### Running download-and-extract step. 07:08:37 INFO - ##### 07:08:37 INFO - Running pre-action listener: _resource_record_pre_action 07:08:37 INFO - Running main action method: download_and_extract 07:08:37 INFO - mkdir: /builds/slave/test/build/tests 07:08: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')]} 07:08:37 INFO - https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:08:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:08:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:08:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:44 INFO - Downloaded 1361 bytes. 07:08:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:08:44 INFO - Using the following test package requirements: 07:08:44 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:44 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:08:44 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:08:44 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:44 INFO - u'jsshell-linux-x86_64.zip'], 07:08:44 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:08:44 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:44 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:08:44 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:08:44 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:08:44 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:08:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:44 INFO - https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:08:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:08:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:47 INFO - Downloaded 24268109 bytes. 07:08:47 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'] 07:08:47 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 07:08:48 INFO - Return code: 0 07:08:48 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 07:08:48 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')]} 07:08:48 INFO - https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:08:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:08:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:58 INFO - Downloaded 24268109 bytes. 07:08:58 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'] 07:08:58 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 07:08:59 INFO - Return code: 0 07:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:59 INFO - https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:08:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:09:02 INFO - Downloaded 14405242 bytes. 07:09:02 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'] 07:09:02 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 07:09:02 INFO - Return code: 0 07:09:02 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')]} 07:09:02 INFO - https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:09:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:09:04 INFO - Downloaded 60330009 bytes. 07:09:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:04 INFO - mkdir: /builds/slave/test/properties 07:09:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:09:04 INFO - Writing to file /builds/slave/test/properties/build_url 07:09:04 INFO - Contents: 07:09:04 INFO - build_url:https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:05 INFO - Running post-action listener: _resource_record_post_action 07:09:05 INFO - Running post-action listener: set_extra_try_arguments 07:09:05 INFO - ##### 07:09:05 INFO - ##### Finished download-and-extract step (success) 07:09:05 INFO - ##### 07:09:05 INFO - ##### 07:09:05 INFO - ##### Running populate-webroot step. 07:09:05 INFO - ##### 07:09:05 INFO - Running pre-action listener: _resource_record_pre_action 07:09:05 INFO - Running main action method: populate_webroot 07:09:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:09:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:09:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:09:05 INFO - '--tppagecycles', 07:09:05 INFO - '7'], 07:09:05 INFO - 'tests': ['tsvgm']}}, 07:09:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:09:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:09:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:09:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:09:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:09:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:09:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:05 INFO - 'talos_options': ['--disable-e10s'], 07:09:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:05 INFO - 'talos_options': ['--disable-e10s'], 07:09:05 INFO - 'tests': ['damp', 'tps']}, 07:09:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:05 INFO - 'tests': ['damp', 'tps']}, 07:09:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:09:05 INFO - 'tests': ['dromaeo_dom']}, 07:09:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:09:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:09:05 INFO - 'tests': ['basic_compositor_video']}, 07:09:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:09:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:09:05 INFO - 'tests': ['a11yr', 07:09:05 INFO - 'ts_paint', 07:09:05 INFO - 'tpaint', 07:09:05 INFO - 'sessionrestore', 07:09:05 INFO - 'sessionrestore_no_auto_restore', 07:09:05 INFO - 'tabpaint']}, 07:09:05 INFO - 'other-e10s': {'tests': ['a11yr', 07:09:05 INFO - 'ts_paint', 07:09:05 INFO - 'tpaint', 07:09:05 INFO - 'sessionrestore', 07:09:05 INFO - 'sessionrestore_no_auto_restore', 07:09:05 INFO - 'tabpaint']}, 07:09:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:09:05 INFO - 'ts_paint', 07:09:05 INFO - 'tpaint', 07:09:05 INFO - 'sessionrestore', 07:09:05 INFO - 'sessionrestore_no_auto_restore', 07:09:05 INFO - 'tabpaint']}, 07:09:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:09:05 INFO - 'ts_paint', 07:09:05 INFO - 'tpaint', 07:09:05 INFO - 'sessionrestore', 07:09:05 INFO - 'sessionrestore_no_auto_restore', 07:09:05 INFO - 'tabpaint']}, 07:09:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:09:05 INFO - 'tests': ['a11yr', 07:09:05 INFO - 'ts_paint', 07:09:05 INFO - 'tpaint', 07:09:05 INFO - 'sessionrestore', 07:09:05 INFO - 'sessionrestore_no_auto_restore', 07:09:05 INFO - 'tabpaint']}, 07:09:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:09:05 INFO - 'tests': ['a11yr', 07:09:05 INFO - 'ts_paint', 07:09:05 INFO - 'tpaint', 07:09:05 INFO - 'sessionrestore', 07:09:05 INFO - 'sessionrestore_no_auto_restore', 07:09:05 INFO - 'tabpaint']}, 07:09:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:09:05 INFO - 'tests': ['tsvgx', 07:09:05 INFO - 'tsvgr_opacity', 07:09:05 INFO - 'tart', 07:09:05 INFO - 'tscrollx', 07:09:05 INFO - 'cart']}, 07:09:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:09:05 INFO - 'tsvgr_opacity', 07:09:05 INFO - 'tart', 07:09:05 INFO - 'tscrollx', 07:09:05 INFO - 'cart']}, 07:09:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:05 INFO - 'talos_options': ['--disable-e10s'], 07:09:05 INFO - 'tests': ['tp5o']}, 07:09:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:05 INFO - 'tests': ['tp5o']}, 07:09:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:05 INFO - 'talos_options': ['--disable-e10s', 07:09:05 INFO - '--xperf_path', 07:09:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:05 INFO - 'tests': ['tp5n']}, 07:09:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:05 INFO - 'talos_options': ['--xperf_path', 07:09:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:05 INFO - 'tests': ['tp5n']}}, 07:09:05 INFO - 'talos.zip': {'path': '', 07:09:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:09:05 INFO - Running post-action listener: _resource_record_post_action 07:09:05 INFO - ##### 07:09:05 INFO - ##### Finished populate-webroot step (success) 07:09:05 INFO - ##### 07:09:05 INFO - ##### 07:09:05 INFO - ##### Running create-virtualenv step. 07:09:05 INFO - ##### 07:09:05 INFO - Running pre-action listener: _resource_record_pre_action 07:09:05 INFO - Running main action method: create_virtualenv 07:09:05 INFO - Creating virtualenv /builds/slave/test/build/venv 07:09:05 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 07:09:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:09:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:09:05 INFO - Using real prefix '/usr' 07:09:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:09:05 INFO - Installing distribute.............................................................................................................................................................................................done. 07:09:07 INFO - Installing pip.................done. 07:09:07 INFO - Return code: 0 07:09:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:07 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 0x1d1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fde3b0>, '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 0x1fdf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf740>, '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': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', '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 07:09:07 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 07:09:07 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 07:09:07 INFO - Using env: {'DISPLAY': ':0', 07:09:07 INFO - 'HOME': '/home/cltbld', 07:09:07 INFO - 'LANG': 'en_US.UTF-8', 07:09:07 INFO - 'LANGUAGE': 'en_US:en', 07:09:07 INFO - 'LOGNAME': 'cltbld', 07:09:07 INFO - 'MAIL': '/var/mail/cltbld', 07:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:07 INFO - 'MOZ_NO_REMOTE': '1', 07:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:07 INFO - 'NO_EM_RESTART': '1', 07:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:07 INFO - 'PWD': '/builds/slave/test', 07:09:07 INFO - 'SHELL': '/bin/bash', 07:09:07 INFO - 'SHLVL': '1', 07:09:07 INFO - 'TERM': 'linux', 07:09:07 INFO - 'TMOUT': '86400', 07:09:07 INFO - 'USER': 'cltbld', 07:09:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', 07:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:07 INFO - '_': '/tools/buildbot/bin/python'} 07:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:08 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 07:09:08 INFO - Cleaning up... 07:09:08 INFO - Return code: 0 07:09:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:08 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 0x1d1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fde3b0>, '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 0x1fdf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf740>, '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': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', '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 07:09:08 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 07:09:08 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 07:09:08 INFO - Using env: {'DISPLAY': ':0', 07:09:08 INFO - 'HOME': '/home/cltbld', 07:09:08 INFO - 'LANG': 'en_US.UTF-8', 07:09:08 INFO - 'LANGUAGE': 'en_US:en', 07:09:08 INFO - 'LOGNAME': 'cltbld', 07:09:08 INFO - 'MAIL': '/var/mail/cltbld', 07:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:08 INFO - 'MOZ_NO_REMOTE': '1', 07:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:08 INFO - 'NO_EM_RESTART': '1', 07:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:08 INFO - 'PWD': '/builds/slave/test', 07:09:08 INFO - 'SHELL': '/bin/bash', 07:09:08 INFO - 'SHLVL': '1', 07:09:08 INFO - 'TERM': 'linux', 07:09:08 INFO - 'TMOUT': '86400', 07:09:08 INFO - 'USER': 'cltbld', 07:09:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', 07:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:08 INFO - '_': '/tools/buildbot/bin/python'} 07:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:08 INFO - Downloading/unpacking psutil>=3.1.1 07:09:08 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 07:09:08 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 07:09:08 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 07:09:08 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 07:09:08 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 07:09:08 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 07:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:09:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:10 INFO - Installing collected packages: psutil 07:09:10 INFO - Running setup.py install for psutil 07:09:10 INFO - building 'psutil._psutil_linux' extension 07:09:10 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 07:09:10 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 07:09:10 INFO - building 'psutil._psutil_posix' extension 07:09:10 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 07:09:10 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 07:09:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:10 INFO - Successfully installed psutil 07:09:10 INFO - Cleaning up... 07:09:10 INFO - Return code: 0 07:09:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:09:10 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')]} 07:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:10 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')]} 07:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:10 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 0x1d1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fde3b0>, '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 0x1fdf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf740>, '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': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', '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 07:09:10 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 07:09:10 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 07:09:10 INFO - Using env: {'DISPLAY': ':0', 07:09:10 INFO - 'HOME': '/home/cltbld', 07:09:10 INFO - 'LANG': 'en_US.UTF-8', 07:09:10 INFO - 'LANGUAGE': 'en_US:en', 07:09:10 INFO - 'LOGNAME': 'cltbld', 07:09:10 INFO - 'MAIL': '/var/mail/cltbld', 07:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:10 INFO - 'MOZ_NO_REMOTE': '1', 07:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:10 INFO - 'NO_EM_RESTART': '1', 07:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:10 INFO - 'PWD': '/builds/slave/test', 07:09:10 INFO - 'SHELL': '/bin/bash', 07:09:10 INFO - 'SHLVL': '1', 07:09:10 INFO - 'TERM': 'linux', 07:09:10 INFO - 'TMOUT': '86400', 07:09:10 INFO - 'USER': 'cltbld', 07:09:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', 07:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:10 INFO - '_': '/tools/buildbot/bin/python'} 07:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:09:11 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 07:09:11 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 07:09:11 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 07:09:11 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 07:09:11 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 07:09:11 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 07:09:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:09:13 INFO - Installing collected packages: mozsystemmonitor 07:09:13 INFO - Running setup.py install for mozsystemmonitor 07:09:13 INFO - Successfully installed mozsystemmonitor 07:09:13 INFO - Cleaning up... 07:09:13 INFO - Return code: 0 07:09:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:13 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 0x1d1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fde3b0>, '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 0x1fdf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf740>, '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': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', '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 07:09:13 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 07:09:13 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 07:09:13 INFO - Using env: {'DISPLAY': ':0', 07:09:13 INFO - 'HOME': '/home/cltbld', 07:09:13 INFO - 'LANG': 'en_US.UTF-8', 07:09:13 INFO - 'LANGUAGE': 'en_US:en', 07:09:13 INFO - 'LOGNAME': 'cltbld', 07:09:13 INFO - 'MAIL': '/var/mail/cltbld', 07:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:13 INFO - 'MOZ_NO_REMOTE': '1', 07:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:13 INFO - 'NO_EM_RESTART': '1', 07:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:13 INFO - 'PWD': '/builds/slave/test', 07:09:13 INFO - 'SHELL': '/bin/bash', 07:09:13 INFO - 'SHLVL': '1', 07:09:13 INFO - 'TERM': 'linux', 07:09:13 INFO - 'TMOUT': '86400', 07:09:13 INFO - 'USER': 'cltbld', 07:09:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', 07:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:13 INFO - '_': '/tools/buildbot/bin/python'} 07:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:13 INFO - Downloading/unpacking jsonschema==2.5.1 07:09:13 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 07:09:13 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 07:09:13 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 07:09:13 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 07:09:13 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 07:09:13 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 07:09:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:09:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:09:15 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 07:09:15 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 07:09:15 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 07:09:15 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 07:09:15 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 07:09:15 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 07:09:15 INFO - Downloading functools32-3.2.3-2.tar.gz 07:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:09:15 INFO - warning: no files found matching '*.txt' 07:09:15 INFO - no previously-included directories found matching 'build' 07:09:15 INFO - no previously-included directories found matching 'dist' 07:09:15 INFO - no previously-included directories found matching '.git*' 07:09:15 INFO - Installing collected packages: jsonschema, functools32 07:09:15 INFO - Running setup.py install for functools32 07:09:15 INFO - warning: no files found matching '*.txt' 07:09:15 INFO - no previously-included directories found matching 'build' 07:09:15 INFO - no previously-included directories found matching 'dist' 07:09:15 INFO - no previously-included directories found matching '.git*' 07:09:15 INFO - Successfully installed jsonschema functools32 07:09:15 INFO - Cleaning up... 07:09:15 INFO - Return code: 0 07:09:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:09:15 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')]} 07:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:15 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')]} 07:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:15 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 0x1d1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fde3b0>, '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 0x1fdf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf740>, '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': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', '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 07:09:15 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 07:09:15 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 07:09:15 INFO - Using env: {'DISPLAY': ':0', 07:09:15 INFO - 'HOME': '/home/cltbld', 07:09:15 INFO - 'LANG': 'en_US.UTF-8', 07:09:15 INFO - 'LANGUAGE': 'en_US:en', 07:09:15 INFO - 'LOGNAME': 'cltbld', 07:09:15 INFO - 'MAIL': '/var/mail/cltbld', 07:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:15 INFO - 'MOZ_NO_REMOTE': '1', 07:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:15 INFO - 'NO_EM_RESTART': '1', 07:09:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:15 INFO - 'PWD': '/builds/slave/test', 07:09:15 INFO - 'SHELL': '/bin/bash', 07:09:15 INFO - 'SHLVL': '1', 07:09:15 INFO - 'TERM': 'linux', 07:09:15 INFO - 'TMOUT': '86400', 07:09:15 INFO - 'USER': 'cltbld', 07:09:15 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', 07:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:15 INFO - '_': '/tools/buildbot/bin/python'} 07:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:15 INFO - Downloading/unpacking blobuploader==1.2.4 07:09:15 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 07:09:15 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 07:09:15 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 07:09:15 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 07:09:15 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 07:09:15 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 07:09:17 INFO - Downloading blobuploader-1.2.4.tar.gz 07:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:09:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:09:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:18 INFO - Downloading docopt-0.6.1.tar.gz 07:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:09:18 INFO - Installing collected packages: blobuploader, requests, docopt 07:09:18 INFO - Running setup.py install for blobuploader 07:09:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:09:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:09:18 INFO - Running setup.py install for requests 07:09:19 INFO - Running setup.py install for docopt 07:09:19 INFO - Successfully installed blobuploader requests docopt 07:09:19 INFO - Cleaning up... 07:09:19 INFO - Return code: 0 07:09:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:19 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 0x1d1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fde3b0>, '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 0x1fdf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf740>, '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': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', '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 07:09:19 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 07:09:19 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 07:09:19 INFO - Using env: {'DISPLAY': ':0', 07:09:19 INFO - 'HOME': '/home/cltbld', 07:09:19 INFO - 'LANG': 'en_US.UTF-8', 07:09:19 INFO - 'LANGUAGE': 'en_US:en', 07:09:19 INFO - 'LOGNAME': 'cltbld', 07:09:19 INFO - 'MAIL': '/var/mail/cltbld', 07:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:19 INFO - 'MOZ_NO_REMOTE': '1', 07:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:19 INFO - 'NO_EM_RESTART': '1', 07:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:19 INFO - 'PWD': '/builds/slave/test', 07:09:19 INFO - 'SHELL': '/bin/bash', 07:09:19 INFO - 'SHLVL': '1', 07:09:19 INFO - 'TERM': 'linux', 07:09:19 INFO - 'TMOUT': '86400', 07:09:19 INFO - 'USER': 'cltbld', 07:09:19 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', 07:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:19 INFO - '_': '/tools/buildbot/bin/python'} 07:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:19 INFO - Running setup.py (path:/tmp/pip-b_HvCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:19 INFO - Running setup.py (path:/tmp/pip-pDl0VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:19 INFO - Running setup.py (path:/tmp/pip-PmOAdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:19 INFO - Running setup.py (path:/tmp/pip-ceeRuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:19 INFO - Running setup.py (path:/tmp/pip-BoENMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:19 INFO - Running setup.py (path:/tmp/pip-48P2qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:20 INFO - Running setup.py (path:/tmp/pip-GK52uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:20 INFO - Running setup.py (path:/tmp/pip-jx0lln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:20 INFO - Running setup.py (path:/tmp/pip-2fVhqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:20 INFO - Running setup.py (path:/tmp/pip-pDMhfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:20 INFO - Running setup.py (path:/tmp/pip-YuHox_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:20 INFO - Running setup.py (path:/tmp/pip-rkl4ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:20 INFO - Running setup.py (path:/tmp/pip-LbMI8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:20 INFO - Running setup.py (path:/tmp/pip-hjrUau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:20 INFO - Running setup.py (path:/tmp/pip-1kHo33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:20 INFO - Running setup.py (path:/tmp/pip-ughZvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:20 INFO - Running setup.py (path:/tmp/pip-lkLeBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:09:20 INFO - Running setup.py install for manifestparser 07:09:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:09:20 INFO - Running setup.py install for mozcrash 07:09:20 INFO - Running setup.py install for mozdebug 07:09:21 INFO - Running setup.py install for mozdevice 07:09:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:09:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:09:21 INFO - Running setup.py install for mozfile 07:09:21 INFO - Running setup.py install for mozhttpd 07:09:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:09:21 INFO - Running setup.py install for mozinfo 07:09:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:09:21 INFO - Running setup.py install for mozInstall 07:09:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:09:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:09:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:09:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:09:21 INFO - Running setup.py install for mozleak 07:09:21 INFO - Running setup.py install for mozlog 07:09:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:09:21 INFO - Running setup.py install for moznetwork 07:09:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:09:21 INFO - Running setup.py install for mozprocess 07:09:22 INFO - Running setup.py install for mozprofile 07:09:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:09:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:09:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:09:22 INFO - Running setup.py install for mozrunner 07:09:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:09:22 INFO - Running setup.py install for mozscreenshot 07:09:22 INFO - Running setup.py install for moztest 07:09:22 INFO - Running setup.py install for mozversion 07:09:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:09:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:09:22 INFO - Cleaning up... 07:09:22 INFO - Return code: 0 07:09:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:22 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 0x1d1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fde3b0>, '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 0x1fdf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf740>, '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': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', '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 07:09:22 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 07:09:22 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 07:09:22 INFO - Using env: {'DISPLAY': ':0', 07:09:22 INFO - 'HOME': '/home/cltbld', 07:09:22 INFO - 'LANG': 'en_US.UTF-8', 07:09:22 INFO - 'LANGUAGE': 'en_US:en', 07:09:22 INFO - 'LOGNAME': 'cltbld', 07:09:22 INFO - 'MAIL': '/var/mail/cltbld', 07:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:22 INFO - 'MOZ_NO_REMOTE': '1', 07:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:22 INFO - 'NO_EM_RESTART': '1', 07:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:22 INFO - 'PWD': '/builds/slave/test', 07:09:22 INFO - 'SHELL': '/bin/bash', 07:09:22 INFO - 'SHLVL': '1', 07:09:22 INFO - 'TERM': 'linux', 07:09:22 INFO - 'TMOUT': '86400', 07:09:22 INFO - 'USER': 'cltbld', 07:09:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', 07:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:22 INFO - '_': '/tools/buildbot/bin/python'} 07:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:22 INFO - Running setup.py (path:/tmp/pip-9IJ6FD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:22 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)) 07:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:22 INFO - Running setup.py (path:/tmp/pip-SAcuK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:22 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)) 07:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:22 INFO - Running setup.py (path:/tmp/pip-riQVHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:23 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)) 07:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:23 INFO - Running setup.py (path:/tmp/pip-oVJXFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:23 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)) 07:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:23 INFO - Running setup.py (path:/tmp/pip-63Qpmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:23 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)) 07:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:23 INFO - Running setup.py (path:/tmp/pip-5SWQXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:23 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)) 07:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:23 INFO - Running setup.py (path:/tmp/pip-MQDlb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:23 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)) 07:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:23 INFO - Running setup.py (path:/tmp/pip-r93gur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:23 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)) 07:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:23 INFO - Running setup.py (path:/tmp/pip-j0MRGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:23 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)) 07:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:23 INFO - Running setup.py (path:/tmp/pip-ZcFSk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:23 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)) 07:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:23 INFO - Running setup.py (path:/tmp/pip-BYZlLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:23 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)) 07:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:23 INFO - Running setup.py (path:/tmp/pip-S3qD8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:23 INFO - Running setup.py (path:/tmp/pip-uEZ7hX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:23 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)) 07:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:23 INFO - Running setup.py (path:/tmp/pip-sNTCvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:23 INFO - Running setup.py (path:/tmp/pip-m4Ts6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:23 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)) 07:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:23 INFO - Running setup.py (path:/tmp/pip-Ut559R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:23 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)) 07:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:23 INFO - Running setup.py (path:/tmp/pip-PEzQXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:25 INFO - Downloading blessings-1.6.tar.gz 07:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:09:26 INFO - Installing collected packages: blessings 07:09:26 INFO - Running setup.py install for blessings 07:09:26 INFO - Successfully installed blessings 07:09:26 INFO - Cleaning up... 07:09:26 INFO - Return code: 0 07:09:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:09:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:26 INFO - Reading from file tmpfile_stdout 07:09:26 INFO - Current package versions: 07:09:26 INFO - argparse == 1.2.1 07:09:26 INFO - blessings == 1.6 07:09:26 INFO - blobuploader == 1.2.4 07:09:26 INFO - docopt == 0.6.1 07:09:26 INFO - functools32 == 3.2.3-2 07:09:26 INFO - jsonschema == 2.5.1 07:09:26 INFO - manifestparser == 1.1 07:09:26 INFO - mozInstall == 1.12 07:09:26 INFO - mozcrash == 0.17 07:09:26 INFO - mozdebug == 0.1 07:09:26 INFO - mozdevice == 0.48 07:09:26 INFO - mozfile == 1.2 07:09:26 INFO - mozhttpd == 0.7 07:09:26 INFO - mozinfo == 0.9 07:09:26 INFO - mozleak == 0.1 07:09:26 INFO - mozlog == 3.2 07:09:26 INFO - moznetwork == 0.27 07:09:26 INFO - mozprocess == 0.22 07:09:26 INFO - mozprofile == 0.28 07:09:26 INFO - mozrunner == 6.11 07:09:26 INFO - mozscreenshot == 0.1 07:09:26 INFO - mozsystemmonitor == 0.3 07:09:26 INFO - moztest == 0.7 07:09:26 INFO - mozversion == 1.4 07:09:26 INFO - psutil == 3.1.1 07:09:26 INFO - requests == 1.2.3 07:09:26 INFO - wsgiref == 0.1.2 07:09:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:26 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 0x1d1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fde3b0>, '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 0x1fdf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf740>, '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': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', '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 07:09:26 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 07:09:26 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 07:09:26 INFO - Using env: {'DISPLAY': ':0', 07:09:26 INFO - 'HOME': '/home/cltbld', 07:09:26 INFO - 'LANG': 'en_US.UTF-8', 07:09:26 INFO - 'LANGUAGE': 'en_US:en', 07:09:26 INFO - 'LOGNAME': 'cltbld', 07:09:26 INFO - 'MAIL': '/var/mail/cltbld', 07:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:26 INFO - 'MOZ_NO_REMOTE': '1', 07:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:26 INFO - 'NO_EM_RESTART': '1', 07:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:26 INFO - 'PWD': '/builds/slave/test', 07:09:26 INFO - 'SHELL': '/bin/bash', 07:09:26 INFO - 'SHLVL': '1', 07:09:26 INFO - 'TERM': 'linux', 07:09:26 INFO - 'TMOUT': '86400', 07:09:26 INFO - 'USER': 'cltbld', 07:09:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', 07:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:26 INFO - '_': '/tools/buildbot/bin/python'} 07:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:26 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)) 07:09:26 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)) 07:09:26 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)) 07:09:26 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)) 07:09:26 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)) 07:09:26 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)) 07:09:26 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)) 07:09:26 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)) 07:09:26 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)) 07:09:26 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)) 07:09:26 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)) 07:09:26 INFO - Cleaning up... 07:09:26 INFO - Return code: 0 07:09:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fde3b0>, '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 0x1fdf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf740>, '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': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', '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 07:09: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', 'jsonschema'] in /builds/slave/test/build 07:09: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 jsonschema 07:09:26 INFO - Using env: {'DISPLAY': ':0', 07:09:26 INFO - 'HOME': '/home/cltbld', 07:09:26 INFO - 'LANG': 'en_US.UTF-8', 07:09:26 INFO - 'LANGUAGE': 'en_US:en', 07:09:26 INFO - 'LOGNAME': 'cltbld', 07:09:26 INFO - 'MAIL': '/var/mail/cltbld', 07:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:26 INFO - 'MOZ_NO_REMOTE': '1', 07:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:26 INFO - 'NO_EM_RESTART': '1', 07:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:26 INFO - 'PWD': '/builds/slave/test', 07:09:26 INFO - 'SHELL': '/bin/bash', 07:09:26 INFO - 'SHLVL': '1', 07:09:26 INFO - 'TERM': 'linux', 07:09:26 INFO - 'TMOUT': '86400', 07:09:26 INFO - 'USER': 'cltbld', 07:09:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', 07:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:26 INFO - '_': '/tools/buildbot/bin/python'} 07:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:09:26 INFO - Cleaning up... 07:09:26 INFO - Return code: 0 07:09:26 INFO - Running post-action listener: _resource_record_post_action 07:09:26 INFO - Running post-action listener: _start_resource_monitoring 07:09:26 INFO - Starting resource monitoring. 07:09:26 INFO - ##### 07:09:26 INFO - ##### Finished create-virtualenv step (success) 07:09:26 INFO - ##### 07:09:26 INFO - ##### 07:09:26 INFO - ##### Running install step. 07:09:26 INFO - ##### 07:09:26 INFO - Running pre-action listener: _resource_record_pre_action 07:09:26 INFO - Running main action method: install 07:09:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:27 INFO - Reading from file tmpfile_stdout 07:09:27 INFO - Detecting whether we're running mozinstall >=1.0... 07:09:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:09:27 INFO - Reading from file tmpfile_stdout 07:09:27 INFO - Output received: 07:09:27 INFO - Usage: mozinstall [options] installer 07:09:27 INFO - Options: 07:09:27 INFO - -h, --help show this help message and exit 07:09:27 INFO - -d DEST, --destination=DEST 07:09:27 INFO - Directory to install application into. [default: 07:09:27 INFO - "/builds/slave/test"] 07:09:27 INFO - --app=APP Application being installed. [default: firefox] 07:09:27 INFO - mkdir: /builds/slave/test/build/application 07:09:27 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'] 07:09:27 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 07:09:44 INFO - Reading from file tmpfile_stdout 07:09:44 INFO - Output received: 07:09:44 INFO - /builds/slave/test/build/application/firefox/firefox 07:09:44 INFO - Running post-action listener: _resource_record_post_action 07:09:44 INFO - ##### 07:09:44 INFO - ##### Finished install step (success) 07:09:44 INFO - ##### 07:09:44 INFO - ##### 07:09:44 INFO - ##### Running run-tests step. 07:09:44 INFO - ##### 07:09:44 INFO - Running pre-action listener: _resource_record_pre_action 07:09:44 INFO - Running main action method: run_tests 07:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:09:44 INFO - Python 2.7.3 07:09:44 INFO - Return code: 0 07:09:44 INFO - grabbing minidump binary from tooltool 07:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:44 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 0x1fde3b0>, '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 0x1fdf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:09:44 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 07:09:44 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 07:09:44 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 07:09:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:09:44 INFO - Return code: 0 07:09:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:09:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:09:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:09:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:09:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:09:44 INFO - Using env: {'DISPLAY': ':0', 07:09:44 INFO - 'HOME': '/home/cltbld', 07:09:44 INFO - 'LANG': 'en_US.UTF-8', 07:09:44 INFO - 'LANGUAGE': 'en_US:en', 07:09:44 INFO - 'LOGNAME': 'cltbld', 07:09:44 INFO - 'MAIL': '/var/mail/cltbld', 07:09:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:09:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:44 INFO - 'MOZ_NO_REMOTE': '1', 07:09:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:44 INFO - 'NO_EM_RESTART': '1', 07:09:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:44 INFO - 'PWD': '/builds/slave/test', 07:09:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:09:44 INFO - 'SHELL': '/bin/bash', 07:09:44 INFO - 'SHLVL': '1', 07:09:44 INFO - 'TERM': 'linux', 07:09:44 INFO - 'TMOUT': '86400', 07:09:44 INFO - 'USER': 'cltbld', 07:09:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654', 07:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:44 INFO - '_': '/tools/buildbot/bin/python'} 07:09:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:09:44 INFO - mozversion application_buildid: 20160630043019 07:09:44 INFO - mozversion application_changeset: bcf4ff0c3eef498cd853a88270c75c161e524549 07:09:44 INFO - mozversion application_display_name: Nightly 07:09:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:09:44 INFO - mozversion application_name: Firefox 07:09:44 INFO - mozversion application_remotingname: firefox 07:09:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:09:44 INFO - mozversion application_vendor: Mozilla 07:09:44 INFO - mozversion application_version: 50.0a1 07:09:44 INFO - mozversion platform_buildid: 20160630043019 07:09:44 INFO - mozversion platform_changeset: bcf4ff0c3eef498cd853a88270c75c161e524549 07:09:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:09:44 INFO - mozversion platform_version: 50.0a1 07:09:44 INFO - using testdate: 1467295784 07:09:44 INFO - actual date: 1467295784 07:09:44 INFO - starting webserver on 'localhost:58379' 07:09:44 INFO - SUITE-START | Running 2 tests 07:09:44 INFO - TEST-START | dromaeo_css 07:09:44 INFO - operating with platform_type : linux_ 07:09:44 INFO - Initialising browser for dromaeo_css test... 07:09:44 INFO - TEST-INFO | started process 18098 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKSXOIF/profile http://localhost:58379/getInfo.html) 07:09:49 INFO - PROCESS | 18098 | __metrics Screen width/height:1600/1200 07:09:49 INFO - PROCESS | 18098 | colorDepth:24 07:09:49 INFO - PROCESS | 18098 | Browser inner width/height: 1024/697 07:09:49 INFO - PROCESS | 18098 | __metrics 07:09:49 ERROR - PROCESS | 18098 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:09:50 INFO - TEST-INFO | 18098: exit 0 07:09:50 INFO - Browser initialized. 07:09:50 INFO - Running cycle 1/1 for dromaeo_css test... 07:09:50 INFO - TEST-INFO | started process 18216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKSXOIF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:02 INFO - PROCESS | 18216 | RSS: Main: 168144896 07:10:02 INFO - PROCESS | 18216 | 07:10:51 INFO - PROCESS | 18216 | 1467295851993 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] 07:12:59 INFO - PROCESS | 18216 | Cycle 1(1): loaded http://localhost:58379/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58379/tests/dromaeo/cssquery-ext.html) 07:13:00 INFO - PROCESS | 18216 | RSS: Main: 171761664 07:13:00 INFO - PROCESS | 18216 | 07:16:02 INFO - PROCESS | 18216 | Cycle 1(1): loaded http://localhost:58379/tests/dromaeo/cssquery-ext.html (next: http://localhost:58379/tests/dromaeo/cssquery-jquery.html) 07:16:03 INFO - PROCESS | 18216 | RSS: Main: 168570880 07:16:03 INFO - PROCESS | 18216 | 07:19:05 INFO - PROCESS | 18216 | Cycle 1(1): loaded http://localhost:58379/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58379/tests/dromaeo/cssquery-mootools.html) 07:19:06 INFO - PROCESS | 18216 | RSS: Main: 171851776 07:19:06 INFO - PROCESS | 18216 | 07:22:07 INFO - PROCESS | 18216 | Cycle 1(1): loaded http://localhost:58379/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58379/tests/dromaeo/cssquery-prototype.html) 07:22:08 INFO - PROCESS | 18216 | RSS: Main: 167952384 07:22:08 INFO - PROCESS | 18216 | 07:25:10 INFO - PROCESS | 18216 | Cycle 1(1): loaded http://localhost:58379/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58379/tests/dromaeo/cssquery-yui.html) 07:25:11 INFO - PROCESS | 18216 | RSS: Main: 170033152 07:25:11 INFO - PROCESS | 18216 | 07:28:14 INFO - PROCESS | 18216 | Cycle 1(1): loaded http://localhost:58379/tests/dromaeo/cssquery-yui.html (next: http://localhost:58379/tests/dromaeo/cssquery-dojo.html) 07:28:14 INFO - PROCESS | 18216 | RSS: Main: 170737664 07:28:14 INFO - PROCESS | 18216 | 07:28:14 INFO - PROCESS | 18216 | __start_tp_report 07:28:14 INFO - PROCESS | 18216 | _x_x_mozilla_page_load 07:28:14 INFO - PROCESS | 18216 | _x_x_mozilla_page_load_details 07:28:14 INFO - PROCESS | 18216 | |i|pagename|runs| 07:28:14 INFO - PROCESS | 18216 | |0;dojo.html;3065.4635438798214;3134.655187929329;3153.369326134773;3160.984195079024;3169.5245713143013;5248.5276325130735;5329.094054010818;5365.785368585257;5399.5680345572355;5418.160185171295;5184.818531351403;5272.209168624699;5301.681899086047;5325.254464374981;5330.760115794789;4774.713517188971;4822.397200349957;4890.559849613534;4959.132151873426;5000.274960130779;812.2264951597934;4781.258904869751;4786.066716990188;4845.563899249067;5021.17150670139;4859.58693511052;4867.1482490564185;4871.050145221683;4882.194437917739;4889.804407823683;4843.58829499493;4860.635452341053;4861.756912154378;4922.187839006559;4968.552830245295;4694.57748802606;4714.7642617869315;4745.738984355859;4830.275458681191;4853.902921941577;5285.920711189336;5344.599155063386;5349.491798279158;5374.140137577969;5413.485718856702;5588.636738611977;5712.571557133231;5726.427357264281;5742.310922689304;5743.310802703661;5726.198332233491;5747.511461525775;5802.5938184327115;5809.88380232393;5848;5406.486383793534;5411.053065713484;5422.186671999192;5428.267183930158;5439.5376393006645;5764.798232061858;5847.502962248172;5873.119032145212;5886.264216972879;5910.379410161871;5639.069553523623;5716.228309178291;5717.771289148387;5725.370209276976;5768.826935191951;5813.912791308134;5820.301563812285;5823.767049318065;5828.154917536934;5835.4748072673665;5500.752466138953;5712.542996560265;5726.455986681259;5794.855128621818;5808.506276966421;5802.4777770000055;5810;5819.88360232793;5831.446012628793;5890.646561206341;4401.537838526909;4410.0738844842945;4410.206162890647;4458.754768487699;4497.662675299301;3891;3922.8823135305415;3944.8027598619956;3947.86701501768;3958.247932892741;5313.521783039545;5329.600279979017;5451;5502.449755024466;5548.861278468071;5828.388019258002;5839.328477225174;5844.211031510777;5858.53131749459;5875.794347197913;5315;5418.241446197536;5423;5467.644603100785;5573.916391254134;4788.976055119702;4799.856004319876;4815.855524334275;4817.759112044384;4856.587190088811;5904.763809447574;5908.763649454059;5920.31916329619;5928.347881733006;5930.258717660293;5564.721763911869;5644.85887852807;5645.49190572834;5709.54323654115;5725;5852.502537284208;5882.676452795137;5894.528437725057;5907.3797251288;5916.31962324321;5370.275012873212;5597.832065038056;5608.242887210175;5616.438356164351;5627.099664053731;5688.829335119953;5691.3170419549915;5727.799527016701;5782.508486778671;5783.710814459344;5596.468335508121;5638.774449021993;5640.943590564042;5641.323041235078;5642.407547207484;5458.344998600193;5526.613137080366;5585.301837270341;5633.943660563342;5650.208970744181;5480.698561579152;5548.861278468071;5553.4724201200825;5556.249906262603;5573.442655734394;5597.524210442158;5610.635308704921;5639.210510528447;5646.632968857011;5653.152027195953;5255.211718242294;5500.037493438712;5513.807016754555;5542.418046105101;5543.861403464784 07:28:14 INFO - PROCESS | 18216 | |1;ext.html;566.1762136091986;613.72995881812;634.8825467288552;644.916160899083;676.3642176354224;38368.80815595922;42784.93037674056;42785.144297114115;42793.358099628495;42815;42937.570624293745;43272;43527;43667.12665746683;43831.12337753243;8655.307575393968;8784.253338466238;8790.780230494225;8799.912000880006;8819.338549608805;8689.695860644879;8700.956495217515;8774.429662071976;8784.868226976601;8788.51663158526;8746.912530874706;8786.16531429513;8786.253168480687;8844.07137250589;8846.20384165425;8686.86969695455;8702.34732395073;8707.912920870805;8745.95627021864;8748.081451447602;8521.914780852174;8571.185737354941;8598.312135029182;8602.440841345293;8605.354598405082;32665.18337041593;41097.794511027554;41418.37872431916;41484.1703165938;41532;3183.0291661261763;3323.96676033239;3388.915277118067;3546.6453354664586;3575.9987203583037;31106.222344441343;31304.373912521623;31443.842780786177;31497.007784260688;31604.209894752585;4121.402396652498;4188;4249.128928569636;4336.91326173478;4369.541198174209;313770;315120;317201.41399293084;318030;319542;36261.27477450436;36285.63714362875;36470.45294320587;36489.27021459556;36551.4517282241;37111.62888371136;37304.62695373011;37563.81218093892;37698.43452348217;38035.57679808775;15421.614459638375;15477.071375717493;15477.071375717493;15501.534953951399;15709.685806283811;11319.151063670093;11424.771504569862;11492.42537873103;11590.362530060758;11705.531778728926;19337.806621933883;19359;19386.321478748458;19434.61130777405;19588.412347629594;7093.184283807325;7297.781066567905;7461.216572259943;7509.316708129769;7560;937.7468083617522;1019.4036488654073;1049.2812423489934;1078.0351585331084;1146.5643055638805;32200.35599288001;32266.516002259985;32654;32661.346773064404;33168.3366332672;1099.2250463423268;1115.9553617855195;1131.0612191880718;1154.4343271796758;1261.1676293646333;17086.914565427094;17263.223154957806;17271.481855544353;17319.913400433168;17337.219825107648;512312;512560;516356;516522;516667;55958;57436.712816436484;57472;58041;58086.419135808945;1334.7397257534687;1336.0914578086995;1346.9932650336686;1358.5720498043086;1368.1996032321006;30033.249168770955;32099;32324.515132272565;32442.10515792706;32585.185370364983;50478;50739.49260507348;50785;50898.236526451394;51154;430174;430613;432311;434094;434139;29185.562216566344;29216.7078329214;29860.402791943605;29950.400991980474;29984.85007574948;48191.5180848187;48314.275285871445;48384.27423588579;48577.271340929205;49337.50662493329;38742.6125738739;41421.378679319234;41424;41876;42270.154596907276;41207.58792412037;41251.793741031106;42165.367519486615;43143;43301.56698433102;38381.80809095937;40750.79624601858;42003.15993680048;42083.36874946817;42935.570644293155;36917.815410923846;37937;38316.80841595774;38327.42508862314;38669.806650966566;28210.15369538917;28255.576166357932;28483;28505.714942850307;28626 07:28:14 INFO - PROCESS | 18216 | |2;jquery.html;394.9763014219145;398.54963890803396;404.3489981130378;406.8982754311422;415.5303218128626;16417.261223244954;18479.35322263721;19128.13923373448;20429.182832686693;20488.487787805294;19228.13473393697;19300.806991930076;20436.795632043675;20456.488587785312;20462.07920643571;5711.571632127586;5909.788493358851;5962.970185149068;5970.253718285215;5985.34161242263;5819.563532735041;5841.591088623798;5898.528117750569;5903.793367232148;5945.88108237835;5769.3076830780365;5848.561357898154;5921.289445266552;5937.584369094165;5942.049272116462;5487.6158668893195;5796.13058041293;5875.941240587604;5884.76460941564;5885.352611212763;5643.68959707216;5646.830595082154;5657.868426314753;5663.2637757091725;5678.659280443187;14815.111093334435;14819.851801481955;22314.77268750218;23912.760872391227;24642.260732178063;2415.1760011118013;2522.331582130737;2708.3093811078047;2955.650420965258;3035.3322269100763;10613.46932653372;12371.75256494874;12455.813162802566;14901.701965960729;14977.700445991019;1902.8477721782224;1945.902704864751;1949.5905859769323;1995.7804641489424;1999.7000449932627;81987.5900620499;91920;92295.07704922932;94115.52942235314;94539.05460945371;11430.314181149157;11570.42147892602;11692.356920369291;11733.120015998835;11892.524299028115;13615;16440;16524.256408461406;30501.38997220043;32235.67764322374;9291.349605527683;9418.623255069857;9605.231581473465;10013.749656258651;10107.292489525662;7679.654415551314;7920.6039698014865;7957.403194760416;8046.316063134582;8234.505929644241;9057.411268267542;9244.3528952974;9297.489677787094;9358.625654973861;9391;3300.72190819243;3513.3675938330834;3576.6602172794064;3660.899792232716;3768.3028639701197;891.3493150000536;977.1010670183448;1048.2190767877828;1055.3034996902009;1058.9682309530726;20160.798392016186;20382.28661996823;20459.38621841347;20654.380368588965;20842.37472875816;997.3567049253191;1007.4761124215366;1019.8980101989741;1057.0539367266254;1058.1904842795268;11115.777684446428;11471.197016208785;11643.941780291045;11664.6500604982;11677.766444671059;452894;456929;457631;461548;465361;56953;89472.5526372364;91093.08906910979;101005;102113;1008.2135933971367;1049.8320268756963;1065.504540388723;1067.530286673861;1067.631667074858;15592.532224033297;17377.304907803547;18140.45578632643;18879.150438230037;19124.61750764949;35246.823765881;45924.311135333664;45988.31017534673;46097.53902460932;46357;61328;64913.67543162254;65212.34000329063;66138.66930665316;66706.66646666736;9206.125418085272;9338.673146439842;9428.764280893032;9574.760630984281;9585.808283834145;11310.4910279036;14264.286785660468;14348.426062957366;14783.334749936494;14954.775678364616;12347.13570050088;12679.80980285278;12695.492180313053;12837.293948832903;12844.871551284368;7764.836935440611;12157.458357194291;12529.561465348668;12645.810312845499;12910.935445322713;11857.992070674089;12038.578649747216;12700.237985720516;12957.546485872948;13032.47870085186;9257.86113208289;9311.323961686961;9319.394239374418;9349.532523373668;9531.618735250513;9922.503874806087;11822.82265765997;12192.390380480763;12627.242365458102;12810.74378512406 07:28:14 INFO - PROCESS | 18216 | |3;mootools.html;1489.806325177727;1502.2864139533722;1644.8190699023112;1777.4756446848178;1795.8653101017428;7733.188015258401;8436.367272454567;8458.450200736963;8961.775955601113;8967.955160224197;8524.659013639463;8723.127687231274;8797.164269394414;8799.164079412445;8834.381593288472;2349.318697577705;2383.2969274064194;2384.308550520347;2387.1167667962877;2387.7134743830766;2303.332033710222;2311.653252012203;2333.369990102671;2337.0534933351933;2345.94135146621;2317.9884100579475;2324.0587562037317;2330.731965823935;2368.9407764805846;2368.9931778993946;2274.749777524471;2281.6007198740235;2289.599320118981;2291.7822806833406;2300.3214051854743;2172.0334451169238;2202.977970220293;2205.911763529457;2209.823214142865;2211.7456492503406;8706.1729135732;8832.02847686754;8857.424267422597;8878.467291962503;8904.376693631448;5084.288199652052;5111.131107711698;5171.689698618057;5180.6373553851245;5189;3203.2312245061016;3251.5122731590213;3298.323843612078;3310.519974603693;3313.701766840996;1103.8289065194826;1111.4387234446554;1118.9608363707312;1142.9885701142966;1149.3046706742468;12226.572069977597;12272.877271227351;12330.50677972889;12350.073744469111;12400.00799936003;4389.253826849444;4515.254982927846;4590.632749380042;4600.861974140781;4612.123696497655;10202.540885660163;10207.948960255151;10233.48832558384;10264.948675256725;10287.537060832281;5138.871528211825;5158.767855446514;5165.767540460688;5166.276721259027;5173.818916337986;4216.64158546527;4646.303054541778;4753.239481682914;4828.420589529279;4839.854804355875;3998.3202855514633;4002.2595819773437;4077.571854955246;4127.607877251657;4127.690423218271;1275.43880692495;1289.0976316578433;1295.747329270802;1298.4546490474024;1339.4441306857739;792.5324058805332;816.6161903905155;928.1182876267573;934.5654270763991;942.7784470649392;5730.656160630376;5787.305523337226;5896.086106653475;5951.083186331847;6021.638701677914;462.0182113009854;464.42875263426174;471.0390802762395;941.9058094190664;1036.108946306176;3847.5960024197616;3914.5498267699577;3930.1157239620857;3931.66580840626;3964.900877478086;10790.892091079146;10983.066439352744;10998.175136864767;11014.339139651647;11120.277181983145;10776.67669969902;11238.550457981753;11243.212975091665;11289.15331350152;11339.716507087389;8012.639431225609;8198.262156405952;8302.211289927447;8317.750467485865;8328.500289982621;5651.124075768263;5667.4332566743;5678.176664383724;5766.5675074368755;5864.589478736448;9930.25523085757;10016.899831001889;10236.948815256173;10262.35802271633;10386.532606032897;10114.544845481823;10169.338992965433;10372.481375931324;10607.045365917105;10615.734606634587;7614.619269036415;8297.211764882326;8307.418480706292;8572.485650860968;8746.344024198337;8841.425307355;8846.513441760764;8846.778830529289;8849.4247873888;8892.15524525195;7411.5553066816165;7619.08570971487;7625.771226863203;7637.350825179922;7717.536947783151;7311.707531698672;7401.962990185015;7425.740099096722;7513.4740568159705;7642.923570764221;6825.863482730417;6836.692348844214;6893.276205998298;6907.240203577502;6936.965315173392;5088.618353623419;5173.22401639742;5215.608829337891;5270.78916843322;5302.045631786315;5235.319408476874;5268.81559145428;5276.604254680991;5361.195820626781;5365.839024829262 07:28:14 INFO - PROCESS | 18216 | |4;prototype.html;330.2766940400523;332.220941891265;338.2592123250082;345.73551233306523;348.6583148514457;5708.7431065602095;5713.657180569169;5731.856703582413;5756.222909907161;5813.081683044596;5635.380108188096;5675.177099320596;5676.631018983763;5686.658800471974;5693.544516438686;4356.8257269709175;4359.673024523157;4418.895276180955;4429.86710398687;4458.710183838057;4405.427294451717;4446.733196008234;4476.216662084138;4478.14915166119;4482.148391805546;4423.823047078113;4432.423784907957;4440.800163992628;4447.3996010538485;4447.799849006802;4212.641925436342;4399.450068741423;4402.625776808975;4405.31717583775;4408.354987007801;3775.867844625425;3804.90487737806;3822.9808850955847;3827.158025234444;3832.3868181090893;5507.862303442406;5557.610597350662;5590.580706446992;5595.608307418483;5623.578231632603;4919.253664948963;4994.300797888299;5014.172661510883;5024.145895197825;5026.597872170218;5939.643621382731;5965.910511342333;5977.8804423911715;5985.730642121115;6014.909776353358;4202.411662367271;4206.663466922639;4230.534641189467;4234.55537168599;4238.978805105986;5899.793507227227;6064.605800622945;6083.2395950506625;6109.266887973472;6132.724027418777;4248.957510424918;4329.935050974238;4334.913301733947;4348.369486424451;4364.759938203366;4378.430803995524;4385.451818522684;4395.077033822933;4400.119976004812;4402.9559704402545;4739.928901066418;4926.778294976734;4974.955259395568;4975.975120124376;5025.673331233458;5903.940960590425;6025.096235564701;6041;6052.636841789506;6059.697015149225;1425.7504936636046;1474.329180222996;1499.5876134063;1504.9548513544612;1510.8489151084805;938.8544775559799;945.8980287964445;974.9567962280292;975.331897650112;975.8731364922656;4941.170592790544;4955.992822906728;5031.52200540948;5042.016806722654;5042.235217673785;5210.541048506424;5280.9207861882105;5304.170061328912;5316.119232959961;5370.0333939890415;5048.697078175322;5081.390233171969;5459.672419654833;5541.224228607998;5736.4550367715;3201.9039428817173;3220.7423406127455;3242.1732458223473;3256.9903329967788;3262.5758651375645;6056.939430605726;6258.08998815553;6319.58922670025;6327.753647455087;6358.268799088071;6192.195014648067;6218.533609979179;6222.160008398808;6239.719212635351;6243.562950593415;6201.317855035943;6262.279837818618;6271.27880293763;6297.96851015742;6300.180976473029;5752.395998420106;6067.36181231074;6075.848103797441;6100.816975490742;6120.418560236771;6001.339852616122;6036.486898613667;6046.27444706638;6061.605995610271;6097.4817140543555;5982.341942386247;6175.69121543912;6212.534059945612;6250;6275.466585340115;4221;4246.214450326699;4265.12564924196;4280.079782846578;4294.957050429456;6031.577789554689;6105.45050945417;6113.358097399887;6127.20346354971;6145.293291271382;5617.522510586646;5804.068945182656;5834.708264586839;5858.2677165354335;5923.940760592339;5847.7368518417625;5856.619319744203;5880.353161152356;5894.351621321737;5918.201042859159;5537.446255374431;5792.015357389169;5837.29952405714;5841.912371314519;5856.707164641836;5917.644941303535;5939.2575928009;5949.791757288474;5958.314793798769;5969.791057312973;5784.681842498703;5788.450097240755;5802.854928626818;5810.535157187331;5843.532517398683 07:28:14 INFO - PROCESS | 18216 | |5;yui.html;709.1702707831836;717.7918403662939;724.9093863267092;728.7959371376016;776.8290975985283;15209;16601.086940218283;16630.1684915754;16739.91630041851;17582.120893955314;16031.599210019725;16209.189540522986;16209.594760131002;16220.270087846045;16243.431479898207;653.464159389301;794.7695168401171;811;814.149214071294;814.2305521282391;784.7292684024031;805.3718099882101;812.92277233663;814.2793627639552;815.7104227999034;853.2065179383171;857.7298151082421;859.9312055035614;860.3762272352557;861.8491763941286;847.9576021198916;848.3806821020659;848.6138806842872;850.0479463001448;853.8463076646201;616.2389449030444;621.1459243540132;621.6394491195095;623.1618473153601;623.9968800156015;15426.151561664105;15458.845411545966;15468.071915685096;15479.303431345505;15483.922580387138;14977.475788347465;15232.162231077285;15241.771373429407;15245.771313430196;15251.542453726406;12300.692482687915;12389.504419823286;12560.623181304576;12570.874291257152;12734.745305093846;3788;3958.841646334143;4044.1911617676583;4053.1893621275863;4076.1236334187997;78328.60835695842;80115;81189.18810811876;81247.5937620314;81345;11161.274517156358;11287.49206285719;11347.37589432589;11419.714507137389;11592.014678752232;21839.563208736054;21888.23391181301;21907.233246836604;22051;22124.88937555302;8496.150384961455;8507.957460212783;8629.827403451896;8738.169873861973;8872.334574906909;4727.361806156194;4730;4770.284457331359;4805.711657300573;4840.878978025577;3298.93402131956;3419.059758566414;3433.759636825398;3438.054535002844;3440.6215316315183;634.8888944434798;661.4113439039259;668.8829454845383;684.6679360510149;684.8561802021632;632.4371309534517;672.6166085331412;704.9259827718016;717.4296434334613;745.5079647432776;9650.372725772802;9703.369280996712;9759.951200244095;10204.285700000928;10309.587616495257;719.9208087110413;742.4988133010196;755.3692666623322;759.1004659478535;776.6543887969799;4501.234790085693;4631.513691062457;4660.370849935215;4701.553352431513;5068.189089745697;125267.3736631311;130659.34670326777;132667;134509.32745336407;135476.32261838825;106585;109406;109690.45154774335;110002.44998774955;110983;97129;98036;99554;99601;101580.49209753904;9964.402135871582;10206.387616743019;10260.384376937407;10579.994900484442;10598.629047983284;46609.300860486444;48439.5156048435;54531.72734136304;55032;55498.72250638721;55537;58094;75410.6229468871;76048.23951760633;80050;11968.401579921143;11996.40017999114;12156;12299.44652490658;12313.938430307791;15079.54761357161;15218.315175817337;15266.847331526988;15409.614759631098;15761.290741916871;14205.218712970885;14279;14337.211453370164;14394.496192633207;14555.563333100024;13631.454741810216;13976.440942362191;14284.285785710465;14290.42838286457;14365;13544.187348759106;13719.657008574866;13725.176489410667;13788.793168102286;14364.569062928129;11326.129176833627;11587.594434194763;11965.76068478608;12077.894243661263;12269.75460490803;11421.257618254787;11478.82781758291;11507.539698411969;11754.529818807152;11789.174757766874 07:28:14 INFO - PROCESS | 18216 | __end_tp_report 07:28:14 INFO - PROCESS | 18216 | __start_cc_report 07:28:14 INFO - PROCESS | 18216 | _x_x_mozilla_cycle_collect,342 07:28:14 INFO - PROCESS | 18216 | __end_cc_report 07:28:14 INFO - PROCESS | 18216 | __startTimestamp1467296894517__endTimestamp 07:28:14 INFO - PROCESS | 18216 | 07:28:14 INFO - PROCESS | 18216 | ------- Summary: start ------- 07:28:14 INFO - PROCESS | 18216 | Number of tests: 6 07:28:14 INFO - PROCESS | 18216 | 07:28:14 INFO - PROCESS | 18216 | [#0] dojo.html Cycles:165 Average:5301.70 Median:5548.86 stddev:700.17 (12.6%) stddev-sans-first:679.99 07:28:14 INFO - PROCESS | 18216 | Values: 3065.5 3134.7 3153.4 3161.0 3169.5 5248.5 5329.1 5365.8 5399.6 5418.2 5184.8 5272.2 5301.7 5325.3 5330.8 4774.7 4822.4 4890.6 4959.1 5000.3 812.2 4781.3 4786.1 4845.6 5021.2 4859.6 4867.1 4871.1 4882.2 4889.8 4843.6 4860.6 4861.8 4922.2 4968.6 4694.6 4714.8 4745.7 4830.3 4853.9 5285.9 5344.6 5349.5 5374.1 5413.5 5588.6 5712.6 5726.4 5742.3 5743.3 5726.2 5747.5 5802.6 5809.9 5848.0 5406.5 5411.1 5422.2 5428.3 5439.5 5764.8 5847.5 5873.1 5886.3 5910.4 5639.1 5716.2 5717.8 5725.4 5768.8 5813.9 5820.3 5823.8 5828.2 5835.5 5500.8 5712.5 5726.5 5794.9 5808.5 5802.5 5810.0 5819.9 5831.4 5890.6 4401.5 4410.1 4410.2 4458.8 4497.7 3891.0 3922.9 3944.8 3947.9 3958.2 5313.5 5329.6 5451.0 5502.4 5548.9 5828.4 5839.3 5844.2 5858.5 5875.8 5315.0 5418.2 5423.0 5467.6 5573.9 4789.0 4799.9 4815.9 4817.8 4856.6 5904.8 5908.8 5920.3 5928.3 5930.3 5564.7 5644.9 5645.5 5709.5 5725.0 5852.5 5882.7 5894.5 5907.4 5916.3 5370.3 5597.8 5608.2 5616.4 5627.1 5688.8 5691.3 5727.8 5782.5 5783.7 5596.5 5638.8 5640.9 5641.3 5642.4 5458.3 5526.6 5585.3 5633.9 5650.2 5480.7 5548.9 5553.5 5556.2 5573.4 5597.5 5610.6 5639.2 5646.6 5653.2 5255.2 5500.0 5513.8 5542.4 5543.9 07:28:14 INFO - PROCESS | 18216 | 07:28:14 INFO - PROCESS | 18216 | [#1] ext.html Cycles:180 Average:57297.13 Median:22664.50 stddev:113747.87 (501.9%) stddev-sans-first:113987.21 07:28:14 INFO - PROCESS | 18216 | Values: 566.2 613.7 634.9 644.9 676.4 38368.8 42784.9 42785.1 42793.4 42815.0 42937.6 43272.0 43527.0 43667.1 43831.1 8655.3 8784.3 8790.8 8799.9 8819.3 8689.7 8701.0 8774.4 8784.9 8788.5 8746.9 8786.2 8786.3 8844.1 8846.2 8686.9 8702.3 8707.9 8746.0 8748.1 8521.9 8571.2 8598.3 8602.4 8605.4 32665.2 41097.8 41418.4 41484.2 41532.0 3183.0 3324.0 3388.9 3546.6 3576.0 31106.2 31304.4 31443.8 31497.0 31604.2 4121.4 4188.0 4249.1 4336.9 4369.5 313770.0 315120.0 317201.4 318030.0 319542.0 36261.3 36285.6 36470.5 36489.3 36551.5 37111.6 37304.6 37563.8 37698.4 38035.6 15421.6 15477.1 15477.1 15501.5 15709.7 11319.2 11424.8 11492.4 11590.4 11705.5 19337.8 19359.0 19386.3 19434.6 19588.4 7093.2 7297.8 7461.2 7509.3 7560.0 937.7 1019.4 1049.3 1078.0 1146.6 32200.4 32266.5 32654.0 32661.3 33168.3 1099.2 1116.0 1131.1 1154.4 1261.2 17086.9 17263.2 17271.5 17319.9 17337.2 512312.0 512560.0 516356.0 516522.0 516667.0 55958.0 57436.7 57472.0 58041.0 58086.4 1334.7 1336.1 1347.0 1358.6 1368.2 30033.2 32099.0 32324.5 32442.1 32585.2 50478.0 50739.5 50785.0 50898.2 51154.0 430174.0 430613.0 432311.0 434094.0 434139.0 29185.6 29216.7 29860.4 29950.4 29984.9 48191.5 48314.3 48384.3 48577.3 49337.5 38742.6 41421.4 41424.0 41876.0 42270.2 41207.6 41251.8 42165.4 43143.0 43301.6 38381.8 40750.8 42003.2 42083.4 42935.6 36917.8 37937.0 38316.8 38327.4 38669.8 28210.2 28255.6 28483.0 28505.7 28626.0 07:28:14 INFO - PROCESS | 18216 | 07:28:14 INFO - PROCESS | 18216 | [#2] jquery.html Cycles:180 Average:29206.09 Median:2995.49 stddev:75981.95 (2536.5%) stddev-sans-first:76164.30 07:28:14 INFO - PROCESS | 18216 | Values: 395.0 398.5 404.3 406.9 415.5 16417.3 18479.4 19128.1 20429.2 20488.5 19228.1 19300.8 20436.8 20456.5 20462.1 5711.6 5909.8 5963.0 5970.3 5985.3 5819.6 5841.6 5898.5 5903.8 5945.9 5769.3 5848.6 5921.3 5937.6 5942.0 5487.6 5796.1 5875.9 5884.8 5885.4 5643.7 5646.8 5657.9 5663.3 5678.7 14815.1 14819.9 22314.8 23912.8 24642.3 2415.2 2522.3 2708.3 2955.7 3035.3 10613.5 12371.8 12455.8 14901.7 14977.7 1902.8 1945.9 1949.6 1995.8 1999.7 81987.6 91920.0 92295.1 94115.5 94539.1 11430.3 11570.4 11692.4 11733.1 11892.5 13615.0 16440.0 16524.3 30501.4 32235.7 9291.3 9418.6 9605.2 10013.7 10107.3 7679.7 7920.6 7957.4 8046.3 8234.5 9057.4 9244.4 9297.5 9358.6 9391.0 3300.7 3513.4 3576.7 3660.9 3768.3 891.3 977.1 1048.2 1055.3 1059.0 20160.8 20382.3 20459.4 20654.4 20842.4 997.4 1007.5 1019.9 1057.1 1058.2 11115.8 11471.2 11643.9 11664.7 11677.8 452894.0 456929.0 457631.0 461548.0 465361.0 56953.0 89472.6 91093.1 101005.0 102113.0 1008.2 1049.8 1065.5 1067.5 1067.6 15592.5 17377.3 18140.5 18879.2 19124.6 35246.8 45924.3 45988.3 46097.5 46357.0 61328.0 64913.7 65212.3 66138.7 66706.7 9206.1 9338.7 9428.8 9574.8 9585.8 11310.5 14264.3 14348.4 14783.3 14954.8 12347.1 12679.8 12695.5 12837.3 12844.9 7764.8 12157.5 12529.6 12645.8 12910.9 11858.0 12038.6 12700.2 12957.5 13032.5 9257.9 9311.3 9319.4 9349.5 9531.6 9922.5 11822.8 12192.4 12627.2 12810.7 07:28:14 INFO - PROCESS | 18216 | 07:28:14 INFO - PROCESS | 18216 | [#3] mootools.html Cycles:180 Average:5797.68 Median:2537.07 stddev:3345.41 (131.9%) stddev-sans-first:3339.13 07:28:14 INFO - PROCESS | 18216 | Values: 1489.8 1502.3 1644.8 1777.5 1795.9 7733.2 8436.4 8458.5 8961.8 8968.0 8524.7 8723.1 8797.2 8799.2 8834.4 2349.3 2383.3 2384.3 2387.1 2387.7 2303.3 2311.7 2333.4 2337.1 2345.9 2318.0 2324.1 2330.7 2368.9 2369.0 2274.7 2281.6 2289.6 2291.8 2300.3 2172.0 2203.0 2205.9 2209.8 2211.7 8706.2 8832.0 8857.4 8878.5 8904.4 5084.3 5111.1 5171.7 5180.6 5189.0 3203.2 3251.5 3298.3 3310.5 3313.7 1103.8 1111.4 1119.0 1143.0 1149.3 12226.6 12272.9 12330.5 12350.1 12400.0 4389.3 4515.3 4590.6 4600.9 4612.1 10202.5 10207.9 10233.5 10264.9 10287.5 5138.9 5158.8 5165.8 5166.3 5173.8 4216.6 4646.3 4753.2 4828.4 4839.9 3998.3 4002.3 4077.6 4127.6 4127.7 1275.4 1289.1 1295.7 1298.5 1339.4 792.5 816.6 928.1 934.6 942.8 5730.7 5787.3 5896.1 5951.1 6021.6 462.0 464.4 471.0 941.9 1036.1 3847.6 3914.5 3930.1 3931.7 3964.9 10790.9 10983.1 10998.2 11014.3 11120.3 10776.7 11238.6 11243.2 11289.2 11339.7 8012.6 8198.3 8302.2 8317.8 8328.5 5651.1 5667.4 5678.2 5766.6 5864.6 9930.3 10016.9 10236.9 10262.4 10386.5 10114.5 10169.3 10372.5 10607.0 10615.7 7614.6 8297.2 8307.4 8572.5 8746.3 8841.4 8846.5 8846.8 8849.4 8892.2 7411.6 7619.1 7625.8 7637.4 7717.5 7311.7 7402.0 7425.7 7513.5 7642.9 6825.9 6836.7 6893.3 6907.2 6937.0 5088.6 5173.2 5215.6 5270.8 5302.0 5235.3 5268.8 5276.6 5361.2 5365.8 07:28:14 INFO - PROCESS | 18216 | 07:28:14 INFO - PROCESS | 18216 | [#4] prototype.html Cycles:180 Average:4935.18 Median:5629.48 stddev:1456.97 (25.9%) stddev-sans-first:1419.47 07:28:14 INFO - PROCESS | 18216 | Values: 330.3 332.2 338.3 345.7 348.7 5708.7 5713.7 5731.9 5756.2 5813.1 5635.4 5675.2 5676.6 5686.7 5693.5 4356.8 4359.7 4418.9 4429.9 4458.7 4405.4 4446.7 4476.2 4478.1 4482.1 4423.8 4432.4 4440.8 4447.4 4447.8 4212.6 4399.5 4402.6 4405.3 4408.4 3775.9 3804.9 3823.0 3827.2 3832.4 5507.9 5557.6 5590.6 5595.6 5623.6 4919.3 4994.3 5014.2 5024.1 5026.6 5939.6 5965.9 5977.9 5985.7 6014.9 4202.4 4206.7 4230.5 4234.6 4239.0 5899.8 6064.6 6083.2 6109.3 6132.7 4249.0 4329.9 4334.9 4348.4 4364.8 4378.4 4385.5 4395.1 4400.1 4403.0 4739.9 4926.8 4975.0 4976.0 5025.7 5903.9 6025.1 6041.0 6052.6 6059.7 1425.8 1474.3 1499.6 1505.0 1510.8 938.9 945.9 975.0 975.3 975.9 4941.2 4956.0 5031.5 5042.0 5042.2 5210.5 5280.9 5304.2 5316.1 5370.0 5048.7 5081.4 5459.7 5541.2 5736.5 3201.9 3220.7 3242.2 3257.0 3262.6 6056.9 6258.1 6319.6 6327.8 6358.3 6192.2 6218.5 6222.2 6239.7 6243.6 6201.3 6262.3 6271.3 6298.0 6300.2 5752.4 6067.4 6075.8 6100.8 6120.4 6001.3 6036.5 6046.3 6061.6 6097.5 5982.3 6175.7 6212.5 6250.0 6275.5 4221.0 4246.2 4265.1 4280.1 4295.0 6031.6 6105.5 6113.4 6127.2 6145.3 5617.5 5804.1 5834.7 5858.3 5923.9 5847.7 5856.6 5880.4 5894.4 5918.2 5537.4 5792.0 5837.3 5841.9 5856.7 5917.6 5939.3 5949.8 5958.3 5969.8 5784.7 5788.5 5802.9 5810.5 5843.5 07:28:14 INFO - PROCESS | 18216 | 07:28:14 INFO - PROCESS | 18216 | [#5] yui.html Cycles:180 Average:22130.59 Median:3439.34 stddev:32994.23 (959.3%) stddev-sans-first:33047.58 07:28:14 INFO - PROCESS | 18216 | Values: 709.2 717.8 724.9 728.8 776.8 15209.0 16601.1 16630.2 16739.9 17582.1 16031.6 16209.2 16209.6 16220.3 16243.4 653.5 794.8 811.0 814.1 814.2 784.7 805.4 812.9 814.3 815.7 853.2 857.7 859.9 860.4 861.8 848.0 848.4 848.6 850.0 853.8 616.2 621.1 621.6 623.2 624.0 15426.2 15458.8 15468.1 15479.3 15483.9 14977.5 15232.2 15241.8 15245.8 15251.5 12300.7 12389.5 12560.6 12570.9 12734.7 3788.0 3958.8 4044.2 4053.2 4076.1 78328.6 80115.0 81189.2 81247.6 81345.0 11161.3 11287.5 11347.4 11419.7 11592.0 21839.6 21888.2 21907.2 22051.0 22124.9 8496.2 8508.0 8629.8 8738.2 8872.3 4727.4 4730.0 4770.3 4805.7 4840.9 3298.9 3419.1 3433.8 3438.1 3440.6 634.9 661.4 668.9 684.7 684.9 632.4 672.6 704.9 717.4 745.5 9650.4 9703.4 9760.0 10204.3 10309.6 719.9 742.5 755.4 759.1 776.7 4501.2 4631.5 4660.4 4701.6 5068.2 125267.4 130659.3 132667.0 134509.3 135476.3 106585.0 109406.0 109690.5 110002.4 110983.0 97129.0 98036.0 99554.0 99601.0 101580.5 9964.4 10206.4 10260.4 10580.0 10598.6 46609.3 48439.5 54531.7 55032.0 55498.7 55537.0 58094.0 75410.6 76048.2 80050.0 11968.4 11996.4 12156.0 12299.4 12313.9 15079.5 15218.3 15266.8 15409.6 15761.3 14205.2 14279.0 14337.2 14394.5 14555.6 13631.5 13976.4 14284.3 14290.4 14365.0 13544.2 13719.7 13725.2 13788.8 14364.6 11326.1 11587.6 11965.8 12077.9 12269.8 11421.3 11478.8 11507.5 11754.5 11789.2 07:28:14 INFO - PROCESS | 18216 | -------- Summary: end -------- 07:28:14 INFO - PROCESS | 18216 | 07:28:15 INFO - TEST-INFO | 18216: exit 0 07:28:15 INFO - TEST-OK | dromaeo_css | took 1110641ms 07:28:15 INFO - TEST-START | kraken 07:28:15 INFO - operating with platform_type : linux_ 07:28:15 INFO - Initialising browser for kraken test... 07:28:15 INFO - TEST-INFO | started process 18462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyLmrcr/profile http://localhost:58379/getInfo.html) 07:28:19 INFO - PROCESS | 18462 | __metrics Screen width/height:1600/1200 07:28:19 INFO - PROCESS | 18462 | colorDepth:24 07:28:19 INFO - PROCESS | 18462 | Browser inner width/height: 1024/697 07:28:19 INFO - PROCESS | 18462 | __metrics 07:28:20 ERROR - PROCESS | 18462 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:28:21 INFO - TEST-INFO | 18462: exit 0 07:28:21 INFO - Browser initialized. 07:28:21 INFO - Running cycle 1/1 for kraken test... 07:28:21 INFO - TEST-INFO | started process 18584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyLmrcr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:32 INFO - PROCESS | 18584 | RSS: Main: 168669184 07:28:32 INFO - PROCESS | 18584 | 07:28:35 INFO - PROCESS | 18584 | Cycle 1(1): loaded http://localhost:58379/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58379/tests/kraken/driver.html?testName=audio-beat-detection) 07:28:36 INFO - PROCESS | 18584 | RSS: Main: 174243840 07:28:36 INFO - PROCESS | 18584 | 07:28:38 INFO - PROCESS | 18584 | Cycle 1(1): loaded http://localhost:58379/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58379/tests/kraken/driver.html?testName=audio-dft) 07:28:39 INFO - PROCESS | 18584 | RSS: Main: 173428736 07:28:39 INFO - PROCESS | 18584 | 07:28:42 INFO - PROCESS | 18584 | Cycle 1(1): loaded http://localhost:58379/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58379/tests/kraken/driver.html?testName=audio-fft) 07:28:43 INFO - PROCESS | 18584 | RSS: Main: 168579072 07:28:43 INFO - PROCESS | 18584 | 07:28:45 INFO - PROCESS | 18584 | Cycle 1(1): loaded http://localhost:58379/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58379/tests/kraken/driver.html?testName=audio-oscillator) 07:28:45 INFO - PROCESS | 18584 | RSS: Main: 169009152 07:28:45 INFO - PROCESS | 18584 | 07:28:47 INFO - PROCESS | 18584 | Cycle 1(1): loaded http://localhost:58379/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58379/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:28:48 INFO - PROCESS | 18584 | RSS: Main: 169410560 07:28:48 INFO - PROCESS | 18584 | 07:28:51 INFO - PROCESS | 18584 | Cycle 1(1): loaded http://localhost:58379/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58379/tests/kraken/driver.html?testName=imaging-darkroom) 07:28:52 INFO - PROCESS | 18584 | RSS: Main: 169463808 07:28:52 INFO - PROCESS | 18584 | 07:28:55 INFO - PROCESS | 18584 | Cycle 1(1): loaded http://localhost:58379/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58379/tests/kraken/driver.html?testName=imaging-desaturate) 07:28:56 INFO - PROCESS | 18584 | RSS: Main: 167239680 07:28:56 INFO - PROCESS | 18584 | 07:28:59 INFO - PROCESS | 18584 | Cycle 1(1): loaded http://localhost:58379/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58379/tests/kraken/driver.html?testName=json-parse-financial) 07:28:59 INFO - PROCESS | 18584 | RSS: Main: 168558592 07:28:59 INFO - PROCESS | 18584 | 07:29:01 INFO - PROCESS | 18584 | Cycle 1(1): loaded http://localhost:58379/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58379/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:29:02 INFO - PROCESS | 18584 | RSS: Main: 168898560 07:29:02 INFO - PROCESS | 18584 | 07:29:03 INFO - PROCESS | 18584 | Cycle 1(1): loaded http://localhost:58379/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58379/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:29:04 INFO - PROCESS | 18584 | RSS: Main: 169009152 07:29:04 INFO - PROCESS | 18584 | 07:29:06 INFO - PROCESS | 18584 | Cycle 1(1): loaded http://localhost:58379/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58379/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:29:07 INFO - PROCESS | 18584 | RSS: Main: 169525248 07:29:07 INFO - PROCESS | 18584 | 07:29:09 INFO - PROCESS | 18584 | Cycle 1(1): loaded http://localhost:58379/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:29:10 INFO - PROCESS | 18584 | RSS: Main: 169586688 07:29:10 INFO - PROCESS | 18584 | 07:29:13 INFO - PROCESS | 18584 | Cycle 1(1): loaded http://localhost:58379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:29:13 INFO - PROCESS | 18584 | RSS: Main: 169881600 07:29:13 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | Cycle 1(1): loaded http://localhost:58379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58379/tests/kraken/driver.html?testName=ai-astar) 07:29:15 INFO - PROCESS | 18584 | RSS: Main: 171118592 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | __start_tp_report 07:29:15 INFO - PROCESS | 18584 | _x_x_mozilla_page_load 07:29:15 INFO - PROCESS | 18584 | _x_x_mozilla_page_load_details 07:29:15 INFO - PROCESS | 18584 | |i|pagename|runs| 07:29:15 INFO - PROCESS | 18584 | |0;ai-astar;105;112;109;110;111;114;112;111;111;111 07:29:15 INFO - PROCESS | 18584 | |1;audio-beat-detection;147;122;147;165;118;151;147;119;175;117 07:29:15 INFO - PROCESS | 18584 | |2;audio-dft;162;163;163;164;162;175;166;175;163;162 07:29:15 INFO - PROCESS | 18584 | |3;audio-fft;75;76;76;171;77;75;76;74;166;76 07:29:15 INFO - PROCESS | 18584 | |4;audio-oscillator;84;84;141;83;83;84;138;83;85;153 07:29:15 INFO - PROCESS | 18584 | |5;imaging-gaussian-blur;117;117;118;118;117;116;117;119;117;117 07:29:15 INFO - PROCESS | 18584 | |6;imaging-darkroom;147;146;147;148;147;151;147;148;147;147 07:29:15 INFO - PROCESS | 18584 | |7;imaging-desaturate;95;96;95;96;96;96;96;96;96;96 07:29:15 INFO - PROCESS | 18584 | |8;json-parse-financial;57;55;55;54;56;54;55;55;53;53 07:29:15 INFO - PROCESS | 18584 | |9;json-stringify-tinderbox;60;60;61;61;61;63;61;60;63;60 07:29:15 INFO - PROCESS | 18584 | |10;stanford-crypto-aes;81;75;75;83;76;75;74;76;81;76 07:29:15 INFO - PROCESS | 18584 | |11;stanford-crypto-ccm;133;127;127;117;131;137;126;124;164;121 07:29:15 INFO - PROCESS | 18584 | |12;stanford-crypto-pbkdf2;158;159;159;159;162;154;156;154;153;152 07:29:15 INFO - PROCESS | 18584 | |13;stanford-crypto-sha256-iterative;64;66;64;62;64;63;64;66;65;63 07:29:15 INFO - PROCESS | 18584 | __end_tp_report 07:29:15 INFO - PROCESS | 18584 | __start_cc_report 07:29:15 INFO - PROCESS | 18584 | _x_x_mozilla_cycle_collect,890 07:29:15 INFO - PROCESS | 18584 | __end_cc_report 07:29:15 INFO - PROCESS | 18584 | __startTimestamp1467296955575__endTimestamp 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | ------- Summary: start ------- 07:29:15 INFO - PROCESS | 18584 | Number of tests: 14 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:2.37 (2.1%) stddev-sans-first:1.39 07:29:15 INFO - PROCESS | 18584 | Values: 105.0 112.0 109.0 110.0 111.0 114.0 112.0 111.0 111.0 111.0 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:147.00 stddev:20.79 (14.1%) stddev-sans-first:21.93 07:29:15 INFO - PROCESS | 18584 | Values: 147.0 122.0 147.0 165.0 118.0 151.0 147.0 119.0 175.0 117.0 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | [#2] audio-dft Cycles:10 Average:165.50 Median:163.50 stddev:5.15 (3.1%) stddev-sans-first:5.30 07:29:15 INFO - PROCESS | 18584 | Values: 162.0 163.0 163.0 164.0 162.0 175.0 166.0 175.0 163.0 162.0 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:39.19 (51.6%) stddev-sans-first:40.94 07:29:15 INFO - PROCESS | 18584 | Values: 75.0 76.0 76.0 171.0 77.0 75.0 76.0 74.0 166.0 76.0 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:83.50 stddev:29.37 (35.2%) stddev-sans-first:30.43 07:29:15 INFO - PROCESS | 18584 | Values: 84.0 84.0 141.0 83.0 83.0 84.0 138.0 83.0 85.0 153.0 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 07:29:15 INFO - PROCESS | 18584 | Values: 117.0 117.0 118.0 118.0 117.0 116.0 117.0 119.0 117.0 117.0 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 07:29:15 INFO - PROCESS | 18584 | Values: 147.0 146.0 147.0 148.0 147.0 151.0 147.0 148.0 147.0 147.0 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:29:15 INFO - PROCESS | 18584 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.25 (2.3%) stddev-sans-first:1.01 07:29:15 INFO - PROCESS | 18584 | Values: 57.0 55.0 55.0 54.0 56.0 54.0 55.0 55.0 53.0 53.0 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:1.15 (1.9%) stddev-sans-first:1.17 07:29:15 INFO - PROCESS | 18584 | Values: 60.0 60.0 61.0 61.0 61.0 63.0 61.0 60.0 63.0 60.0 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:76.00 stddev:3.19 (4.2%) stddev-sans-first:3.07 07:29:15 INFO - PROCESS | 18584 | Values: 81.0 75.0 75.0 83.0 76.0 75.0 74.0 76.0 81.0 76.0 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:129.00 stddev:13.04 (10.1%) stddev-sans-first:13.80 07:29:15 INFO - PROCESS | 18584 | Values: 133.0 127.0 127.0 117.0 131.0 137.0 126.0 124.0 164.0 121.0 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:158.50 stddev:3.27 (2.1%) stddev-sans-first:3.43 07:29:15 INFO - PROCESS | 18584 | Values: 158.0 159.0 159.0 159.0 162.0 154.0 156.0 154.0 153.0 152.0 07:29:15 INFO - PROCESS | 18584 | 07:29:15 INFO - PROCESS | 18584 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:1.29 (2.0%) stddev-sans-first:1.36 07:29:15 INFO - PROCESS | 18584 | Values: 64.0 66.0 64.0 62.0 64.0 63.0 64.0 66.0 65.0 63.0 07:29:15 INFO - PROCESS | 18584 | -------- Summary: end -------- 07:29:15 INFO - PROCESS | 18584 | 07:29:16 INFO - TEST-INFO | 18584: exit 0 07:29:16 INFO - TEST-OK | kraken | took 61307ms 07:29:16 INFO - SUITE-END | took 1171s 07:29:16 INFO - Completed test suite (00:19:32) 07:29:16 INFO - javascript benchmark 07:29:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7394.267190208125, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.4635438798214, 3134.655187929329, 3153.369326134773, 3160.984195079024, 3169.5245713143013, 5248.5276325130735, 5329.094054010818, 5365.785368585257, 5399.5680345572355, 5418.160185171295, 5184.818531351403, 5272.209168624699, 5301.681899086047, 5325.254464374981, 5330.760115794789, 4774.713517188971, 4822.397200349957, 4890.559849613534, 4959.132151873426, 5000.274960130779, 812.2264951597934, 4781.258904869751, 4786.066716990188, 4845.563899249067, 5021.17150670139, 4859.58693511052, 4867.1482490564185, 4871.050145221683, 4882.194437917739, 4889.804407823683, 4843.58829499493, 4860.635452341053, 4861.756912154378, 4922.187839006559, 4968.552830245295, 4694.57748802606, 4714.7642617869315, 4745.738984355859, 4830.275458681191, 4853.902921941577, 5285.920711189336, 5344.599155063386, 5349.491798279158, 5374.140137577969, 5413.485718856702, 5588.636738611977, 5712.571557133231, 5726.427357264281, 5742.310922689304, 5743.310802703661, 5726.198332233491, 5747.511461525775, 5802.5938184327115, 5809.88380232393, 5848.0, 5406.486383793534, 5411.053065713484, 5422.186671999192, 5428.267183930158, 5439.5376393006645, 5764.798232061858, 5847.502962248172, 5873.119032145212, 5886.264216972879, 5910.379410161871, 5639.069553523623, 5716.228309178291, 5717.771289148387, 5725.370209276976, 5768.826935191951, 5813.912791308134, 5820.301563812285, 5823.767049318065, 5828.154917536934, 5835.4748072673665, 5500.752466138953, 5712.542996560265, 5726.455986681259, 5794.855128621818, 5808.506276966421, 5802.4777770000055, 5810.0, 5819.88360232793, 5831.446012628793, 5890.646561206341, 4401.537838526909, 4410.0738844842945, 4410.206162890647, 4458.754768487699, 4497.662675299301, 3891.0, 3922.8823135305415, 3944.8027598619956, 3947.86701501768, 3958.247932892741, 5313.521783039545, 5329.600279979017, 5451.0, 5502.449755024466, 5548.861278468071, 5828.388019258002, 5839.328477225174, 5844.211031510777, 5858.53131749459, 5875.794347197913, 5315.0, 5418.241446197536, 5423.0, 5467.644603100785, 5573.916391254134, 4788.976055119702, 4799.856004319876, 4815.855524334275, 4817.759112044384, 4856.587190088811, 5904.763809447574, 5908.763649454059, 5920.31916329619, 5928.347881733006, 5930.258717660293, 5564.721763911869, 5644.85887852807, 5645.49190572834, 5709.54323654115, 5725.0, 5852.502537284208, 5882.676452795137, 5894.528437725057, 5907.3797251288, 5916.31962324321, 5370.275012873212, 5597.832065038056, 5608.242887210175, 5616.438356164351, 5627.099664053731, 5688.829335119953, 5691.3170419549915, 5727.799527016701, 5782.508486778671, 5783.710814459344, 5596.468335508121, 5638.774449021993, 5640.943590564042, 5641.323041235078, 5642.407547207484, 5458.344998600193, 5526.613137080366, 5585.301837270341, 5633.943660563342, 5650.208970744181, 5480.698561579152, 5548.861278468071, 5553.4724201200825, 5556.249906262603, 5573.442655734394, 5597.524210442158, 5610.635308704921, 5639.210510528447, 5646.632968857011, 5653.152027195953, 5255.211718242294, 5500.037493438712, 5513.807016754555, 5542.418046105101, 5543.861403464784], "value": 5256.510230343443, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.1762136091986, 613.72995881812, 634.8825467288552, 644.916160899083, 676.3642176354224, 38368.80815595922, 42784.93037674056, 42785.144297114115, 42793.358099628495, 42815.0, 42937.570624293745, 43272.0, 43527.0, 43667.12665746683, 43831.12337753243, 8655.307575393968, 8784.253338466238, 8790.780230494225, 8799.912000880006, 8819.338549608805, 8689.695860644879, 8700.956495217515, 8774.429662071976, 8784.868226976601, 8788.51663158526, 8746.912530874706, 8786.16531429513, 8786.253168480687, 8844.07137250589, 8846.20384165425, 8686.86969695455, 8702.34732395073, 8707.912920870805, 8745.95627021864, 8748.081451447602, 8521.914780852174, 8571.185737354941, 8598.312135029182, 8602.440841345293, 8605.354598405082, 32665.18337041593, 41097.794511027554, 41418.37872431916, 41484.1703165938, 41532.0, 3183.0291661261763, 3323.96676033239, 3388.915277118067, 3546.6453354664586, 3575.9987203583037, 31106.222344441343, 31304.373912521623, 31443.842780786177, 31497.007784260688, 31604.209894752585, 4121.402396652498, 4188.0, 4249.128928569636, 4336.91326173478, 4369.541198174209, 313770.0, 315120.0, 317201.41399293084, 318030.0, 319542.0, 36261.27477450436, 36285.63714362875, 36470.45294320587, 36489.27021459556, 36551.4517282241, 37111.62888371136, 37304.62695373011, 37563.81218093892, 37698.43452348217, 38035.57679808775, 15421.614459638375, 15477.071375717493, 15477.071375717493, 15501.534953951399, 15709.685806283811, 11319.151063670093, 11424.771504569862, 11492.42537873103, 11590.362530060758, 11705.531778728926, 19337.806621933883, 19359.0, 19386.321478748458, 19434.61130777405, 19588.412347629594, 7093.184283807325, 7297.781066567905, 7461.216572259943, 7509.316708129769, 7560.0, 937.7468083617522, 1019.4036488654073, 1049.2812423489934, 1078.0351585331084, 1146.5643055638805, 32200.35599288001, 32266.516002259985, 32654.0, 32661.346773064404, 33168.3366332672, 1099.2250463423268, 1115.9553617855195, 1131.0612191880718, 1154.4343271796758, 1261.1676293646333, 17086.914565427094, 17263.223154957806, 17271.481855544353, 17319.913400433168, 17337.219825107648, 512312.0, 512560.0, 516356.0, 516522.0, 516667.0, 55958.0, 57436.712816436484, 57472.0, 58041.0, 58086.419135808945, 1334.7397257534687, 1336.0914578086995, 1346.9932650336686, 1358.5720498043086, 1368.1996032321006, 30033.249168770955, 32099.0, 32324.515132272565, 32442.10515792706, 32585.185370364983, 50478.0, 50739.49260507348, 50785.0, 50898.236526451394, 51154.0, 430174.0, 430613.0, 432311.0, 434094.0, 434139.0, 29185.562216566344, 29216.7078329214, 29860.402791943605, 29950.400991980474, 29984.85007574948, 48191.5180848187, 48314.275285871445, 48384.27423588579, 48577.271340929205, 49337.50662493329, 38742.6125738739, 41421.378679319234, 41424.0, 41876.0, 42270.154596907276, 41207.58792412037, 41251.793741031106, 42165.367519486615, 43143.0, 43301.56698433102, 38381.80809095937, 40750.79624601858, 42003.15993680048, 42083.36874946817, 42935.570644293155, 36917.815410923846, 37937.0, 38316.80841595774, 38327.42508862314, 38669.806650966566, 28210.15369538917, 28255.576166357932, 28483.0, 28505.714942850307, 28626.0], "value": 19433.066672389417, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.9763014219145, 398.54963890803396, 404.3489981130378, 406.8982754311422, 415.5303218128626, 16417.261223244954, 18479.35322263721, 19128.13923373448, 20429.182832686693, 20488.487787805294, 19228.13473393697, 19300.806991930076, 20436.795632043675, 20456.488587785312, 20462.07920643571, 5711.571632127586, 5909.788493358851, 5962.970185149068, 5970.253718285215, 5985.34161242263, 5819.563532735041, 5841.591088623798, 5898.528117750569, 5903.793367232148, 5945.88108237835, 5769.3076830780365, 5848.561357898154, 5921.289445266552, 5937.584369094165, 5942.049272116462, 5487.6158668893195, 5796.13058041293, 5875.941240587604, 5884.76460941564, 5885.352611212763, 5643.68959707216, 5646.830595082154, 5657.868426314753, 5663.2637757091725, 5678.659280443187, 14815.111093334435, 14819.851801481955, 22314.77268750218, 23912.760872391227, 24642.260732178063, 2415.1760011118013, 2522.331582130737, 2708.3093811078047, 2955.650420965258, 3035.3322269100763, 10613.46932653372, 12371.75256494874, 12455.813162802566, 14901.701965960729, 14977.700445991019, 1902.8477721782224, 1945.902704864751, 1949.5905859769323, 1995.7804641489424, 1999.7000449932627, 81987.5900620499, 91920.0, 92295.07704922932, 94115.52942235314, 94539.05460945371, 11430.314181149157, 11570.42147892602, 11692.356920369291, 11733.120015998835, 11892.524299028115, 13615.0, 16440.0, 16524.256408461406, 30501.38997220043, 32235.67764322374, 9291.349605527683, 9418.623255069857, 9605.231581473465, 10013.749656258651, 10107.292489525662, 7679.654415551314, 7920.6039698014865, 7957.403194760416, 8046.316063134582, 8234.505929644241, 9057.411268267542, 9244.3528952974, 9297.489677787094, 9358.625654973861, 9391.0, 3300.72190819243, 3513.3675938330834, 3576.6602172794064, 3660.899792232716, 3768.3028639701197, 891.3493150000536, 977.1010670183448, 1048.2190767877828, 1055.3034996902009, 1058.9682309530726, 20160.798392016186, 20382.28661996823, 20459.38621841347, 20654.380368588965, 20842.37472875816, 997.3567049253191, 1007.4761124215366, 1019.8980101989741, 1057.0539367266254, 1058.1904842795268, 11115.777684446428, 11471.197016208785, 11643.941780291045, 11664.6500604982, 11677.766444671059, 452894.0, 456929.0, 457631.0, 461548.0, 465361.0, 56953.0, 89472.5526372364, 91093.08906910979, 101005.0, 102113.0, 1008.2135933971367, 1049.8320268756963, 1065.504540388723, 1067.530286673861, 1067.631667074858, 15592.532224033297, 17377.304907803547, 18140.45578632643, 18879.150438230037, 19124.61750764949, 35246.823765881, 45924.311135333664, 45988.31017534673, 46097.53902460932, 46357.0, 61328.0, 64913.67543162254, 65212.34000329063, 66138.66930665316, 66706.66646666736, 9206.125418085272, 9338.673146439842, 9428.764280893032, 9574.760630984281, 9585.808283834145, 11310.4910279036, 14264.286785660468, 14348.426062957366, 14783.334749936494, 14954.775678364616, 12347.13570050088, 12679.80980285278, 12695.492180313053, 12837.293948832903, 12844.871551284368, 7764.836935440611, 12157.458357194291, 12529.561465348668, 12645.810312845499, 12910.935445322713, 11857.992070674089, 12038.578649747216, 12700.237985720516, 12957.546485872948, 13032.47870085186, 9257.86113208289, 9311.323961686961, 9319.394239374418, 9349.532523373668, 9531.618735250513, 9922.503874806087, 11822.82265765997, 12192.390380480763, 12627.242365458102, 12810.74378512406], "value": 10053.68426112046, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1489.806325177727, 1502.2864139533722, 1644.8190699023112, 1777.4756446848178, 1795.8653101017428, 7733.188015258401, 8436.367272454567, 8458.450200736963, 8961.775955601113, 8967.955160224197, 8524.659013639463, 8723.127687231274, 8797.164269394414, 8799.164079412445, 8834.381593288472, 2349.318697577705, 2383.2969274064194, 2384.308550520347, 2387.1167667962877, 2387.7134743830766, 2303.332033710222, 2311.653252012203, 2333.369990102671, 2337.0534933351933, 2345.94135146621, 2317.9884100579475, 2324.0587562037317, 2330.731965823935, 2368.9407764805846, 2368.9931778993946, 2274.749777524471, 2281.6007198740235, 2289.599320118981, 2291.7822806833406, 2300.3214051854743, 2172.0334451169238, 2202.977970220293, 2205.911763529457, 2209.823214142865, 2211.7456492503406, 8706.1729135732, 8832.02847686754, 8857.424267422597, 8878.467291962503, 8904.376693631448, 5084.288199652052, 5111.131107711698, 5171.689698618057, 5180.6373553851245, 5189.0, 3203.2312245061016, 3251.5122731590213, 3298.323843612078, 3310.519974603693, 3313.701766840996, 1103.8289065194826, 1111.4387234446554, 1118.9608363707312, 1142.9885701142966, 1149.3046706742468, 12226.572069977597, 12272.877271227351, 12330.50677972889, 12350.073744469111, 12400.00799936003, 4389.253826849444, 4515.254982927846, 4590.632749380042, 4600.861974140781, 4612.123696497655, 10202.540885660163, 10207.948960255151, 10233.48832558384, 10264.948675256725, 10287.537060832281, 5138.871528211825, 5158.767855446514, 5165.767540460688, 5166.276721259027, 5173.818916337986, 4216.64158546527, 4646.303054541778, 4753.239481682914, 4828.420589529279, 4839.854804355875, 3998.3202855514633, 4002.2595819773437, 4077.571854955246, 4127.607877251657, 4127.690423218271, 1275.43880692495, 1289.0976316578433, 1295.747329270802, 1298.4546490474024, 1339.4441306857739, 792.5324058805332, 816.6161903905155, 928.1182876267573, 934.5654270763991, 942.7784470649392, 5730.656160630376, 5787.305523337226, 5896.086106653475, 5951.083186331847, 6021.638701677914, 462.0182113009854, 464.42875263426174, 471.0390802762395, 941.9058094190664, 1036.108946306176, 3847.5960024197616, 3914.5498267699577, 3930.1157239620857, 3931.66580840626, 3964.900877478086, 10790.892091079146, 10983.066439352744, 10998.175136864767, 11014.339139651647, 11120.277181983145, 10776.67669969902, 11238.550457981753, 11243.212975091665, 11289.15331350152, 11339.716507087389, 8012.639431225609, 8198.262156405952, 8302.211289927447, 8317.750467485865, 8328.500289982621, 5651.124075768263, 5667.4332566743, 5678.176664383724, 5766.5675074368755, 5864.589478736448, 9930.25523085757, 10016.899831001889, 10236.948815256173, 10262.35802271633, 10386.532606032897, 10114.544845481823, 10169.338992965433, 10372.481375931324, 10607.045365917105, 10615.734606634587, 7614.619269036415, 8297.211764882326, 8307.418480706292, 8572.485650860968, 8746.344024198337, 8841.425307355, 8846.513441760764, 8846.778830529289, 8849.4247873888, 8892.15524525195, 7411.5553066816165, 7619.08570971487, 7625.771226863203, 7637.350825179922, 7717.536947783151, 7311.707531698672, 7401.962990185015, 7425.740099096722, 7513.4740568159705, 7642.923570764221, 6825.863482730417, 6836.692348844214, 6893.276205998298, 6907.240203577502, 6936.965315173392, 5088.618353623419, 5173.22401639742, 5215.608829337891, 5270.78916843322, 5302.045631786315, 5235.319408476874, 5268.81559145428, 5276.604254680991, 5361.195820626781, 5365.839024829262], "value": 4585.78682248762, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.2766940400523, 332.220941891265, 338.2592123250082, 345.73551233306523, 348.6583148514457, 5708.7431065602095, 5713.657180569169, 5731.856703582413, 5756.222909907161, 5813.081683044596, 5635.380108188096, 5675.177099320596, 5676.631018983763, 5686.658800471974, 5693.544516438686, 4356.8257269709175, 4359.673024523157, 4418.895276180955, 4429.86710398687, 4458.710183838057, 4405.427294451717, 4446.733196008234, 4476.216662084138, 4478.14915166119, 4482.148391805546, 4423.823047078113, 4432.423784907957, 4440.800163992628, 4447.3996010538485, 4447.799849006802, 4212.641925436342, 4399.450068741423, 4402.625776808975, 4405.31717583775, 4408.354987007801, 3775.867844625425, 3804.90487737806, 3822.9808850955847, 3827.158025234444, 3832.3868181090893, 5507.862303442406, 5557.610597350662, 5590.580706446992, 5595.608307418483, 5623.578231632603, 4919.253664948963, 4994.300797888299, 5014.172661510883, 5024.145895197825, 5026.597872170218, 5939.643621382731, 5965.910511342333, 5977.8804423911715, 5985.730642121115, 6014.909776353358, 4202.411662367271, 4206.663466922639, 4230.534641189467, 4234.55537168599, 4238.978805105986, 5899.793507227227, 6064.605800622945, 6083.2395950506625, 6109.266887973472, 6132.724027418777, 4248.957510424918, 4329.935050974238, 4334.913301733947, 4348.369486424451, 4364.759938203366, 4378.430803995524, 4385.451818522684, 4395.077033822933, 4400.119976004812, 4402.9559704402545, 4739.928901066418, 4926.778294976734, 4974.955259395568, 4975.975120124376, 5025.673331233458, 5903.940960590425, 6025.096235564701, 6041.0, 6052.636841789506, 6059.697015149225, 1425.7504936636046, 1474.329180222996, 1499.5876134063, 1504.9548513544612, 1510.8489151084805, 938.8544775559799, 945.8980287964445, 974.9567962280292, 975.331897650112, 975.8731364922656, 4941.170592790544, 4955.992822906728, 5031.52200540948, 5042.016806722654, 5042.235217673785, 5210.541048506424, 5280.9207861882105, 5304.170061328912, 5316.119232959961, 5370.0333939890415, 5048.697078175322, 5081.390233171969, 5459.672419654833, 5541.224228607998, 5736.4550367715, 3201.9039428817173, 3220.7423406127455, 3242.1732458223473, 3256.9903329967788, 3262.5758651375645, 6056.939430605726, 6258.08998815553, 6319.58922670025, 6327.753647455087, 6358.268799088071, 6192.195014648067, 6218.533609979179, 6222.160008398808, 6239.719212635351, 6243.562950593415, 6201.317855035943, 6262.279837818618, 6271.27880293763, 6297.96851015742, 6300.180976473029, 5752.395998420106, 6067.36181231074, 6075.848103797441, 6100.816975490742, 6120.418560236771, 6001.339852616122, 6036.486898613667, 6046.27444706638, 6061.605995610271, 6097.4817140543555, 5982.341942386247, 6175.69121543912, 6212.534059945612, 6250.0, 6275.466585340115, 4221.0, 4246.214450326699, 4265.12564924196, 4280.079782846578, 4294.957050429456, 6031.577789554689, 6105.45050945417, 6113.358097399887, 6127.20346354971, 6145.293291271382, 5617.522510586646, 5804.068945182656, 5834.708264586839, 5858.2677165354335, 5923.940760592339, 5847.7368518417625, 5856.619319744203, 5880.353161152356, 5894.351621321737, 5918.201042859159, 5537.446255374431, 5792.015357389169, 5837.29952405714, 5841.912371314519, 5856.707164641836, 5917.644941303535, 5939.2575928009, 5949.791757288474, 5958.314793798769, 5969.791057312973, 5784.681842498703, 5788.450097240755, 5802.854928626818, 5810.535157187331, 5843.532517398683], "value": 4464.746965262628, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.1702707831836, 717.7918403662939, 724.9093863267092, 728.7959371376016, 776.8290975985283, 15209.0, 16601.086940218283, 16630.1684915754, 16739.91630041851, 17582.120893955314, 16031.599210019725, 16209.189540522986, 16209.594760131002, 16220.270087846045, 16243.431479898207, 653.464159389301, 794.7695168401171, 811.0, 814.149214071294, 814.2305521282391, 784.7292684024031, 805.3718099882101, 812.92277233663, 814.2793627639552, 815.7104227999034, 853.2065179383171, 857.7298151082421, 859.9312055035614, 860.3762272352557, 861.8491763941286, 847.9576021198916, 848.3806821020659, 848.6138806842872, 850.0479463001448, 853.8463076646201, 616.2389449030444, 621.1459243540132, 621.6394491195095, 623.1618473153601, 623.9968800156015, 15426.151561664105, 15458.845411545966, 15468.071915685096, 15479.303431345505, 15483.922580387138, 14977.475788347465, 15232.162231077285, 15241.771373429407, 15245.771313430196, 15251.542453726406, 12300.692482687915, 12389.504419823286, 12560.623181304576, 12570.874291257152, 12734.745305093846, 3788.0, 3958.841646334143, 4044.1911617676583, 4053.1893621275863, 4076.1236334187997, 78328.60835695842, 80115.0, 81189.18810811876, 81247.5937620314, 81345.0, 11161.274517156358, 11287.49206285719, 11347.37589432589, 11419.714507137389, 11592.014678752232, 21839.563208736054, 21888.23391181301, 21907.233246836604, 22051.0, 22124.88937555302, 8496.150384961455, 8507.957460212783, 8629.827403451896, 8738.169873861973, 8872.334574906909, 4727.361806156194, 4730.0, 4770.284457331359, 4805.711657300573, 4840.878978025577, 3298.93402131956, 3419.059758566414, 3433.759636825398, 3438.054535002844, 3440.6215316315183, 634.8888944434798, 661.4113439039259, 668.8829454845383, 684.6679360510149, 684.8561802021632, 632.4371309534517, 672.6166085331412, 704.9259827718016, 717.4296434334613, 745.5079647432776, 9650.372725772802, 9703.369280996712, 9759.951200244095, 10204.285700000928, 10309.587616495257, 719.9208087110413, 742.4988133010196, 755.3692666623322, 759.1004659478535, 776.6543887969799, 4501.234790085693, 4631.513691062457, 4660.370849935215, 4701.553352431513, 5068.189089745697, 125267.3736631311, 130659.34670326777, 132667.0, 134509.32745336407, 135476.32261838825, 106585.0, 109406.0, 109690.45154774335, 110002.44998774955, 110983.0, 97129.0, 98036.0, 99554.0, 99601.0, 101580.49209753904, 9964.402135871582, 10206.387616743019, 10260.384376937407, 10579.994900484442, 10598.629047983284, 46609.300860486444, 48439.5156048435, 54531.72734136304, 55032.0, 55498.72250638721, 55537.0, 58094.0, 75410.6229468871, 76048.23951760633, 80050.0, 11968.401579921143, 11996.40017999114, 12156.0, 12299.44652490658, 12313.938430307791, 15079.54761357161, 15218.315175817337, 15266.847331526988, 15409.614759631098, 15761.290741916871, 14205.218712970885, 14279.0, 14337.211453370164, 14394.496192633207, 14555.563333100024, 13631.454741810216, 13976.440942362191, 14284.285785710465, 14290.42838286457, 14365.0, 13544.187348759106, 13719.657008574866, 13725.176489410667, 13788.793168102286, 14364.569062928129, 11326.129176833627, 11587.594434194763, 11965.76068478608, 12077.894243661263, 12269.75460490803, 11421.257618254787, 11478.82781758291, 11507.539698411969, 11754.529818807152, 11789.174757766874], "value": 7772.351346248661, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 109.0, 110.0, 111.0, 114.0, 112.0, 111.0, 111.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 147.0, 165.0, 118.0, 151.0, 147.0, 119.0, 175.0, 117.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 164.0, 162.0, 175.0, 166.0, 175.0, 163.0, 162.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 171.0, 77.0, 75.0, 76.0, 74.0, 166.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 141.0, 83.0, 83.0, 84.0, 138.0, 83.0, 85.0, 153.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 116.0, 117.0, 119.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 148.0, 147.0, 151.0, 147.0, 148.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 54.0, 56.0, 54.0, 55.0, 55.0, 53.0, 53.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 61.0, 61.0, 63.0, 61.0, 60.0, 63.0, 60.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 75.0, 83.0, 76.0, 75.0, 74.0, 76.0, 81.0, 76.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 127.0, 127.0, 117.0, 131.0, 137.0, 126.0, 124.0, 164.0, 121.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 159.0, 159.0, 159.0, 162.0, 154.0, 156.0, 154.0, 153.0, 152.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 62.0, 64.0, 63.0, 64.0, 66.0, 65.0, 63.0], "value": 64.1, "unit": "score"}]}]} 07:29:16 INFO - Return code: 0 07:29:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:29:16 ERROR - # TBPL SUCCESS # 07:29:16 INFO - Running post-action listener: _resource_record_post_action 07:29:16 INFO - ##### 07:29:16 INFO - ##### Finished run-tests step (success) 07:29:16 INFO - ##### 07:29:16 INFO - Running post-run listener: _resource_record_post_run 07:29:16 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554188800; Read time: 12; Write time: 358724 07:29:16 INFO - TinderboxPrint: CPU usage
13.3% 07:29:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:29:16 INFO - TinderboxPrint: I/O write bytes / time
554,188,800 / 358,724 07:29:16 INFO - TinderboxPrint: CPU idle
8,222.2 (86.7%) 07:29:16 INFO - TinderboxPrint: CPU user
1,211.8 (12.8%) 07:29:16 INFO - TinderboxPrint: Swap in / out
0 / 0 07:29:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 256536576; Read time: 0; Write time: 204984 07:29:16 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 297652224; Read time: 0; Write time: 153740 07:29:17 INFO - Running post-run listener: _upload_blobber_files 07:29:17 INFO - Blob upload gear active. 07:29:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:29:17 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 07:29:17 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'] 07:29:17 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 07:29:17 INFO - (blobuploader) - INFO - Open directory for files ... 07:29:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:29:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:29:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:18 INFO - (blobuploader) - INFO - Done attempting. 07:29:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:29:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:29:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:22 INFO - (blobuploader) - INFO - Done attempting. 07:29:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:29:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:29:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:22 INFO - (blobuploader) - INFO - Done attempting. 07:29:22 INFO - (blobuploader) - INFO - Iteration through files over. 07:29:22 INFO - Return code: 0 07:29:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:29:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:29:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b7488983787660421881965eaa45ee0000c2a28e9213c61e81b76698723d91699c04c28c9f79e53d2eec3e0c9f62472faf0262bc79d7adba80cf75b2a523ca3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b18e4a328951032b77a1b0b9a131a84d902a493f5c7e730aaeb73ce26918dde4f0d7d9bd9f02698875c23839a37de134b3e770dd727dfd2bf114cdee45c82e5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b2671fd99202502891297a56ba2a03d2f30a50cc43ccc05af2bf4b6a7f8dcfe731af91eaa2789a539922206b8dd6df5055ca2c46b63f3df4b33763e1fab9af"} 07:29:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:29:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:29:22 INFO - Contents: 07:29:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b7488983787660421881965eaa45ee0000c2a28e9213c61e81b76698723d91699c04c28c9f79e53d2eec3e0c9f62472faf0262bc79d7adba80cf75b2a523ca3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b18e4a328951032b77a1b0b9a131a84d902a493f5c7e730aaeb73ce26918dde4f0d7d9bd9f02698875c23839a37de134b3e770dd727dfd2bf114cdee45c82e5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b2671fd99202502891297a56ba2a03d2f30a50cc43ccc05af2bf4b6a7f8dcfe731af91eaa2789a539922206b8dd6df5055ca2c46b63f3df4b33763e1fab9af"} 07:29:22 INFO - Running post-run listener: copy_logs_to_upload_dir 07:29:22 INFO - Copying logs to upload dir... 07:29:22 INFO - mkdir: /builds/slave/test/build/upload/logs 07:29:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.653621 ========= master_lag: 0.90 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-30 07:29:23.683285) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 07:29:23.687828) ========= 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=6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b7488983787660421881965eaa45ee0000c2a28e9213c61e81b76698723d91699c04c28c9f79e53d2eec3e0c9f62472faf0262bc79d7adba80cf75b2a523ca3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b18e4a328951032b77a1b0b9a131a84d902a493f5c7e730aaeb73ce26918dde4f0d7d9bd9f02698875c23839a37de134b3e770dd727dfd2bf114cdee45c82e5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b2671fd99202502891297a56ba2a03d2f30a50cc43ccc05af2bf4b6a7f8dcfe731af91eaa2789a539922206b8dd6df5055ca2c46b63f3df4b33763e1fab9af"} build_url:https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011257 build_url: 'https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b7488983787660421881965eaa45ee0000c2a28e9213c61e81b76698723d91699c04c28c9f79e53d2eec3e0c9f62472faf0262bc79d7adba80cf75b2a523ca3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b18e4a328951032b77a1b0b9a131a84d902a493f5c7e730aaeb73ce26918dde4f0d7d9bd9f02698875c23839a37de134b3e770dd727dfd2bf114cdee45c82e5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b2671fd99202502891297a56ba2a03d2f30a50cc43ccc05af2bf4b6a7f8dcfe731af91eaa2789a539922206b8dd6df5055ca2c46b63f3df4b33763e1fab9af"}' ========= master_lag: 0.27 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 07:29:23.972442) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:29:23.972804) ========= 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=6dbc10da6d83fee962c624be000001a8-1467295429.410279-1362675654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:29:23.990088) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 07:29:23.993492) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 07:29:23.993885) ========= ========= Total master_lag: 1.25 =========